builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1464899613.2 results: success (0) buildid: 20160602121839 builduid: ee28a285bda34c77906a84d52afd3298 revision: 1914a4e74ae00436943a1c0dd4cae62bc23fab4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.201315) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.201798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.202131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.295500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.295817) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 13:33:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.2M=0.001s 2016-06-02 13:33:33 (20.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.444003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.444407) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.497398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:33.497780) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 1914a4e74ae00436943a1c0dd4cae62bc23fab4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 1914a4e74ae00436943a1c0dd4cae62bc23fab4a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 13:33:33,861 truncating revision to first 12 chars 2016-06-02 13:33:33,861 Setting DEBUG logging. 2016-06-02 13:33:33,861 attempt 1/10 2016-06-02 13:33:33,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/1914a4e74ae0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 13:33:34,187 unpacking tar archive at: larch-1914a4e74ae0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:34.179310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:34.179652) ========= script_repo_revision: 1914a4e74ae00436943a1c0dd4cae62bc23fab4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:34.180076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:34.180405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 13:33:34.191878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-02 13:33:34.192218) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:33:34 INFO - MultiFileLogger online at 20160602 13:33:34 in /builds/slave/test 13:33:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:33:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:33:34 INFO - {'append_to_log': False, 13:33:34 INFO - 'base_work_dir': '/builds/slave/test', 13:33:34 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:33:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:33:34 INFO - 'branch': 'Larch-Non-PGO', 13:33:34 INFO - 'buildbot_json_path': 'buildprops.json', 13:33:34 INFO - 'config_files': ('talos/linux_config.py',), 13:33:34 INFO - 'default_actions': ('clobber', 13:33:34 INFO - 'read-buildbot-config', 13:33:34 INFO - 'download-and-extract', 13:33:34 INFO - 'populate-webroot', 13:33:34 INFO - 'create-virtualenv', 13:33:34 INFO - 'install', 13:33:34 INFO - 'run-tests'), 13:33:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:33:34 INFO - 'download_minidump_stackwalk': True, 13:33:34 INFO - 'download_symbols': 'ondemand', 13:33:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:33:34 INFO - 'tooltool.py': '/tools/tooltool.py', 13:33:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:33:34 INFO - '/tools/misc-python/virtualenv.py')}, 13:33:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:33:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:33:34 INFO - 'installer_path': 'installer.exe', 13:33:34 INFO - 'log_level': 'info', 13:33:34 INFO - 'log_name': 'talos', 13:33:34 INFO - 'log_to_console': True, 13:33:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:33:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:33:34 INFO - 'opt_config_files': (), 13:33:34 INFO - 'pip_index': False, 13:33:34 INFO - 'sps_profile': False, 13:33:34 INFO - 'sps_profile_interval': 0, 13:33:34 INFO - 'suite': 'dromaeojs', 13:33:34 INFO - 'system_bits': '32', 13:33:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:33:34 INFO - 'title': 'talos-linux64-ix-019', 13:33:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:33:34 INFO - 'use_talos_json': True, 13:33:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:33:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:33:34 INFO - 'work_dir': 'build'} 13:33:34 INFO - ##### 13:33:34 INFO - ##### Running clobber step. 13:33:34 INFO - ##### 13:33:34 INFO - Running pre-action listener: _resource_record_pre_action 13:33:34 INFO - Running main action method: clobber 13:33:34 INFO - rmtree: /builds/slave/test/build 13:33:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:33:35 INFO - Running post-action listener: _resource_record_post_action 13:33:35 INFO - ##### 13:33:35 INFO - ##### Finished clobber step (success) 13:33:35 INFO - ##### 13:33:35 INFO - ##### 13:33:35 INFO - ##### Running read-buildbot-config step. 13:33:35 INFO - ##### 13:33:35 INFO - Running pre-action listener: _resource_record_pre_action 13:33:35 INFO - Running main action method: read_buildbot_config 13:33:35 INFO - Using buildbot properties: 13:33:35 INFO - { 13:33:35 INFO - "project": "", 13:33:35 INFO - "product": "firefox", 13:33:35 INFO - "script_repo_revision": "production", 13:33:35 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 13:33:35 INFO - "repository": "", 13:33:35 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 13:33:35 INFO - "buildid": "20160602121839", 13:33:35 INFO - "pgo_build": "False", 13:33:35 INFO - "basedir": "/builds/slave/test", 13:33:35 INFO - "buildnumber": 6, 13:33:35 INFO - "slavename": "talos-linux64-ix-019", 13:33:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:33:35 INFO - "platform": "ubuntu64_hw", 13:33:35 INFO - "scheduler": "tests-larch-linux64-talos", 13:33:35 INFO - "branch": "larch", 13:33:35 INFO - "repo_path": "projects/larch", 13:33:35 INFO - "revision": "1914a4e74ae00436943a1c0dd4cae62bc23fab4a", 13:33:35 INFO - "stage_platform": "linux64", 13:33:35 INFO - "builduid": "ee28a285bda34c77906a84d52afd3298", 13:33:35 INFO - "slavebuilddir": "test" 13:33:35 INFO - } 13:33:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:33:35 INFO - Running post-action listener: _resource_record_post_action 13:33:35 INFO - ##### 13:33:35 INFO - ##### Finished read-buildbot-config step (success) 13:33:35 INFO - ##### 13:33:35 INFO - ##### 13:33:35 INFO - ##### Running download-and-extract step. 13:33:35 INFO - ##### 13:33:35 INFO - Running pre-action listener: _resource_record_pre_action 13:33:35 INFO - Running main action method: download_and_extract 13:33:35 INFO - mkdir: /builds/slave/test/build/tests 13:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:35 INFO - https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:33:39 INFO - Downloaded 1361 bytes. 13:33:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:33:39 INFO - Using the following test package requirements: 13:33:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:33:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:33:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'jsshell-linux-x86_64.zip'], 13:33:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:33:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:33:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:33:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:33:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:33:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:39 INFO - https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:33:40 INFO - Downloaded 22850562 bytes. 13:33:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:33:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:33:41 INFO - Return code: 0 13:33:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:41 INFO - https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:33:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:33:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:33:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:33:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:33:45 INFO - Downloaded 22850562 bytes. 13:33:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:33:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:33:46 INFO - Return code: 0 13:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:46 INFO - https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:33:48 INFO - Downloaded 10834063 bytes. 13:33:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:33:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:33:48 INFO - Return code: 0 13:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:48 INFO - https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:33:50 INFO - Downloaded 55179266 bytes. 13:33:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:33:50 INFO - mkdir: /builds/slave/test/properties 13:33:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:33:50 INFO - Writing to file /builds/slave/test/properties/build_url 13:33:50 INFO - Contents: 13:33:50 INFO - build_url:https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:33:50 INFO - Running post-action listener: _resource_record_post_action 13:33:50 INFO - Running post-action listener: set_extra_try_arguments 13:33:50 INFO - ##### 13:33:50 INFO - ##### Finished download-and-extract step (success) 13:33:50 INFO - ##### 13:33:50 INFO - ##### 13:33:50 INFO - ##### Running populate-webroot step. 13:33:50 INFO - ##### 13:33:50 INFO - Running pre-action listener: _resource_record_pre_action 13:33:50 INFO - Running main action method: populate_webroot 13:33:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:50 INFO - '--tppagecycles', 13:33:50 INFO - '7'], 13:33:50 INFO - 'tests': ['tsvgm']}}, 13:33:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:33:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:33:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:33:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['damp', 'tps']}, 13:33:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'tests': ['damp', 'tps']}, 13:33:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['dromaeo_dom']}, 13:33:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['a11yr', 13:33:50 INFO - 'ts_paint', 13:33:50 INFO - 'tpaint', 13:33:50 INFO - 'sessionrestore', 13:33:50 INFO - 'sessionrestore_no_auto_restore', 13:33:50 INFO - 'tabpaint']}, 13:33:50 INFO - 'other-e10s': {'tests': ['a11yr', 13:33:50 INFO - 'ts_paint', 13:33:50 INFO - 'tpaint', 13:33:50 INFO - 'sessionrestore', 13:33:50 INFO - 'sessionrestore_no_auto_restore', 13:33:50 INFO - 'tabpaint']}, 13:33:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:33:50 INFO - 'ts_paint', 13:33:50 INFO - 'tpaint', 13:33:50 INFO - 'sessionrestore', 13:33:50 INFO - 'sessionrestore_no_auto_restore', 13:33:50 INFO - 'tabpaint']}, 13:33:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:33:50 INFO - 'ts_paint', 13:33:50 INFO - 'tpaint', 13:33:50 INFO - 'sessionrestore', 13:33:50 INFO - 'sessionrestore_no_auto_restore', 13:33:50 INFO - 'tabpaint']}, 13:33:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['a11yr', 13:33:50 INFO - 'ts_paint', 13:33:50 INFO - 'tpaint', 13:33:50 INFO - 'sessionrestore', 13:33:50 INFO - 'sessionrestore_no_auto_restore', 13:33:50 INFO - 'tabpaint']}, 13:33:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['a11yr', 13:33:50 INFO - 'ts_paint', 13:33:50 INFO - 'tpaint', 13:33:50 INFO - 'sessionrestore', 13:33:50 INFO - 'sessionrestore_no_auto_restore', 13:33:50 INFO - 'tabpaint']}, 13:33:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['tsvgx', 13:33:50 INFO - 'tsvgr_opacity', 13:33:50 INFO - 'tart', 13:33:50 INFO - 'tscrollx', 13:33:50 INFO - 'cart']}, 13:33:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:33:50 INFO - 'tsvgr_opacity', 13:33:50 INFO - 'tart', 13:33:50 INFO - 'tscrollx', 13:33:50 INFO - 'cart']}, 13:33:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'talos_options': ['--disable-e10s'], 13:33:50 INFO - 'tests': ['tp5o']}, 13:33:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'tests': ['tp5o']}, 13:33:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'talos_options': ['--disable-e10s', 13:33:50 INFO - '--xperf_path', 13:33:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:50 INFO - 'tests': ['tp5n']}, 13:33:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:50 INFO - 'talos_options': ['--xperf_path', 13:33:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:50 INFO - 'tests': ['tp5n']}}, 13:33:50 INFO - 'talos.zip': {'path': '', 13:33:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:50 INFO - Running post-action listener: _resource_record_post_action 13:33:50 INFO - ##### 13:33:50 INFO - ##### Finished populate-webroot step (success) 13:33:50 INFO - ##### 13:33:50 INFO - ##### 13:33:50 INFO - ##### Running create-virtualenv step. 13:33:50 INFO - ##### 13:33:50 INFO - Running pre-action listener: _resource_record_pre_action 13:33:50 INFO - Running main action method: create_virtualenv 13:33:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:33:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:51 INFO - Using real prefix '/usr' 13:33:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:53 INFO - Installing pip.................done. 13:33:53 INFO - Return code: 0 13:33:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:33:53 INFO - Using env: {'DISPLAY': ':0', 13:33:53 INFO - 'HOME': '/home/cltbld', 13:33:53 INFO - 'LANG': 'en_US.UTF-8', 13:33:53 INFO - 'LANGUAGE': 'en_US:en', 13:33:53 INFO - 'LOGNAME': 'cltbld', 13:33:53 INFO - 'MAIL': '/var/mail/cltbld', 13:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:53 INFO - 'MOZ_NO_REMOTE': '1', 13:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:53 INFO - 'NO_EM_RESTART': '1', 13:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:53 INFO - 'PWD': '/builds/slave/test', 13:33:53 INFO - 'SHELL': '/bin/bash', 13:33:53 INFO - 'SHLVL': '1', 13:33:53 INFO - 'TERM': 'linux', 13:33:53 INFO - 'TMOUT': '86400', 13:33:53 INFO - 'USER': 'cltbld', 13:33:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:53 INFO - '_': '/tools/buildbot/bin/python'} 13:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:33:53 INFO - Cleaning up... 13:33:53 INFO - Return code: 0 13:33:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:33:53 INFO - Using env: {'DISPLAY': ':0', 13:33:53 INFO - 'HOME': '/home/cltbld', 13:33:53 INFO - 'LANG': 'en_US.UTF-8', 13:33:53 INFO - 'LANGUAGE': 'en_US:en', 13:33:53 INFO - 'LOGNAME': 'cltbld', 13:33:53 INFO - 'MAIL': '/var/mail/cltbld', 13:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:53 INFO - 'MOZ_NO_REMOTE': '1', 13:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:53 INFO - 'NO_EM_RESTART': '1', 13:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:53 INFO - 'PWD': '/builds/slave/test', 13:33:53 INFO - 'SHELL': '/bin/bash', 13:33:53 INFO - 'SHLVL': '1', 13:33:53 INFO - 'TERM': 'linux', 13:33:53 INFO - 'TMOUT': '86400', 13:33:53 INFO - 'USER': 'cltbld', 13:33:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:53 INFO - '_': '/tools/buildbot/bin/python'} 13:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:53 INFO - Downloading/unpacking psutil>=3.1.1 13:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:55 INFO - Installing collected packages: psutil 13:33:55 INFO - Running setup.py install for psutil 13:33:55 INFO - building 'psutil._psutil_linux' extension 13:33:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:33:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:33:56 INFO - building 'psutil._psutil_posix' extension 13:33:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:33:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:33:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:56 INFO - Successfully installed psutil 13:33:56 INFO - Cleaning up... 13:33:56 INFO - Return code: 0 13:33:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:33:56 INFO - Using env: {'DISPLAY': ':0', 13:33:56 INFO - 'HOME': '/home/cltbld', 13:33:56 INFO - 'LANG': 'en_US.UTF-8', 13:33:56 INFO - 'LANGUAGE': 'en_US:en', 13:33:56 INFO - 'LOGNAME': 'cltbld', 13:33:56 INFO - 'MAIL': '/var/mail/cltbld', 13:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:56 INFO - 'MOZ_NO_REMOTE': '1', 13:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:56 INFO - 'NO_EM_RESTART': '1', 13:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:56 INFO - 'PWD': '/builds/slave/test', 13:33:56 INFO - 'SHELL': '/bin/bash', 13:33:56 INFO - 'SHLVL': '1', 13:33:56 INFO - 'TERM': 'linux', 13:33:56 INFO - 'TMOUT': '86400', 13:33:56 INFO - 'USER': 'cltbld', 13:33:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:56 INFO - '_': '/tools/buildbot/bin/python'} 13:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:33:58 INFO - Installing collected packages: mozsystemmonitor 13:33:58 INFO - Running setup.py install for mozsystemmonitor 13:33:58 INFO - Successfully installed mozsystemmonitor 13:33:58 INFO - Cleaning up... 13:33:58 INFO - Return code: 0 13:33:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:33:58 INFO - Using env: {'DISPLAY': ':0', 13:33:58 INFO - 'HOME': '/home/cltbld', 13:33:58 INFO - 'LANG': 'en_US.UTF-8', 13:33:58 INFO - 'LANGUAGE': 'en_US:en', 13:33:58 INFO - 'LOGNAME': 'cltbld', 13:33:58 INFO - 'MAIL': '/var/mail/cltbld', 13:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:58 INFO - 'MOZ_NO_REMOTE': '1', 13:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:58 INFO - 'NO_EM_RESTART': '1', 13:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:58 INFO - 'PWD': '/builds/slave/test', 13:33:58 INFO - 'SHELL': '/bin/bash', 13:33:58 INFO - 'SHLVL': '1', 13:33:58 INFO - 'TERM': 'linux', 13:33:58 INFO - 'TMOUT': '86400', 13:33:58 INFO - 'USER': 'cltbld', 13:33:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:58 INFO - '_': '/tools/buildbot/bin/python'} 13:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:00 INFO - Downloading blobuploader-1.2.4.tar.gz 13:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:34:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:34:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:01 INFO - Downloading docopt-0.6.1.tar.gz 13:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:34:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:34:01 INFO - Running setup.py install for blobuploader 13:34:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:34:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:34:01 INFO - Running setup.py install for requests 13:34:02 INFO - Running setup.py install for docopt 13:34:02 INFO - Successfully installed blobuploader requests docopt 13:34:02 INFO - Cleaning up... 13:34:02 INFO - Return code: 0 13:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:34:02 INFO - Using env: {'DISPLAY': ':0', 13:34:02 INFO - 'HOME': '/home/cltbld', 13:34:02 INFO - 'LANG': 'en_US.UTF-8', 13:34:02 INFO - 'LANGUAGE': 'en_US:en', 13:34:02 INFO - 'LOGNAME': 'cltbld', 13:34:02 INFO - 'MAIL': '/var/mail/cltbld', 13:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:02 INFO - 'MOZ_NO_REMOTE': '1', 13:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:02 INFO - 'NO_EM_RESTART': '1', 13:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:02 INFO - 'PWD': '/builds/slave/test', 13:34:02 INFO - 'SHELL': '/bin/bash', 13:34:02 INFO - 'SHLVL': '1', 13:34:02 INFO - 'TERM': 'linux', 13:34:02 INFO - 'TMOUT': '86400', 13:34:02 INFO - 'USER': 'cltbld', 13:34:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:02 INFO - '_': '/tools/buildbot/bin/python'} 13:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:34:02 INFO - Running setup.py (path:/tmp/pip-MBKJmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:34:02 INFO - Running setup.py (path:/tmp/pip-jcQncp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:34:02 INFO - Running setup.py (path:/tmp/pip-y6KTFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:34:02 INFO - Running setup.py (path:/tmp/pip-MU_Va9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:34:02 INFO - Running setup.py (path:/tmp/pip-4c6V25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:34:02 INFO - Running setup.py (path:/tmp/pip-Kz58pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:34:02 INFO - Running setup.py (path:/tmp/pip-0CV6FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:34:02 INFO - Running setup.py (path:/tmp/pip-X_7xH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:34:03 INFO - Running setup.py (path:/tmp/pip-KiMMl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:34:03 INFO - Running setup.py (path:/tmp/pip-94TH3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:34:03 INFO - Running setup.py (path:/tmp/pip-r8g8Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:34:03 INFO - Running setup.py (path:/tmp/pip-il8aZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:34:03 INFO - Running setup.py (path:/tmp/pip-nsVEMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:34:03 INFO - Running setup.py (path:/tmp/pip-hlgdi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:03 INFO - Running setup.py (path:/tmp/pip-aejfDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:34:03 INFO - Running setup.py (path:/tmp/pip-9MQTZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:34:03 INFO - Running setup.py (path:/tmp/pip-42FLyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:34:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:34:03 INFO - Running setup.py install for manifestparser 13:34:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:34:03 INFO - Running setup.py install for mozcrash 13:34:03 INFO - Running setup.py install for mozdebug 13:34:04 INFO - Running setup.py install for mozdevice 13:34:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Running setup.py install for mozfile 13:34:04 INFO - Running setup.py install for mozhttpd 13:34:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Running setup.py install for mozinfo 13:34:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Running setup.py install for mozInstall 13:34:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Running setup.py install for mozleak 13:34:04 INFO - Running setup.py install for mozlog 13:34:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Running setup.py install for moznetwork 13:34:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:34:04 INFO - Running setup.py install for mozprocess 13:34:04 INFO - Running setup.py install for mozprofile 13:34:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:34:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:34:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:34:05 INFO - Running setup.py install for mozrunner 13:34:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:34:05 INFO - Running setup.py install for mozscreenshot 13:34:05 INFO - Running setup.py install for moztest 13:34:05 INFO - Running setup.py install for mozversion 13:34:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:34:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:34:05 INFO - Cleaning up... 13:34:05 INFO - Return code: 0 13:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:34:05 INFO - Using env: {'DISPLAY': ':0', 13:34:05 INFO - 'HOME': '/home/cltbld', 13:34:05 INFO - 'LANG': 'en_US.UTF-8', 13:34:05 INFO - 'LANGUAGE': 'en_US:en', 13:34:05 INFO - 'LOGNAME': 'cltbld', 13:34:05 INFO - 'MAIL': '/var/mail/cltbld', 13:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:05 INFO - 'MOZ_NO_REMOTE': '1', 13:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:05 INFO - 'NO_EM_RESTART': '1', 13:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:05 INFO - 'PWD': '/builds/slave/test', 13:34:05 INFO - 'SHELL': '/bin/bash', 13:34:05 INFO - 'SHLVL': '1', 13:34:05 INFO - 'TERM': 'linux', 13:34:05 INFO - 'TMOUT': '86400', 13:34:05 INFO - 'USER': 'cltbld', 13:34:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:05 INFO - '_': '/tools/buildbot/bin/python'} 13:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:34:05 INFO - Running setup.py (path:/tmp/pip-_DEkDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:34:05 INFO - Running setup.py (path:/tmp/pip-ZMargQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:34:05 INFO - Running setup.py (path:/tmp/pip-a0_DXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:34:05 INFO - Running setup.py (path:/tmp/pip-H9mxED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:34:06 INFO - Running setup.py (path:/tmp/pip-46iHkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:34:06 INFO - Running setup.py (path:/tmp/pip-dtE4ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:34:06 INFO - Running setup.py (path:/tmp/pip-40bPJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:34:06 INFO - Running setup.py (path:/tmp/pip-KOlJ8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:34:06 INFO - Running setup.py (path:/tmp/pip-3wMjjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:34:06 INFO - Running setup.py (path:/tmp/pip-qs11C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:34:06 INFO - Running setup.py (path:/tmp/pip-rv2Ztw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:34:06 INFO - Running setup.py (path:/tmp/pip-Nf_sSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:34:06 INFO - Running setup.py (path:/tmp/pip-JbLuog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:34:06 INFO - Running setup.py (path:/tmp/pip-R5PmxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:06 INFO - Running setup.py (path:/tmp/pip-0iy7dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:34:06 INFO - Running setup.py (path:/tmp/pip-CULsPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:34:06 INFO - Running setup.py (path:/tmp/pip-mmPKtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:34:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:08 INFO - Downloading blessings-1.6.tar.gz 13:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:34:08 INFO - Installing collected packages: blessings 13:34:08 INFO - Running setup.py install for blessings 13:34:09 INFO - Successfully installed blessings 13:34:09 INFO - Cleaning up... 13:34:09 INFO - Return code: 0 13:34:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:34:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:09 INFO - Reading from file tmpfile_stdout 13:34:09 INFO - Current package versions: 13:34:09 INFO - argparse == 1.2.1 13:34:09 INFO - blessings == 1.6 13:34:09 INFO - blobuploader == 1.2.4 13:34:09 INFO - docopt == 0.6.1 13:34:09 INFO - manifestparser == 1.1 13:34:09 INFO - mozInstall == 1.12 13:34:09 INFO - mozcrash == 0.17 13:34:09 INFO - mozdebug == 0.1 13:34:09 INFO - mozdevice == 0.48 13:34:09 INFO - mozfile == 1.2 13:34:09 INFO - mozhttpd == 0.7 13:34:09 INFO - mozinfo == 0.9 13:34:09 INFO - mozleak == 0.1 13:34:09 INFO - mozlog == 3.2 13:34:09 INFO - moznetwork == 0.27 13:34:09 INFO - mozprocess == 0.22 13:34:09 INFO - mozprofile == 0.28 13:34:09 INFO - mozrunner == 6.11 13:34:09 INFO - mozscreenshot == 0.1 13:34:09 INFO - mozsystemmonitor == 0.3 13:34:09 INFO - moztest == 0.7 13:34:09 INFO - mozversion == 1.4 13:34:09 INFO - psutil == 3.1.1 13:34:09 INFO - requests == 1.2.3 13:34:09 INFO - wsgiref == 0.1.2 13:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:34:09 INFO - Using env: {'DISPLAY': ':0', 13:34:09 INFO - 'HOME': '/home/cltbld', 13:34:09 INFO - 'LANG': 'en_US.UTF-8', 13:34:09 INFO - 'LANGUAGE': 'en_US:en', 13:34:09 INFO - 'LOGNAME': 'cltbld', 13:34:09 INFO - 'MAIL': '/var/mail/cltbld', 13:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:09 INFO - 'MOZ_NO_REMOTE': '1', 13:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:09 INFO - 'NO_EM_RESTART': '1', 13:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:09 INFO - 'PWD': '/builds/slave/test', 13:34:09 INFO - 'SHELL': '/bin/bash', 13:34:09 INFO - 'SHLVL': '1', 13:34:09 INFO - 'TERM': 'linux', 13:34:09 INFO - 'TMOUT': '86400', 13:34:09 INFO - 'USER': 'cltbld', 13:34:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:09 INFO - '_': '/tools/buildbot/bin/python'} 13:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:34:09 INFO - Cleaning up... 13:34:09 INFO - Return code: 0 13:34:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:34:09 INFO - Using env: {'DISPLAY': ':0', 13:34:09 INFO - 'HOME': '/home/cltbld', 13:34:09 INFO - 'LANG': 'en_US.UTF-8', 13:34:09 INFO - 'LANGUAGE': 'en_US:en', 13:34:09 INFO - 'LOGNAME': 'cltbld', 13:34:09 INFO - 'MAIL': '/var/mail/cltbld', 13:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:09 INFO - 'MOZ_NO_REMOTE': '1', 13:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:09 INFO - 'NO_EM_RESTART': '1', 13:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:09 INFO - 'PWD': '/builds/slave/test', 13:34:09 INFO - 'SHELL': '/bin/bash', 13:34:09 INFO - 'SHLVL': '1', 13:34:09 INFO - 'TERM': 'linux', 13:34:09 INFO - 'TMOUT': '86400', 13:34:09 INFO - 'USER': 'cltbld', 13:34:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:09 INFO - '_': '/tools/buildbot/bin/python'} 13:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:09 INFO - Downloading/unpacking jsonschema 13:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:34:11 INFO - Downloading/unpacking functools32 (from jsonschema) 13:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:34:11 INFO - warning: no files found matching '*.txt' 13:34:11 INFO - no previously-included directories found matching 'build' 13:34:11 INFO - no previously-included directories found matching 'dist' 13:34:11 INFO - no previously-included directories found matching '.git*' 13:34:11 INFO - Installing collected packages: jsonschema, functools32 13:34:11 INFO - Running setup.py install for functools32 13:34:12 INFO - warning: no files found matching '*.txt' 13:34:12 INFO - no previously-included directories found matching 'build' 13:34:12 INFO - no previously-included directories found matching 'dist' 13:34:12 INFO - no previously-included directories found matching '.git*' 13:34:12 INFO - Successfully installed jsonschema functools32 13:34:12 INFO - Cleaning up... 13:34:12 INFO - Return code: 0 13:34:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dcf1def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2263770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:34:12 INFO - Using env: {'DISPLAY': ':0', 13:34:12 INFO - 'HOME': '/home/cltbld', 13:34:12 INFO - 'LANG': 'en_US.UTF-8', 13:34:12 INFO - 'LANGUAGE': 'en_US:en', 13:34:12 INFO - 'LOGNAME': 'cltbld', 13:34:12 INFO - 'MAIL': '/var/mail/cltbld', 13:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:12 INFO - 'MOZ_NO_REMOTE': '1', 13:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:12 INFO - 'NO_EM_RESTART': '1', 13:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:12 INFO - 'PWD': '/builds/slave/test', 13:34:12 INFO - 'SHELL': '/bin/bash', 13:34:12 INFO - 'SHLVL': '1', 13:34:12 INFO - 'TERM': 'linux', 13:34:12 INFO - 'TMOUT': '86400', 13:34:12 INFO - 'USER': 'cltbld', 13:34:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:12 INFO - '_': '/tools/buildbot/bin/python'} 13:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:12 INFO - Downloading/unpacking flake8 13:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:34:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:34:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:34:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:34:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:34:14 INFO - no previously-included directories found matching 'docs/_build' 13:34:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:34:15 INFO - Running setup.py install for pep8 13:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:34:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:34:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:34:15 INFO - no previously-included directories found matching 'docs/_build' 13:34:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:34:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:34:15 INFO - Cleaning up... 13:34:15 INFO - Return code: 0 13:34:15 INFO - Running post-action listener: _resource_record_post_action 13:34:15 INFO - Running post-action listener: _start_resource_monitoring 13:34:15 INFO - Starting resource monitoring. 13:34:15 INFO - ##### 13:34:15 INFO - ##### Finished create-virtualenv step (success) 13:34:15 INFO - ##### 13:34:15 INFO - ##### 13:34:15 INFO - ##### Running install step. 13:34:15 INFO - ##### 13:34:15 INFO - Running pre-action listener: _resource_record_pre_action 13:34:15 INFO - Running main action method: install 13:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:15 INFO - Reading from file tmpfile_stdout 13:34:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:34:15 INFO - Reading from file tmpfile_stdout 13:34:15 INFO - Output received: 13:34:15 INFO - Usage: mozinstall [options] installer 13:34:15 INFO - Options: 13:34:15 INFO - -h, --help show this help message and exit 13:34:15 INFO - -d DEST, --destination=DEST 13:34:15 INFO - Directory to install application into. [default: 13:34:15 INFO - "/builds/slave/test"] 13:34:15 INFO - --app=APP Application being installed. [default: firefox] 13:34:15 INFO - mkdir: /builds/slave/test/build/application 13:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:34:31 INFO - Reading from file tmpfile_stdout 13:34:31 INFO - Output received: 13:34:31 INFO - /builds/slave/test/build/application/firefox/firefox 13:34:31 INFO - Running post-action listener: _resource_record_post_action 13:34:31 INFO - ##### 13:34:31 INFO - ##### Finished install step (success) 13:34:31 INFO - ##### 13:34:31 INFO - ##### 13:34:31 INFO - ##### Running run-tests step. 13:34:31 INFO - ##### 13:34:31 INFO - Running pre-action listener: _resource_record_pre_action 13:34:31 INFO - Running main action method: run_tests 13:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:34:31 INFO - Python 2.7.3 13:34:31 INFO - Return code: 0 13:34:31 INFO - grabbing minidump binary from tooltool 13:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f29c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:34:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:34:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:34:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:34:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:34:31 INFO - Return code: 0 13:34:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:34:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:34:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:34:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:34:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:34:32 INFO - Return code: 0 13:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:34:32 INFO - Using env: {'DISPLAY': ':0', 13:34:32 INFO - 'HOME': '/home/cltbld', 13:34:32 INFO - 'LANG': 'en_US.UTF-8', 13:34:32 INFO - 'LANGUAGE': 'en_US:en', 13:34:32 INFO - 'LOGNAME': 'cltbld', 13:34:32 INFO - 'MAIL': '/var/mail/cltbld', 13:34:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:34:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:32 INFO - 'MOZ_NO_REMOTE': '1', 13:34:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:32 INFO - 'NO_EM_RESTART': '1', 13:34:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:32 INFO - 'PWD': '/builds/slave/test', 13:34:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:34:32 INFO - 'SHELL': '/bin/bash', 13:34:32 INFO - 'SHLVL': '1', 13:34:32 INFO - 'TERM': 'linux', 13:34:32 INFO - 'TMOUT': '86400', 13:34:32 INFO - 'USER': 'cltbld', 13:34:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982', 13:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:32 INFO - '_': '/tools/buildbot/bin/python'} 13:34:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:34:32 INFO - mozversion application_buildid: 20160602121839 13:34:32 INFO - mozversion application_changeset: 1914a4e74ae00436943a1c0dd4cae62bc23fab4a 13:34:32 INFO - mozversion application_display_name: Nightly 13:34:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:34:32 INFO - mozversion application_name: Firefox 13:34:32 INFO - mozversion application_remotingname: firefox 13:34:32 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:34:32 INFO - mozversion application_vendor: Mozilla 13:34:32 INFO - mozversion application_version: 49.0a1 13:34:32 INFO - mozversion platform_buildid: 20160602121839 13:34:32 INFO - mozversion platform_changeset: 1914a4e74ae00436943a1c0dd4cae62bc23fab4a 13:34:32 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:34:32 INFO - mozversion platform_version: 49.0a1 13:34:32 INFO - using testdate: 1464899672 13:34:32 INFO - actual date: 1464899672 13:34:32 INFO - starting webserver on 'localhost:36865' 13:34:32 INFO - SUITE-START | Running 2 tests 13:34:32 INFO - TEST-START | dromaeo_css 13:34:32 INFO - operating with platform_type : linux_ 13:34:32 INFO - Initialising browser for dromaeo_css test... 13:34:32 INFO - TEST-INFO | started process 31380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAd9qZX/profile http://localhost:36865/getInfo.html) 13:34:37 INFO - PROCESS | 31380 | __metrics Screen width/height:1600/1200 13:34:37 INFO - PROCESS | 31380 | colorDepth:24 13:34:37 INFO - PROCESS | 31380 | Browser inner width/height: 1024/697 13:34:37 INFO - PROCESS | 31380 | __metrics 13:34:38 ERROR - PROCESS | 31380 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:34:39 INFO - TEST-INFO | 31380: exit 0 13:34:39 INFO - Browser initialized. 13:34:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:34:39 INFO - TEST-INFO | started process 31459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAd9qZX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:51 INFO - PROCESS | 31459 | RSS: Main: 157433856 13:34:51 INFO - PROCESS | 31459 | 13:35:42 INFO - PROCESS | 31459 | 1464899742976 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:37:54 INFO - PROCESS | 31459 | Cycle 1(1): loaded http://localhost:36865/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36865/tests/dromaeo/cssquery-ext.html) 13:37:55 INFO - PROCESS | 31459 | RSS: Main: 238706688 13:37:55 INFO - PROCESS | 31459 | 13:40:58 INFO - PROCESS | 31459 | Cycle 1(1): loaded http://localhost:36865/tests/dromaeo/cssquery-ext.html (next: http://localhost:36865/tests/dromaeo/cssquery-jquery.html) 13:40:58 INFO - PROCESS | 31459 | RSS: Main: 239534080 13:40:58 INFO - PROCESS | 31459 | 13:44:01 INFO - PROCESS | 31459 | Cycle 1(1): loaded http://localhost:36865/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36865/tests/dromaeo/cssquery-mootools.html) 13:44:01 INFO - PROCESS | 31459 | RSS: Main: 252440576 13:44:01 INFO - PROCESS | 31459 | 13:47:03 INFO - PROCESS | 31459 | Cycle 1(1): loaded http://localhost:36865/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36865/tests/dromaeo/cssquery-prototype.html) 13:47:04 INFO - PROCESS | 31459 | RSS: Main: 238645248 13:47:04 INFO - PROCESS | 31459 | 13:50:07 INFO - PROCESS | 31459 | Cycle 1(1): loaded http://localhost:36865/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36865/tests/dromaeo/cssquery-yui.html) 13:50:08 INFO - PROCESS | 31459 | RSS: Main: 216346624 13:50:08 INFO - PROCESS | 31459 | 13:53:10 INFO - PROCESS | 31459 | Cycle 1(1): loaded http://localhost:36865/tests/dromaeo/cssquery-yui.html (next: http://localhost:36865/tests/dromaeo/cssquery-dojo.html) 13:53:11 INFO - PROCESS | 31459 | RSS: Main: 259260416 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | __start_tp_report 13:53:11 INFO - PROCESS | 31459 | _x_x_mozilla_page_load 13:53:11 INFO - PROCESS | 31459 | _x_x_mozilla_page_load_details 13:53:11 INFO - PROCESS | 31459 | |i|pagename|runs| 13:53:11 INFO - PROCESS | 31459 | |0;dojo.html;2681.0348274621133;2695.0971424572767;2721.1972468121908;2734.0567504211053;2752.779777617791;4652.139354219472;4703.15343238217;4738.336632871401;4778.904421911559;4820.614350851933;4648.372469716595;4685.390899183101;4705.623550115991;4755.595774359183;4772.475027746945;4327.935080973796;4367.803448844809;4424.2921132618785;4448.822047118111;4559.703619264754;4477.082198149388;4502.774861256924;4507.323901414781;4539.841105561306;4561.771911404433;4313.978430107861;4338.045629961403;4353.782310884443;4367.03925136471;4424.823007079713;4289.914201715979;4329.826806927751;4369.410129632491;4371.103923695667;4375.9562404375865;4383.232934236527;4391.736495810262;4393.428854248928;4396.472423309224;4430.867073987785;4569.6801223914335;4638.1883170445035;4719;4771.856844294677;4776.2119250324;5107.9744601277125;5215.530602245816;5221.399539052982;5222.8694282642855;5227.66020208689;5187.636865419422;5221.39953905302;5225.843224703227;5242.501962313574;5244;4677.2750223715375;4754.049190161982;4808.014357056795;4877.0489754497885;4883.731394773251;5275.894482110336;5278.973605132027;5312.628116031918;5325.254464374991;5339.706316152571;5060.165072763027;5102.642815002914;5106.872328191825;5108.897822043538;5112.207607820794;4959.181735013754;4987.62592805541;4991.201407774739;5001.19980803077;5206.349206349207;4968.701877887338;4976.477469865612;4988.975055124701;4990.550850423407;5035.949640503548;4964.67729597575;4971.080350135237;4971.45314015458;4977.527134922177;5017.272495488134;4077.286474866946;4098.303288440972;4101.036256479725;4145.91708165835;4151.833926642961;3650.123970247175;3671.4125739881492;3677.3564626190846;3686.3548878946076;3688.446732990073;4249.957500424956;4345.174416860787;4390.758508282075;4391.429114215131;4421.557844215553;5098.107831129538;5101.413337466239;5101.642884998015;5109.38687357512;5145;4461.620762235247;4463.062756821039;4468.17338792318;4500.684952053325;4513.684042117086;4386.890327741832;4433.357163211316;4447.844325448594;4473.865784026484;4534.206513860061;4769.8569042928075;4774.379330686988;4774.95225047745;4778.976105119452;4792.185328494234;5014.7994080236385;5050.419201791841;5058.924116138334;5059.999999999853;5061.924071138862;4717.764111794328;4754.168020596451;4774.641901857305;4777.0684716479955;4779.569838714532;5021.4225364083595;5031.823886163967;5037.874053148701;5044.218146187347;5091.261767043684;5106.336176297058;5107.10625640504;5107.131787596043;5122.308488354024;5145.536901678717;4814.5907597853175;4830.565249127595;4863.90272194547;4869.001854619865;4951.628627852853;4866.245731911559;4892.608591312615;4894.437139728977;4895.951040489549;4938.2098864183;4822.734749588806;4830.806767729251;4833.250846118857;4902.681325713817;4908.730019848943;4839.322494850794;4965.553100220997;5002.599792016557;5021.974890125526;5051;4925.975370123127;4932.901341973069;4945.6043516517875;4946.950530494649;4982.850514484571 13:53:11 INFO - PROCESS | 31459 | |1;ext.html;538.479227349379;586.1295975476417;590.2268028882168;590.3004939147108;596.1772753600033;26092.86953565232;27105.86447067767;27117.728822711768;27121.457570848597;40594.79702601483;39490.80254598723;40193.799031004804;40205.39691904624;40206.597934020654;40275;7830.491018083821;8010.799730006738;8014.238647328494;8015.238552337519;8015.879761803549;7809.804754881116;7940.642671079815;7955.005624296963;7962.920370796305;7966.800829979239;7965.8805117923275;8034.839303213932;8036.8392632147325;8039.799005024863;8039.919600803975;7940.166282540336;7995.800104997364;7997.120316765151;7998.960005199966;8001.639926203335;7701.537907725555;7766.378689704867;7776.416768742367;7889.644965976545;7901.446898717092;36445.63554364449;36829;36864.262714745826;36921.81539092314;36987.4451883222;3083.522054081621;3358.44585643371;3432.1419645088727;3477.1480987158056;3734.0851491384783;28884.33737335583;29476;29624.40751184986;29750;29844;3262.918427039343;3274.1978215337394;3280.6719328067243;3331.4336562784383;3361.865525378982;250933;251544.74227628927;251804;252228;252398;32494.350112997607;54235;54690.45309546933;54701.45298547043;54734.45265547373;34387.656123438945;34685.826570866986;34714;34727.652723472944;34729.82635086808;13288.136271142344;13383.732325353632;13433.596992090253;13444.395002224923;13449.932750336382;11004.22970392081;11030.558777648965;11099.389533575732;11120.555177792798;11125.109991200685;8000.279974802295;8032.196780321921;8064.879026814602;8099.757007289791;8129.75610731679;3099.2561785171397;3123.7969531980348;3135.5923729914966;3139.6703346148784;3161.2571045804216;885.6413152673177;897.9281657467387;1010.7725761703705;1028.7736697926443;1031.5770534080991;28204;28369.716302836707;28639.85680071628;28693.426131477252;28699.28251793722;786.70105359964;995.2436148527172;1008.1128606826093;1025.1132770153763;1047.5914393386586;14225;14917.850821491864;15019.849801502063;15173.165475898932;15281.770773438186;379482;380828;381709;382660;384676;46945.29582056272;47928.28107578389;48011.75994120007;48121.518784811706;48286.51713482891;1086.7011571817654;1132.3319241647469;1189.5420263198557;1200.0939290835363;1236.536298887917;27844.16467505978;29026;29116;29500.557491638072;29549.556756649097;43047;43386;43597.12805743931;43602.34596481119;43619;282200;285183;285260;285331;364718;25225;25770.613440798028;25956.22131336063;27171.72828271771;27182.320441989108;42198.15603687971;43287.783561082;43370.349444757725;43935.340969886114;43958.340624890014;35925;36154.63845361512;36723.44914826333;37127.81436092802;37219.25561488809;36538.39470561727;36544.81727591345;36629.63370366262;36962.44556331603;37453.81273093617;35859.82070089633;35936.4609530852;36592;36901.44647830338;36942.44586331261;31681.5247771279;33224.66775332216;33377.165570860925;33443.66556334405;33477;25045.24864254075;25584.36039098963;25730.614040789027;25814.354641134123;26013.869930650984 13:53:11 INFO - PROCESS | 31459 | |2;jquery.html;371.1093375897845;378.4984895014105;381.70417926107245;383.6987964447909;394.8716667083199;10717.142628589714;11267.774644507104;11270.380129092897;11287.15346349023;15410.61473463164;14479.13125212488;14757.704845903076;15127.77308340373;15154;15466;5572.665640061609;5656.377798442158;5835.241418615574;7031.894521582155;7033.8944915826305;6721.0926524919;6744.898826517606;6771.729130834785;6792.898106528406;6834.521583489158;6818.181818181825;6849.383555480006;6859.279775623562;6864.073350097748;6864.7940561783225;6148.200733904609;6478.676066196718;6494.675266236716;6664.766733164341;6872.381485666289;6132.233470816148;6414.839629009265;6418.06937993993;6615.933840661628;6644.302348253412;22117.115315387528;23072.76927230723;23457.88271058634;23471.295861124192;23556.528869422687;1836.2012524551862;1839.7516335294697;1862.5995410986702;1961.6861302191724;1974.0228586849457;13162.736745265041;13349.666258343523;14082.577522674335;14265.857341426661;14329.283535823168;1763.2594310389668;1843.1797849956774;1854.6290741851683;1904.2954106980367;1926.2006267399013;59673.40326596765;73498.26501734968;78620.60689696515;79218;81293.18706812915;14666.193714060284;16441.83558164427;16598.6680266394;16672;17009.574760630836;29101.272468188043;29151.416971660874;29360.85319573431;29435.264118396783;29494.705052949626;8493.447925884797;8994.775130621787;9012.233960113334;9108.954455227682;9153.588088536031;7400.48196626231;7402.962985185148;7432.9256707433315;7554.169041405441;7593.430492713069;8427;8631.180037896389;8633;8643.783905402415;8698.95650521756;3333.6999670029327;3388.881389151368;3421.3328400961573;3424.33225521021;3519.489673997256;365.02720250532565;370.6589937257729;371.33160311439303;833.7165363776345;886.7694399456187;10472.371657700562;10490.364719666972;10646.467676616137;10798.460076996118;10799.67600971972;393.472746519665;404.38533429188055;406.4249087541155;416.71038628153747;417.2843573271793;5530.474604912527;5728.312602487645;5731.914021289684;5732;5867.090600956859;376824;384169;385182;389944;391193;78052.60973695095;78149.60925195337;78417.60791196008;79384.60307698425;79793.20206797858;388.8716723481301;397.8846134620928;408.29568993486595;412.9256733787947;419.73556659304444;9845.120654884346;10147.594096236067;10432.895671043192;10499.160067194452;10614.469276535989;36116.304880366435;36410.27179456343;36451.635483645885;37264.25471490501;37591.81204093962;46156.30765538587;47249.527504724516;51549.7422512885;51946;52057.47942520678;7123.145222573325;7342.816429589303;7413.925860741324;7496.62516874165;7868.291853733192;8769.38614296993;10113.747156321151;10326.225533085199;10700.357978521313;10897.618583349546;8641.56792160402;8771.16673915977;8989.640414383352;9034.774130646787;9127.995920448613;8715.172058654418;9065.866766654168;9204.98745138021;9248.16766491019;9290.303227257848;9133.360664753403;9142.451452912846;9282.35023548345;9340.439573625332;9522.571484283086;7509.784613539128;7553.546787192786;7554.244575542401;7622.618869056414;7897.763067107996;8161.3062889652665;8691.304695624462;9111.954440227757;9150.993390727148;9232.030636783042 13:53:11 INFO - PROCESS | 31459 | |3;mootools.html;1176.8587769467665;1289.7033682253082;1373.4780783302344;1410.4922227997924;1709.811920688724;6252.437280644741;6882;7019.9821025951205;7043.401310888574;7175.748848790294;6952.965235173817;7084.433245340373;7091.042709234252;7091.539049961749;7126.96436517818;1777.075920521328;1835.1466568045855;1839.0804597701149;2055.14711394771;2086.551391450838;1878.9718154227699;2046.7134601155851;2093.288281984125;2098.244631932511;2115.428834214761;2065.5662310914727;2066.142550841399;2069.430906500717;2070.534129820786;2077.584483103378;1977.6044791041777;2015.5263513074415;2016.3144530859431;2017.4754563813367;2017.6267390532726;1966.016991504248;1969.202472998438;1971.310041485483;2015.889126098064;2017.6267390532798;7010.263922288188;7089.751858684973;7100.041494398293;7122.180949190858;7131.89302160468;4194.91610167798;4324.372965919955;4325.740455572675;4327.415798867176;4331.7617531035785;2752.628395166647;2840.701726318748;2890.8120972136953;2896.319364949235;2913.6066631004755;803.7468197517763;822.0078912757567;900.477722920711;919.9218066464358;951.3768481644533;9477.383970041925;9482.146606805421;9487.098725621056;9493.762655933588;10090.344127631754;4016.959830401717;4095.406166105898;4102.0360215349365;4106.322456794595;4107.9178416431505;8578.313734901192;8609.311255099577;8619.6983105591;8628.78428039304;8641.524716140673;4411.889702757457;4427.22523558376;4441.244988351923;4442.400275962768;4445.466544014675;3900.6932677553336;3919.8824035278985;3963.02905788078;4072.6538244248977;4110.506739191256;3539.592946811098;3582.946255806165;3596.6583174598372;3640.0535860676414;3677.485152078711;1124.7131981344705;1125.1280257800106;1134.143721490286;1136.6021892337615;1155.2433156282648;838.2832678060292;852.1606217875387;856.6316483911978;872.47651409154;878.3675753457501;4941.357623508921;5052.621053420935;5138.203578445347;5153.433122356538;5162.9483705162465;365.49379109932937;370.9146896213886;377.0987340256788;377.5582568394984;378.5419642232874;3493.703035242033;3505.1938054247157;3527.647235276503;3578.2664553766417;3579.427291633326;8913;9062.139096785795;9317.580708868118;9318.347715659975;9330.206932410685;9298.163165315018;9298.442093474277;9306.208972237435;9314.068593140768;9315.34792564514;6846.520743548003;6932.202796678446;6939.4795390346935;6943.270956549591;6944;4989.501049895127;4996.675216110941;5018.1469150245275;5073.365829271341;5181.948180518298;8539.701110461352;8556.486610803371;8585.828283434172;8590.269827064769;8590.398672092893;7723.420743444377;8382.455140415854;8606.311495080254;8621.439606425562;8864.911350886408;6111.297200821962;6284.968575157095;6308.179936608211;6483.513736469689;6488.9026664601015;6863.862722745617;6973.755918542826;7031.894521582078;7033.437325013884;7060.223375428802;6392.169018027626;6653.035309880137;6698.765543205965;6716.361945615159;6783.525153239423;6282;6332.556721029484;6344.68276586178;6352.205974253218;6449.774257900951;6108.541859360655;6114.6636934969;6158.353372895961;6182.443580077815;6220.284667263322;4429.180601588717;4442.555744425661;4497.482789479252;4520.389747384061;4615.861524154281;4332.891677708082;4421.2262854001065;4505.32420136969;4517.277235642281;4573.245414506569 13:53:11 INFO - PROCESS | 31459 | |4;prototype.html;279.3728080459369;289.9681035086141;298.98355590442515;299.0251779199808;301.3535965354316;4541.227991241489;4657.416478397344;4689.48415674276;4704.482506924235;4721.645876559259;4494.752788596634;4603.240465323218;4620.168369693454;4637.744924029177;4647.140279048378;3673.9242328084615;3682.8526858925743;3687.483752274684;3689.9631003690024;3698.611645777195;3489.5343955538733;3538.575370955489;3691.760035597691;3704.1480459494333;3723.3111874303204;3648.5885696873374;3658.689011434018;3670.3209906167313;3678.1907980244305;3680.1167719747336;3647.069997150736;3651.525301710787;3656.8171591420323;3658.8719394821055;3703;3271.443854544709;3273.541704161419;3276.2792185719104;3277.0987978305916;3302.85137168828;4299.226139294926;4502.459704835441;4506.301523263899;4513.458384993789;4558.814708175865;4087.5708050654553;4118.382242663594;4129.69027322952;4133.855315063988;4160.625543701081;4869.70781753096;4878.975225281504;4886.53577910098;4893.779779909913;4908.239222920453;3294.5717056782705;3488.8081155536433;3491.3765099228726;3502.614712381636;3505.8422370993367;5084.822031228926;5091.79632814687;5110.693358398471;5129.256257842592;5138.922916156261;3536.469529570585;3544.1494041430387;3546.556680414948;3547.4324108142573;3557.2351944332095;3580.4987301777774;3586.1751797086295;3602.2435288589168;3618.5115009473384;3619.7647152934974;3931.64615184629;4088.3254263046265;4098.897527561775;4112.568180341081;4124.979375103106;4611.515790841981;4820.4456487503685;4879.341288926021;4879.634027447955;4886.511348865156;1200.3218181727295;1231.987680123205;1234.8147777833397;1235.765204611121;1239.2812168942173;777.366446346226;787.8778789287669;796.3191471292077;798.2057852436747;808.8867558541809;3949.8025098744947;3973.980130099331;3981.9402708959387;3982.820773065219;3989.9027767364205;4465.732056076646;4479.260921947907;4490.236659767782;4506.571875671806;4516.570925762047;3925.980370098131;3940.645341919241;3958.7426817256787;3963.009247688078;3995.320795464778;2305.250793492122;2310.798384839874;2363.7045369328835;2392.4018995251186;2415.837825146484;4229.513605935295;4253.255680255943;4264.466941632296;4291.334843099325;4294.570542945743;4543.522930092358;4546.840860569864;4564.726116433025;4586.931196031996;4605.723656580616;4007.6192761687594;4257.297545904891;4281.97859010703;4293.355996600535;4327.740335579875;4452.532484089124;4463.709858859163;4471.859675782654;4472.888177795581;4485;4421.071574969293;4428.158649856517;4436.9334459983775;4441.555844415532;4445.37764712947;4065.531859648886;4287.614114729565;4291.914161716686;4319.460067491564;4323.394724738476;3287.967120328766;3288.769786114949;3307.5534802802276;3317.6516465770746;3318.651541588195;4416.84541041062;4480.596746292849;4515.706479078849;4516.638668906414;4831.565159135695;4721.457032441176;4901.191303434894;4902.852914412573;4903.289023091703;4914.950850491592;4846.903061938671;4868.245421959602;4883.755812209446;4900.779464924016;4916.074935413423;4573.016801387717;4784.976075119602;4791.688540244873;4798.880027999328;4819.277108433763;4920.630952678635;4932.975335123301;4949.995251922977;4952.7771250294545;4954.1825598775795;4795.304680821192;4820.783064762024;4833.613310935047;4850.393700787402;4859.635527335535 13:53:11 INFO - PROCESS | 31459 | |5;yui.html;622.4802290087777;678.0913575808415;681.3152781454635;717.6499198475367;745.3031415626391;12300.876991230096;12849.164804287715;14309.141451512904;14829.851701482981;14864.702705945874;14783.039102458359;14853.628659283524;14950.626234344147;15008.849911500882;15016.17411042395;608.8782243551285;762.2948772385549;765.0971853213206;770.414484991405;789.4631650477687;777.7316825695154;778.9844203115935;781.269513005339;781.7303030454484;782.0654318089885;838.828040251747;839.1692224697535;840.0885039731868;840.2857571064577;840.6595328891779;641.522066060783;799.2886331165209;801.2508304735062;802.9518228906285;828.4780588229437;605.1799811255729;605.2132228103447;605.5549171359047;605.8424809549505;605.9939400605981;12665.113442059059;12716.745665086646;12730.618081457478;12742.745145097138;12764.106512544126;11333.376664283462;11688.415579221006;11698.356590387526;11740.354280514568;12154.027677785756;11624.6512604622;11639.06887449002;11716.121290903131;11746.177767556275;11874.821877671842;3910.1397692507603;3948.7038472114705;4060.6751459883435;4065.308897487434;4067.2068946555432;44165;44621.10757784826;44682;44696.55303446989;50081.74959125218;10038.64864729731;10044.899551004542;10087.142592879542;10347.534360953776;10505.789884202426;17591.29634814619;17766.733498997524;17767;17803.19885605151;17821.465356039338;6702.128723266042;6767.35710107539;6825.726970921108;6903.861922761516;6990.510664253555;3769.095417099876;3841.078141246081;3844.596317386634;3855.383138697851;3878.9030274242805;2770.5844123381653;2868.5983962244886;2870.2537340291674;2870.3254735137225;2870.7416332530174;429.9462567179103;472.0723777776685;487.8097541958639;497.6267799150637;497.63423883445637;596.9582129250911;609.1330271133611;650.9446697030711;660.7819419591523;685.8285428642839;8745.823567545927;8968.327375446868;9115.270778337717;9193.218576421079;9211.980053151798;602.2231321595181;643.9098526206335;644.687326646576;657.7434800427837;666.9366410191024;3934.2131573684806;3968.3253846846105;3992.401139828991;4020.592792522652;4021.8391264349684;90234.09765902389;100341;101626;101947;104397;65184.67407663026;69570;75414.49171016549;79841.20158798338;86707;65812.67093664501;68890.31109688939;70904.2909570908;72207.63896180486;72261.6386918062;9020.278377729635;9031.63873445055;9041.68354107603;9075.54622268897;9179.954100229455;31353.8432307837;33452.832735836164;43071.56928430801;43732.78133609312;44103.33844992264;58110;60037.699811500665;60723.392766071775;60740;61174.69412652908;11356.04209266384;11428.371439570903;11521.884781152416;11544.88455115438;11575.88424115748;11697.23967942081;11922.4038798058;12467.812982805446;12768.553100641433;13547.458101676217;11778.76442471163;11870.228435151688;12086.274823510617;12198.939005304917;12243.142979991315;11480.081593472669;11613;11656.766864662828;11777.175597708421;11926.463309151282;11617.709557261136;12166.452509637265;12223.93888030554;12572.622821315375;12602.49590016389;9436.150746432853;9590.904090959;9825.606975721177;9829.115379615869;10097.747556311151;8830.735077947671;8948.821023579621;9113.726588202364;9386.577604007973;9569.3779904306 13:53:11 INFO - PROCESS | 31459 | __end_tp_report 13:53:11 INFO - PROCESS | 31459 | __start_cc_report 13:53:11 INFO - PROCESS | 31459 | _x_x_mozilla_cycle_collect,1075 13:53:11 INFO - PROCESS | 31459 | __end_cc_report 13:53:11 INFO - PROCESS | 31459 | __startTimestamp1464900791026__endTimestamp 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | ------- Summary: start ------- 13:53:11 INFO - PROCESS | 31459 | Number of tests: 6 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | [#0] dojo.html Cycles:165 Average:4698.10 Median:4814.59 stddev:500.23 (10.4%) stddev-sans-first:476.08 13:53:11 INFO - PROCESS | 31459 | Values: 2681.0 2695.1 2721.2 2734.1 2752.8 4652.1 4703.2 4738.3 4778.9 4820.6 4648.4 4685.4 4705.6 4755.6 4772.5 4327.9 4367.8 4424.3 4448.8 4559.7 4477.1 4502.8 4507.3 4539.8 4561.8 4314.0 4338.0 4353.8 4367.0 4424.8 4289.9 4329.8 4369.4 4371.1 4376.0 4383.2 4391.7 4393.4 4396.5 4430.9 4569.7 4638.2 4719.0 4771.9 4776.2 5108.0 5215.5 5221.4 5222.9 5227.7 5187.6 5221.4 5225.8 5242.5 5244.0 4677.3 4754.0 4808.0 4877.0 4883.7 5275.9 5279.0 5312.6 5325.3 5339.7 5060.2 5102.6 5106.9 5108.9 5112.2 4959.2 4987.6 4991.2 5001.2 5206.3 4968.7 4976.5 4989.0 4990.6 5035.9 4964.7 4971.1 4971.5 4977.5 5017.3 4077.3 4098.3 4101.0 4145.9 4151.8 3650.1 3671.4 3677.4 3686.4 3688.4 4250.0 4345.2 4390.8 4391.4 4421.6 5098.1 5101.4 5101.6 5109.4 5145.0 4461.6 4463.1 4468.2 4500.7 4513.7 4386.9 4433.4 4447.8 4473.9 4534.2 4769.9 4774.4 4775.0 4779.0 4792.2 5014.8 5050.4 5058.9 5060.0 5061.9 4717.8 4754.2 4774.6 4777.1 4779.6 5021.4 5031.8 5037.9 5044.2 5091.3 5106.3 5107.1 5107.1 5122.3 5145.5 4814.6 4830.6 4863.9 4869.0 4951.6 4866.2 4892.6 4894.4 4896.0 4938.2 4822.7 4830.8 4833.3 4902.7 4908.7 4839.3 4965.6 5002.6 5022.0 5051.0 4926.0 4932.9 4945.6 4947.0 4982.9 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | [#1] ext.html Cycles:180 Average:45632.70 Median:35930.73 stddev:83443.69 (232.2%) stddev-sans-first:83609.08 13:53:11 INFO - PROCESS | 31459 | Values: 538.5 586.1 590.2 590.3 596.2 26092.9 27105.9 27117.7 27121.5 40594.8 39490.8 40193.8 40205.4 40206.6 40275.0 7830.5 8010.8 8014.2 8015.2 8015.9 7809.8 7940.6 7955.0 7962.9 7966.8 7965.9 8034.8 8036.8 8039.8 8039.9 7940.2 7995.8 7997.1 7999.0 8001.6 7701.5 7766.4 7776.4 7889.6 7901.4 36445.6 36829.0 36864.3 36921.8 36987.4 3083.5 3358.4 3432.1 3477.1 3734.1 28884.3 29476.0 29624.4 29750.0 29844.0 3262.9 3274.2 3280.7 3331.4 3361.9 250933.0 251544.7 251804.0 252228.0 252398.0 32494.4 54235.0 54690.5 54701.5 54734.5 34387.7 34685.8 34714.0 34727.7 34729.8 13288.1 13383.7 13433.6 13444.4 13449.9 11004.2 11030.6 11099.4 11120.6 11125.1 8000.3 8032.2 8064.9 8099.8 8129.8 3099.3 3123.8 3135.6 3139.7 3161.3 885.6 897.9 1010.8 1028.8 1031.6 28204.0 28369.7 28639.9 28693.4 28699.3 786.7 995.2 1008.1 1025.1 1047.6 14225.0 14917.9 15019.8 15173.2 15281.8 379482.0 380828.0 381709.0 382660.0 384676.0 46945.3 47928.3 48011.8 48121.5 48286.5 1086.7 1132.3 1189.5 1200.1 1236.5 27844.2 29026.0 29116.0 29500.6 29549.6 43047.0 43386.0 43597.1 43602.3 43619.0 282200.0 285183.0 285260.0 285331.0 364718.0 25225.0 25770.6 25956.2 27171.7 27182.3 42198.2 43287.8 43370.3 43935.3 43958.3 35925.0 36154.6 36723.4 37127.8 37219.3 36538.4 36544.8 36629.6 36962.4 37453.8 35859.8 35936.5 36592.0 36901.4 36942.4 31681.5 33224.7 33377.2 33443.7 33477.0 25045.2 25584.4 25730.6 25814.4 26013.9 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | [#2] jquery.html Cycles:180 Average:24712.77 Median:28793.98 stddev:63802.97 (221.6%) stddev-sans-first:63955.77 13:53:11 INFO - PROCESS | 31459 | Values: 371.1 378.5 381.7 383.7 394.9 10717.1 11267.8 11270.4 11287.2 15410.6 14479.1 14757.7 15127.8 15154.0 15466.0 5572.7 5656.4 5835.2 7031.9 7033.9 6721.1 6744.9 6771.7 6792.9 6834.5 6818.2 6849.4 6859.3 6864.1 6864.8 6148.2 6478.7 6494.7 6664.8 6872.4 6132.2 6414.8 6418.1 6615.9 6644.3 22117.1 23072.8 23457.9 23471.3 23556.5 1836.2 1839.8 1862.6 1961.7 1974.0 13162.7 13349.7 14082.6 14265.9 14329.3 1763.3 1843.2 1854.6 1904.3 1926.2 59673.4 73498.3 78620.6 79218.0 81293.2 14666.2 16441.8 16598.7 16672.0 17009.6 29101.3 29151.4 29360.9 29435.3 29494.7 8493.4 8994.8 9012.2 9109.0 9153.6 7400.5 7403.0 7432.9 7554.2 7593.4 8427.0 8631.2 8633.0 8643.8 8699.0 3333.7 3388.9 3421.3 3424.3 3519.5 365.0 370.7 371.3 833.7 886.8 10472.4 10490.4 10646.5 10798.5 10799.7 393.5 404.4 406.4 416.7 417.3 5530.5 5728.3 5731.9 5732.0 5867.1 376824.0 384169.0 385182.0 389944.0 391193.0 78052.6 78149.6 78417.6 79384.6 79793.2 388.9 397.9 408.3 412.9 419.7 9845.1 10147.6 10432.9 10499.2 10614.5 36116.3 36410.3 36451.6 37264.3 37591.8 46156.3 47249.5 51549.7 51946.0 52057.5 7123.1 7342.8 7413.9 7496.6 7868.3 8769.4 10113.7 10326.2 10700.4 10897.6 8641.6 8771.2 8989.6 9034.8 9128.0 8715.2 9065.9 9205.0 9248.2 9290.3 9133.4 9142.5 9282.4 9340.4 9522.6 7509.8 7553.5 7554.2 7622.6 7897.8 8161.3 8691.3 9112.0 9151.0 9232.0 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | [#3] mootools.html Cycles:180 Average:4854.78 Median:5062.99 stddev:2707.19 (53.5%) stddev-sans-first:2700.67 13:53:11 INFO - PROCESS | 31459 | Values: 1176.9 1289.7 1373.5 1410.5 1709.8 6252.4 6882.0 7020.0 7043.4 7175.7 6953.0 7084.4 7091.0 7091.5 7127.0 1777.1 1835.1 1839.1 2055.1 2086.6 1879.0 2046.7 2093.3 2098.2 2115.4 2065.6 2066.1 2069.4 2070.5 2077.6 1977.6 2015.5 2016.3 2017.5 2017.6 1966.0 1969.2 1971.3 2015.9 2017.6 7010.3 7089.8 7100.0 7122.2 7131.9 4194.9 4324.4 4325.7 4327.4 4331.8 2752.6 2840.7 2890.8 2896.3 2913.6 803.7 822.0 900.5 919.9 951.4 9477.4 9482.1 9487.1 9493.8 10090.3 4017.0 4095.4 4102.0 4106.3 4107.9 8578.3 8609.3 8619.7 8628.8 8641.5 4411.9 4427.2 4441.2 4442.4 4445.5 3900.7 3919.9 3963.0 4072.7 4110.5 3539.6 3582.9 3596.7 3640.1 3677.5 1124.7 1125.1 1134.1 1136.6 1155.2 838.3 852.2 856.6 872.5 878.4 4941.4 5052.6 5138.2 5153.4 5162.9 365.5 370.9 377.1 377.6 378.5 3493.7 3505.2 3527.6 3578.3 3579.4 8913.0 9062.1 9317.6 9318.3 9330.2 9298.2 9298.4 9306.2 9314.1 9315.3 6846.5 6932.2 6939.5 6943.3 6944.0 4989.5 4996.7 5018.1 5073.4 5181.9 8539.7 8556.5 8585.8 8590.3 8590.4 7723.4 8382.5 8606.3 8621.4 8864.9 6111.3 6285.0 6308.2 6483.5 6488.9 6863.9 6973.8 7031.9 7033.4 7060.2 6392.2 6653.0 6698.8 6716.4 6783.5 6282.0 6332.6 6344.7 6352.2 6449.8 6108.5 6114.7 6158.4 6182.4 6220.3 4429.2 4442.6 4497.5 4520.4 4615.9 4332.9 4421.2 4505.3 4517.3 4573.2 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | [#4] prototype.html Cycles:180 Average:3909.64 Median:4293.96 stddev:1123.99 (26.2%) stddev-sans-first:1093.62 13:53:11 INFO - PROCESS | 31459 | Values: 279.4 290.0 299.0 299.0 301.4 4541.2 4657.4 4689.5 4704.5 4721.6 4494.8 4603.2 4620.2 4637.7 4647.1 3673.9 3682.9 3687.5 3690.0 3698.6 3489.5 3538.6 3691.8 3704.1 3723.3 3648.6 3658.7 3670.3 3678.2 3680.1 3647.1 3651.5 3656.8 3658.9 3703.0 3271.4 3273.5 3276.3 3277.1 3302.9 4299.2 4502.5 4506.3 4513.5 4558.8 4087.6 4118.4 4129.7 4133.9 4160.6 4869.7 4879.0 4886.5 4893.8 4908.2 3294.6 3488.8 3491.4 3502.6 3505.8 5084.8 5091.8 5110.7 5129.3 5138.9 3536.5 3544.1 3546.6 3547.4 3557.2 3580.5 3586.2 3602.2 3618.5 3619.8 3931.6 4088.3 4098.9 4112.6 4125.0 4611.5 4820.4 4879.3 4879.6 4886.5 1200.3 1232.0 1234.8 1235.8 1239.3 777.4 787.9 796.3 798.2 808.9 3949.8 3974.0 3981.9 3982.8 3989.9 4465.7 4479.3 4490.2 4506.6 4516.6 3926.0 3940.6 3958.7 3963.0 3995.3 2305.3 2310.8 2363.7 2392.4 2415.8 4229.5 4253.3 4264.5 4291.3 4294.6 4543.5 4546.8 4564.7 4586.9 4605.7 4007.6 4257.3 4282.0 4293.4 4327.7 4452.5 4463.7 4471.9 4472.9 4485.0 4421.1 4428.2 4436.9 4441.6 4445.4 4065.5 4287.6 4291.9 4319.5 4323.4 3288.0 3288.8 3307.6 3317.7 3318.7 4416.8 4480.6 4515.7 4516.6 4831.6 4721.5 4901.2 4902.9 4903.3 4915.0 4846.9 4868.2 4883.8 4900.8 4916.1 4573.0 4785.0 4791.7 4798.9 4819.3 4920.6 4933.0 4950.0 4952.8 4954.2 4795.3 4820.8 4833.6 4850.4 4859.6 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - PROCESS | 31459 | [#5] yui.html Cycles:180 Average:16877.13 Median:44134.17 stddev:23674.84 (53.6%) stddev-sans-first:23709.79 13:53:11 INFO - PROCESS | 31459 | Values: 622.5 678.1 681.3 717.6 745.3 12300.9 12849.2 14309.1 14829.9 14864.7 14783.0 14853.6 14950.6 15008.8 15016.2 608.9 762.3 765.1 770.4 789.5 777.7 779.0 781.3 781.7 782.1 838.8 839.2 840.1 840.3 840.7 641.5 799.3 801.3 803.0 828.5 605.2 605.2 605.6 605.8 606.0 12665.1 12716.7 12730.6 12742.7 12764.1 11333.4 11688.4 11698.4 11740.4 12154.0 11624.7 11639.1 11716.1 11746.2 11874.8 3910.1 3948.7 4060.7 4065.3 4067.2 44165.0 44621.1 44682.0 44696.6 50081.7 10038.6 10044.9 10087.1 10347.5 10505.8 17591.3 17766.7 17767.0 17803.2 17821.5 6702.1 6767.4 6825.7 6903.9 6990.5 3769.1 3841.1 3844.6 3855.4 3878.9 2770.6 2868.6 2870.3 2870.3 2870.7 429.9 472.1 487.8 497.6 497.6 597.0 609.1 650.9 660.8 685.8 8745.8 8968.3 9115.3 9193.2 9212.0 602.2 643.9 644.7 657.7 666.9 3934.2 3968.3 3992.4 4020.6 4021.8 90234.1 100341.0 101626.0 101947.0 104397.0 65184.7 69570.0 75414.5 79841.2 86707.0 65812.7 68890.3 70904.3 72207.6 72261.6 9020.3 9031.6 9041.7 9075.5 9180.0 31353.8 33452.8 43071.6 43732.8 44103.3 58110.0 60037.7 60723.4 60740.0 61174.7 11356.0 11428.4 11521.9 11544.9 11575.9 11697.2 11922.4 12467.8 12768.6 13547.5 11778.8 11870.2 12086.3 12198.9 12243.1 11480.1 11613.0 11656.8 11777.2 11926.5 11617.7 12166.5 12223.9 12572.6 12602.5 9436.2 9590.9 9825.6 9829.1 10097.7 8830.7 8948.8 9113.7 9386.6 9569.4 13:53:11 INFO - PROCESS | 31459 | -------- Summary: end -------- 13:53:11 INFO - PROCESS | 31459 | 13:53:11 INFO - TEST-INFO | 31459: exit 0 13:53:11 INFO - TEST-OK | dromaeo_css | took 1119139ms 13:53:11 INFO - TEST-START | kraken 13:53:11 INFO - operating with platform_type : linux_ 13:53:11 INFO - Initialising browser for kraken test... 13:53:11 INFO - TEST-INFO | started process 31641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9H_X2/profile http://localhost:36865/getInfo.html) 13:53:16 INFO - PROCESS | 31641 | __metrics Screen width/height:1600/1200 13:53:16 INFO - PROCESS | 31641 | colorDepth:24 13:53:16 INFO - PROCESS | 31641 | Browser inner width/height: 1024/697 13:53:16 INFO - PROCESS | 31641 | __metrics 13:53:17 ERROR - PROCESS | 31641 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:53:18 INFO - TEST-INFO | 31641: exit 0 13:53:18 INFO - Browser initialized. 13:53:18 INFO - Running cycle 1/1 for kraken test... 13:53:18 INFO - TEST-INFO | started process 31721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9H_X2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:30 INFO - PROCESS | 31721 | RSS: Main: 158515200 13:53:30 INFO - PROCESS | 31721 | 13:53:32 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36865/tests/kraken/driver.html?testName=audio-beat-detection) 13:53:33 INFO - PROCESS | 31721 | RSS: Main: 215674880 13:53:33 INFO - PROCESS | 31721 | 13:53:36 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36865/tests/kraken/driver.html?testName=audio-dft) 13:53:37 INFO - PROCESS | 31721 | RSS: Main: 205029376 13:53:37 INFO - PROCESS | 31721 | 13:53:40 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36865/tests/kraken/driver.html?testName=audio-fft) 13:53:41 INFO - PROCESS | 31721 | RSS: Main: 270786560 13:53:41 INFO - PROCESS | 31721 | 13:53:43 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36865/tests/kraken/driver.html?testName=audio-oscillator) 13:53:43 INFO - PROCESS | 31721 | RSS: Main: 181252096 13:53:43 INFO - PROCESS | 31721 | 13:53:46 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36865/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:53:46 INFO - PROCESS | 31721 | RSS: Main: 184557568 13:53:46 INFO - PROCESS | 31721 | 13:53:49 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36865/tests/kraken/driver.html?testName=imaging-darkroom) 13:53:50 INFO - PROCESS | 31721 | RSS: Main: 221122560 13:53:50 INFO - PROCESS | 31721 | 13:53:54 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36865/tests/kraken/driver.html?testName=imaging-desaturate) 13:53:54 INFO - PROCESS | 31721 | RSS: Main: 217214976 13:53:54 INFO - PROCESS | 31721 | 13:53:57 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36865/tests/kraken/driver.html?testName=json-parse-financial) 13:53:58 INFO - PROCESS | 31721 | RSS: Main: 220041216 13:53:58 INFO - PROCESS | 31721 | 13:53:59 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36865/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:54:00 INFO - PROCESS | 31721 | RSS: Main: 205725696 13:54:00 INFO - PROCESS | 31721 | 13:54:02 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:54:02 INFO - PROCESS | 31721 | RSS: Main: 211722240 13:54:02 INFO - PROCESS | 31721 | 13:54:05 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:54:05 INFO - PROCESS | 31721 | RSS: Main: 218017792 13:54:05 INFO - PROCESS | 31721 | 13:54:08 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:54:09 INFO - PROCESS | 31721 | RSS: Main: 224321536 13:54:09 INFO - PROCESS | 31721 | 13:54:12 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:54:12 INFO - PROCESS | 31721 | RSS: Main: 225341440 13:54:12 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | Cycle 1(1): loaded http://localhost:36865/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36865/tests/kraken/driver.html?testName=ai-astar) 13:54:14 INFO - PROCESS | 31721 | RSS: Main: 267997184 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | __start_tp_report 13:54:14 INFO - PROCESS | 31721 | _x_x_mozilla_page_load 13:54:14 INFO - PROCESS | 31721 | _x_x_mozilla_page_load_details 13:54:14 INFO - PROCESS | 31721 | |i|pagename|runs| 13:54:14 INFO - PROCESS | 31721 | |0;ai-astar;114;110;113;116;113;115;115;113;113;112 13:54:14 INFO - PROCESS | 31721 | |1;audio-beat-detection;158;140;141;177;138;155;158;142;201;130 13:54:14 INFO - PROCESS | 31721 | |2;audio-dft;161;160;161;161;163;161;161;162;163;160 13:54:14 INFO - PROCESS | 31721 | |3;audio-fft;75;74;75;104;75;78;75;74;98;75 13:54:14 INFO - PROCESS | 31721 | |4;audio-oscillator;84;85;114;84;85;84;117;85;85;132 13:54:14 INFO - PROCESS | 31721 | |5;imaging-gaussian-blur;116;118;117;117;117;117;117;117;117;116 13:54:14 INFO - PROCESS | 31721 | |6;imaging-darkroom;147;147;147;146;146;147;147;146;147;147 13:54:14 INFO - PROCESS | 31721 | |7;imaging-desaturate;95;96;96;94;95;95;94;95;95;94 13:54:14 INFO - PROCESS | 31721 | |8;json-parse-financial;74;64;64;65;65;64;64;64;62;64 13:54:14 INFO - PROCESS | 31721 | |9;json-stringify-tinderbox;66;65;65;64;65;65;64;65;65;66 13:54:14 INFO - PROCESS | 31721 | |10;stanford-crypto-aes;84;85;83;83;86;84;84;85;115;84 13:54:14 INFO - PROCESS | 31721 | |11;stanford-crypto-ccm;137;131;131;128;130;133;134;141;147;133 13:54:14 INFO - PROCESS | 31721 | |12;stanford-crypto-pbkdf2;171;172;177;168;175;168;169;169;167;177 13:54:14 INFO - PROCESS | 31721 | |13;stanford-crypto-sha256-iterative;67;68;66;66;67;66;67;67;66;65 13:54:14 INFO - PROCESS | 31721 | __end_tp_report 13:54:14 INFO - PROCESS | 31721 | __start_cc_report 13:54:14 INFO - PROCESS | 31721 | _x_x_mozilla_cycle_collect,1914 13:54:14 INFO - PROCESS | 31721 | __end_cc_report 13:54:14 INFO - PROCESS | 31721 | __startTimestamp1464900854712__endTimestamp 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | ------- Summary: start ------- 13:54:14 INFO - PROCESS | 31721 | Number of tests: 14 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:1.71 (1.5%) stddev-sans-first:1.80 13:54:14 INFO - PROCESS | 31721 | Values: 114.0 110.0 113.0 116.0 113.0 115.0 115.0 113.0 113.0 112.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:156.50 stddev:21.37 (13.7%) stddev-sans-first:22.62 13:54:14 INFO - PROCESS | 31721 | Values: 158.0 140.0 141.0 177.0 138.0 155.0 158.0 142.0 201.0 130.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 13:54:14 INFO - PROCESS | 31721 | Values: 161.0 160.0 161.0 161.0 163.0 161.0 161.0 162.0 163.0 160.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.06 (14.7%) stddev-sans-first:11.56 13:54:14 INFO - PROCESS | 31721 | Values: 75.0 74.0 75.0 104.0 75.0 78.0 75.0 74.0 98.0 75.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.50 stddev:18.18 (21.5%) stddev-sans-first:18.80 13:54:14 INFO - PROCESS | 31721 | Values: 84.0 85.0 114.0 84.0 85.0 84.0 117.0 85.0 85.0 132.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:54:14 INFO - PROCESS | 31721 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:54:14 INFO - PROCESS | 31721 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 13:54:14 INFO - PROCESS | 31721 | Values: 95.0 96.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:3.27 (5.1%) stddev-sans-first:0.87 13:54:14 INFO - PROCESS | 31721 | Values: 74.0 64.0 64.0 65.0 65.0 64.0 64.0 64.0 62.0 64.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 13:54:14 INFO - PROCESS | 31721 | Values: 66.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 66.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.00 stddev:9.78 (11.6%) stddev-sans-first:10.30 13:54:14 INFO - PROCESS | 31721 | Values: 84.0 85.0 83.0 83.0 86.0 84.0 84.0 85.0 115.0 84.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:133.50 stddev:5.74 (4.3%) stddev-sans-first:6.02 13:54:14 INFO - PROCESS | 31721 | Values: 137.0 131.0 131.0 128.0 130.0 133.0 134.0 141.0 147.0 133.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:3.80 (2.2%) stddev-sans-first:4.03 13:54:14 INFO - PROCESS | 31721 | Values: 171.0 172.0 177.0 168.0 175.0 168.0 169.0 169.0 167.0 177.0 13:54:14 INFO - PROCESS | 31721 | 13:54:14 INFO - PROCESS | 31721 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 13:54:14 INFO - PROCESS | 31721 | Values: 67.0 68.0 66.0 66.0 67.0 66.0 67.0 67.0 66.0 65.0 13:54:14 INFO - PROCESS | 31721 | -------- Summary: end -------- 13:54:14 INFO - PROCESS | 31721 | 13:54:15 INFO - TEST-INFO | 31721: exit 0 13:54:15 INFO - TEST-OK | kraken | took 63971ms 13:54:15 INFO - SUITE-END | took 1183s 13:54:15 INFO - Completed test suite (00:19:43) 13:54:15 INFO - javascript benchmark 13:54:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.0348274621133, 2695.0971424572767, 2721.1972468121908, 2734.0567504211053, 2752.779777617791, 4652.139354219472, 4703.15343238217, 4738.336632871401, 4778.904421911559, 4820.614350851933, 4648.372469716595, 4685.390899183101, 4705.623550115991, 4755.595774359183, 4772.475027746945, 4327.935080973796, 4367.803448844809, 4424.2921132618785, 4448.822047118111, 4559.703619264754, 4477.082198149388, 4502.774861256924, 4507.323901414781, 4539.841105561306, 4561.771911404433, 4313.978430107861, 4338.045629961403, 4353.782310884443, 4367.03925136471, 4424.823007079713, 4289.914201715979, 4329.826806927751, 4369.410129632491, 4371.103923695667, 4375.9562404375865, 4383.232934236527, 4391.736495810262, 4393.428854248928, 4396.472423309224, 4430.867073987785, 4569.6801223914335, 4638.1883170445035, 4719.0, 4771.856844294677, 4776.2119250324, 5107.9744601277125, 5215.530602245816, 5221.399539052982, 5222.8694282642855, 5227.66020208689, 5187.636865419422, 5221.39953905302, 5225.843224703227, 5242.501962313574, 5244.0, 4677.2750223715375, 4754.049190161982, 4808.014357056795, 4877.0489754497885, 4883.731394773251, 5275.894482110336, 5278.973605132027, 5312.628116031918, 5325.254464374991, 5339.706316152571, 5060.165072763027, 5102.642815002914, 5106.872328191825, 5108.897822043538, 5112.207607820794, 4959.181735013754, 4987.62592805541, 4991.201407774739, 5001.19980803077, 5206.349206349207, 4968.701877887338, 4976.477469865612, 4988.975055124701, 4990.550850423407, 5035.949640503548, 4964.67729597575, 4971.080350135237, 4971.45314015458, 4977.527134922177, 5017.272495488134, 4077.286474866946, 4098.303288440972, 4101.036256479725, 4145.91708165835, 4151.833926642961, 3650.123970247175, 3671.4125739881492, 3677.3564626190846, 3686.3548878946076, 3688.446732990073, 4249.957500424956, 4345.174416860787, 4390.758508282075, 4391.429114215131, 4421.557844215553, 5098.107831129538, 5101.413337466239, 5101.642884998015, 5109.38687357512, 5145.0, 4461.620762235247, 4463.062756821039, 4468.17338792318, 4500.684952053325, 4513.684042117086, 4386.890327741832, 4433.357163211316, 4447.844325448594, 4473.865784026484, 4534.206513860061, 4769.8569042928075, 4774.379330686988, 4774.95225047745, 4778.976105119452, 4792.185328494234, 5014.7994080236385, 5050.419201791841, 5058.924116138334, 5059.999999999853, 5061.924071138862, 4717.764111794328, 4754.168020596451, 4774.641901857305, 4777.0684716479955, 4779.569838714532, 5021.4225364083595, 5031.823886163967, 5037.874053148701, 5044.218146187347, 5091.261767043684, 5106.336176297058, 5107.10625640504, 5107.131787596043, 5122.308488354024, 5145.536901678717, 4814.5907597853175, 4830.565249127595, 4863.90272194547, 4869.001854619865, 4951.628627852853, 4866.245731911559, 4892.608591312615, 4894.437139728977, 4895.951040489549, 4938.2098864183, 4822.734749588806, 4830.806767729251, 4833.250846118857, 4902.681325713817, 4908.730019848943, 4839.322494850794, 4965.553100220997, 5002.599792016557, 5021.974890125526, 5051.0, 4925.975370123127, 4932.901341973069, 4945.6043516517875, 4946.950530494649, 4982.850514484571], "value": 4666.275819013765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.479227349379, 586.1295975476417, 590.2268028882168, 590.3004939147108, 596.1772753600033, 26092.86953565232, 27105.86447067767, 27117.728822711768, 27121.457570848597, 40594.79702601483, 39490.80254598723, 40193.799031004804, 40205.39691904624, 40206.597934020654, 40275.0, 7830.491018083821, 8010.799730006738, 8014.238647328494, 8015.238552337519, 8015.879761803549, 7809.804754881116, 7940.642671079815, 7955.005624296963, 7962.920370796305, 7966.800829979239, 7965.8805117923275, 8034.839303213932, 8036.8392632147325, 8039.799005024863, 8039.919600803975, 7940.166282540336, 7995.800104997364, 7997.120316765151, 7998.960005199966, 8001.639926203335, 7701.537907725555, 7766.378689704867, 7776.416768742367, 7889.644965976545, 7901.446898717092, 36445.63554364449, 36829.0, 36864.262714745826, 36921.81539092314, 36987.4451883222, 3083.522054081621, 3358.44585643371, 3432.1419645088727, 3477.1480987158056, 3734.0851491384783, 28884.33737335583, 29476.0, 29624.40751184986, 29750.0, 29844.0, 3262.918427039343, 3274.1978215337394, 3280.6719328067243, 3331.4336562784383, 3361.865525378982, 250933.0, 251544.74227628927, 251804.0, 252228.0, 252398.0, 32494.350112997607, 54235.0, 54690.45309546933, 54701.45298547043, 54734.45265547373, 34387.656123438945, 34685.826570866986, 34714.0, 34727.652723472944, 34729.82635086808, 13288.136271142344, 13383.732325353632, 13433.596992090253, 13444.395002224923, 13449.932750336382, 11004.22970392081, 11030.558777648965, 11099.389533575732, 11120.555177792798, 11125.109991200685, 8000.279974802295, 8032.196780321921, 8064.879026814602, 8099.757007289791, 8129.75610731679, 3099.2561785171397, 3123.7969531980348, 3135.5923729914966, 3139.6703346148784, 3161.2571045804216, 885.6413152673177, 897.9281657467387, 1010.7725761703705, 1028.7736697926443, 1031.5770534080991, 28204.0, 28369.716302836707, 28639.85680071628, 28693.426131477252, 28699.28251793722, 786.70105359964, 995.2436148527172, 1008.1128606826093, 1025.1132770153763, 1047.5914393386586, 14225.0, 14917.850821491864, 15019.849801502063, 15173.165475898932, 15281.770773438186, 379482.0, 380828.0, 381709.0, 382660.0, 384676.0, 46945.29582056272, 47928.28107578389, 48011.75994120007, 48121.518784811706, 48286.51713482891, 1086.7011571817654, 1132.3319241647469, 1189.5420263198557, 1200.0939290835363, 1236.536298887917, 27844.16467505978, 29026.0, 29116.0, 29500.557491638072, 29549.556756649097, 43047.0, 43386.0, 43597.12805743931, 43602.34596481119, 43619.0, 282200.0, 285183.0, 285260.0, 285331.0, 364718.0, 25225.0, 25770.613440798028, 25956.22131336063, 27171.72828271771, 27182.320441989108, 42198.15603687971, 43287.783561082, 43370.349444757725, 43935.340969886114, 43958.340624890014, 35925.0, 36154.63845361512, 36723.44914826333, 37127.81436092802, 37219.25561488809, 36538.39470561727, 36544.81727591345, 36629.63370366262, 36962.44556331603, 37453.81273093617, 35859.82070089633, 35936.4609530852, 36592.0, 36901.44647830338, 36942.44586331261, 31681.5247771279, 33224.66775332216, 33377.165570860925, 33443.66556334405, 33477.0, 25045.24864254075, 25584.36039098963, 25730.614040789027, 25814.354641134123, 26013.869930650984], "value": 16502.580999275066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1093375897845, 378.4984895014105, 381.70417926107245, 383.6987964447909, 394.8716667083199, 10717.142628589714, 11267.774644507104, 11270.380129092897, 11287.15346349023, 15410.61473463164, 14479.13125212488, 14757.704845903076, 15127.77308340373, 15154.0, 15466.0, 5572.665640061609, 5656.377798442158, 5835.241418615574, 7031.894521582155, 7033.8944915826305, 6721.0926524919, 6744.898826517606, 6771.729130834785, 6792.898106528406, 6834.521583489158, 6818.181818181825, 6849.383555480006, 6859.279775623562, 6864.073350097748, 6864.7940561783225, 6148.200733904609, 6478.676066196718, 6494.675266236716, 6664.766733164341, 6872.381485666289, 6132.233470816148, 6414.839629009265, 6418.06937993993, 6615.933840661628, 6644.302348253412, 22117.115315387528, 23072.76927230723, 23457.88271058634, 23471.295861124192, 23556.528869422687, 1836.2012524551862, 1839.7516335294697, 1862.5995410986702, 1961.6861302191724, 1974.0228586849457, 13162.736745265041, 13349.666258343523, 14082.577522674335, 14265.857341426661, 14329.283535823168, 1763.2594310389668, 1843.1797849956774, 1854.6290741851683, 1904.2954106980367, 1926.2006267399013, 59673.40326596765, 73498.26501734968, 78620.60689696515, 79218.0, 81293.18706812915, 14666.193714060284, 16441.83558164427, 16598.6680266394, 16672.0, 17009.574760630836, 29101.272468188043, 29151.416971660874, 29360.85319573431, 29435.264118396783, 29494.705052949626, 8493.447925884797, 8994.775130621787, 9012.233960113334, 9108.954455227682, 9153.588088536031, 7400.48196626231, 7402.962985185148, 7432.9256707433315, 7554.169041405441, 7593.430492713069, 8427.0, 8631.180037896389, 8633.0, 8643.783905402415, 8698.95650521756, 3333.6999670029327, 3388.881389151368, 3421.3328400961573, 3424.33225521021, 3519.489673997256, 365.02720250532565, 370.6589937257729, 371.33160311439303, 833.7165363776345, 886.7694399456187, 10472.371657700562, 10490.364719666972, 10646.467676616137, 10798.460076996118, 10799.67600971972, 393.472746519665, 404.38533429188055, 406.4249087541155, 416.71038628153747, 417.2843573271793, 5530.474604912527, 5728.312602487645, 5731.914021289684, 5732.0, 5867.090600956859, 376824.0, 384169.0, 385182.0, 389944.0, 391193.0, 78052.60973695095, 78149.60925195337, 78417.60791196008, 79384.60307698425, 79793.20206797858, 388.8716723481301, 397.8846134620928, 408.29568993486595, 412.9256733787947, 419.73556659304444, 9845.120654884346, 10147.594096236067, 10432.895671043192, 10499.160067194452, 10614.469276535989, 36116.304880366435, 36410.27179456343, 36451.635483645885, 37264.25471490501, 37591.81204093962, 46156.30765538587, 47249.527504724516, 51549.7422512885, 51946.0, 52057.47942520678, 7123.145222573325, 7342.816429589303, 7413.925860741324, 7496.62516874165, 7868.291853733192, 8769.38614296993, 10113.747156321151, 10326.225533085199, 10700.357978521313, 10897.618583349546, 8641.56792160402, 8771.16673915977, 8989.640414383352, 9034.774130646787, 9127.995920448613, 8715.172058654418, 9065.866766654168, 9204.98745138021, 9248.16766491019, 9290.303227257848, 9133.360664753403, 9142.451452912846, 9282.35023548345, 9340.439573625332, 9522.571484283086, 7509.784613539128, 7553.546787192786, 7554.244575542401, 7622.618869056414, 7897.763067107996, 8161.3062889652665, 8691.304695624462, 9111.954440227757, 9150.993390727148, 9232.030636783042], "value": 8212.985291283207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1176.8587769467665, 1289.7033682253082, 1373.4780783302344, 1410.4922227997924, 1709.811920688724, 6252.437280644741, 6882.0, 7019.9821025951205, 7043.401310888574, 7175.748848790294, 6952.965235173817, 7084.433245340373, 7091.042709234252, 7091.539049961749, 7126.96436517818, 1777.075920521328, 1835.1466568045855, 1839.0804597701149, 2055.14711394771, 2086.551391450838, 1878.9718154227699, 2046.7134601155851, 2093.288281984125, 2098.244631932511, 2115.428834214761, 2065.5662310914727, 2066.142550841399, 2069.430906500717, 2070.534129820786, 2077.584483103378, 1977.6044791041777, 2015.5263513074415, 2016.3144530859431, 2017.4754563813367, 2017.6267390532726, 1966.016991504248, 1969.202472998438, 1971.310041485483, 2015.889126098064, 2017.6267390532798, 7010.263922288188, 7089.751858684973, 7100.041494398293, 7122.180949190858, 7131.89302160468, 4194.91610167798, 4324.372965919955, 4325.740455572675, 4327.415798867176, 4331.7617531035785, 2752.628395166647, 2840.701726318748, 2890.8120972136953, 2896.319364949235, 2913.6066631004755, 803.7468197517763, 822.0078912757567, 900.477722920711, 919.9218066464358, 951.3768481644533, 9477.383970041925, 9482.146606805421, 9487.098725621056, 9493.762655933588, 10090.344127631754, 4016.959830401717, 4095.406166105898, 4102.0360215349365, 4106.322456794595, 4107.9178416431505, 8578.313734901192, 8609.311255099577, 8619.6983105591, 8628.78428039304, 8641.524716140673, 4411.889702757457, 4427.22523558376, 4441.244988351923, 4442.400275962768, 4445.466544014675, 3900.6932677553336, 3919.8824035278985, 3963.02905788078, 4072.6538244248977, 4110.506739191256, 3539.592946811098, 3582.946255806165, 3596.6583174598372, 3640.0535860676414, 3677.485152078711, 1124.7131981344705, 1125.1280257800106, 1134.143721490286, 1136.6021892337615, 1155.2433156282648, 838.2832678060292, 852.1606217875387, 856.6316483911978, 872.47651409154, 878.3675753457501, 4941.357623508921, 5052.621053420935, 5138.203578445347, 5153.433122356538, 5162.9483705162465, 365.49379109932937, 370.9146896213886, 377.0987340256788, 377.5582568394984, 378.5419642232874, 3493.703035242033, 3505.1938054247157, 3527.647235276503, 3578.2664553766417, 3579.427291633326, 8913.0, 9062.139096785795, 9317.580708868118, 9318.347715659975, 9330.206932410685, 9298.163165315018, 9298.442093474277, 9306.208972237435, 9314.068593140768, 9315.34792564514, 6846.520743548003, 6932.202796678446, 6939.4795390346935, 6943.270956549591, 6944.0, 4989.501049895127, 4996.675216110941, 5018.1469150245275, 5073.365829271341, 5181.948180518298, 8539.701110461352, 8556.486610803371, 8585.828283434172, 8590.269827064769, 8590.398672092893, 7723.420743444377, 8382.455140415854, 8606.311495080254, 8621.439606425562, 8864.911350886408, 6111.297200821962, 6284.968575157095, 6308.179936608211, 6483.513736469689, 6488.9026664601015, 6863.862722745617, 6973.755918542826, 7031.894521582078, 7033.437325013884, 7060.223375428802, 6392.169018027626, 6653.035309880137, 6698.765543205965, 6716.361945615159, 6783.525153239423, 6282.0, 6332.556721029484, 6344.68276586178, 6352.205974253218, 6449.774257900951, 6108.541859360655, 6114.6636934969, 6158.353372895961, 6182.443580077815, 6220.284667263322, 4429.180601588717, 4442.555744425661, 4497.482789479252, 4520.389747384061, 4615.861524154281, 4332.891677708082, 4421.2262854001065, 4505.32420136969, 4517.277235642281, 4573.245414506569], "value": 3850.888425136818, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.3728080459369, 289.9681035086141, 298.98355590442515, 299.0251779199808, 301.3535965354316, 4541.227991241489, 4657.416478397344, 4689.48415674276, 4704.482506924235, 4721.645876559259, 4494.752788596634, 4603.240465323218, 4620.168369693454, 4637.744924029177, 4647.140279048378, 3673.9242328084615, 3682.8526858925743, 3687.483752274684, 3689.9631003690024, 3698.611645777195, 3489.5343955538733, 3538.575370955489, 3691.760035597691, 3704.1480459494333, 3723.3111874303204, 3648.5885696873374, 3658.689011434018, 3670.3209906167313, 3678.1907980244305, 3680.1167719747336, 3647.069997150736, 3651.525301710787, 3656.8171591420323, 3658.8719394821055, 3703.0, 3271.443854544709, 3273.541704161419, 3276.2792185719104, 3277.0987978305916, 3302.85137168828, 4299.226139294926, 4502.459704835441, 4506.301523263899, 4513.458384993789, 4558.814708175865, 4087.5708050654553, 4118.382242663594, 4129.69027322952, 4133.855315063988, 4160.625543701081, 4869.70781753096, 4878.975225281504, 4886.53577910098, 4893.779779909913, 4908.239222920453, 3294.5717056782705, 3488.8081155536433, 3491.3765099228726, 3502.614712381636, 3505.8422370993367, 5084.822031228926, 5091.79632814687, 5110.693358398471, 5129.256257842592, 5138.922916156261, 3536.469529570585, 3544.1494041430387, 3546.556680414948, 3547.4324108142573, 3557.2351944332095, 3580.4987301777774, 3586.1751797086295, 3602.2435288589168, 3618.5115009473384, 3619.7647152934974, 3931.64615184629, 4088.3254263046265, 4098.897527561775, 4112.568180341081, 4124.979375103106, 4611.515790841981, 4820.4456487503685, 4879.341288926021, 4879.634027447955, 4886.511348865156, 1200.3218181727295, 1231.987680123205, 1234.8147777833397, 1235.765204611121, 1239.2812168942173, 777.366446346226, 787.8778789287669, 796.3191471292077, 798.2057852436747, 808.8867558541809, 3949.8025098744947, 3973.980130099331, 3981.9402708959387, 3982.820773065219, 3989.9027767364205, 4465.732056076646, 4479.260921947907, 4490.236659767782, 4506.571875671806, 4516.570925762047, 3925.980370098131, 3940.645341919241, 3958.7426817256787, 3963.009247688078, 3995.320795464778, 2305.250793492122, 2310.798384839874, 2363.7045369328835, 2392.4018995251186, 2415.837825146484, 4229.513605935295, 4253.255680255943, 4264.466941632296, 4291.334843099325, 4294.570542945743, 4543.522930092358, 4546.840860569864, 4564.726116433025, 4586.931196031996, 4605.723656580616, 4007.6192761687594, 4257.297545904891, 4281.97859010703, 4293.355996600535, 4327.740335579875, 4452.532484089124, 4463.709858859163, 4471.859675782654, 4472.888177795581, 4485.0, 4421.071574969293, 4428.158649856517, 4436.9334459983775, 4441.555844415532, 4445.37764712947, 4065.531859648886, 4287.614114729565, 4291.914161716686, 4319.460067491564, 4323.394724738476, 3287.967120328766, 3288.769786114949, 3307.5534802802276, 3317.6516465770746, 3318.651541588195, 4416.84541041062, 4480.596746292849, 4515.706479078849, 4516.638668906414, 4831.565159135695, 4721.457032441176, 4901.191303434894, 4902.852914412573, 4903.289023091703, 4914.950850491592, 4846.903061938671, 4868.245421959602, 4883.755812209446, 4900.779464924016, 4916.074935413423, 4573.016801387717, 4784.976075119602, 4791.688540244873, 4798.880027999328, 4819.277108433763, 4920.630952678635, 4932.975335123301, 4949.995251922977, 4952.7771250294545, 4954.1825598775795, 4795.304680821192, 4820.783064762024, 4833.613310935047, 4850.393700787402, 4859.635527335535], "value": 3556.050922327999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.4802290087777, 678.0913575808415, 681.3152781454635, 717.6499198475367, 745.3031415626391, 12300.876991230096, 12849.164804287715, 14309.141451512904, 14829.851701482981, 14864.702705945874, 14783.039102458359, 14853.628659283524, 14950.626234344147, 15008.849911500882, 15016.17411042395, 608.8782243551285, 762.2948772385549, 765.0971853213206, 770.414484991405, 789.4631650477687, 777.7316825695154, 778.9844203115935, 781.269513005339, 781.7303030454484, 782.0654318089885, 838.828040251747, 839.1692224697535, 840.0885039731868, 840.2857571064577, 840.6595328891779, 641.522066060783, 799.2886331165209, 801.2508304735062, 802.9518228906285, 828.4780588229437, 605.1799811255729, 605.2132228103447, 605.5549171359047, 605.8424809549505, 605.9939400605981, 12665.113442059059, 12716.745665086646, 12730.618081457478, 12742.745145097138, 12764.106512544126, 11333.376664283462, 11688.415579221006, 11698.356590387526, 11740.354280514568, 12154.027677785756, 11624.6512604622, 11639.06887449002, 11716.121290903131, 11746.177767556275, 11874.821877671842, 3910.1397692507603, 3948.7038472114705, 4060.6751459883435, 4065.308897487434, 4067.2068946555432, 44165.0, 44621.10757784826, 44682.0, 44696.55303446989, 50081.74959125218, 10038.64864729731, 10044.899551004542, 10087.142592879542, 10347.534360953776, 10505.789884202426, 17591.29634814619, 17766.733498997524, 17767.0, 17803.19885605151, 17821.465356039338, 6702.128723266042, 6767.35710107539, 6825.726970921108, 6903.861922761516, 6990.510664253555, 3769.095417099876, 3841.078141246081, 3844.596317386634, 3855.383138697851, 3878.9030274242805, 2770.5844123381653, 2868.5983962244886, 2870.2537340291674, 2870.3254735137225, 2870.7416332530174, 429.9462567179103, 472.0723777776685, 487.8097541958639, 497.6267799150637, 497.63423883445637, 596.9582129250911, 609.1330271133611, 650.9446697030711, 660.7819419591523, 685.8285428642839, 8745.823567545927, 8968.327375446868, 9115.270778337717, 9193.218576421079, 9211.980053151798, 602.2231321595181, 643.9098526206335, 644.687326646576, 657.7434800427837, 666.9366410191024, 3934.2131573684806, 3968.3253846846105, 3992.401139828991, 4020.592792522652, 4021.8391264349684, 90234.09765902389, 100341.0, 101626.0, 101947.0, 104397.0, 65184.67407663026, 69570.0, 75414.49171016549, 79841.20158798338, 86707.0, 65812.67093664501, 68890.31109688939, 70904.2909570908, 72207.63896180486, 72261.6386918062, 9020.278377729635, 9031.63873445055, 9041.68354107603, 9075.54622268897, 9179.954100229455, 31353.8432307837, 33452.832735836164, 43071.56928430801, 43732.78133609312, 44103.33844992264, 58110.0, 60037.699811500665, 60723.392766071775, 60740.0, 61174.69412652908, 11356.04209266384, 11428.371439570903, 11521.884781152416, 11544.88455115438, 11575.88424115748, 11697.23967942081, 11922.4038798058, 12467.812982805446, 12768.553100641433, 13547.458101676217, 11778.76442471163, 11870.228435151688, 12086.274823510617, 12198.939005304917, 12243.142979991315, 11480.081593472669, 11613.0, 11656.766864662828, 11777.175597708421, 11926.463309151282, 11617.709557261136, 12166.452509637265, 12223.93888030554, 12572.622821315375, 12602.49590016389, 9436.150746432853, 9590.904090959, 9825.606975721177, 9829.115379615869, 10097.747556311151, 8830.735077947671, 8948.821023579621, 9113.726588202364, 9386.577604007973, 9569.3779904306], "value": 6554.876158725263, "unit": "score"}], "name": "dromaeo_css", "value": 6199.570977267497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 113.0, 116.0, 113.0, 115.0, 115.0, 113.0, 113.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 140.0, 141.0, 177.0, 138.0, 155.0, 158.0, 142.0, 201.0, 130.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 163.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 104.0, 75.0, 78.0, 75.0, 74.0, 98.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 84.0, 85.0, 84.0, 117.0, 85.0, 85.0, 132.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 62.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 83.0, 86.0, 84.0, 84.0, 85.0, 115.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 131.0, 128.0, 130.0, 133.0, 134.0, 141.0, 147.0, 133.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 177.0, 168.0, 175.0, 168.0, 169.0, 169.0, 167.0, 177.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1552.6, "alertThreshold": 2.0}]} 13:54:15 INFO - Return code: 0 13:54:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:54:16 ERROR - # TBPL SUCCESS # 13:54:16 INFO - Running post-action listener: _resource_record_post_action 13:54:16 INFO - ##### 13:54:16 INFO - ##### Finished run-tests step (success) 13:54:16 INFO - ##### 13:54:16 INFO - Running post-run listener: _resource_record_post_run 13:54:16 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522506240; Read time: 16; Write time: 394840 13:54:16 INFO - TinderboxPrint: CPU usage
13.2% 13:54:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:54:16 INFO - TinderboxPrint: I/O write bytes / time
522,506,240 / 394,840 13:54:16 INFO - TinderboxPrint: CPU idle
8,314.2 (86.8%) 13:54:16 INFO - TinderboxPrint: CPU user
1,219.0 (12.7%) 13:54:16 INFO - TinderboxPrint: Swap in / out
0 / 0 13:54:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237367296; Read time: 0; Write time: 193400 13:54:16 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285138944; Read time: 16; Write time: 201440 13:54:16 INFO - Running post-run listener: _upload_blobber_files 13:54:16 INFO - Blob upload gear active. 13:54:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:54:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:54:17 INFO - (blobuploader) - INFO - Open directory for files ... 13:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:54:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:17 INFO - (blobuploader) - INFO - Done attempting. 13:54:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:54:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:54:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:18 INFO - (blobuploader) - INFO - Done attempting. 13:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:54:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:22 INFO - (blobuploader) - INFO - Done attempting. 13:54:22 INFO - (blobuploader) - INFO - Iteration through files over. 13:54:22 INFO - Return code: 0 13:54:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:54:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:54:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/df0033f6ea187162ad882f737fb46b5d052befe86a9995851bbc6e899ff6fab3c45e783c22a67f9806327f95c715579b6e321ff5160067c3c1dc3379b47e8077", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/a1dd449bd8cc2b46f79b1fe6fca60dbc028aa1110e25e067086d6dc2001cc8f4ef0d9de5770c1cae0b7f11192ba80f05073066843d817319a772288aa7c5aba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1085e07efcd84d7b8ad9beff28bf41dbeb3512151ea6b4ec53e98db488c38463ca0c36b2dda979d6e0521573e78533507cd4f9c06c4061d9a4066d13274cacc"} 13:54:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:54:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:54:22 INFO - Contents: 13:54:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/df0033f6ea187162ad882f737fb46b5d052befe86a9995851bbc6e899ff6fab3c45e783c22a67f9806327f95c715579b6e321ff5160067c3c1dc3379b47e8077", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/a1dd449bd8cc2b46f79b1fe6fca60dbc028aa1110e25e067086d6dc2001cc8f4ef0d9de5770c1cae0b7f11192ba80f05073066843d817319a772288aa7c5aba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1085e07efcd84d7b8ad9beff28bf41dbeb3512151ea6b4ec53e98db488c38463ca0c36b2dda979d6e0521573e78533507cd4f9c06c4061d9a4066d13274cacc"} 13:54:22 INFO - Running post-run listener: copy_logs_to_upload_dir 13:54:22 INFO - Copying logs to upload dir... 13:54:22 INFO - mkdir: /builds/slave/test/build/upload/logs 13:54:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.383632 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-02 13:54:22.595009) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 13:54:22.598850) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/df0033f6ea187162ad882f737fb46b5d052befe86a9995851bbc6e899ff6fab3c45e783c22a67f9806327f95c715579b6e321ff5160067c3c1dc3379b47e8077", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/a1dd449bd8cc2b46f79b1fe6fca60dbc028aa1110e25e067086d6dc2001cc8f4ef0d9de5770c1cae0b7f11192ba80f05073066843d817319a772288aa7c5aba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1085e07efcd84d7b8ad9beff28bf41dbeb3512151ea6b4ec53e98db488c38463ca0c36b2dda979d6e0521573e78533507cd4f9c06c4061d9a4066d13274cacc"} build_url:https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/S2T_DVtNSIOz_s92kU6zlA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/df0033f6ea187162ad882f737fb46b5d052befe86a9995851bbc6e899ff6fab3c45e783c22a67f9806327f95c715579b6e321ff5160067c3c1dc3379b47e8077", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/a1dd449bd8cc2b46f79b1fe6fca60dbc028aa1110e25e067086d6dc2001cc8f4ef0d9de5770c1cae0b7f11192ba80f05073066843d817319a772288aa7c5aba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1085e07efcd84d7b8ad9beff28bf41dbeb3512151ea6b4ec53e98db488c38463ca0c36b2dda979d6e0521573e78533507cd4f9c06c4061d9a4066d13274cacc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 13:54:22.623134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:54:22.623463) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464898423.964193-891513982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 13:54:22.706099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 13:54:22.706400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 13:54:22.706676) ========= ========= Total master_lag: 0.18 =========