builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1463411808.82 results: success (0) buildid: 20160516053010 builduid: 797e29dcf96b4d119651053e0316412f revision: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:48.823381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:48.823830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:48.824126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:48.860440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:48.860761) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 08:16:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-05-16 08:16:49 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.245886 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.124042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.124405) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013937 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.174894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.175237) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 --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=2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 08:16:49,803 truncating revision to first 12 chars 2016-05-16 08:16:49,803 Setting DEBUG logging. 2016-05-16 08:16:49,803 attempt 1/10 2016-05-16 08:16:49,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26656bbb6d39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 08:16:50,052 unpacking tar archive at: fx-team-26656bbb6d39/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517343 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.706989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.707454) ========= script_repo_revision: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.708066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.708488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 08:16:49.719519) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-16 08:16:49.720004) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:50 INFO - MultiFileLogger online at 20160516 08:16:50 in /builds/slave/test 08:16:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:16:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:50 INFO - {'append_to_log': False, 08:16:50 INFO - 'base_work_dir': '/builds/slave/test', 08:16:50 INFO - 'blob_upload_branch': 'Fx-Team', 08:16:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:50 INFO - 'branch': 'Fx-Team', 08:16:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:50 INFO - 'config_files': ('talos/linux_config.py',), 08:16:50 INFO - 'default_actions': ('clobber', 08:16:50 INFO - 'read-buildbot-config', 08:16:50 INFO - 'download-and-extract', 08:16:50 INFO - 'populate-webroot', 08:16:50 INFO - 'create-virtualenv', 08:16:50 INFO - 'install', 08:16:50 INFO - 'run-tests'), 08:16:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:50 INFO - 'download_minidump_stackwalk': True, 08:16:50 INFO - 'download_symbols': 'ondemand', 08:16:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:50 INFO - 'installer_path': 'installer.exe', 08:16:50 INFO - 'log_level': 'info', 08:16:50 INFO - 'log_name': 'talos', 08:16:50 INFO - 'log_to_console': True, 08:16:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:50 INFO - 'opt_config_files': (), 08:16:50 INFO - 'pip_index': False, 08:16:50 INFO - 'sps_profile': False, 08:16:50 INFO - 'sps_profile_interval': 0, 08:16:50 INFO - 'suite': 'dromaeojs', 08:16:50 INFO - 'system_bits': '32', 08:16:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:50 INFO - 'title': 'talos-linux64-ix-012', 08:16:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:50 INFO - 'use_talos_json': True, 08:16:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:50 INFO - 'work_dir': 'build'} 08:16:50 INFO - ##### 08:16:50 INFO - ##### Running clobber step. 08:16:50 INFO - ##### 08:16:50 INFO - Running pre-action listener: _resource_record_pre_action 08:16:50 INFO - Running main action method: clobber 08:16:50 INFO - rmtree: /builds/slave/test/build 08:16:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:51 INFO - Running post-action listener: _resource_record_post_action 08:16:51 INFO - ##### 08:16:51 INFO - ##### Finished clobber step (success) 08:16:51 INFO - ##### 08:16:51 INFO - ##### 08:16:51 INFO - ##### Running read-buildbot-config step. 08:16:51 INFO - ##### 08:16:51 INFO - Running pre-action listener: _resource_record_pre_action 08:16:51 INFO - Running main action method: read_buildbot_config 08:16:51 INFO - Using buildbot properties: 08:16:51 INFO - { 08:16:51 INFO - "project": "", 08:16:51 INFO - "product": "firefox", 08:16:51 INFO - "script_repo_revision": "production", 08:16:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:16:51 INFO - "repository": "", 08:16:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:16:51 INFO - "buildid": "20160516053010", 08:16:51 INFO - "pgo_build": "True", 08:16:51 INFO - "basedir": "/builds/slave/test", 08:16:51 INFO - "buildnumber": 1156, 08:16:51 INFO - "slavename": "talos-linux64-ix-012", 08:16:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:16:51 INFO - "platform": "ubuntu64_hw", 08:16:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:16:51 INFO - "branch": "fx-team", 08:16:51 INFO - "repo_path": "integration/fx-team", 08:16:51 INFO - "revision": "26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89", 08:16:51 INFO - "stage_platform": "linux64-pgo", 08:16:51 INFO - "builduid": "797e29dcf96b4d119651053e0316412f", 08:16:51 INFO - "slavebuilddir": "test" 08:16:51 INFO - } 08:16:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:16:51 INFO - Running post-action listener: _resource_record_post_action 08:16:51 INFO - ##### 08:16:51 INFO - ##### Finished read-buildbot-config step (success) 08:16:51 INFO - ##### 08:16:51 INFO - ##### 08:16:51 INFO - ##### Running download-and-extract step. 08:16:51 INFO - ##### 08:16:51 INFO - Running pre-action listener: _resource_record_pre_action 08:16:51 INFO - Running main action method: download_and_extract 08:16:51 INFO - mkdir: /builds/slave/test/build/tests 08:16:51 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')]} 08:16:51 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:16:58 INFO - Downloaded 1361 bytes. 08:16:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:16:58 INFO - Using the following test package requirements: 08:16:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:16:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:16:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'jsshell-linux-x86_64.zip'], 08:16:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:16:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:16:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:16:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:16:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:16:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:16: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')]} 08:16:58 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:16:59 INFO - Downloaded 24023288 bytes. 08:16:59 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'] 08:16:59 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 08:17:01 INFO - Return code: 0 08:17:01 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 08:17:01 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')]} 08:17:01 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:17:02 INFO - Downloaded 24023288 bytes. 08:17:02 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'] 08:17:02 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 08:17:03 INFO - Return code: 0 08:17:03 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')]} 08:17:03 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:17:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:17:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:17:04 INFO - Downloaded 10840194 bytes. 08:17:04 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'] 08:17:04 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 08:17:04 INFO - Return code: 0 08:17:04 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')]} 08:17:04 INFO - https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JE6Mp7W_Sh2UekFFde15tw/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 08:17:09 INFO - Downloaded 58421766 bytes. 08:17:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:17:09 INFO - mkdir: /builds/slave/test/properties 08:17:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:09 INFO - Contents: 08:17:09 INFO - build_url:https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:17:09 INFO - Running post-action listener: _resource_record_post_action 08:17:09 INFO - Running post-action listener: set_extra_try_arguments 08:17:09 INFO - ##### 08:17:09 INFO - ##### Finished download-and-extract step (success) 08:17:09 INFO - ##### 08:17:09 INFO - ##### 08:17:09 INFO - ##### Running populate-webroot step. 08:17:09 INFO - ##### 08:17:09 INFO - Running pre-action listener: _resource_record_pre_action 08:17:09 INFO - Running main action method: populate_webroot 08:17:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:17:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:17:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:17:09 INFO - '--tppagecycles', 08:17:09 INFO - '7'], 08:17:09 INFO - 'tests': ['tsvgm']}}, 08:17:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:17:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:17:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['damp', 'tps']}, 08:17:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'tests': ['damp', 'tps']}, 08:17:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['dromaeo_dom']}, 08:17:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['a11yr', 08:17:09 INFO - 'ts_paint', 08:17:09 INFO - 'tpaint', 08:17:09 INFO - 'sessionrestore', 08:17:09 INFO - 'sessionrestore_no_auto_restore', 08:17:09 INFO - 'tabpaint']}, 08:17:09 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:09 INFO - 'ts_paint', 08:17:09 INFO - 'tpaint', 08:17:09 INFO - 'sessionrestore', 08:17:09 INFO - 'sessionrestore_no_auto_restore', 08:17:09 INFO - 'tabpaint']}, 08:17:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:17:09 INFO - 'ts_paint', 08:17:09 INFO - 'tpaint', 08:17:09 INFO - 'sessionrestore', 08:17:09 INFO - 'sessionrestore_no_auto_restore', 08:17:09 INFO - 'tabpaint']}, 08:17:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:17:09 INFO - 'ts_paint', 08:17:09 INFO - 'tpaint', 08:17:09 INFO - 'sessionrestore', 08:17:09 INFO - 'sessionrestore_no_auto_restore', 08:17:09 INFO - 'tabpaint']}, 08:17:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['a11yr', 08:17:09 INFO - 'ts_paint', 08:17:09 INFO - 'tpaint', 08:17:09 INFO - 'sessionrestore', 08:17:09 INFO - 'sessionrestore_no_auto_restore', 08:17:09 INFO - 'tabpaint']}, 08:17:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['a11yr', 08:17:09 INFO - 'ts_paint', 08:17:09 INFO - 'tpaint', 08:17:09 INFO - 'sessionrestore', 08:17:09 INFO - 'sessionrestore_no_auto_restore', 08:17:09 INFO - 'tabpaint']}, 08:17:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['tsvgx', 08:17:09 INFO - 'tsvgr_opacity', 08:17:09 INFO - 'tart', 08:17:09 INFO - 'tscrollx', 08:17:09 INFO - 'cart']}, 08:17:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:09 INFO - 'tsvgr_opacity', 08:17:09 INFO - 'tart', 08:17:09 INFO - 'tscrollx', 08:17:09 INFO - 'cart']}, 08:17:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'talos_options': ['--disable-e10s'], 08:17:09 INFO - 'tests': ['tp5o']}, 08:17:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'tests': ['tp5o']}, 08:17:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'talos_options': ['--disable-e10s', 08:17:09 INFO - '--xperf_path', 08:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:09 INFO - 'tests': ['tp5n']}, 08:17:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:17:09 INFO - 'talos_options': ['--xperf_path', 08:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:09 INFO - 'tests': ['tp5n']}}, 08:17:09 INFO - 'talos.zip': {'path': '', 08:17:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:17:09 INFO - Running post-action listener: _resource_record_post_action 08:17:09 INFO - ##### 08:17:09 INFO - ##### Finished populate-webroot step (success) 08:17:09 INFO - ##### 08:17:09 INFO - ##### 08:17:09 INFO - ##### Running create-virtualenv step. 08:17:09 INFO - ##### 08:17:09 INFO - Running pre-action listener: _resource_record_pre_action 08:17:09 INFO - Running main action method: create_virtualenv 08:17:09 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:09 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 08:17:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:17:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:10 INFO - Using real prefix '/usr' 08:17:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:12 INFO - Installing pip.................done. 08:17:12 INFO - Return code: 0 08:17:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17: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', 'pip>=1.5'] in /builds/slave/test/build 08:17: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 pip>=1.5 08:17:12 INFO - Using env: {'DISPLAY': ':0', 08:17:12 INFO - 'HOME': '/home/cltbld', 08:17:12 INFO - 'LANG': 'en_US.UTF-8', 08:17:12 INFO - 'LANGUAGE': 'en_US:en', 08:17:12 INFO - 'LOGNAME': 'cltbld', 08:17:12 INFO - 'MAIL': '/var/mail/cltbld', 08:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:12 INFO - 'MOZ_NO_REMOTE': '1', 08:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:12 INFO - 'NO_EM_RESTART': '1', 08:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:12 INFO - 'PWD': '/builds/slave/test', 08:17:12 INFO - 'SHELL': '/bin/bash', 08:17:12 INFO - 'SHLVL': '1', 08:17:12 INFO - 'TERM': 'linux', 08:17:12 INFO - 'TMOUT': '86400', 08:17:12 INFO - 'USER': 'cltbld', 08:17:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:12 INFO - '_': '/tools/buildbot/bin/python'} 08:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:12 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 08:17:12 INFO - Cleaning up... 08:17:12 INFO - Return code: 0 08:17:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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', '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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:17: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 psutil>=3.1.1 08:17:12 INFO - Using env: {'DISPLAY': ':0', 08:17:12 INFO - 'HOME': '/home/cltbld', 08:17:12 INFO - 'LANG': 'en_US.UTF-8', 08:17:12 INFO - 'LANGUAGE': 'en_US:en', 08:17:12 INFO - 'LOGNAME': 'cltbld', 08:17:12 INFO - 'MAIL': '/var/mail/cltbld', 08:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:12 INFO - 'MOZ_NO_REMOTE': '1', 08:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:12 INFO - 'NO_EM_RESTART': '1', 08:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:12 INFO - 'PWD': '/builds/slave/test', 08:17:12 INFO - 'SHELL': '/bin/bash', 08:17:12 INFO - 'SHLVL': '1', 08:17:12 INFO - 'TERM': 'linux', 08:17:12 INFO - 'TMOUT': '86400', 08:17:12 INFO - 'USER': 'cltbld', 08:17:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:12 INFO - '_': '/tools/buildbot/bin/python'} 08:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:12 INFO - Downloading/unpacking psutil>=3.1.1 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:14 INFO - Installing collected packages: psutil 08:17:14 INFO - Running setup.py install for psutil 08:17:15 INFO - building 'psutil._psutil_linux' extension 08:17:15 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 08:17:15 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 08:17:15 INFO - building 'psutil._psutil_posix' extension 08:17:15 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 08:17:15 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 08:17:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:15 INFO - Successfully installed psutil 08:17:15 INFO - Cleaning up... 08:17:15 INFO - Return code: 0 08:17:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:15 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')]} 08:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:15 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')]} 08:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:15 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:15 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 08:17:15 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 08:17:15 INFO - Using env: {'DISPLAY': ':0', 08:17:15 INFO - 'HOME': '/home/cltbld', 08:17:15 INFO - 'LANG': 'en_US.UTF-8', 08:17:15 INFO - 'LANGUAGE': 'en_US:en', 08:17:15 INFO - 'LOGNAME': 'cltbld', 08:17:15 INFO - 'MAIL': '/var/mail/cltbld', 08:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:15 INFO - 'MOZ_NO_REMOTE': '1', 08:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:15 INFO - 'NO_EM_RESTART': '1', 08:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:15 INFO - 'PWD': '/builds/slave/test', 08:17:15 INFO - 'SHELL': '/bin/bash', 08:17:15 INFO - 'SHLVL': '1', 08:17:15 INFO - 'TERM': 'linux', 08:17:15 INFO - 'TMOUT': '86400', 08:17:15 INFO - 'USER': 'cltbld', 08:17:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:15 INFO - '_': '/tools/buildbot/bin/python'} 08:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 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 08:17:15 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 08:17:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:17 INFO - Installing collected packages: mozsystemmonitor 08:17:17 INFO - Running setup.py install for mozsystemmonitor 08:17:17 INFO - Successfully installed mozsystemmonitor 08:17:17 INFO - Cleaning up... 08:17:17 INFO - Return code: 0 08:17:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:17 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')]} 08:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:17 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')]} 08:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:17 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:17 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 08:17:17 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 08:17:17 INFO - Using env: {'DISPLAY': ':0', 08:17:17 INFO - 'HOME': '/home/cltbld', 08:17:17 INFO - 'LANG': 'en_US.UTF-8', 08:17:17 INFO - 'LANGUAGE': 'en_US:en', 08:17:17 INFO - 'LOGNAME': 'cltbld', 08:17:17 INFO - 'MAIL': '/var/mail/cltbld', 08:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:17 INFO - 'MOZ_NO_REMOTE': '1', 08:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:17 INFO - 'NO_EM_RESTART': '1', 08:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:17 INFO - 'PWD': '/builds/slave/test', 08:17:17 INFO - 'SHELL': '/bin/bash', 08:17:17 INFO - 'SHLVL': '1', 08:17:17 INFO - 'TERM': 'linux', 08:17:17 INFO - 'TMOUT': '86400', 08:17:17 INFO - 'USER': 'cltbld', 08:17:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:17 INFO - '_': '/tools/buildbot/bin/python'} 08:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:17 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 08:17:17 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 08:17:17 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 08:17:17 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 08:17:17 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 08:17:17 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 08:17:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:19 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 08:17:19 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 08:17:19 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 08:17:19 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 08:17:19 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 08:17:19 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 08:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17:20 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 08:17:20 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 08:17:20 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 08:17:20 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 08:17:20 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 08:17:20 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 08:17:20 INFO - Downloading docopt-0.6.1.tar.gz 08:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:20 INFO - Running setup.py install for blobuploader 08:17:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:20 INFO - Running setup.py install for requests 08:17:21 INFO - Running setup.py install for docopt 08:17:21 INFO - Successfully installed blobuploader requests docopt 08:17:21 INFO - Cleaning up... 08:17:21 INFO - Return code: 0 08:17:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:21 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')]} 08:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:21 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')]} 08:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:21 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:21 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 08:17:21 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 08:17:21 INFO - Using env: {'DISPLAY': ':0', 08:17:21 INFO - 'HOME': '/home/cltbld', 08:17:21 INFO - 'LANG': 'en_US.UTF-8', 08:17:21 INFO - 'LANGUAGE': 'en_US:en', 08:17:21 INFO - 'LOGNAME': 'cltbld', 08:17:21 INFO - 'MAIL': '/var/mail/cltbld', 08:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:21 INFO - 'MOZ_NO_REMOTE': '1', 08:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:21 INFO - 'NO_EM_RESTART': '1', 08:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:21 INFO - 'PWD': '/builds/slave/test', 08:17:21 INFO - 'SHELL': '/bin/bash', 08:17:21 INFO - 'SHLVL': '1', 08:17:21 INFO - 'TERM': 'linux', 08:17:21 INFO - 'TMOUT': '86400', 08:17:21 INFO - 'USER': 'cltbld', 08:17:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:21 INFO - '_': '/tools/buildbot/bin/python'} 08:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:21 INFO - Running setup.py (path:/tmp/pip-uLoT_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:21 INFO - Running setup.py (path:/tmp/pip-UkhCm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:21 INFO - Running setup.py (path:/tmp/pip-HZRFWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:21 INFO - Running setup.py (path:/tmp/pip-Ewzot8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:21 INFO - Running setup.py (path:/tmp/pip-so3RIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:21 INFO - Running setup.py (path:/tmp/pip-Z70PQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:21 INFO - Running setup.py (path:/tmp/pip-idI5BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:21 INFO - Running setup.py (path:/tmp/pip-K7Coey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:21 INFO - Running setup.py (path:/tmp/pip-iZorF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:22 INFO - Running setup.py (path:/tmp/pip-0m8UBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:22 INFO - Running setup.py (path:/tmp/pip-YNQdM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:22 INFO - Running setup.py (path:/tmp/pip-YJ9AUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:22 INFO - Running setup.py (path:/tmp/pip-Fc9F0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:22 INFO - Running setup.py (path:/tmp/pip-5Sx8fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:22 INFO - Running setup.py (path:/tmp/pip-MpWRZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:22 INFO - Running setup.py (path:/tmp/pip-eSljTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:22 INFO - Running setup.py (path:/tmp/pip-Qx0DNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:22 INFO - Running setup.py install for manifestparser 08:17:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:22 INFO - Running setup.py install for mozcrash 08:17:22 INFO - Running setup.py install for mozdebug 08:17:22 INFO - Running setup.py install for mozdevice 08:17:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for mozfile 08:17:23 INFO - Running setup.py install for mozhttpd 08:17:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for mozinfo 08:17:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for mozInstall 08:17:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for mozleak 08:17:23 INFO - Running setup.py install for mozlog 08:17:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for moznetwork 08:17:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for mozprocess 08:17:23 INFO - Running setup.py install for mozprofile 08:17:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:23 INFO - Running setup.py install for mozrunner 08:17:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:24 INFO - Running setup.py install for mozscreenshot 08:17:24 INFO - Running setup.py install for moztest 08:17:24 INFO - Running setup.py install for mozversion 08:17:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:24 INFO - Cleaning up... 08:17:24 INFO - Return code: 0 08:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:24 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')]} 08:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:24 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')]} 08:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:24 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:24 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 08:17:24 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 08:17:24 INFO - Using env: {'DISPLAY': ':0', 08:17:24 INFO - 'HOME': '/home/cltbld', 08:17:24 INFO - 'LANG': 'en_US.UTF-8', 08:17:24 INFO - 'LANGUAGE': 'en_US:en', 08:17:24 INFO - 'LOGNAME': 'cltbld', 08:17:24 INFO - 'MAIL': '/var/mail/cltbld', 08:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:24 INFO - 'MOZ_NO_REMOTE': '1', 08:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:24 INFO - 'NO_EM_RESTART': '1', 08:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:24 INFO - 'PWD': '/builds/slave/test', 08:17:24 INFO - 'SHELL': '/bin/bash', 08:17:24 INFO - 'SHLVL': '1', 08:17:24 INFO - 'TERM': 'linux', 08:17:24 INFO - 'TMOUT': '86400', 08:17:24 INFO - 'USER': 'cltbld', 08:17:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:24 INFO - '_': '/tools/buildbot/bin/python'} 08:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:24 INFO - Running setup.py (path:/tmp/pip-VfQObF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:24 INFO - Running setup.py (path:/tmp/pip-iZ6NDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:24 INFO - Running setup.py (path:/tmp/pip-xne4UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:24 INFO - Running setup.py (path:/tmp/pip-pgvpQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:24 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)) 08:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:24 INFO - Running setup.py (path:/tmp/pip-vfUWFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:25 INFO - Running setup.py (path:/tmp/pip-a_5rHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:25 INFO - Running setup.py (path:/tmp/pip-P65_Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:25 INFO - Running setup.py (path:/tmp/pip-VHfQAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:25 INFO - Running setup.py (path:/tmp/pip-PPYZbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:25 INFO - Running setup.py (path:/tmp/pip-1WwkXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:25 INFO - Running setup.py (path:/tmp/pip-pVB3Uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:25 INFO - Running setup.py (path:/tmp/pip-T4aigS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:25 INFO - Running setup.py (path:/tmp/pip-rbNVzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:25 INFO - Running setup.py (path:/tmp/pip-J95LUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:25 INFO - Running setup.py (path:/tmp/pip-o3ZpjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:25 INFO - Running setup.py (path:/tmp/pip-AD7I41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:25 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)) 08:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:25 INFO - Running setup.py (path:/tmp/pip-6efQ_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:25 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)) 08:17:25 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)) 08:17:25 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)) 08:17:25 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)) 08:17:25 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)) 08:17:25 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)) 08:17:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:25 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 08:17:25 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 08:17:25 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 08:17:25 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 08:17:25 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 08:17:25 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 08:17:27 INFO - Downloading blessings-1.6.tar.gz 08:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:28 INFO - Installing collected packages: blessings 08:17:28 INFO - Running setup.py install for blessings 08:17:28 INFO - Successfully installed blessings 08:17:28 INFO - Cleaning up... 08:17:28 INFO - Return code: 0 08:17:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:28 INFO - Reading from file tmpfile_stdout 08:17:28 INFO - Current package versions: 08:17:28 INFO - argparse == 1.2.1 08:17:28 INFO - blessings == 1.6 08:17:28 INFO - blobuploader == 1.2.4 08:17:28 INFO - docopt == 0.6.1 08:17:28 INFO - manifestparser == 1.1 08:17:28 INFO - mozInstall == 1.12 08:17:28 INFO - mozcrash == 0.17 08:17:28 INFO - mozdebug == 0.1 08:17:28 INFO - mozdevice == 0.48 08:17:28 INFO - mozfile == 1.2 08:17:28 INFO - mozhttpd == 0.7 08:17:28 INFO - mozinfo == 0.9 08:17:28 INFO - mozleak == 0.1 08:17:28 INFO - mozlog == 3.2 08:17:28 INFO - moznetwork == 0.27 08:17:28 INFO - mozprocess == 0.22 08:17:28 INFO - mozprofile == 0.28 08:17:28 INFO - mozrunner == 6.11 08:17:28 INFO - mozscreenshot == 0.1 08:17:28 INFO - mozsystemmonitor == 0.3 08:17:28 INFO - moztest == 0.7 08:17:28 INFO - mozversion == 1.4 08:17:28 INFO - psutil == 3.1.1 08:17:28 INFO - requests == 1.2.3 08:17:28 INFO - wsgiref == 0.1.2 08:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:28 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')]} 08:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:28 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')]} 08:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:28 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:28 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 08:17:28 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 08:17:28 INFO - Using env: {'DISPLAY': ':0', 08:17:28 INFO - 'HOME': '/home/cltbld', 08:17:28 INFO - 'LANG': 'en_US.UTF-8', 08:17:28 INFO - 'LANGUAGE': 'en_US:en', 08:17:28 INFO - 'LOGNAME': 'cltbld', 08:17:28 INFO - 'MAIL': '/var/mail/cltbld', 08:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:28 INFO - 'MOZ_NO_REMOTE': '1', 08:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:28 INFO - 'NO_EM_RESTART': '1', 08:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:28 INFO - 'PWD': '/builds/slave/test', 08:17:28 INFO - 'SHELL': '/bin/bash', 08:17:28 INFO - 'SHLVL': '1', 08:17:28 INFO - 'TERM': 'linux', 08:17:28 INFO - 'TMOUT': '86400', 08:17:28 INFO - 'USER': 'cltbld', 08:17:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:28 INFO - '_': '/tools/buildbot/bin/python'} 08:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 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)) 08:17:28 INFO - Cleaning up... 08:17:28 INFO - Return code: 0 08:17:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:28 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')]} 08:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:28 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')]} 08:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:28 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:28 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 08:17:28 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 08:17:28 INFO - Using env: {'DISPLAY': ':0', 08:17:28 INFO - 'HOME': '/home/cltbld', 08:17:28 INFO - 'LANG': 'en_US.UTF-8', 08:17:28 INFO - 'LANGUAGE': 'en_US:en', 08:17:28 INFO - 'LOGNAME': 'cltbld', 08:17:28 INFO - 'MAIL': '/var/mail/cltbld', 08:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:28 INFO - 'MOZ_NO_REMOTE': '1', 08:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:28 INFO - 'NO_EM_RESTART': '1', 08:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:28 INFO - 'PWD': '/builds/slave/test', 08:17:28 INFO - 'SHELL': '/bin/bash', 08:17:28 INFO - 'SHLVL': '1', 08:17:28 INFO - 'TERM': 'linux', 08:17:28 INFO - 'TMOUT': '86400', 08:17:28 INFO - 'USER': 'cltbld', 08:17:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:28 INFO - '_': '/tools/buildbot/bin/python'} 08:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:28 INFO - Downloading/unpacking jsonschema 08:17:28 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 08:17:28 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 08:17:28 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 08:17:28 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 08:17:28 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 08:17:28 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 08:17:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:30 INFO - Downloading/unpacking functools32 (from jsonschema) 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:31 INFO - warning: no files found matching '*.txt' 08:17:31 INFO - no previously-included directories found matching 'build' 08:17:31 INFO - no previously-included directories found matching 'dist' 08:17:31 INFO - no previously-included directories found matching '.git*' 08:17:31 INFO - Installing collected packages: jsonschema, functools32 08:17:31 INFO - Running setup.py install for functools32 08:17:31 INFO - warning: no files found matching '*.txt' 08:17:31 INFO - no previously-included directories found matching 'build' 08:17:31 INFO - no previously-included directories found matching 'dist' 08:17:31 INFO - no previously-included directories found matching '.git*' 08:17:31 INFO - Successfully installed jsonschema functools32 08:17:31 INFO - Cleaning up... 08:17:31 INFO - Return code: 0 08:17:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:31 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 0x7f9ca6b5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', '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 08:17:31 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 08:17:31 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 08:17:31 INFO - Using env: {'DISPLAY': ':0', 08:17:31 INFO - 'HOME': '/home/cltbld', 08:17:31 INFO - 'LANG': 'en_US.UTF-8', 08:17:31 INFO - 'LANGUAGE': 'en_US:en', 08:17:31 INFO - 'LOGNAME': 'cltbld', 08:17:31 INFO - 'MAIL': '/var/mail/cltbld', 08:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:31 INFO - 'MOZ_NO_REMOTE': '1', 08:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:31 INFO - 'NO_EM_RESTART': '1', 08:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:31 INFO - 'PWD': '/builds/slave/test', 08:17:31 INFO - 'SHELL': '/bin/bash', 08:17:31 INFO - 'SHLVL': '1', 08:17:31 INFO - 'TERM': 'linux', 08:17:31 INFO - 'TMOUT': '86400', 08:17:31 INFO - 'USER': 'cltbld', 08:17:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:31 INFO - '_': '/tools/buildbot/bin/python'} 08:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:31 INFO - Downloading/unpacking flake8 08:17:31 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 08:17:31 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 08:17:31 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 08:17:31 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 08:17:31 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 08:17:31 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 08:17:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:17:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:17:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 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 08:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:17:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:17:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:17:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:17:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:17:34 INFO - no previously-included directories found matching 'docs/_build' 08:17:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:17:34 INFO - Running setup.py install for pep8 08:17:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:17:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:17:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:17:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:17:34 INFO - no previously-included directories found matching 'docs/_build' 08:17:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:17:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:17:34 INFO - Cleaning up... 08:17:34 INFO - Return code: 0 08:17:34 INFO - Running post-action listener: _resource_record_post_action 08:17:34 INFO - Running post-action listener: _start_resource_monitoring 08:17:34 INFO - Starting resource monitoring. 08:17:34 INFO - ##### 08:17:34 INFO - ##### Finished create-virtualenv step (success) 08:17:34 INFO - ##### 08:17:34 INFO - ##### 08:17:34 INFO - ##### Running install step. 08:17:34 INFO - ##### 08:17:34 INFO - Running pre-action listener: _resource_record_pre_action 08:17:34 INFO - Running main action method: install 08:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:34 INFO - Reading from file tmpfile_stdout 08:17:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:34 INFO - Reading from file tmpfile_stdout 08:17:34 INFO - Output received: 08:17:34 INFO - Usage: mozinstall [options] installer 08:17:34 INFO - Options: 08:17:34 INFO - -h, --help show this help message and exit 08:17:34 INFO - -d DEST, --destination=DEST 08:17:34 INFO - Directory to install application into. [default: 08:17:34 INFO - "/builds/slave/test"] 08:17:34 INFO - --app=APP Application being installed. [default: firefox] 08:17:34 INFO - mkdir: /builds/slave/test/build/application 08:17:34 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'] 08:17:34 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 08:17:51 INFO - Reading from file tmpfile_stdout 08:17:51 INFO - Output received: 08:17:51 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:51 INFO - Running post-action listener: _resource_record_post_action 08:17:51 INFO - ##### 08:17:51 INFO - ##### Finished install step (success) 08:17:51 INFO - ##### 08:17:51 INFO - ##### 08:17:51 INFO - ##### Running run-tests step. 08:17:51 INFO - ##### 08:17:51 INFO - Running pre-action listener: _resource_record_pre_action 08:17:51 INFO - Running main action method: run_tests 08:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:51 INFO - Python 2.7.3 08:17:51 INFO - Return code: 0 08:17:51 INFO - grabbing minidump binary from tooltool 08:17:51 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')]} 08:17:51 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 0x24cdb20>, '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 0x24cea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ceeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:51 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 08:17:51 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 08:17:51 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 08:17:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:51 INFO - Return code: 0 08:17:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:17:52 INFO - Return code: 0 08:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 08:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 08:17:52 INFO - Using env: {'DISPLAY': ':0', 08:17:52 INFO - 'HOME': '/home/cltbld', 08:17:52 INFO - 'LANG': 'en_US.UTF-8', 08:17:52 INFO - 'LANGUAGE': 'en_US:en', 08:17:52 INFO - 'LOGNAME': 'cltbld', 08:17:52 INFO - 'MAIL': '/var/mail/cltbld', 08:17:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:52 INFO - 'MOZ_NO_REMOTE': '1', 08:17:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:52 INFO - 'NO_EM_RESTART': '1', 08:17:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:52 INFO - 'PWD': '/builds/slave/test', 08:17:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:52 INFO - 'SHELL': '/bin/bash', 08:17:52 INFO - 'SHLVL': '1', 08:17:52 INFO - 'TERM': 'linux', 08:17:52 INFO - 'TMOUT': '86400', 08:17:52 INFO - 'USER': 'cltbld', 08:17:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329', 08:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:52 INFO - '_': '/tools/buildbot/bin/python'} 08:17:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 08:17:52 INFO - mozversion application_buildid: 20160516053010 08:17:52 INFO - mozversion application_changeset: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 08:17:52 INFO - mozversion application_display_name: Nightly 08:17:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:52 INFO - mozversion application_name: Firefox 08:17:52 INFO - mozversion application_remotingname: firefox 08:17:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:17:52 INFO - mozversion application_vendor: Mozilla 08:17:52 INFO - mozversion application_version: 49.0a1 08:17:52 INFO - mozversion platform_buildid: 20160516053010 08:17:52 INFO - mozversion platform_changeset: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 08:17:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:17:52 INFO - mozversion platform_version: 49.0a1 08:17:52 INFO - using testdate: 1463411872 08:17:52 INFO - actual date: 1463411872 08:17:52 INFO - starting webserver on 'localhost:53537' 08:17:52 INFO - SUITE-START | Running 2 tests 08:17:52 INFO - TEST-START | dromaeo_css 08:17:52 INFO - operating with platform_type : linux_ 08:17:52 INFO - Initialising browser for dromaeo_css test... 08:17:52 INFO - TEST-INFO | started process 2586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpixAEix/profile http://localhost:53537/getInfo.html) 08:17:56 INFO - PROCESS | 2586 | __metrics Screen width/height:1600/1200 08:17:56 INFO - PROCESS | 2586 | colorDepth:24 08:17:56 INFO - PROCESS | 2586 | Browser inner width/height: 1024/697 08:17:56 INFO - PROCESS | 2586 | __metrics 08:17:57 ERROR - PROCESS | 2586 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:17:57 INFO - TEST-INFO | 2586: exit 0 08:17:57 INFO - Browser initialized. 08:17:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:57 INFO - TEST-INFO | started process 2680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpixAEix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:09 INFO - PROCESS | 2680 | RSS: Main: 152698880 08:18:09 INFO - PROCESS | 2680 | 08:19:00 INFO - PROCESS | 2680 | 1463411940744 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] 08:21:08 INFO - PROCESS | 2680 | Cycle 1(1): loaded http://localhost:53537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53537/tests/dromaeo/cssquery-ext.html) 08:21:09 INFO - PROCESS | 2680 | RSS: Main: 265437184 08:21:09 INFO - PROCESS | 2680 | 08:24:11 INFO - PROCESS | 2680 | Cycle 1(1): loaded http://localhost:53537/tests/dromaeo/cssquery-ext.html (next: http://localhost:53537/tests/dromaeo/cssquery-jquery.html) 08:24:12 INFO - PROCESS | 2680 | RSS: Main: 240406528 08:24:12 INFO - PROCESS | 2680 | 08:27:14 INFO - PROCESS | 2680 | Cycle 1(1): loaded http://localhost:53537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53537/tests/dromaeo/cssquery-mootools.html) 08:27:14 INFO - PROCESS | 2680 | RSS: Main: 234745856 08:27:14 INFO - PROCESS | 2680 | 08:30:16 INFO - PROCESS | 2680 | Cycle 1(1): loaded http://localhost:53537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53537/tests/dromaeo/cssquery-prototype.html) 08:30:17 INFO - PROCESS | 2680 | RSS: Main: 231063552 08:30:17 INFO - PROCESS | 2680 | 08:33:20 INFO - PROCESS | 2680 | Cycle 1(1): loaded http://localhost:53537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53537/tests/dromaeo/cssquery-yui.html) 08:33:20 INFO - PROCESS | 2680 | RSS: Main: 206282752 08:33:20 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | Cycle 1(1): loaded http://localhost:53537/tests/dromaeo/cssquery-yui.html (next: http://localhost:53537/tests/dromaeo/cssquery-dojo.html) 08:36:23 INFO - PROCESS | 2680 | RSS: Main: 259153920 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | __start_tp_report 08:36:23 INFO - PROCESS | 2680 | _x_x_mozilla_page_load 08:36:23 INFO - PROCESS | 2680 | _x_x_mozilla_page_load_details 08:36:23 INFO - PROCESS | 2680 | |i|pagename|runs| 08:36:23 INFO - PROCESS | 2680 | |0;dojo.html;3166.7149956503927;3193.0420873737876;3225.6129264488263;3238.352329534091;3256.055743834288;5341;5362.731863406829;5404.513593776559;5427.701476418795;5457.29055222821;5446.482584154509;5454.263674403955;5458.781648734046;5497.230387745719;5516.034693928566;4858.3927009123945;4950.900981980359;4983.72589507577;4994.725290109042;5116.462771409004;5005.374328208974;5023.422306434752;5058.721770302632;5076.390833100033;5078;4809.230523116302;4881.926771098454;4886.315915771795;4886.438059623153;4895.902081958377;4896.6817156885045;4970.925436118461;4975.502449755032;4982.626303027251;5017.774200161001;4783.856484305476;4865.781039853215;4942.406911170647;4961.330220420269;5007.399112106534;5327.733613319358;5381.085215513333;5384.757685904144;5444.455554444564;5452.018636645442;5890.087036509348;5906.675132867691;5922.1116832475045;5925.259342582177;5927.229460170151;5770.682612456313;5781.566382521328;5783.450572195635;5869.295684517842;5907.2911250650195;5462.426445223234;5470.234167216513;5470.507654311131;5471.316085489274;5476.561875050026;5970.014947533695;5977.103434484775;5979.521638269015;5983.461488466059;5986.132010858489;5574.470425309589;5707.543396528268;5726.79956201531;5731.340895797037;5738.569607279471;5855.268091488564;5865.442782935615;5868.794592189253;5913.2608423947;5918.201042859159;5791.482643538047;5841.211436456109;5842.357340692521;5848.385919478394;5849.590528663038;5705.857353566111;5706.9429305707245;5707.571932105108;5735.541156707453;5781.768729250867;4375.1031038637;4377.277749171415;4379.605835474823;4387.166438376762;4419.248727716296;3869.5743468218475;3911.9804400977814;3925.2542017016676;3941.7240793144206;3966.920661586752;5463.617546771768;5466.125419932791;5513.558915286768;5542.63972841764;5546.500814926676;5848.970755146197;5877.500412464989;5883.441073098049;5893.823185304448;5895.322037965603;5397.2443857859935;5441.918371224356;5481.75332110056;5523.861903452445;5539.584531160179;4824.903501929942;4841.540053694894;4852.587530059914;4884;4892.8532144035735;6007.939920600826;6013;6013.338532761392;6013.879722405527;6014.548908831855;5698.601097923106;5837.124431335334;5849.122631605123;5854.677992710272;5879.97100507401;5955.583109182316;5961.926853166472;5979.701014949148;5996.70016499182;6027.728752206073;5762.366139724543;5770.13447982806;5770.682612456355;5778.104393818965;5787.074068149076;5642.71786410686;5761;5781.5663825214115;5813.563982701399;5845.09401042839;5658.5473162147755;5664.433556644302;5665.12190610456;5671.149327600893;5673.659580425187;5555.805546805843;5627.7467513961155;5659.603827732019;5675.177099320658;5679.346875109415;5519.061759500814;5539.7784088636;5560.221568980265;5578.665280083208;5596.216529685766;5668.37647858727;5703.258576385043;5789.797357092481;5797.681127537857;5801.158831969426;5425.457454254543;5524.281843360337;5612.7754889803955;5627.352854421631;5663.8867222656145 08:36:23 INFO - PROCESS | 2680 | |1;ext.html;599.8080614203454;640.8910485217513;645.2128403347917;653.1737352249404;659.8548319369737;32429.51355729663;45048.3242751359;45503.31745023823;45564.316535252;49187.75406122964;46243.53756462434;46705.532944670544;46793;46801.29798053032;46810;8988.820223595541;9142.63429462824;9143.405678630901;9145.176934075931;9147.95426022869;8856.822863542726;8934.061923498004;8957.059508751585;8962.103789621018;8966.596503157374;9024.593893274818;9052.230560402373;9065.95467022664;9070.319726020574;9072.546372681372;8966;8995.775105622346;9011;9011.594478248462;9011.999999999967;8853.203211710977;8908.287337013024;8919.643214271422;8922;8930.732078037669;42768.57231427677;43382.78308608437;43499.34750978738;43544.34683479751;43546.12907741827;3353.5808023997;3467.739919506047;3490.9301813963834;3603.585587657427;4438.201123797715;31909;31977;32119;32847.507287390705;32942.835285823654;4275.914481710349;4392.209402307583;4397.824087036514;4398.6700997425005;4418.248897687368;333266.33366833255;334525;334731;336374;336620;53783.46216537863;56137;56766.716166418904;56835.43164568384;56927.14609280864;60432;60765.22730340611;60998.695006524686;66871;66921.33078669249;17150.742738858928;17267.481975540755;17279;17284.481465556055;17308.913455432896;11537.077033837273;11688.298702077902;13340.399682014333;13410.530631428048;13445.932770336085;16352.591185220464;16560.917195413946;16673;17169.399071032705;17186.140692965302;6385.776497822647;6419.935800641933;6437.935620643827;6608.669566521655;6731.596104233761;1040.8959104089531;1078.397299041768;1080.5137688040413;1127.6898852815377;1169.5438778876246;32677.50983735246;32863.671363286536;33249.168770780925;33307.16732081669;33340.49989250163;1121.506537123663;1172.7713095946378;1178.7583545373177;1198.8861058199457;1253.473541112735;17638.647227055386;17686.204120814593;17714.025728584795;17736;17869.195886185153;524162;526415;526440;527008;530369;59935;60175.09737353943;60387.39612603818;60509.39490605125;60604.393956060754;1283.4545318239711;1408.5281430720822;1413.6671103069061;1433.5054406229833;1466.0910235653962;33308;34569.1357716049;35023.47464788081;35037.47443788294;35103.64896351106;51345.743271283405;51458.48541514537;51949.7402512985;52120.478795211566;52134.47865521296;401561;402744;403016;404885;405885;35259.47110793289;40363.3945490812;40940.1811963765;40977.59022409738;44546.554534455536;49350.75324623354;49359.506404936925;49667;49809.75095124501;50521;40421.98945026398;40558.79720601378;41675.58324416838;41761.58238417577;42066.57933420627;38206.61793382031;40100.598994009684;41151.794241028605;41494.58505415028;42408.36387454129;42753.572464274956;43455.782721086194;43899.78050109729;43907.34138987982;44001.33997989968;37003;37848;38124;38639.80680096582;38773.22453550857;29055.7094429053;29132.417351652424;29186.708132919248;29317.120486385444;29685 08:36:23 INFO - PROCESS | 2680 | |2;jquery.html;393.73226206179794;399.61237599528454;400.94587230723846;403.5863240178818;416.43780895790667;18352.265909363625;19733;19997.600047999033;20006.09972551235;20907.68638470424;19153.61692766144;19572;20276;20288.18847246112;20292.289769858056;5404.945950540503;5490.80782172624;5697.515711164556;5709.314882214119;5778;5744.770209191627;5758;5816.476517113459;6561.901571476432;6572.21133463985;6516.543841931067;6519.152510173671;6521.445677117451;6535.60786352818;6551.541392102555;5877.2947246330505;5880;5888.646681199099;5889.263842019747;6232.688365581703;5523.861903452405;5701.6864072476;5703.173039909231;5726.427357264281;5745.023346031143;13825.930870345685;13856.30718464083;21680.783192168034;23437.296881093593;23908.40228994289;2240.350298413458;2252.40311317501;2518.962215566768;2537.1880998080624;2550.3369124027886;10524.36853788775;11691.298522088702;12703.682407939783;14850.925745371313;15004.624884377869;1939.4472575315967;1956.5304326961568;1981.8018198180212;1999.4601457606366;2028.3610662641368;76954.23045769526;77205;79744;81695.18304816935;82004.9999999994;10668.679939601825;10797.460126993776;10932.398718070583;11077.778444431066;11192.481691619321;15300.387984480496;15381.461648842236;15390.769138462932;15398.07611543311;15436;8183.181681831888;8323.750287491384;8394.706185283485;8474.957625211835;8554.78613034679;8257.298129659046;8257.587120644064;8280.130586288353;8497.957510212409;8511.148885111439;4540.387047748512;4589.701669391546;4644.210484217691;4654.25531914892;4820.373351464287;1913.1104036623037;1929.729837822706;1937.321937321926;1965.7837637859825;1991.2134706791026;925.7824411263348;1012.584840215508;1055.4617145255975;1066.0991462214417;1101.64196636092;18555.16501757424;18585.628287434174;19113.331033413764;19449.8055019448;19797.331431458228;1042.1714736784274;1094.7044298039643;1100.8128618134936;1104.7127746785734;1112.9888701112886;10497.2127090467;10929.726756830984;11025.944870275598;11030.28303160292;11067.72330691739;480650;490058;497380;502377;505571;95142.52428737812;95438;95820.60448488843;95978;96665;975.8682577852042;992.8907820139779;994.7314225159166;1000.0449570660003;1075.2097208551709;17284.481465556055;17361.30554777795;17362.47912562625;17610.73583896217;17695.93824370542;37658.8117059413;38862;40172.79481615556;40786;44602.330965034904;60450.69774651274;60988;61431.078533822925;61817.690911545156;62874;6799.422049125879;11199.776004480027;11414.885851141382;11510.94244528772;12308.26150430977;13875.653108672364;13903.304834758019;13904.235267060005;13984.720305594035;14227.715445690821;12221.75556488883;12417.503299867903;12568.74862502763;12616.684582885502;12778.552750653682;12002.699932501757;12143.14997950135;12146.39268036577;12393;12726.490940362282;12438.19151755133;12563.246205227715;12626;12950.158239714388;13009.869901300866;12666.43001064936;12789.488420463078;12830.16603920742;12884.355782210665;13036.348182590642;12508.997840518392;12549.121561490972;12880.291583962971;12886.42011109521;12977.416016279101 08:36:23 INFO - PROCESS | 2680 | |3;mootools.html;1415.299426783742;1573.2998815527092;1594.5296137639398;1746.2491128814613;1911.0635788463658;8509.744707658772;8791.824163516734;8857.247133993618;9251.352405331629;9254.07459254076;8791.692290769824;8956.119214964849;8962.731118066453;8970.327225458084;8974.237189838872;2073.751149862019;2147.4309308033385;2149.6023235701446;2357.634566642173;2400.3639035655565;2324.6048171810835;2371.205646108547;2371.2886134159685;2375.5486457573006;2376.4652953085592;2271.3867255840914;2278.487340348425;2295;2295.483516208856;2304.343262170282;1906.304198967367;1970.9408717738347;2300.884955752214;2336.474293284006;2339.988300058506;2072.77199508054;2265.456290490287;2327.837051406402;2332.3935776698013;2347.2019513365367;8909.73270801877;8937.240334571568;8967.372283940127;8978.640854365818;9006.414583052081;5074.517920797518;5186.40356359016;5191.532762051395;5194.71429071401;5197.870053248661;3284.934301313984;3299.6700329967052;3383.0865666270215;3426.229098452853;3429.005588379367;1047.2198212331784;1049.2235745548317;1061.5488417422641;1064.302881612545;1068.076114161245;12725.745485090247;12779.616611501577;12797.680057998532;12849.293288869108;12850.55023074188;4566.20091483989;4596.770161491912;4656.906861862812;4699.342092107107;4705.12955103307;10062.69811905644;10107;10109.39343639384;10125.443100629536;10126.088652021206;5212.087884620252;5257.921131183035;5259.211118332204;5268.28878101459;5269.841904742864;4392.231359512072;4852.053849499384;4898.044881248123;4965.404151501771;4966.90066198674;3889.8249578769023;3915.0799562102884;3974.682025437958;3996.540397854284;4109.589041095866;1089.2538611051455;1089.803835309652;1090.2586241355796;1097.5884043483693;1132.1452303510962;864.4631137563913;901.900790912999;987.3730181334904;1027.3733022856052;1062.8246339354075;6238.968805156036;6266.3758727560635;6352.269489008823;6356.682165891687;6517.674116294261;406.32347142008814;410.71455338539425;413.52857742173944;414.05595242846357;429.336674837377;4364.454443194601;4366.781660916941;4387.934180987288;4397.670174736843;4429.202743506135;10999.625046869141;11431.971122599007;11437;11469.942650286695;11498.59754908591;10996.0653344465;11127.944360278147;11139.498722557504;11142.331460112418;11233.550657973752;7718.845623087507;7960.800979975547;7982.720604778805;8114;8157.632906519221;6067.271927368567;6302.1492098566105;6337.176167098248;6374.247082052472;6386.840328991812;9399.81200375975;9687.564059617192;9748.951255243963;9760.60957561718;10130.341527800669;10156.593736250763;10199.847002294822;10247.231457640557;10292.433916134685;10297.794044119226;7720.922790772021;7728.652210650646;7768.106667733057;7804.219578042151;7805.843883122192;8385.874211886949;8394.370422218235;8399.748007559783;8399.832003360021;8491.23578877904;7663.501872378278;7710.344620707303;7747.031621047369;7809.453338266267;7823.569703666353;7307.5980821055355;7464.477486575887;7484.139323977594;7500.212477689764;7582.203868593939;7045.542039767399;7108.928910710827;7214.206437291999;7223.819404514929;7258.237885022208;5364.544013758874;5372.382176049804;5484.341878974389;5492.505674489315;5604.523615492729;5530.142827861688;5576.7662908389575;5607.971960140173;5696.54427645779;5712.34308054579 08:36:23 INFO - PROCESS | 2680 | |4;prototype.html;323.7329203407191;334.9263162104337;335.6157200005995;335.6710423784691;339.0050202655207;5221.608379371548;5265.3681558212975;5342.252084708139;5383.515483606475;5391.137418013119;5241.213817927312;5268.841934741964;5274.182501712231;5274.681329667583;5287.889543195924;4165.500419848852;4193.6645068394455;4199.202151591203;4214.051838336381;4233.322668373061;3997.72015958883;4070.816813243396;4201.138766552865;4207;4207.137536804948;4117.732347397409;4120.877747959788;4151.626353628173;4156.524433825994;4172.4784401949755;3999.1201935574127;4164.00063984643;4178.143480586473;4196.139791342767;4201.34879093741;3646.6353364663587;3701.38927077032;3701.6668499835146;3713.591504934455;3721.1813401051727;5131.153359695646;5131.435542090367;5157.767900444489;5162.070827251093;5165.708572856785;4583.349994002157;4764.928526072112;4766.213574760161;4769.785359658789;4784.736839473828;5447.945520544784;5510.91733623996;5522;5555.805546805883;5579.721013949327;3997.400389941503;4033.737807042533;4043.6765058795227;4080.0411903202726;4088.897777555555;5568.55451563878;5757.740901659394;5783.248177736868;5817.912731309034;5822.737976791054;4121.845883152722;4129.483814523184;4153;4158.126793373365;4167.854125105607;4187.1625674865145;4208;4212.115455754326;4221.472315960505;4230.894227644333;4768.690035147704;4776.5701086902345;4776.59398951093;4797.40032495938;4799.232122860395;5452.6183167177915;5548.4174161712435;5567.109262518059;5569.526590239875;5593.993081245333;1414.610981979943;1418.2483283859572;1419.1626940105182;1433.992830035864;1444.4294503671201;919.3564504846634;938.6955025412595;940.1068984464786;950.4487397309543;956.402807311791;4763.332833508313;4778.235482322812;4806.269742892556;5206.8958620828125;5317.361916569959;5691.715414229272;5774.94225057744;5781.364049954502;5798.811243695032;5811.692369216977;5452.263944367539;5466.371367292732;5467.7424192435965;5479.479449452296;5504.394516603171;2882.5820256062752;2999.7600191985025;3047.6342838859478;3060.9286749637895;3077.38452309539;5926.140709597084;5950.702464876739;5961.970190149022;5971.253593300838;5978.4021597839865;5626.887462250732;5858.355580886099;5887.499562537147;5914.2498738087;5922.703864806743;5983.14522498027;5992.730327135289;5994.820155395345;5996.481477779256;6017.548683848729;5802.94197058024;5818.7090645466715;5823.272090988627;5825.3592104867585;5842.941570584239;5503.11950087984;5693.800716974886;5699.173619825019;5707.828765137053;5710.428957104256;5905.261842269716;5942.524598032233;5957.434043765836;5966.433188847052;6005.759769609167;3862.517185351831;4135.7518548887165;4136.172765446983;4166.91666166681;4175.415441838206;5642.012647786703;5692;5701.144828275792;5721.656700597978;5748.252727145445;5558.24963629921;5570.5543556516195;5575.275214222287;5581.804636837691;5607.822357304848;5267.920981185209;5552.222688823487;5552.750126244409;5555.50000499957;5566.638168519034;5364.463553644604;5440.183972404171;5470.480304371078;5493.258410114583;5498.642588231752;5459.672419654675;5495.450454954473;5589.3511414133745;5641.097424412074;5642.492175704207;5492.890142197213;5496.395396506301;5497.752601133038;5524.116141417354;5528.668279903219 08:36:23 INFO - PROCESS | 2680 | |5;yui.html;862.2799962031703;871.7341210930667;883.58913105406;883.6818745251712;899.9055099214578;16283.918580407111;17176.3129474821;17182.656346873086;17183.054931978735;17208.91395543022;15372.154531500762;15446.227688615552;15502.30239639216;15546.222688865568;15561.144137072457;711.9288071192891;835.0814104485079;861.4788053227801;872.2542226396434;881.5724373678761;865.2169786343338;870.4081224767156;872.7948932000975;875.7372788163557;876.1457578860624;905.1039470923804;907.2379201470764;907.3240435875282;907.591583787295;907.7549061753323;744.7281742164098;892.1034360467721;902.702108304258;909.9044600316938;910.7950711090018;660.352854202879;666.6699983508146;667.0860920538844;667.432682220109;668.2982867988593;15053.548393548212;15123.697526049418;15153;15155.924220378827;15176.924115379352;13536.390862411117;13835.79246311306;13838.723225535434;13857.722845543134;13865;13004.869951300461;13156.736865262737;13181.340932953313;13234.205947643171;13328.067035307435;4290.099079193373;4307.073979094478;4330.588594083557;4345.217860785057;4372.453443319585;60103.69948150275;60139.69930150321;61432.69283653598;61476.692616537526;61492;10797.46012699362;10897.782044359068;10916.07213386871;11006.944965275123;11224.214304998572;19977.400677979684;20437.795622043886;20493;20496.59006819885;20500.38498845037;8562.357823163287;8864.157904999014;8917.197452229331;9008.189262966365;9100.681476148435;4872.19608764557;4905.337779399807;5026.698398096053;5072.087024335655;5073.264376665363;3284.786488878215;3374.122728090665;3380.087376408356;3383.4586466165297;3388.0513456232293;623.2707731953625;624.4255285137684;632.2255237334228;640.638039507686;645.9289478157399;659.2715049869921;706.3501578547748;706.3783870194196;743.9814004649927;792.2157064506098;9283.210927071139;9520.523973801282;9563.474008929576;9582.425054496753;9603.615855365708;731.7146312937958;778.2023425988407;789.2305002622397;808.3654331349862;812.6018251057058;4485.865424037284;4590.449146102423;4668.183067963093;4761.880972958366;4858.854234372974;49211.75394123006;49643.50356496461;56457.43542564522;74195.62902185455;74234;63543;63904.68047659732;64096.35903640904;64191.99999999907;65127.67436162789;56189.43810561842;58506.707466463246;58513.12230316549;58740;59368.70315648394;9158;9186.127317904788;9222.40054396462;9235.307351948764;9291.86062209081;38553.2289354217;38561;38615.979922609884;38646.806765965994;39423;49193.2621010678;51591.226131608804;51633.483665162865;52138.73930630474;52699.736501317246;11267.323960562393;11342.262752921364;11539.942300288445;11605.535778569101;11880.821787673365;12606.55877044299;13190.80213796813;13643.181409115485;13738.519151829638;14221.502247421291;11998.64004079879;12406.069544783997;12861.871381286068;12871.613851584092;13026.609201723963;11638.941805290919;11886.702832429259;12119.151659384112;12142.482189726285;12624.74750505003;12275.386230688608;12506;12567.371631418575;12838.101332906606;13192.472301108231;10092;10161.796764064826;10170.288079834636;10214.285000049926;10505.527251273865;9926.652567160114;10037.297389182688;10075.546600402853;10131.189504839742;10319.845202321821 08:36:23 INFO - PROCESS | 2680 | __end_tp_report 08:36:23 INFO - PROCESS | 2680 | __start_cc_report 08:36:23 INFO - PROCESS | 2680 | _x_x_mozilla_cycle_collect,875 08:36:23 INFO - PROCESS | 2680 | __end_cc_report 08:36:23 INFO - PROCESS | 2680 | __startTimestamp1463412983534__endTimestamp 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | ------- Summary: start ------- 08:36:23 INFO - PROCESS | 2680 | Number of tests: 6 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | [#0] dojo.html Cycles:165 Average:5399.44 Median:5578.67 stddev:616.45 (11.1%) stddev-sans-first:592.94 08:36:23 INFO - PROCESS | 2680 | Values: 3166.7 3193.0 3225.6 3238.4 3256.1 5341.0 5362.7 5404.5 5427.7 5457.3 5446.5 5454.3 5458.8 5497.2 5516.0 4858.4 4950.9 4983.7 4994.7 5116.5 5005.4 5023.4 5058.7 5076.4 5078.0 4809.2 4881.9 4886.3 4886.4 4895.9 4896.7 4970.9 4975.5 4982.6 5017.8 4783.9 4865.8 4942.4 4961.3 5007.4 5327.7 5381.1 5384.8 5444.5 5452.0 5890.1 5906.7 5922.1 5925.3 5927.2 5770.7 5781.6 5783.5 5869.3 5907.3 5462.4 5470.2 5470.5 5471.3 5476.6 5970.0 5977.1 5979.5 5983.5 5986.1 5574.5 5707.5 5726.8 5731.3 5738.6 5855.3 5865.4 5868.8 5913.3 5918.2 5791.5 5841.2 5842.4 5848.4 5849.6 5705.9 5706.9 5707.6 5735.5 5781.8 4375.1 4377.3 4379.6 4387.2 4419.2 3869.6 3912.0 3925.3 3941.7 3966.9 5463.6 5466.1 5513.6 5542.6 5546.5 5849.0 5877.5 5883.4 5893.8 5895.3 5397.2 5441.9 5481.8 5523.9 5539.6 4824.9 4841.5 4852.6 4884.0 4892.9 6007.9 6013.0 6013.3 6013.9 6014.5 5698.6 5837.1 5849.1 5854.7 5880.0 5955.6 5961.9 5979.7 5996.7 6027.7 5762.4 5770.1 5770.7 5778.1 5787.1 5642.7 5761.0 5781.6 5813.6 5845.1 5658.5 5664.4 5665.1 5671.1 5673.7 5555.8 5627.7 5659.6 5675.2 5679.3 5519.1 5539.8 5560.2 5578.7 5596.2 5668.4 5703.3 5789.8 5797.7 5801.2 5425.5 5524.3 5612.8 5627.4 5663.9 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | [#1] ext.html Cycles:180 Average:59502.19 Median:42761.07 stddev:113524.30 (265.5%) stddev-sans-first:113756.62 08:36:23 INFO - PROCESS | 2680 | Values: 599.8 640.9 645.2 653.2 659.9 32429.5 45048.3 45503.3 45564.3 49187.8 46243.5 46705.5 46793.0 46801.3 46810.0 8988.8 9142.6 9143.4 9145.2 9148.0 8856.8 8934.1 8957.1 8962.1 8966.6 9024.6 9052.2 9066.0 9070.3 9072.5 8966.0 8995.8 9011.0 9011.6 9012.0 8853.2 8908.3 8919.6 8922.0 8930.7 42768.6 43382.8 43499.3 43544.3 43546.1 3353.6 3467.7 3490.9 3603.6 4438.2 31909.0 31977.0 32119.0 32847.5 32942.8 4275.9 4392.2 4397.8 4398.7 4418.2 333266.3 334525.0 334731.0 336374.0 336620.0 53783.5 56137.0 56766.7 56835.4 56927.1 60432.0 60765.2 60998.7 66871.0 66921.3 17150.7 17267.5 17279.0 17284.5 17308.9 11537.1 11688.3 13340.4 13410.5 13445.9 16352.6 16560.9 16673.0 17169.4 17186.1 6385.8 6419.9 6437.9 6608.7 6731.6 1040.9 1078.4 1080.5 1127.7 1169.5 32677.5 32863.7 33249.2 33307.2 33340.5 1121.5 1172.8 1178.8 1198.9 1253.5 17638.6 17686.2 17714.0 17736.0 17869.2 524162.0 526415.0 526440.0 527008.0 530369.0 59935.0 60175.1 60387.4 60509.4 60604.4 1283.5 1408.5 1413.7 1433.5 1466.1 33308.0 34569.1 35023.5 35037.5 35103.6 51345.7 51458.5 51949.7 52120.5 52134.5 401561.0 402744.0 403016.0 404885.0 405885.0 35259.5 40363.4 40940.2 40977.6 44546.6 49350.8 49359.5 49667.0 49809.8 50521.0 40422.0 40558.8 41675.6 41761.6 42066.6 38206.6 40100.6 41151.8 41494.6 42408.4 42753.6 43455.8 43899.8 43907.3 44001.3 37003.0 37848.0 38124.0 38639.8 38773.2 29055.7 29132.4 29186.7 29317.1 29685.0 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | [#2] jquery.html Cycles:180 Average:29643.42 Median:20001.85 stddev:81634.15 (408.1%) stddev-sans-first:81833.61 08:36:23 INFO - PROCESS | 2680 | Values: 393.7 399.6 400.9 403.6 416.4 18352.3 19733.0 19997.6 20006.1 20907.7 19153.6 19572.0 20276.0 20288.2 20292.3 5404.9 5490.8 5697.5 5709.3 5778.0 5744.8 5758.0 5816.5 6561.9 6572.2 6516.5 6519.2 6521.4 6535.6 6551.5 5877.3 5880.0 5888.6 5889.3 6232.7 5523.9 5701.7 5703.2 5726.4 5745.0 13825.9 13856.3 21680.8 23437.3 23908.4 2240.4 2252.4 2519.0 2537.2 2550.3 10524.4 11691.3 12703.7 14850.9 15004.6 1939.4 1956.5 1981.8 1999.5 2028.4 76954.2 77205.0 79744.0 81695.2 82005.0 10668.7 10797.5 10932.4 11077.8 11192.5 15300.4 15381.5 15390.8 15398.1 15436.0 8183.2 8323.8 8394.7 8475.0 8554.8 8257.3 8257.6 8280.1 8498.0 8511.1 4540.4 4589.7 4644.2 4654.3 4820.4 1913.1 1929.7 1937.3 1965.8 1991.2 925.8 1012.6 1055.5 1066.1 1101.6 18555.2 18585.6 19113.3 19449.8 19797.3 1042.2 1094.7 1100.8 1104.7 1113.0 10497.2 10929.7 11025.9 11030.3 11067.7 480650.0 490058.0 497380.0 502377.0 505571.0 95142.5 95438.0 95820.6 95978.0 96665.0 975.9 992.9 994.7 1000.0 1075.2 17284.5 17361.3 17362.5 17610.7 17695.9 37658.8 38862.0 40172.8 40786.0 44602.3 60450.7 60988.0 61431.1 61817.7 62874.0 6799.4 11199.8 11414.9 11510.9 12308.3 13875.7 13903.3 13904.2 13984.7 14227.7 12221.8 12417.5 12568.7 12616.7 12778.6 12002.7 12143.1 12146.4 12393.0 12726.5 12438.2 12563.2 12626.0 12950.2 13009.9 12666.4 12789.5 12830.2 12884.4 13036.3 12509.0 12549.1 12880.3 12886.4 12977.4 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | [#3] mootools.html Cycles:180 Average:5850.41 Median:4626.84 stddev:3374.75 (72.9%) stddev-sans-first:3367.76 08:36:23 INFO - PROCESS | 2680 | Values: 1415.3 1573.3 1594.5 1746.2 1911.1 8509.7 8791.8 8857.2 9251.4 9254.1 8791.7 8956.1 8962.7 8970.3 8974.2 2073.8 2147.4 2149.6 2357.6 2400.4 2324.6 2371.2 2371.3 2375.5 2376.5 2271.4 2278.5 2295.0 2295.5 2304.3 1906.3 1970.9 2300.9 2336.5 2340.0 2072.8 2265.5 2327.8 2332.4 2347.2 8909.7 8937.2 8967.4 8978.6 9006.4 5074.5 5186.4 5191.5 5194.7 5197.9 3284.9 3299.7 3383.1 3426.2 3429.0 1047.2 1049.2 1061.5 1064.3 1068.1 12725.7 12779.6 12797.7 12849.3 12850.6 4566.2 4596.8 4656.9 4699.3 4705.1 10062.7 10107.0 10109.4 10125.4 10126.1 5212.1 5257.9 5259.2 5268.3 5269.8 4392.2 4852.1 4898.0 4965.4 4966.9 3889.8 3915.1 3974.7 3996.5 4109.6 1089.3 1089.8 1090.3 1097.6 1132.1 864.5 901.9 987.4 1027.4 1062.8 6239.0 6266.4 6352.3 6356.7 6517.7 406.3 410.7 413.5 414.1 429.3 4364.5 4366.8 4387.9 4397.7 4429.2 10999.6 11432.0 11437.0 11469.9 11498.6 10996.1 11127.9 11139.5 11142.3 11233.6 7718.8 7960.8 7982.7 8114.0 8157.6 6067.3 6302.1 6337.2 6374.2 6386.8 9399.8 9687.6 9749.0 9760.6 10130.3 10156.6 10199.8 10247.2 10292.4 10297.8 7720.9 7728.7 7768.1 7804.2 7805.8 8385.9 8394.4 8399.7 8399.8 8491.2 7663.5 7710.3 7747.0 7809.5 7823.6 7307.6 7464.5 7484.1 7500.2 7582.2 7045.5 7108.9 7214.2 7223.8 7258.2 5364.5 5372.4 5484.3 5492.5 5604.5 5530.1 5576.8 5608.0 5696.5 5712.3 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | [#4] prototype.html Cycles:180 Average:4705.10 Median:5387.33 stddev:1382.16 (25.7%) stddev-sans-first:1346.35 08:36:23 INFO - PROCESS | 2680 | Values: 323.7 334.9 335.6 335.7 339.0 5221.6 5265.4 5342.3 5383.5 5391.1 5241.2 5268.8 5274.2 5274.7 5287.9 4165.5 4193.7 4199.2 4214.1 4233.3 3997.7 4070.8 4201.1 4207.0 4207.1 4117.7 4120.9 4151.6 4156.5 4172.5 3999.1 4164.0 4178.1 4196.1 4201.3 3646.6 3701.4 3701.7 3713.6 3721.2 5131.2 5131.4 5157.8 5162.1 5165.7 4583.3 4764.9 4766.2 4769.8 4784.7 5447.9 5510.9 5522.0 5555.8 5579.7 3997.4 4033.7 4043.7 4080.0 4088.9 5568.6 5757.7 5783.2 5817.9 5822.7 4121.8 4129.5 4153.0 4158.1 4167.9 4187.2 4208.0 4212.1 4221.5 4230.9 4768.7 4776.6 4776.6 4797.4 4799.2 5452.6 5548.4 5567.1 5569.5 5594.0 1414.6 1418.2 1419.2 1434.0 1444.4 919.4 938.7 940.1 950.4 956.4 4763.3 4778.2 4806.3 5206.9 5317.4 5691.7 5774.9 5781.4 5798.8 5811.7 5452.3 5466.4 5467.7 5479.5 5504.4 2882.6 2999.8 3047.6 3060.9 3077.4 5926.1 5950.7 5962.0 5971.3 5978.4 5626.9 5858.4 5887.5 5914.2 5922.7 5983.1 5992.7 5994.8 5996.5 6017.5 5802.9 5818.7 5823.3 5825.4 5842.9 5503.1 5693.8 5699.2 5707.8 5710.4 5905.3 5942.5 5957.4 5966.4 6005.8 3862.5 4135.8 4136.2 4166.9 4175.4 5642.0 5692.0 5701.1 5721.7 5748.3 5558.2 5570.6 5575.3 5581.8 5607.8 5267.9 5552.2 5552.8 5555.5 5566.6 5364.5 5440.2 5470.5 5493.3 5498.6 5459.7 5495.5 5589.4 5641.1 5642.5 5492.9 5496.4 5497.8 5524.1 5528.7 08:36:23 INFO - PROCESS | 2680 | 08:36:23 INFO - PROCESS | 2680 | [#5] yui.html Cycles:180 Average:15975.99 Median:27049.30 stddev:19049.14 (70.4%) stddev-sans-first:19068.76 08:36:23 INFO - PROCESS | 2680 | Values: 862.3 871.7 883.6 883.7 899.9 16283.9 17176.3 17182.7 17183.1 17208.9 15372.2 15446.2 15502.3 15546.2 15561.1 711.9 835.1 861.5 872.3 881.6 865.2 870.4 872.8 875.7 876.1 905.1 907.2 907.3 907.6 907.8 744.7 892.1 902.7 909.9 910.8 660.4 666.7 667.1 667.4 668.3 15053.5 15123.7 15153.0 15155.9 15176.9 13536.4 13835.8 13838.7 13857.7 13865.0 13004.9 13156.7 13181.3 13234.2 13328.1 4290.1 4307.1 4330.6 4345.2 4372.5 60103.7 60139.7 61432.7 61476.7 61492.0 10797.5 10897.8 10916.1 11006.9 11224.2 19977.4 20437.8 20493.0 20496.6 20500.4 8562.4 8864.2 8917.2 9008.2 9100.7 4872.2 4905.3 5026.7 5072.1 5073.3 3284.8 3374.1 3380.1 3383.5 3388.1 623.3 624.4 632.2 640.6 645.9 659.3 706.4 706.4 744.0 792.2 9283.2 9520.5 9563.5 9582.4 9603.6 731.7 778.2 789.2 808.4 812.6 4485.9 4590.4 4668.2 4761.9 4858.9 49211.8 49643.5 56457.4 74195.6 74234.0 63543.0 63904.7 64096.4 64192.0 65127.7 56189.4 58506.7 58513.1 58740.0 59368.7 9158.0 9186.1 9222.4 9235.3 9291.9 38553.2 38561.0 38616.0 38646.8 39423.0 49193.3 51591.2 51633.5 52138.7 52699.7 11267.3 11342.3 11539.9 11605.5 11880.8 12606.6 13190.8 13643.2 13738.5 14221.5 11998.6 12406.1 12861.9 12871.6 13026.6 11638.9 11886.7 12119.2 12142.5 12624.7 12275.4 12506.0 12567.4 12838.1 13192.5 10092.0 10161.8 10170.3 10214.3 10505.5 9926.7 10037.3 10075.5 10131.2 10319.8 08:36:23 INFO - PROCESS | 2680 | -------- Summary: end -------- 08:36:23 INFO - PROCESS | 2680 | 08:36:24 INFO - TEST-INFO | 2680: exit 0 08:36:24 INFO - TEST-OK | dromaeo_css | took 1111853ms 08:36:24 INFO - TEST-START | kraken 08:36:24 INFO - operating with platform_type : linux_ 08:36:24 INFO - Initialising browser for kraken test... 08:36:24 INFO - TEST-INFO | started process 2951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDLhg7n/profile http://localhost:53537/getInfo.html) 08:36:27 INFO - PROCESS | 2951 | __metrics Screen width/height:1600/1200 08:36:27 INFO - PROCESS | 2951 | colorDepth:24 08:36:27 INFO - PROCESS | 2951 | Browser inner width/height: 1024/697 08:36:27 INFO - PROCESS | 2951 | __metrics 08:36:28 ERROR - PROCESS | 2951 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:36:29 INFO - TEST-INFO | 2951: exit 0 08:36:29 INFO - Browser initialized. 08:36:29 INFO - Running cycle 1/1 for kraken test... 08:36:29 INFO - TEST-INFO | started process 3033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDLhg7n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:41 INFO - PROCESS | 3033 | RSS: Main: 152297472 08:36:41 INFO - PROCESS | 3033 | 08:36:43 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53537/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:44 INFO - PROCESS | 3033 | RSS: Main: 208564224 08:36:44 INFO - PROCESS | 3033 | 08:36:47 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53537/tests/kraken/driver.html?testName=audio-dft) 08:36:47 INFO - PROCESS | 3033 | RSS: Main: 197697536 08:36:47 INFO - PROCESS | 3033 | 08:36:51 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53537/tests/kraken/driver.html?testName=audio-fft) 08:36:51 INFO - PROCESS | 3033 | RSS: Main: 265228288 08:36:51 INFO - PROCESS | 3033 | 08:36:53 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53537/tests/kraken/driver.html?testName=audio-oscillator) 08:36:54 INFO - PROCESS | 3033 | RSS: Main: 174284800 08:36:54 INFO - PROCESS | 3033 | 08:36:56 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:57 INFO - PROCESS | 3033 | RSS: Main: 178188288 08:36:57 INFO - PROCESS | 3033 | 08:37:00 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53537/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:01 INFO - PROCESS | 3033 | RSS: Main: 214372352 08:37:01 INFO - PROCESS | 3033 | 08:37:04 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53537/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:05 INFO - PROCESS | 3033 | RSS: Main: 212398080 08:37:05 INFO - PROCESS | 3033 | 08:37:08 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53537/tests/kraken/driver.html?testName=json-parse-financial) 08:37:09 INFO - PROCESS | 3033 | RSS: Main: 214028288 08:37:09 INFO - PROCESS | 3033 | 08:37:10 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:11 INFO - PROCESS | 3033 | RSS: Main: 203177984 08:37:11 INFO - PROCESS | 3033 | 08:37:13 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:13 INFO - PROCESS | 3033 | RSS: Main: 206581760 08:37:13 INFO - PROCESS | 3033 | 08:37:15 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:16 INFO - PROCESS | 3033 | RSS: Main: 216686592 08:37:16 INFO - PROCESS | 3033 | 08:37:19 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:19 INFO - PROCESS | 3033 | RSS: Main: 223285248 08:37:19 INFO - PROCESS | 3033 | 08:37:22 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:23 INFO - PROCESS | 3033 | RSS: Main: 219680768 08:37:23 INFO - PROCESS | 3033 | 08:37:24 INFO - PROCESS | 3033 | Cycle 1(1): loaded http://localhost:53537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53537/tests/kraken/driver.html?testName=ai-astar) 08:37:25 INFO - PROCESS | 3033 | RSS: Main: 265166848 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | __start_tp_report 08:37:25 INFO - PROCESS | 3033 | _x_x_mozilla_page_load 08:37:25 INFO - PROCESS | 3033 | _x_x_mozilla_page_load_details 08:37:25 INFO - PROCESS | 3033 | |i|pagename|runs| 08:37:25 INFO - PROCESS | 3033 | |0;ai-astar;111;106;111;109;110;109;110;110;110;110 08:37:25 INFO - PROCESS | 3033 | |1;audio-beat-detection;147;123;154;202;124;153;155;124;178;123 08:37:25 INFO - PROCESS | 3033 | |2;audio-dft;161;161;160;161;160;161;162;161;160;163 08:37:25 INFO - PROCESS | 3033 | |3;audio-fft;74;75;74;147;76;73;77;75;130;75 08:37:25 INFO - PROCESS | 3033 | |4;audio-oscillator;91;92;146;92;91;91;127;91;92;124 08:37:25 INFO - PROCESS | 3033 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;117;117;117 08:37:25 INFO - PROCESS | 3033 | |6;imaging-darkroom;146;149;146;147;146;145;145;146;146;147 08:37:25 INFO - PROCESS | 3033 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;94 08:37:25 INFO - PROCESS | 3033 | |8;json-parse-financial;53;53;54;59;53;54;53;107;51;52 08:37:25 INFO - PROCESS | 3033 | |9;json-stringify-tinderbox;58;60;58;58;58;58;64;59;59;59 08:37:25 INFO - PROCESS | 3033 | |10;stanford-crypto-aes;79;78;83;79;76;83;79;79;79;80 08:37:25 INFO - PROCESS | 3033 | |11;stanford-crypto-ccm;129;126;129;122;116;119;116;116;191;121 08:37:25 INFO - PROCESS | 3033 | |12;stanford-crypto-pbkdf2;174;161;166;165;159;161;160;160;159;160 08:37:25 INFO - PROCESS | 3033 | |13;stanford-crypto-sha256-iterative;62;62;63;61;62;62;62;62;62;61 08:37:25 INFO - PROCESS | 3033 | __end_tp_report 08:37:25 INFO - PROCESS | 3033 | __start_cc_report 08:37:25 INFO - PROCESS | 3033 | _x_x_mozilla_cycle_collect,1867 08:37:25 INFO - PROCESS | 3033 | __end_cc_report 08:37:25 INFO - PROCESS | 3033 | __startTimestamp1463413045006__endTimestamp 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | ------- Summary: start ------- 08:37:25 INFO - PROCESS | 3033 | Number of tests: 14 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:1.42 08:37:25 INFO - PROCESS | 3033 | Values: 111.0 106.0 111.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.50 stddev:26.52 (17.3%) stddev-sans-first:28.12 08:37:25 INFO - PROCESS | 3033 | Values: 147.0 123.0 154.0 202.0 124.0 153.0 155.0 124.0 178.0 123.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 08:37:25 INFO - PROCESS | 3033 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 162.0 161.0 160.0 163.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.00 stddev:27.15 (36.2%) stddev-sans-first:28.34 08:37:25 INFO - PROCESS | 3033 | Values: 74.0 75.0 74.0 147.0 76.0 73.0 77.0 75.0 130.0 75.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:91.00 stddev:20.55 (22.6%) stddev-sans-first:21.27 08:37:25 INFO - PROCESS | 3033 | Values: 91.0 92.0 146.0 92.0 91.0 91.0 127.0 91.0 92.0 124.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:37:25 INFO - PROCESS | 3033 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 08:37:25 INFO - PROCESS | 3033 | Values: 146.0 149.0 146.0 147.0 146.0 145.0 145.0 146.0 146.0 147.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:37:25 INFO - PROCESS | 3033 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:53.00 stddev:17.03 (32.1%) stddev-sans-first:17.93 08:37:25 INFO - PROCESS | 3033 | Values: 53.0 53.0 54.0 59.0 53.0 54.0 53.0 107.0 51.0 52.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:1.85 (3.1%) stddev-sans-first:1.92 08:37:25 INFO - PROCESS | 3033 | Values: 58.0 60.0 58.0 58.0 58.0 58.0 64.0 59.0 59.0 59.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.12 (2.7%) stddev-sans-first:2.24 08:37:25 INFO - PROCESS | 3033 | Values: 79.0 78.0 83.0 79.0 76.0 83.0 79.0 79.0 79.0 80.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:124.00 stddev:22.54 (18.2%) stddev-sans-first:23.90 08:37:25 INFO - PROCESS | 3033 | Values: 129.0 126.0 129.0 122.0 116.0 119.0 116.0 116.0 191.0 121.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:161.00 stddev:4.70 (2.9%) stddev-sans-first:2.54 08:37:25 INFO - PROCESS | 3033 | Values: 174.0 161.0 166.0 165.0 159.0 161.0 160.0 160.0 159.0 160.0 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - PROCESS | 3033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:37:25 INFO - PROCESS | 3033 | Values: 62.0 62.0 63.0 61.0 62.0 62.0 62.0 62.0 62.0 61.0 08:37:25 INFO - PROCESS | 3033 | -------- Summary: end -------- 08:37:25 INFO - PROCESS | 3033 | 08:37:25 INFO - TEST-INFO | 3033: exit 0 08:37:26 INFO - TEST-OK | kraken | took 61799ms 08:37:26 INFO - SUITE-END | took 1173s 08:37:26 INFO - Completed test suite (00:19:33) 08:37:26 INFO - javascript benchmark 08:37:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.7149956503927, 3193.0420873737876, 3225.6129264488263, 3238.352329534091, 3256.055743834288, 5341.0, 5362.731863406829, 5404.513593776559, 5427.701476418795, 5457.29055222821, 5446.482584154509, 5454.263674403955, 5458.781648734046, 5497.230387745719, 5516.034693928566, 4858.3927009123945, 4950.900981980359, 4983.72589507577, 4994.725290109042, 5116.462771409004, 5005.374328208974, 5023.422306434752, 5058.721770302632, 5076.390833100033, 5078.0, 4809.230523116302, 4881.926771098454, 4886.315915771795, 4886.438059623153, 4895.902081958377, 4896.6817156885045, 4970.925436118461, 4975.502449755032, 4982.626303027251, 5017.774200161001, 4783.856484305476, 4865.781039853215, 4942.406911170647, 4961.330220420269, 5007.399112106534, 5327.733613319358, 5381.085215513333, 5384.757685904144, 5444.455554444564, 5452.018636645442, 5890.087036509348, 5906.675132867691, 5922.1116832475045, 5925.259342582177, 5927.229460170151, 5770.682612456313, 5781.566382521328, 5783.450572195635, 5869.295684517842, 5907.2911250650195, 5462.426445223234, 5470.234167216513, 5470.507654311131, 5471.316085489274, 5476.561875050026, 5970.014947533695, 5977.103434484775, 5979.521638269015, 5983.461488466059, 5986.132010858489, 5574.470425309589, 5707.543396528268, 5726.79956201531, 5731.340895797037, 5738.569607279471, 5855.268091488564, 5865.442782935615, 5868.794592189253, 5913.2608423947, 5918.201042859159, 5791.482643538047, 5841.211436456109, 5842.357340692521, 5848.385919478394, 5849.590528663038, 5705.857353566111, 5706.9429305707245, 5707.571932105108, 5735.541156707453, 5781.768729250867, 4375.1031038637, 4377.277749171415, 4379.605835474823, 4387.166438376762, 4419.248727716296, 3869.5743468218475, 3911.9804400977814, 3925.2542017016676, 3941.7240793144206, 3966.920661586752, 5463.617546771768, 5466.125419932791, 5513.558915286768, 5542.63972841764, 5546.500814926676, 5848.970755146197, 5877.500412464989, 5883.441073098049, 5893.823185304448, 5895.322037965603, 5397.2443857859935, 5441.918371224356, 5481.75332110056, 5523.861903452445, 5539.584531160179, 4824.903501929942, 4841.540053694894, 4852.587530059914, 4884.0, 4892.8532144035735, 6007.939920600826, 6013.0, 6013.338532761392, 6013.879722405527, 6014.548908831855, 5698.601097923106, 5837.124431335334, 5849.122631605123, 5854.677992710272, 5879.97100507401, 5955.583109182316, 5961.926853166472, 5979.701014949148, 5996.70016499182, 6027.728752206073, 5762.366139724543, 5770.13447982806, 5770.682612456355, 5778.104393818965, 5787.074068149076, 5642.71786410686, 5761.0, 5781.5663825214115, 5813.563982701399, 5845.09401042839, 5658.5473162147755, 5664.433556644302, 5665.12190610456, 5671.149327600893, 5673.659580425187, 5555.805546805843, 5627.7467513961155, 5659.603827732019, 5675.177099320658, 5679.346875109415, 5519.061759500814, 5539.7784088636, 5560.221568980265, 5578.665280083208, 5596.216529685766, 5668.37647858727, 5703.258576385043, 5789.797357092481, 5797.681127537857, 5801.158831969426, 5425.457454254543, 5524.281843360337, 5612.7754889803955, 5627.352854421631, 5663.8867222656145], "value": 5357.986805697914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8080614203454, 640.8910485217513, 645.2128403347917, 653.1737352249404, 659.8548319369737, 32429.51355729663, 45048.3242751359, 45503.31745023823, 45564.316535252, 49187.75406122964, 46243.53756462434, 46705.532944670544, 46793.0, 46801.29798053032, 46810.0, 8988.820223595541, 9142.63429462824, 9143.405678630901, 9145.176934075931, 9147.95426022869, 8856.822863542726, 8934.061923498004, 8957.059508751585, 8962.103789621018, 8966.596503157374, 9024.593893274818, 9052.230560402373, 9065.95467022664, 9070.319726020574, 9072.546372681372, 8966.0, 8995.775105622346, 9011.0, 9011.594478248462, 9011.999999999967, 8853.203211710977, 8908.287337013024, 8919.643214271422, 8922.0, 8930.732078037669, 42768.57231427677, 43382.78308608437, 43499.34750978738, 43544.34683479751, 43546.12907741827, 3353.5808023997, 3467.739919506047, 3490.9301813963834, 3603.585587657427, 4438.201123797715, 31909.0, 31977.0, 32119.0, 32847.507287390705, 32942.835285823654, 4275.914481710349, 4392.209402307583, 4397.824087036514, 4398.6700997425005, 4418.248897687368, 333266.33366833255, 334525.0, 334731.0, 336374.0, 336620.0, 53783.46216537863, 56137.0, 56766.716166418904, 56835.43164568384, 56927.14609280864, 60432.0, 60765.22730340611, 60998.695006524686, 66871.0, 66921.33078669249, 17150.742738858928, 17267.481975540755, 17279.0, 17284.481465556055, 17308.913455432896, 11537.077033837273, 11688.298702077902, 13340.399682014333, 13410.530631428048, 13445.932770336085, 16352.591185220464, 16560.917195413946, 16673.0, 17169.399071032705, 17186.140692965302, 6385.776497822647, 6419.935800641933, 6437.935620643827, 6608.669566521655, 6731.596104233761, 1040.8959104089531, 1078.397299041768, 1080.5137688040413, 1127.6898852815377, 1169.5438778876246, 32677.50983735246, 32863.671363286536, 33249.168770780925, 33307.16732081669, 33340.49989250163, 1121.506537123663, 1172.7713095946378, 1178.7583545373177, 1198.8861058199457, 1253.473541112735, 17638.647227055386, 17686.204120814593, 17714.025728584795, 17736.0, 17869.195886185153, 524162.0, 526415.0, 526440.0, 527008.0, 530369.0, 59935.0, 60175.09737353943, 60387.39612603818, 60509.39490605125, 60604.393956060754, 1283.4545318239711, 1408.5281430720822, 1413.6671103069061, 1433.5054406229833, 1466.0910235653962, 33308.0, 34569.1357716049, 35023.47464788081, 35037.47443788294, 35103.64896351106, 51345.743271283405, 51458.48541514537, 51949.7402512985, 52120.478795211566, 52134.47865521296, 401561.0, 402744.0, 403016.0, 404885.0, 405885.0, 35259.47110793289, 40363.3945490812, 40940.1811963765, 40977.59022409738, 44546.554534455536, 49350.75324623354, 49359.506404936925, 49667.0, 49809.75095124501, 50521.0, 40421.98945026398, 40558.79720601378, 41675.58324416838, 41761.58238417577, 42066.57933420627, 38206.61793382031, 40100.598994009684, 41151.794241028605, 41494.58505415028, 42408.36387454129, 42753.572464274956, 43455.782721086194, 43899.78050109729, 43907.34138987982, 44001.33997989968, 37003.0, 37848.0, 38124.0, 38639.80680096582, 38773.22453550857, 29055.7094429053, 29132.417351652424, 29186.708132919248, 29317.120486385444, 29685.0], "value": 20602.455374174904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.73226206179794, 399.61237599528454, 400.94587230723846, 403.5863240178818, 416.43780895790667, 18352.265909363625, 19733.0, 19997.600047999033, 20006.09972551235, 20907.68638470424, 19153.61692766144, 19572.0, 20276.0, 20288.18847246112, 20292.289769858056, 5404.945950540503, 5490.80782172624, 5697.515711164556, 5709.314882214119, 5778.0, 5744.770209191627, 5758.0, 5816.476517113459, 6561.901571476432, 6572.21133463985, 6516.543841931067, 6519.152510173671, 6521.445677117451, 6535.60786352818, 6551.541392102555, 5877.2947246330505, 5880.0, 5888.646681199099, 5889.263842019747, 6232.688365581703, 5523.861903452405, 5701.6864072476, 5703.173039909231, 5726.427357264281, 5745.023346031143, 13825.930870345685, 13856.30718464083, 21680.783192168034, 23437.296881093593, 23908.40228994289, 2240.350298413458, 2252.40311317501, 2518.962215566768, 2537.1880998080624, 2550.3369124027886, 10524.36853788775, 11691.298522088702, 12703.682407939783, 14850.925745371313, 15004.624884377869, 1939.4472575315967, 1956.5304326961568, 1981.8018198180212, 1999.4601457606366, 2028.3610662641368, 76954.23045769526, 77205.0, 79744.0, 81695.18304816935, 82004.9999999994, 10668.679939601825, 10797.460126993776, 10932.398718070583, 11077.778444431066, 11192.481691619321, 15300.387984480496, 15381.461648842236, 15390.769138462932, 15398.07611543311, 15436.0, 8183.181681831888, 8323.750287491384, 8394.706185283485, 8474.957625211835, 8554.78613034679, 8257.298129659046, 8257.587120644064, 8280.130586288353, 8497.957510212409, 8511.148885111439, 4540.387047748512, 4589.701669391546, 4644.210484217691, 4654.25531914892, 4820.373351464287, 1913.1104036623037, 1929.729837822706, 1937.321937321926, 1965.7837637859825, 1991.2134706791026, 925.7824411263348, 1012.584840215508, 1055.4617145255975, 1066.0991462214417, 1101.64196636092, 18555.16501757424, 18585.628287434174, 19113.331033413764, 19449.8055019448, 19797.331431458228, 1042.1714736784274, 1094.7044298039643, 1100.8128618134936, 1104.7127746785734, 1112.9888701112886, 10497.2127090467, 10929.726756830984, 11025.944870275598, 11030.28303160292, 11067.72330691739, 480650.0, 490058.0, 497380.0, 502377.0, 505571.0, 95142.52428737812, 95438.0, 95820.60448488843, 95978.0, 96665.0, 975.8682577852042, 992.8907820139779, 994.7314225159166, 1000.0449570660003, 1075.2097208551709, 17284.481465556055, 17361.30554777795, 17362.47912562625, 17610.73583896217, 17695.93824370542, 37658.8117059413, 38862.0, 40172.79481615556, 40786.0, 44602.330965034904, 60450.69774651274, 60988.0, 61431.078533822925, 61817.690911545156, 62874.0, 6799.422049125879, 11199.776004480027, 11414.885851141382, 11510.94244528772, 12308.26150430977, 13875.653108672364, 13903.304834758019, 13904.235267060005, 13984.720305594035, 14227.715445690821, 12221.75556488883, 12417.503299867903, 12568.74862502763, 12616.684582885502, 12778.552750653682, 12002.699932501757, 12143.14997950135, 12146.39268036577, 12393.0, 12726.490940362282, 12438.19151755133, 12563.246205227715, 12626.0, 12950.158239714388, 13009.869901300866, 12666.43001064936, 12789.488420463078, 12830.16603920742, 12884.355782210665, 13036.348182590642, 12508.997840518392, 12549.121561490972, 12880.291583962971, 12886.42011109521, 12977.416016279101], "value": 9658.219482501168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.299426783742, 1573.2998815527092, 1594.5296137639398, 1746.2491128814613, 1911.0635788463658, 8509.744707658772, 8791.824163516734, 8857.247133993618, 9251.352405331629, 9254.07459254076, 8791.692290769824, 8956.119214964849, 8962.731118066453, 8970.327225458084, 8974.237189838872, 2073.751149862019, 2147.4309308033385, 2149.6023235701446, 2357.634566642173, 2400.3639035655565, 2324.6048171810835, 2371.205646108547, 2371.2886134159685, 2375.5486457573006, 2376.4652953085592, 2271.3867255840914, 2278.487340348425, 2295.0, 2295.483516208856, 2304.343262170282, 1906.304198967367, 1970.9408717738347, 2300.884955752214, 2336.474293284006, 2339.988300058506, 2072.77199508054, 2265.456290490287, 2327.837051406402, 2332.3935776698013, 2347.2019513365367, 8909.73270801877, 8937.240334571568, 8967.372283940127, 8978.640854365818, 9006.414583052081, 5074.517920797518, 5186.40356359016, 5191.532762051395, 5194.71429071401, 5197.870053248661, 3284.934301313984, 3299.6700329967052, 3383.0865666270215, 3426.229098452853, 3429.005588379367, 1047.2198212331784, 1049.2235745548317, 1061.5488417422641, 1064.302881612545, 1068.076114161245, 12725.745485090247, 12779.616611501577, 12797.680057998532, 12849.293288869108, 12850.55023074188, 4566.20091483989, 4596.770161491912, 4656.906861862812, 4699.342092107107, 4705.12955103307, 10062.69811905644, 10107.0, 10109.39343639384, 10125.443100629536, 10126.088652021206, 5212.087884620252, 5257.921131183035, 5259.211118332204, 5268.28878101459, 5269.841904742864, 4392.231359512072, 4852.053849499384, 4898.044881248123, 4965.404151501771, 4966.90066198674, 3889.8249578769023, 3915.0799562102884, 3974.682025437958, 3996.540397854284, 4109.589041095866, 1089.2538611051455, 1089.803835309652, 1090.2586241355796, 1097.5884043483693, 1132.1452303510962, 864.4631137563913, 901.900790912999, 987.3730181334904, 1027.3733022856052, 1062.8246339354075, 6238.968805156036, 6266.3758727560635, 6352.269489008823, 6356.682165891687, 6517.674116294261, 406.32347142008814, 410.71455338539425, 413.52857742173944, 414.05595242846357, 429.336674837377, 4364.454443194601, 4366.781660916941, 4387.934180987288, 4397.670174736843, 4429.202743506135, 10999.625046869141, 11431.971122599007, 11437.0, 11469.942650286695, 11498.59754908591, 10996.0653344465, 11127.944360278147, 11139.498722557504, 11142.331460112418, 11233.550657973752, 7718.845623087507, 7960.800979975547, 7982.720604778805, 8114.0, 8157.632906519221, 6067.271927368567, 6302.1492098566105, 6337.176167098248, 6374.247082052472, 6386.840328991812, 9399.81200375975, 9687.564059617192, 9748.951255243963, 9760.60957561718, 10130.341527800669, 10156.593736250763, 10199.847002294822, 10247.231457640557, 10292.433916134685, 10297.794044119226, 7720.922790772021, 7728.652210650646, 7768.106667733057, 7804.219578042151, 7805.843883122192, 8385.874211886949, 8394.370422218235, 8399.748007559783, 8399.832003360021, 8491.23578877904, 7663.501872378278, 7710.344620707303, 7747.031621047369, 7809.453338266267, 7823.569703666353, 7307.5980821055355, 7464.477486575887, 7484.139323977594, 7500.212477689764, 7582.203868593939, 7045.542039767399, 7108.928910710827, 7214.206437291999, 7223.819404514929, 7258.237885022208, 5364.544013758874, 5372.382176049804, 5484.341878974389, 5492.505674489315, 5604.523615492729, 5530.142827861688, 5576.7662908389575, 5607.971960140173, 5696.54427645779, 5712.34308054579], "value": 4555.111851373871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.7329203407191, 334.9263162104337, 335.6157200005995, 335.6710423784691, 339.0050202655207, 5221.608379371548, 5265.3681558212975, 5342.252084708139, 5383.515483606475, 5391.137418013119, 5241.213817927312, 5268.841934741964, 5274.182501712231, 5274.681329667583, 5287.889543195924, 4165.500419848852, 4193.6645068394455, 4199.202151591203, 4214.051838336381, 4233.322668373061, 3997.72015958883, 4070.816813243396, 4201.138766552865, 4207.0, 4207.137536804948, 4117.732347397409, 4120.877747959788, 4151.626353628173, 4156.524433825994, 4172.4784401949755, 3999.1201935574127, 4164.00063984643, 4178.143480586473, 4196.139791342767, 4201.34879093741, 3646.6353364663587, 3701.38927077032, 3701.6668499835146, 3713.591504934455, 3721.1813401051727, 5131.153359695646, 5131.435542090367, 5157.767900444489, 5162.070827251093, 5165.708572856785, 4583.349994002157, 4764.928526072112, 4766.213574760161, 4769.785359658789, 4784.736839473828, 5447.945520544784, 5510.91733623996, 5522.0, 5555.805546805883, 5579.721013949327, 3997.400389941503, 4033.737807042533, 4043.6765058795227, 4080.0411903202726, 4088.897777555555, 5568.55451563878, 5757.740901659394, 5783.248177736868, 5817.912731309034, 5822.737976791054, 4121.845883152722, 4129.483814523184, 4153.0, 4158.126793373365, 4167.854125105607, 4187.1625674865145, 4208.0, 4212.115455754326, 4221.472315960505, 4230.894227644333, 4768.690035147704, 4776.5701086902345, 4776.59398951093, 4797.40032495938, 4799.232122860395, 5452.6183167177915, 5548.4174161712435, 5567.109262518059, 5569.526590239875, 5593.993081245333, 1414.610981979943, 1418.2483283859572, 1419.1626940105182, 1433.992830035864, 1444.4294503671201, 919.3564504846634, 938.6955025412595, 940.1068984464786, 950.4487397309543, 956.402807311791, 4763.332833508313, 4778.235482322812, 4806.269742892556, 5206.8958620828125, 5317.361916569959, 5691.715414229272, 5774.94225057744, 5781.364049954502, 5798.811243695032, 5811.692369216977, 5452.263944367539, 5466.371367292732, 5467.7424192435965, 5479.479449452296, 5504.394516603171, 2882.5820256062752, 2999.7600191985025, 3047.6342838859478, 3060.9286749637895, 3077.38452309539, 5926.140709597084, 5950.702464876739, 5961.970190149022, 5971.253593300838, 5978.4021597839865, 5626.887462250732, 5858.355580886099, 5887.499562537147, 5914.2498738087, 5922.703864806743, 5983.14522498027, 5992.730327135289, 5994.820155395345, 5996.481477779256, 6017.548683848729, 5802.94197058024, 5818.7090645466715, 5823.272090988627, 5825.3592104867585, 5842.941570584239, 5503.11950087984, 5693.800716974886, 5699.173619825019, 5707.828765137053, 5710.428957104256, 5905.261842269716, 5942.524598032233, 5957.434043765836, 5966.433188847052, 6005.759769609167, 3862.517185351831, 4135.7518548887165, 4136.172765446983, 4166.91666166681, 4175.415441838206, 5642.012647786703, 5692.0, 5701.144828275792, 5721.656700597978, 5748.252727145445, 5558.24963629921, 5570.5543556516195, 5575.275214222287, 5581.804636837691, 5607.822357304848, 5267.920981185209, 5552.222688823487, 5552.750126244409, 5555.50000499957, 5566.638168519034, 5364.463553644604, 5440.183972404171, 5470.480304371078, 5493.258410114583, 5498.642588231752, 5459.672419654675, 5495.450454954473, 5589.3511414133745, 5641.097424412074, 5642.492175704207, 5492.890142197213, 5496.395396506301, 5497.752601133038, 5524.116141417354, 5528.668279903219], "value": 4263.538940164691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.2799962031703, 871.7341210930667, 883.58913105406, 883.6818745251712, 899.9055099214578, 16283.918580407111, 17176.3129474821, 17182.656346873086, 17183.054931978735, 17208.91395543022, 15372.154531500762, 15446.227688615552, 15502.30239639216, 15546.222688865568, 15561.144137072457, 711.9288071192891, 835.0814104485079, 861.4788053227801, 872.2542226396434, 881.5724373678761, 865.2169786343338, 870.4081224767156, 872.7948932000975, 875.7372788163557, 876.1457578860624, 905.1039470923804, 907.2379201470764, 907.3240435875282, 907.591583787295, 907.7549061753323, 744.7281742164098, 892.1034360467721, 902.702108304258, 909.9044600316938, 910.7950711090018, 660.352854202879, 666.6699983508146, 667.0860920538844, 667.432682220109, 668.2982867988593, 15053.548393548212, 15123.697526049418, 15153.0, 15155.924220378827, 15176.924115379352, 13536.390862411117, 13835.79246311306, 13838.723225535434, 13857.722845543134, 13865.0, 13004.869951300461, 13156.736865262737, 13181.340932953313, 13234.205947643171, 13328.067035307435, 4290.099079193373, 4307.073979094478, 4330.588594083557, 4345.217860785057, 4372.453443319585, 60103.69948150275, 60139.69930150321, 61432.69283653598, 61476.692616537526, 61492.0, 10797.46012699362, 10897.782044359068, 10916.07213386871, 11006.944965275123, 11224.214304998572, 19977.400677979684, 20437.795622043886, 20493.0, 20496.59006819885, 20500.38498845037, 8562.357823163287, 8864.157904999014, 8917.197452229331, 9008.189262966365, 9100.681476148435, 4872.19608764557, 4905.337779399807, 5026.698398096053, 5072.087024335655, 5073.264376665363, 3284.786488878215, 3374.122728090665, 3380.087376408356, 3383.4586466165297, 3388.0513456232293, 623.2707731953625, 624.4255285137684, 632.2255237334228, 640.638039507686, 645.9289478157399, 659.2715049869921, 706.3501578547748, 706.3783870194196, 743.9814004649927, 792.2157064506098, 9283.210927071139, 9520.523973801282, 9563.474008929576, 9582.425054496753, 9603.615855365708, 731.7146312937958, 778.2023425988407, 789.2305002622397, 808.3654331349862, 812.6018251057058, 4485.865424037284, 4590.449146102423, 4668.183067963093, 4761.880972958366, 4858.854234372974, 49211.75394123006, 49643.50356496461, 56457.43542564522, 74195.62902185455, 74234.0, 63543.0, 63904.68047659732, 64096.35903640904, 64191.99999999907, 65127.67436162789, 56189.43810561842, 58506.707466463246, 58513.12230316549, 58740.0, 59368.70315648394, 9158.0, 9186.127317904788, 9222.40054396462, 9235.307351948764, 9291.86062209081, 38553.2289354217, 38561.0, 38615.979922609884, 38646.806765965994, 39423.0, 49193.2621010678, 51591.226131608804, 51633.483665162865, 52138.73930630474, 52699.736501317246, 11267.323960562393, 11342.262752921364, 11539.942300288445, 11605.535778569101, 11880.821787673365, 12606.55877044299, 13190.80213796813, 13643.181409115485, 13738.519151829638, 14221.502247421291, 11998.64004079879, 12406.069544783997, 12861.871381286068, 12871.613851584092, 13026.609201723963, 11638.941805290919, 11886.702832429259, 12119.151659384112, 12142.482189726285, 12624.74750505003, 12275.386230688608, 12506.0, 12567.371631418575, 12838.101332906606, 13192.472301108231, 10092.0, 10161.796764064826, 10170.288079834636, 10214.285000049926, 10505.527251273865, 9926.652567160114, 10037.297389182688, 10075.546600402853, 10131.189504839742, 10319.845202321821], "value": 7102.126468689649, "unit": "score"}], "name": "dromaeo_css", "value": 7265.302359624747, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 154.0, 202.0, 124.0, 153.0, 155.0, 124.0, 178.0, 123.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 161.0, 160.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 147.0, 76.0, 73.0, 77.0, 75.0, 130.0, 75.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 146.0, 92.0, 91.0, 91.0, 127.0, 91.0, 92.0, 124.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 59.0, 53.0, 54.0, 53.0, 107.0, 51.0, 52.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 64.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 83.0, 79.0, 76.0, 83.0, 79.0, 79.0, 79.0, 80.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 129.0, 122.0, 116.0, 119.0, 116.0, 116.0, 191.0, 121.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 161.0, 166.0, 165.0, 159.0, 161.0, 160.0, 160.0, 159.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1518.4, "alertThreshold": 2.0}]} 08:37:26 INFO - Return code: 0 08:37:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:37:26 ERROR - # TBPL SUCCESS # 08:37:26 INFO - Running post-action listener: _resource_record_post_action 08:37:26 INFO - ##### 08:37:26 INFO - ##### Finished run-tests step (success) 08:37:26 INFO - ##### 08:37:26 INFO - Running post-run listener: _resource_record_post_run 08:37:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539234304; Read time: 8; Write time: 327176 08:37:26 INFO - TinderboxPrint: CPU usage
13.1% 08:37:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:37:26 INFO - TinderboxPrint: I/O write bytes / time
539,234,304 / 327,176 08:37:26 INFO - TinderboxPrint: CPU idle
8,263.1 (86.9%) 08:37:26 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 08:37:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118190080; Read time: 0; Write time: 93916 08:37:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292847616; Read time: 8; Write time: 149084 08:37:26 INFO - Running post-run listener: _upload_blobber_files 08:37:26 INFO - Blob upload gear active. 08:37:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:26 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 08:37:26 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:26 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:28 INFO - (blobuploader) - INFO - Done attempting. 08:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:34 INFO - (blobuploader) - INFO - Done attempting. 08:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:35 INFO - (blobuploader) - INFO - Done attempting. 08:37:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:35 INFO - Return code: 0 08:37:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aac5eff16c85e95412e63310edcb8a19372f4b5780b3484173ee381b91f24a429f7c6ec4605e9bd4dcfb90cb93a74f134e06bbfaf2019c9961b4acff90b244d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3045f60c07b2949bdd0b44fb54503a13912b0489d98db9768bfb8f6750410ed7f14b1769d67a519061e48d05ede46febacd7444f63ecabd19a7398415f6d4f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b26d42fa75176b648ec2d1eeaa6691ee20d3cdbfa80f26379eefbecc7ad941dac0fd36328b6d68bd6edbd18910c6ec528aa90cd72e93b6b342f67ce5dffe507d"} 08:37:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:35 INFO - Contents: 08:37:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aac5eff16c85e95412e63310edcb8a19372f4b5780b3484173ee381b91f24a429f7c6ec4605e9bd4dcfb90cb93a74f134e06bbfaf2019c9961b4acff90b244d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3045f60c07b2949bdd0b44fb54503a13912b0489d98db9768bfb8f6750410ed7f14b1769d67a519061e48d05ede46febacd7444f63ecabd19a7398415f6d4f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b26d42fa75176b648ec2d1eeaa6691ee20d3cdbfa80f26379eefbecc7ad941dac0fd36328b6d68bd6edbd18910c6ec528aa90cd72e93b6b342f67ce5dffe507d"} 08:37:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:35 INFO - Copying logs to upload dir... 08:37:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.903450 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-16 08:37:34.657454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 08:37:34.661251) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aac5eff16c85e95412e63310edcb8a19372f4b5780b3484173ee381b91f24a429f7c6ec4605e9bd4dcfb90cb93a74f134e06bbfaf2019c9961b4acff90b244d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3045f60c07b2949bdd0b44fb54503a13912b0489d98db9768bfb8f6750410ed7f14b1769d67a519061e48d05ede46febacd7444f63ecabd19a7398415f6d4f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b26d42fa75176b648ec2d1eeaa6691ee20d3cdbfa80f26379eefbecc7ad941dac0fd36328b6d68bd6edbd18910c6ec528aa90cd72e93b6b342f67ce5dffe507d"} build_url:https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/JE6Mp7W_Sh2UekFFde15tw/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/Fx-Team/sha512/aac5eff16c85e95412e63310edcb8a19372f4b5780b3484173ee381b91f24a429f7c6ec4605e9bd4dcfb90cb93a74f134e06bbfaf2019c9961b4acff90b244d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3045f60c07b2949bdd0b44fb54503a13912b0489d98db9768bfb8f6750410ed7f14b1769d67a519061e48d05ede46febacd7444f63ecabd19a7398415f6d4f24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b26d42fa75176b648ec2d1eeaa6691ee20d3cdbfa80f26379eefbecc7ad941dac0fd36328b6d68bd6edbd18910c6ec528aa90cd72e93b6b342f67ce5dffe507d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 08:37:34.686105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:37:34.686419) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1463411655.471365-75029329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 08:37:34.771189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 08:37:34.771475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 08:37:34.771739) ========= ========= Total master_lag: 0.20 =========