builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1466681524.11 results: success (0) buildid: 20160623013034 builduid: f3f0508f62824bc683344d19d3eba38b revision: 0a73cc32722952781b61bad3b69ba5a2fc591621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.108170) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.108649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.108959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.123914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.124224) ========= 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=0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 04:32:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-23 04:32:05 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.255130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.255485) ========= 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=0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019490 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.304812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:04.305193) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a73cc32722952781b61bad3b69ba5a2fc591621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0a73cc32722952781b61bad3b69ba5a2fc591621 --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=0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 04:32:05,479 truncating revision to first 12 chars 2016-06-23 04:32:05,479 Setting DEBUG logging. 2016-06-23 04:32:05,479 attempt 1/10 2016-06-23 04:32:05,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0a73cc327229?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 04:32:05,966 unpacking tar archive at: mozilla-inbound-0a73cc327229/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:05.123270) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:05.124178) ========= script_repo_revision: 0a73cc32722952781b61bad3b69ba5a2fc591621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:05.124989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:05.125759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:32:05.137666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-23 04:32:05.137972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:32:06 INFO - MultiFileLogger online at 20160623 04:32:06 in /builds/slave/test 04:32:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:06 INFO - {'append_to_log': False, 04:32:06 INFO - 'base_work_dir': '/builds/slave/test', 04:32:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:06 INFO - 'branch': 'Mozilla-Inbound', 04:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:06 INFO - 'config_files': ('talos/linux_config.py',), 04:32:06 INFO - 'default_actions': ('clobber', 04:32:06 INFO - 'read-buildbot-config', 04:32:06 INFO - 'download-and-extract', 04:32:06 INFO - 'populate-webroot', 04:32:06 INFO - 'create-virtualenv', 04:32:06 INFO - 'install', 04:32:06 INFO - 'run-tests'), 04:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:06 INFO - 'download_minidump_stackwalk': True, 04:32:06 INFO - 'download_symbols': 'ondemand', 04:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:06 INFO - 'installer_path': 'installer.exe', 04:32:06 INFO - 'log_level': 'info', 04:32:06 INFO - 'log_name': 'talos', 04:32:06 INFO - 'log_to_console': True, 04:32:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:32:06 INFO - 'opt_config_files': (), 04:32:06 INFO - 'pip_index': False, 04:32:06 INFO - 'sps_profile': False, 04:32:06 INFO - 'sps_profile_interval': 0, 04:32:06 INFO - 'suite': 'dromaeojs-e10s', 04:32:06 INFO - 'system_bits': '32', 04:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:06 INFO - 'title': 'talos-linux64-ix-058', 04:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:06 INFO - 'use_talos_json': True, 04:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:06 INFO - 'work_dir': 'build'} 04:32:06 INFO - ##### 04:32:06 INFO - ##### Running clobber step. 04:32:06 INFO - ##### 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: clobber 04:32:06 INFO - rmtree: /builds/slave/test/build 04:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - ##### 04:32:06 INFO - ##### Finished clobber step (success) 04:32:06 INFO - ##### 04:32:06 INFO - ##### 04:32:06 INFO - ##### Running read-buildbot-config step. 04:32:06 INFO - ##### 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: read_buildbot_config 04:32:06 INFO - Using buildbot properties: 04:32:06 INFO - { 04:32:06 INFO - "project": "", 04:32:06 INFO - "product": "firefox", 04:32:06 INFO - "script_repo_revision": "production", 04:32:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:32:06 INFO - "repository": "", 04:32:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:32:06 INFO - "buildid": "20160623013034", 04:32:06 INFO - "pgo_build": "True", 04:32:06 INFO - "basedir": "/builds/slave/test", 04:32:06 INFO - "buildnumber": 1199, 04:32:06 INFO - "slavename": "talos-linux64-ix-058", 04:32:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:32:06 INFO - "platform": "ubuntu64_hw", 04:32:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:32:06 INFO - "branch": "mozilla-inbound", 04:32:06 INFO - "repo_path": "integration/mozilla-inbound", 04:32:06 INFO - "revision": "0a73cc32722952781b61bad3b69ba5a2fc591621", 04:32:06 INFO - "stage_platform": "linux64-pgo", 04:32:06 INFO - "builduid": "f3f0508f62824bc683344d19d3eba38b", 04:32:06 INFO - "slavebuilddir": "test" 04:32:06 INFO - } 04:32:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - ##### 04:32:06 INFO - ##### Finished read-buildbot-config step (success) 04:32:06 INFO - ##### 04:32:06 INFO - ##### 04:32:06 INFO - ##### Running download-and-extract step. 04:32:06 INFO - ##### 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: download_and_extract 04:32:06 INFO - mkdir: /builds/slave/test/build/tests 04:32:06 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')]} 04:32:06 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:32:07 INFO - Downloaded 1361 bytes. 04:32:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:32:07 INFO - Using the following test package requirements: 04:32:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:32:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:32:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'jsshell-linux-x86_64.zip'], 04:32:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:32:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:32:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:32:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:32:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:32:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:32:07 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')]} 04:32:07 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:32:08 INFO - Downloaded 24270138 bytes. 04:32:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:32:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:32:09 INFO - Return code: 0 04:32:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:09 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:32:11 INFO - Downloaded 24270138 bytes. 04:32:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:32:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:32:12 INFO - Return code: 0 04:32: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')]} 04:32:12 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:32:13 INFO - Downloaded 14405384 bytes. 04:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:32:13 INFO - Return code: 0 04:32:13 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')]} 04:32:13 INFO - https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:32:15 INFO - Downloaded 60145882 bytes. 04:32:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:32:15 INFO - mkdir: /builds/slave/test/properties 04:32:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:15 INFO - Contents: 04:32:15 INFO - build_url:https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:32:16 INFO - Running post-action listener: _resource_record_post_action 04:32:16 INFO - Running post-action listener: set_extra_try_arguments 04:32:16 INFO - ##### 04:32:16 INFO - ##### Finished download-and-extract step (success) 04:32:16 INFO - ##### 04:32:16 INFO - ##### 04:32:16 INFO - ##### Running populate-webroot step. 04:32:16 INFO - ##### 04:32:16 INFO - Running pre-action listener: _resource_record_pre_action 04:32:16 INFO - Running main action method: populate_webroot 04:32:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:16 INFO - '--tppagecycles', 04:32:16 INFO - '7'], 04:32:16 INFO - 'tests': ['tsvgm']}}, 04:32:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['damp', 'tps']}, 04:32:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'tests': ['damp', 'tps']}, 04:32:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['dromaeo_dom']}, 04:32:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['basic_compositor_video']}, 04:32:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['a11yr', 04:32:16 INFO - 'ts_paint', 04:32:16 INFO - 'tpaint', 04:32:16 INFO - 'sessionrestore', 04:32:16 INFO - 'sessionrestore_no_auto_restore', 04:32:16 INFO - 'tabpaint']}, 04:32:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:16 INFO - 'ts_paint', 04:32:16 INFO - 'tpaint', 04:32:16 INFO - 'sessionrestore', 04:32:16 INFO - 'sessionrestore_no_auto_restore', 04:32:16 INFO - 'tabpaint']}, 04:32:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:16 INFO - 'ts_paint', 04:32:16 INFO - 'tpaint', 04:32:16 INFO - 'sessionrestore', 04:32:16 INFO - 'sessionrestore_no_auto_restore', 04:32:16 INFO - 'tabpaint']}, 04:32:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:16 INFO - 'ts_paint', 04:32:16 INFO - 'tpaint', 04:32:16 INFO - 'sessionrestore', 04:32:16 INFO - 'sessionrestore_no_auto_restore', 04:32:16 INFO - 'tabpaint']}, 04:32:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['a11yr', 04:32:16 INFO - 'ts_paint', 04:32:16 INFO - 'tpaint', 04:32:16 INFO - 'sessionrestore', 04:32:16 INFO - 'sessionrestore_no_auto_restore', 04:32:16 INFO - 'tabpaint']}, 04:32:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['a11yr', 04:32:16 INFO - 'ts_paint', 04:32:16 INFO - 'tpaint', 04:32:16 INFO - 'sessionrestore', 04:32:16 INFO - 'sessionrestore_no_auto_restore', 04:32:16 INFO - 'tabpaint']}, 04:32:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['tsvgx', 04:32:16 INFO - 'tsvgr_opacity', 04:32:16 INFO - 'tart', 04:32:16 INFO - 'tscrollx', 04:32:16 INFO - 'cart']}, 04:32:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:16 INFO - 'tsvgr_opacity', 04:32:16 INFO - 'tart', 04:32:16 INFO - 'tscrollx', 04:32:16 INFO - 'cart']}, 04:32:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'talos_options': ['--disable-e10s'], 04:32:16 INFO - 'tests': ['tp5o']}, 04:32:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'tests': ['tp5o']}, 04:32:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'talos_options': ['--disable-e10s', 04:32:16 INFO - '--xperf_path', 04:32:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:16 INFO - 'tests': ['tp5n']}, 04:32:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:16 INFO - 'talos_options': ['--xperf_path', 04:32:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:16 INFO - 'tests': ['tp5n']}}, 04:32:16 INFO - 'talos.zip': {'path': '', 04:32:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:16 INFO - Running post-action listener: _resource_record_post_action 04:32:16 INFO - ##### 04:32:16 INFO - ##### Finished populate-webroot step (success) 04:32:16 INFO - ##### 04:32:16 INFO - ##### 04:32:16 INFO - ##### Running create-virtualenv step. 04:32:16 INFO - ##### 04:32:16 INFO - Running pre-action listener: _resource_record_pre_action 04:32:16 INFO - Running main action method: create_virtualenv 04:32:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:16 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 04:32:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:16 INFO - Using real prefix '/usr' 04:32:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:18 INFO - Installing pip.................done. 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:18 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')]} 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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')]} 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:18 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 04:32:18 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 04:32:18 INFO - Using env: {'DISPLAY': ':0', 04:32:18 INFO - 'HOME': '/home/cltbld', 04:32:18 INFO - 'LANG': 'en_US.UTF-8', 04:32:18 INFO - 'LANGUAGE': 'en_US:en', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MAIL': '/var/mail/cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SHLVL': '1', 04:32:18 INFO - 'TERM': 'linux', 04:32:18 INFO - 'TMOUT': '86400', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - '_': '/tools/buildbot/bin/python'} 04:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:18 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 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:18 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')]} 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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')]} 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:18 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 04:32:18 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 04:32:18 INFO - Using env: {'DISPLAY': ':0', 04:32:18 INFO - 'HOME': '/home/cltbld', 04:32:18 INFO - 'LANG': 'en_US.UTF-8', 04:32:18 INFO - 'LANGUAGE': 'en_US:en', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MAIL': '/var/mail/cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SHLVL': '1', 04:32:18 INFO - 'TERM': 'linux', 04:32:18 INFO - 'TMOUT': '86400', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - '_': '/tools/buildbot/bin/python'} 04:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:19 INFO - Downloading/unpacking psutil>=3.1.1 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:21 INFO - Installing collected packages: psutil 04:32:21 INFO - Running setup.py install for psutil 04:32:21 INFO - building 'psutil._psutil_linux' extension 04:32:21 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 04:32:21 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 04:32:21 INFO - building 'psutil._psutil_posix' extension 04:32:21 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 04:32:21 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 04:32:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:21 INFO - Successfully installed psutil 04:32:21 INFO - Cleaning up... 04:32:21 INFO - Return code: 0 04:32:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:21 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:21 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 04:32:21 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 04:32:21 INFO - Using env: {'DISPLAY': ':0', 04:32:21 INFO - 'HOME': '/home/cltbld', 04:32:21 INFO - 'LANG': 'en_US.UTF-8', 04:32:21 INFO - 'LANGUAGE': 'en_US:en', 04:32:21 INFO - 'LOGNAME': 'cltbld', 04:32:21 INFO - 'MAIL': '/var/mail/cltbld', 04:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:21 INFO - 'MOZ_NO_REMOTE': '1', 04:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:21 INFO - 'NO_EM_RESTART': '1', 04:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:21 INFO - 'PWD': '/builds/slave/test', 04:32:21 INFO - 'SHELL': '/bin/bash', 04:32:21 INFO - 'SHLVL': '1', 04:32:21 INFO - 'TERM': 'linux', 04:32:21 INFO - 'TMOUT': '86400', 04:32:21 INFO - 'USER': 'cltbld', 04:32:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:21 INFO - '_': '/tools/buildbot/bin/python'} 04:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:21 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 04:32:21 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 04:32:21 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 04:32:21 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 04:32:21 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 04:32:21 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 04:32:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:23 INFO - Installing collected packages: mozsystemmonitor 04:32:23 INFO - Running setup.py install for mozsystemmonitor 04:32:24 INFO - Successfully installed mozsystemmonitor 04:32:24 INFO - Cleaning up... 04:32:24 INFO - Return code: 0 04:32:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:24 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:24 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==2.5.1'] in /builds/slave/test/build 04:32:24 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==2.5.1 04:32:24 INFO - Using env: {'DISPLAY': ':0', 04:32:24 INFO - 'HOME': '/home/cltbld', 04:32:24 INFO - 'LANG': 'en_US.UTF-8', 04:32:24 INFO - 'LANGUAGE': 'en_US:en', 04:32:24 INFO - 'LOGNAME': 'cltbld', 04:32:24 INFO - 'MAIL': '/var/mail/cltbld', 04:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:24 INFO - 'MOZ_NO_REMOTE': '1', 04:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:24 INFO - 'NO_EM_RESTART': '1', 04:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:24 INFO - 'PWD': '/builds/slave/test', 04:32:24 INFO - 'SHELL': '/bin/bash', 04:32:24 INFO - 'SHLVL': '1', 04:32:24 INFO - 'TERM': 'linux', 04:32:24 INFO - 'TMOUT': '86400', 04:32:24 INFO - 'USER': 'cltbld', 04:32:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:24 INFO - '_': '/tools/buildbot/bin/python'} 04:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:24 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 04:32:24 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 04:32:24 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 04:32:24 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 04:32:24 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 04:32:24 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 04:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:26 INFO - warning: no files found matching '*.txt' 04:32:26 INFO - no previously-included directories found matching 'build' 04:32:26 INFO - no previously-included directories found matching 'dist' 04:32:26 INFO - no previously-included directories found matching '.git*' 04:32:26 INFO - Installing collected packages: jsonschema, functools32 04:32:26 INFO - Running setup.py install for functools32 04:32:26 INFO - warning: no files found matching '*.txt' 04:32:26 INFO - no previously-included directories found matching 'build' 04:32:26 INFO - no previously-included directories found matching 'dist' 04:32:26 INFO - no previously-included directories found matching '.git*' 04:32:26 INFO - Successfully installed jsonschema functools32 04:32:26 INFO - Cleaning up... 04:32:26 INFO - Return code: 0 04:32:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:26 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')]} 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 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')]} 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:26 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 04:32:26 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 04:32:26 INFO - Using env: {'DISPLAY': ':0', 04:32:26 INFO - 'HOME': '/home/cltbld', 04:32:26 INFO - 'LANG': 'en_US.UTF-8', 04:32:26 INFO - 'LANGUAGE': 'en_US:en', 04:32:26 INFO - 'LOGNAME': 'cltbld', 04:32:26 INFO - 'MAIL': '/var/mail/cltbld', 04:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:26 INFO - 'MOZ_NO_REMOTE': '1', 04:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:26 INFO - 'NO_EM_RESTART': '1', 04:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:26 INFO - 'PWD': '/builds/slave/test', 04:32:26 INFO - 'SHELL': '/bin/bash', 04:32:26 INFO - 'SHLVL': '1', 04:32:26 INFO - 'TERM': 'linux', 04:32:26 INFO - 'TMOUT': '86400', 04:32:26 INFO - 'USER': 'cltbld', 04:32:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:26 INFO - '_': '/tools/buildbot/bin/python'} 04:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 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 04:32:26 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 04:32:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:29 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 04:32:29 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 04:32:29 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 04:32:29 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 04:32:29 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 04:32:29 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 04:32:29 INFO - Downloading docopt-0.6.1.tar.gz 04:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:29 INFO - Running setup.py install for blobuploader 04:32:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:29 INFO - Running setup.py install for requests 04:32:29 INFO - Running setup.py install for docopt 04:32:30 INFO - Successfully installed blobuploader requests docopt 04:32:30 INFO - Cleaning up... 04:32:30 INFO - Return code: 0 04:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:30 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')]} 04:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:30 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')]} 04:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:30 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:30 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 04:32:30 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 04:32:30 INFO - Using env: {'DISPLAY': ':0', 04:32:30 INFO - 'HOME': '/home/cltbld', 04:32:30 INFO - 'LANG': 'en_US.UTF-8', 04:32:30 INFO - 'LANGUAGE': 'en_US:en', 04:32:30 INFO - 'LOGNAME': 'cltbld', 04:32:30 INFO - 'MAIL': '/var/mail/cltbld', 04:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:30 INFO - 'MOZ_NO_REMOTE': '1', 04:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:30 INFO - 'NO_EM_RESTART': '1', 04:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:30 INFO - 'PWD': '/builds/slave/test', 04:32:30 INFO - 'SHELL': '/bin/bash', 04:32:30 INFO - 'SHLVL': '1', 04:32:30 INFO - 'TERM': 'linux', 04:32:30 INFO - 'TMOUT': '86400', 04:32:30 INFO - 'USER': 'cltbld', 04:32:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:30 INFO - '_': '/tools/buildbot/bin/python'} 04:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:30 INFO - Running setup.py (path:/tmp/pip-kkLgeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:30 INFO - Running setup.py (path:/tmp/pip-02E0N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:30 INFO - Running setup.py (path:/tmp/pip-MEHVwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:30 INFO - Running setup.py (path:/tmp/pip-5OsKOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:30 INFO - Running setup.py (path:/tmp/pip-HhEm7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:30 INFO - Running setup.py (path:/tmp/pip-MnHpuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:30 INFO - Running setup.py (path:/tmp/pip-5jairc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:30 INFO - Running setup.py (path:/tmp/pip-8EvwAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:30 INFO - Running setup.py (path:/tmp/pip-cRpZcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:30 INFO - Running setup.py (path:/tmp/pip-njyJ92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:31 INFO - Running setup.py (path:/tmp/pip-l1pzl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:31 INFO - Running setup.py (path:/tmp/pip-1BapIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:31 INFO - Running setup.py (path:/tmp/pip-fA4ql5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:31 INFO - Running setup.py (path:/tmp/pip-e9EHjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:31 INFO - Running setup.py (path:/tmp/pip-MioVl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:31 INFO - Running setup.py (path:/tmp/pip-TXxUo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:31 INFO - Running setup.py (path:/tmp/pip-zyWHcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:31 INFO - Running setup.py install for manifestparser 04:32:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for mozcrash 04:32:31 INFO - Running setup.py install for mozdebug 04:32:31 INFO - Running setup.py install for mozdevice 04:32:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:31 INFO - Running setup.py install for mozfile 04:32:32 INFO - Running setup.py install for mozhttpd 04:32:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Running setup.py install for mozinfo 04:32:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Running setup.py install for mozInstall 04:32:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Running setup.py install for mozleak 04:32:32 INFO - Running setup.py install for mozlog 04:32:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Running setup.py install for moznetwork 04:32:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Running setup.py install for mozprocess 04:32:32 INFO - Running setup.py install for mozprofile 04:32:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:32 INFO - Running setup.py install for mozrunner 04:32:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:33 INFO - Running setup.py install for mozscreenshot 04:32:33 INFO - Running setup.py install for moztest 04:32:33 INFO - Running setup.py install for mozversion 04:32:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:33 INFO - Cleaning up... 04:32:33 INFO - Return code: 0 04:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:33 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')]} 04:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:33 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')]} 04:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:33 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:33 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 04:32:33 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 04:32:33 INFO - Using env: {'DISPLAY': ':0', 04:32:33 INFO - 'HOME': '/home/cltbld', 04:32:33 INFO - 'LANG': 'en_US.UTF-8', 04:32:33 INFO - 'LANGUAGE': 'en_US:en', 04:32:33 INFO - 'LOGNAME': 'cltbld', 04:32:33 INFO - 'MAIL': '/var/mail/cltbld', 04:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:33 INFO - 'MOZ_NO_REMOTE': '1', 04:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:33 INFO - 'NO_EM_RESTART': '1', 04:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:33 INFO - 'PWD': '/builds/slave/test', 04:32:33 INFO - 'SHELL': '/bin/bash', 04:32:33 INFO - 'SHLVL': '1', 04:32:33 INFO - 'TERM': 'linux', 04:32:33 INFO - 'TMOUT': '86400', 04:32:33 INFO - 'USER': 'cltbld', 04:32:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:33 INFO - '_': '/tools/buildbot/bin/python'} 04:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:33 INFO - Running setup.py (path:/tmp/pip-PZT3y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:33 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)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:33 INFO - Running setup.py (path:/tmp/pip-prj0VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:33 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)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:33 INFO - Running setup.py (path:/tmp/pip-8u_fsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:33 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)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:33 INFO - Running setup.py (path:/tmp/pip-AHn9n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:33 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)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:33 INFO - Running setup.py (path:/tmp/pip-dL9cQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:33 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)) 04:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:33 INFO - Running setup.py (path:/tmp/pip-i89T6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:34 INFO - Running setup.py (path:/tmp/pip-3IDgjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:34 INFO - Running setup.py (path:/tmp/pip-Q5slqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:34 INFO - Running setup.py (path:/tmp/pip-RJw0nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:34 INFO - Running setup.py (path:/tmp/pip-Dxs7Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:34 INFO - Running setup.py (path:/tmp/pip-awe6xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:34 INFO - Running setup.py (path:/tmp/pip-gmWrNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:34 INFO - Running setup.py (path:/tmp/pip-O64X6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:34 INFO - Running setup.py (path:/tmp/pip-cr3gNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:34 INFO - Running setup.py (path:/tmp/pip-3padcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:34 INFO - Running setup.py (path:/tmp/pip-xWAoJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:34 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)) 04:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:34 INFO - Running setup.py (path:/tmp/pip-7r2Khl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:34 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)) 04:32:34 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)) 04:32:34 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)) 04:32:34 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)) 04:32:34 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)) 04:32:34 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)) 04:32:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 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 04:32:36 INFO - Downloading blessings-1.6.tar.gz 04:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:36 INFO - Installing collected packages: blessings 04:32:36 INFO - Running setup.py install for blessings 04:32:36 INFO - Successfully installed blessings 04:32:36 INFO - Cleaning up... 04:32:37 INFO - Return code: 0 04:32:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:37 INFO - Reading from file tmpfile_stdout 04:32:37 INFO - Current package versions: 04:32:37 INFO - argparse == 1.2.1 04:32:37 INFO - blessings == 1.6 04:32:37 INFO - blobuploader == 1.2.4 04:32:37 INFO - docopt == 0.6.1 04:32:37 INFO - functools32 == 3.2.3-2 04:32:37 INFO - jsonschema == 2.5.1 04:32:37 INFO - manifestparser == 1.1 04:32:37 INFO - mozInstall == 1.12 04:32:37 INFO - mozcrash == 0.17 04:32:37 INFO - mozdebug == 0.1 04:32:37 INFO - mozdevice == 0.48 04:32:37 INFO - mozfile == 1.2 04:32:37 INFO - mozhttpd == 0.7 04:32:37 INFO - mozinfo == 0.9 04:32:37 INFO - mozleak == 0.1 04:32:37 INFO - mozlog == 3.2 04:32:37 INFO - moznetwork == 0.27 04:32:37 INFO - mozprocess == 0.22 04:32:37 INFO - mozprofile == 0.28 04:32:37 INFO - mozrunner == 6.11 04:32:37 INFO - mozscreenshot == 0.1 04:32:37 INFO - mozsystemmonitor == 0.3 04:32:37 INFO - moztest == 0.7 04:32:37 INFO - mozversion == 1.4 04:32:37 INFO - psutil == 3.1.1 04:32:37 INFO - requests == 1.2.3 04:32:37 INFO - wsgiref == 0.1.2 04:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:37 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')]} 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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')]} 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:37 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 04:32:37 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 04:32:37 INFO - Using env: {'DISPLAY': ':0', 04:32:37 INFO - 'HOME': '/home/cltbld', 04:32:37 INFO - 'LANG': 'en_US.UTF-8', 04:32:37 INFO - 'LANGUAGE': 'en_US:en', 04:32:37 INFO - 'LOGNAME': 'cltbld', 04:32:37 INFO - 'MAIL': '/var/mail/cltbld', 04:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:37 INFO - 'MOZ_NO_REMOTE': '1', 04:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:37 INFO - 'NO_EM_RESTART': '1', 04:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:37 INFO - 'PWD': '/builds/slave/test', 04:32:37 INFO - 'SHELL': '/bin/bash', 04:32:37 INFO - 'SHLVL': '1', 04:32:37 INFO - 'TERM': 'linux', 04:32:37 INFO - 'TMOUT': '86400', 04:32:37 INFO - 'USER': 'cltbld', 04:32:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:37 INFO - '_': '/tools/buildbot/bin/python'} 04:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 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)) 04:32:37 INFO - Cleaning up... 04:32:37 INFO - Return code: 0 04:32:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:37 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')]} 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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')]} 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:37 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 04:32:37 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 04:32:37 INFO - Using env: {'DISPLAY': ':0', 04:32:37 INFO - 'HOME': '/home/cltbld', 04:32:37 INFO - 'LANG': 'en_US.UTF-8', 04:32:37 INFO - 'LANGUAGE': 'en_US:en', 04:32:37 INFO - 'LOGNAME': 'cltbld', 04:32:37 INFO - 'MAIL': '/var/mail/cltbld', 04:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:37 INFO - 'MOZ_NO_REMOTE': '1', 04:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:37 INFO - 'NO_EM_RESTART': '1', 04:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:37 INFO - 'PWD': '/builds/slave/test', 04:32:37 INFO - 'SHELL': '/bin/bash', 04:32:37 INFO - 'SHLVL': '1', 04:32:37 INFO - 'TERM': 'linux', 04:32:37 INFO - 'TMOUT': '86400', 04:32:37 INFO - 'USER': 'cltbld', 04:32:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:37 INFO - '_': '/tools/buildbot/bin/python'} 04:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:37 INFO - Cleaning up... 04:32:37 INFO - Return code: 0 04:32:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:37 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')]} 04:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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')]} 04:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:37 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 0x7f0c2519ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d05020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', '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 04:32:37 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 04:32:37 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 04:32:37 INFO - Using env: {'DISPLAY': ':0', 04:32:37 INFO - 'HOME': '/home/cltbld', 04:32:37 INFO - 'LANG': 'en_US.UTF-8', 04:32:37 INFO - 'LANGUAGE': 'en_US:en', 04:32:37 INFO - 'LOGNAME': 'cltbld', 04:32:37 INFO - 'MAIL': '/var/mail/cltbld', 04:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:37 INFO - 'MOZ_NO_REMOTE': '1', 04:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:37 INFO - 'NO_EM_RESTART': '1', 04:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:37 INFO - 'PWD': '/builds/slave/test', 04:32:37 INFO - 'SHELL': '/bin/bash', 04:32:37 INFO - 'SHLVL': '1', 04:32:37 INFO - 'TERM': 'linux', 04:32:37 INFO - 'TMOUT': '86400', 04:32:37 INFO - 'USER': 'cltbld', 04:32:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:37 INFO - '_': '/tools/buildbot/bin/python'} 04:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:37 INFO - Downloading/unpacking flake8 04:32:37 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 04:32:37 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 04:32:37 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 04:32:37 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 04:32:37 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 04:32:37 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 04:32:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 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 04:32:39 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 04:32:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:40 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 04:32:40 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 04:32:40 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 04:32:40 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 04:32:40 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 04:32:40 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 04:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:40 INFO - no previously-included directories found matching 'docs/_build' 04:32:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:40 INFO - Running setup.py install for pep8 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:40 INFO - no previously-included directories found matching 'docs/_build' 04:32:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:40 INFO - Cleaning up... 04:32:40 INFO - Return code: 0 04:32:40 INFO - Running post-action listener: _resource_record_post_action 04:32:40 INFO - Running post-action listener: _start_resource_monitoring 04:32:40 INFO - Starting resource monitoring. 04:32:40 INFO - ##### 04:32:40 INFO - ##### Finished create-virtualenv step (success) 04:32:40 INFO - ##### 04:32:40 INFO - ##### 04:32:40 INFO - ##### Running install step. 04:32:40 INFO - ##### 04:32:40 INFO - Running pre-action listener: _resource_record_pre_action 04:32:40 INFO - Running main action method: install 04:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:41 INFO - Reading from file tmpfile_stdout 04:32:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:41 INFO - Reading from file tmpfile_stdout 04:32:41 INFO - Output received: 04:32:41 INFO - Usage: mozinstall [options] installer 04:32:41 INFO - Options: 04:32:41 INFO - -h, --help show this help message and exit 04:32:41 INFO - -d DEST, --destination=DEST 04:32:41 INFO - Directory to install application into. [default: 04:32:41 INFO - "/builds/slave/test"] 04:32:41 INFO - --app=APP Application being installed. [default: firefox] 04:32:41 INFO - mkdir: /builds/slave/test/build/application 04:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:32:58 INFO - Reading from file tmpfile_stdout 04:32:58 INFO - Output received: 04:32:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:58 INFO - Running post-action listener: _resource_record_post_action 04:32:58 INFO - ##### 04:32:58 INFO - ##### Finished install step (success) 04:32:58 INFO - ##### 04:32:58 INFO - ##### 04:32:58 INFO - ##### Running run-tests step. 04:32:58 INFO - ##### 04:32:58 INFO - Running pre-action listener: _resource_record_pre_action 04:32:58 INFO - Running main action method: run_tests 04:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:58 INFO - Python 2.7.3 04:32:58 INFO - Return code: 0 04:32:58 INFO - grabbing minidump binary from tooltool 04:32: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')]} 04:32:58 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 0x1d972e0>, '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 0x1d03140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d035d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:58 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 04:32:58 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 04:32:58 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 04:32:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:58 INFO - Return code: 0 04:32:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:32:59 INFO - Return code: 0 04:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:32:59 INFO - Using env: {'DISPLAY': ':0', 04:32:59 INFO - 'HOME': '/home/cltbld', 04:32:59 INFO - 'LANG': 'en_US.UTF-8', 04:32:59 INFO - 'LANGUAGE': 'en_US:en', 04:32:59 INFO - 'LOGNAME': 'cltbld', 04:32:59 INFO - 'MAIL': '/var/mail/cltbld', 04:32:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:59 INFO - 'MOZ_NO_REMOTE': '1', 04:32:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:59 INFO - 'NO_EM_RESTART': '1', 04:32:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:59 INFO - 'PWD': '/builds/slave/test', 04:32:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:59 INFO - 'SHELL': '/bin/bash', 04:32:59 INFO - 'SHLVL': '1', 04:32:59 INFO - 'TERM': 'linux', 04:32:59 INFO - 'TMOUT': '86400', 04:32:59 INFO - 'USER': 'cltbld', 04:32:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799', 04:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:59 INFO - '_': '/tools/buildbot/bin/python'} 04:32:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:32:59 INFO - mozversion application_buildid: 20160623013034 04:32:59 INFO - mozversion application_changeset: 0a73cc32722952781b61bad3b69ba5a2fc591621 04:32:59 INFO - mozversion application_display_name: Nightly 04:32:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:59 INFO - mozversion application_name: Firefox 04:32:59 INFO - mozversion application_remotingname: firefox 04:32:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:32:59 INFO - mozversion application_vendor: Mozilla 04:32:59 INFO - mozversion application_version: 50.0a1 04:32:59 INFO - mozversion platform_buildid: 20160623013034 04:32:59 INFO - mozversion platform_changeset: 0a73cc32722952781b61bad3b69ba5a2fc591621 04:32:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:32:59 INFO - mozversion platform_version: 50.0a1 04:32:59 INFO - using testdate: 1466681579 04:32:59 INFO - actual date: 1466681579 04:32:59 INFO - starting webserver on 'localhost:50512' 04:32:59 INFO - SUITE-START | Running 2 tests 04:32:59 INFO - TEST-START | dromaeo_css 04:32:59 INFO - operating with platform_type : linux_ 04:32:59 INFO - Initialising browser for dromaeo_css test... 04:32:59 INFO - TEST-INFO | started process 24649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEerR6L/profile http://localhost:50512/getInfo.html) 04:33:04 INFO - PROCESS | 24649 | __metrics Screen width/height:1600/1200 04:33:04 INFO - PROCESS | 24649 | colorDepth:24 04:33:04 INFO - PROCESS | 24649 | Browser inner width/height: 1024/697 04:33:04 INFO - PROCESS | 24649 | __metrics 04:33:04 ERROR - PROCESS | 24649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:33:05 INFO - TEST-INFO | 24649: exit 0 04:33:05 INFO - Browser initialized. 04:33:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:05 INFO - TEST-INFO | started process 24770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEerR6L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:17 INFO - PROCESS | 24770 | RSS: Main: 184586240 04:33:17 INFO - PROCESS | 24770 | 04:34:07 INFO - PROCESS | 24770 | 1466681647381 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] 04:36:15 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50512/tests/dromaeo/cssquery-ext.html) 04:36:16 INFO - PROCESS | 24770 | RSS: Main: 188383232 04:36:16 INFO - PROCESS | 24770 | 04:39:18 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-ext.html (next: http://localhost:50512/tests/dromaeo/cssquery-jquery.html) 04:39:19 INFO - PROCESS | 24770 | RSS: Main: 188108800 04:39:19 INFO - PROCESS | 24770 | 04:42:20 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50512/tests/dromaeo/cssquery-mootools.html) 04:42:21 INFO - PROCESS | 24770 | RSS: Main: 188796928 04:42:21 INFO - PROCESS | 24770 | 04:45:23 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50512/tests/dromaeo/cssquery-prototype.html) 04:45:23 INFO - PROCESS | 24770 | RSS: Main: 186511360 04:45:23 INFO - PROCESS | 24770 | 04:48:26 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50512/tests/dromaeo/cssquery-yui.html) 04:48:27 INFO - PROCESS | 24770 | RSS: Main: 188055552 04:48:27 INFO - PROCESS | 24770 | 04:51:29 INFO - PROCESS | 24770 | Cycle 1(1): loaded http://localhost:50512/tests/dromaeo/cssquery-yui.html (next: http://localhost:50512/tests/dromaeo/cssquery-dojo.html) 04:51:30 INFO - PROCESS | 24770 | RSS: Main: 189255680 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | __start_tp_report 04:51:30 INFO - PROCESS | 24770 | _x_x_mozilla_page_load 04:51:30 INFO - PROCESS | 24770 | _x_x_mozilla_page_load_details 04:51:30 INFO - PROCESS | 24770 | |i|pagename|runs| 04:51:30 INFO - PROCESS | 24770 | |0;dojo.html;3106.394253120641;3110.129163834127;3146.08763458597;3148.9212769680753;3150.968490315097;5250.6324557281005;5273.604479664022;5352.384475785281;5370.624056316059;5411.891762164754;5263.131583288753;5301.443348448415;5326.973365133179;5367.35591728993;5381.165919282517;4874;4887.437944636376;4993.875153121183;5035.093683137034;5078.060558796616;4890.046440943999;5063.113955057868;5096.770645320951;5101.38783345999;5101.438841727407;4823.589994850442;4830.782614782343;4841.9031619367415;4949.851504454854;4951.925721114186;4806.663533552653;4818;4820.927686084711;4850.199717046718;4872.805087796484;4848.733319667417;4859.489753575895;4861.562459378673;4873.31773551703;4880.414350277953;5288.65623734456;5297.4437684043005;5326.520613144797;5360.463953604608;5387.568994480433;5712.971435142797;5752.539796816244;5757.136429535562;5789.623674461189;5800.448957349087;5661.179129026268;5849.85375365615;5855.560832937546;5862.20860183874;5876.941230587725;5403.540699040586;5431.701256430894;5456.208849716769;5456.48163424474;5470.015397228537;5900.380460051632;5926;5934.465898069195;5951.642901425928;5958.225430693982;5536.972315138479;5595.4124816894455;5708.885822283531;5709.571782116358;5722.685252311079;5627.71861406928;5725.370209276976;5738.655680659091;5739.799107031234;5793.536517078708;5634.943650563442;5685.3177618685195;5687.971560142173;5706.885862282731;5727.11229759388;5630.465105814941;5697.800576979786;5732.426757324318;5747.540196784331;5754.367019627837;4385.846495372647;4427.955720442818;4438.35643831649;4440.622547083534;4469.44131983502;3925.1364699766004;3943.783091929914;3947.973526883031;3965.6827453804203;3983.880483585497;5392.379876314196;5431.548359489312;5441.700706461103;5447;5514.6691198527415;5783.161441590946;5783.2192653992015;5799.594028418054;5828.679422631796;5855.941440585625;5489.505944465017;5496;5496.203050557727;5511.751971161227;5530.86172845674;4870.269459581091;4892.363992680928;4895.779689913962;4895.853124406273;4948.876278093005;5854.385289544536;5864.853378665567;5869.325027621793;5877.941220587825;5880.529557635379;5680.573956953162;5686.2323586315315;5686.857828554319;5687.919295333873;5694.231278777478;5807.8548036299435;5866.472017518444;5871.911921321098;5896.587238893237;5942.1383899335215;5625.690587017753;5627.634203776742;5641.12562552805;5642.5485961122195;5643.802466913638;5549.722513874371;5691.573132015033;5729.598928074995;5777.364489906023;5779.133130030529;5554.722263886871;5619;5619.550435965195;5710.771569137188;5713.8285851424525;5567.331920169606;5582.8325150245555;5607.046802043744;5617.045102332695;5684.232628595087;5561.110222364402;5565.220869078251;5565.387807341108;5572.275604171432;5574.665520068809;5562.582806289625;5673.858153546029;5687.914681279867;5760.798372056958;5774.9133762994425;5635.323761148688;5644.379118296902;5649.6327738696855;5654.491095801398;5657.151427285776 04:51:30 INFO - PROCESS | 24770 | |1;ext.html;578.8292453726153;623.6788054152113;626.7117126121987;643.1735220241989;648.4941745438559;37820.81089594551;40899;41111.58888411115;41302.58697413025;41360.17279654405;42753.35869961953;43265.35101973473;43426.131477370436;43460.3480947786;43599.12801743963;8667.739967800977;8896.510691911943;8919.687810926618;8925.196732294093;8928.419652722585;8609.784755381103;8627.913720862774;8679.956600217021;8701.260392866614;8718.825623487526;8676.52279124648;8698.47809131451;8702.695405660803;8730.126987301282;8768.780780480507;8562.785930351729;8665.090165532623;8699.260562852165;8713.215810577047;8736.8689469658;8731.47611143327;8815.338849586307;8817.29461643067;8828.646854125827;8849.867251991225;40600.79699601483;40792.184156317;40894.591054089375;40927.590724092675;41086.178276434606;2883.610712553799;3429.5884493860895;3459.930801383958;3861.362875125601;4250;30283.545746813816;30701.38597228043;30881.69118308833;31810.204744881332;31962.520562191585;3728.738988270822;3768.9057773555605;3785.8674946376746;3786.9431958520645;3811.1615444602144;295621;296222;298387.99999999785;299545;300158;33399;34146.48780268298;34152.658473415446;34187.974360769214;34274;34859.477107843406;35325.47011794825;35395.637414445584;35443.29113417717;36421.635783642356;13762.518311859038;13937.442502299997;14001.369938352798;14015.649608759863;14102.435902563988;11231.38227397501;11302.886971130349;11307.943460282646;11366.602168924048;11387.373694446886;8003.759887203393;8084.191580841869;8111.310538604284;8137.715179968673;8168.632411541495;3210.775245732776;3211.245357341023;3211.823349715741;3214.148250713563;3216.986649205493;1019.4087429290994;1033.3696445168441;1059.7456610413599;1177.581958404754;1181.9290842549474;32290.35419291601;32374.676253237165;32375.838120809247;32438.513422298685;32759.344813103606;1118.066414543865;1172.8299396587447;1190.6309044196328;1192.8508936382952;1201.333260040686;17319.26807319258;18003.72994405085;18519.629607407776;18521;18669.533261668294;555648;557882;559341;559632;561422;57052;58008.709956450795;58541;58593;58909.41090589039;1338.6653336665834;1367.685432350565;1370.1436602123672;1378.1678650373378;1382.5990462765685;31353.8432307837;32653.18367040843;32906.1901595405;33017.834910825295;33431.49852752259;49650.255246172055;49982;50491.747541263525;50515.49484505108;50711.49288507068;356805;368176;368543;371652;482792.2045456925;26933.86533067322;26986.86506567533;27137;27287.59068614012;27314.453710926067;46279.30581041354;46782.76608617071;47195;47925;48373.27440088472;39491.80254098711;39968.60031399649;40516.1896762069;40545.594544054184;40926.59073409347;39267.80366098151;39824.80087599543;40058.799706001286;40130;40825.795871020455;39717.60282397255;40094.799526002185;40924.38613420861;41091.1781764369;41346.1730765389;33651.3269734599;36615.63384366122;36899.26201476009;37056.62943370532;37595.436068459545;27934.161975140778;28247.57628635531;28452.85773571119;28561.28596785097;28678.856605717672 04:51:30 INFO - PROCESS | 24770 | |2;jquery.html;382.89470395641195;383.77384257297933;387.76263872961556;390.7382054023804;409.80739052645265;18195.727064094033;19198.328058517956;19880.90059549702;19883;19932.60134797303;19192.424227273204;19407.32074377397;19678.606427871433;19801.108950097245;20005.499862503446;5326.573874090063;5615.073512870372;5620.57845661575;5636.577256705743;5904.084866845625;5518.724063796814;5611.9158212626635;5637.577181711388;5649.4633009864;5653.293338332708;5582.972085139569;5638.4361563843695;5782.3639399666;5782.595218334718;5836.358000619928;5320.920186197191;5637.436256374371;5652.5195358394585;5722.7424765885635;5770.33641131269;5372.462753724635;5387.272718183034;5476.91784623231;5503.257060296849;5592.356878958931;13687.726245475034;13716.245606491639;18999.240030398767;22370.66444003341;23024.539509209888;2190.167736260211;2244.337920313495;2310.9422264443356;2431.63525471179;2891.5373540233463;9999.50002499872;10070.597176112946;10183.490825458697;10202.744931376701;10331.89668103317;1843.2074208090517;1847.5196448923243;1927.094265695121;1958.9902050489657;1996.8801871887588;62620.68689656568;72233.63883180551;75457.24542754557;81787;86532.56733716353;9014.86477702835;9494.572744226389;9691.418514888988;10094;10633.840492392621;11680.182387232811;11727.941360293144;13160.276184809927;13238.470461181638;13263.801042984363;5631.267935168484;5741.971290143522;6442.9355706443275;7480.0649918760155;7548.773536793905;7157.4274058075225;7266.745663901844;7322.890156647654;7492.175860655324;7499.5875226863045;3682.558093028854;4071.1247081876945;4073.551909289976;4098.241825262336;4207.852725154666;1912.9713054304198;1949.4736421166206;1991.9203231870852;2058.433930669048;2069.1619893942975;860.4837097741305;955.1833182628891;960.7261930349956;968.4383057826584;1003.996003996004;18969.62060758777;19357.612847743247;19703.507412314808;19797;19885.204591816455;972.0959507657946;981.7419934151424;1005.9497025148713;1015.0712098430001;1018.6078359831519;10948.726281842859;11221.719457013476;11270;11290.830637540443;11341.773164536664;476099;479573;491246;491368;492349;70328;82931;97346;100312.49843750881;103045.48477257566;1013.640157744005;1049.7638031442864;1050.7740835720356;1069.3530414099514;1075.548269726701;14929.776053358992;16627.91918525292;17847.553811154827;18458;18752.812471875106;40216.597834022454;41233.58766412418;42050.57949420589;42268.577314226466;43759.99999999873;54254;54382.456175437736;57256.141157883496;57538.42461575498;59536.10695839479;8091.959540202261;8218.21926916942;8353.958230209053;8389.244967952913;8747;12363.381830908238;12485.812712809133;12575.182613130117;13208.933955330162;13482.460701571827;11185.552577896793;11302.886971130183;11327.490262938352;11419.543218271176;11493.827592586285;11521.769564608829;11761.294322340687;11761.705957351134;11855.64433066975;12135.635930922086;11253.324800511995;11267.380294083576;11431.657050288504;11459.255148415326;11683.649490515298;8115.458062968017;8350.62422191015;8388.748337549883;8423.031351394668;8553.61508732121;10211.336263142872;10523.631672891412;11087.667369978913;11326.716832079264;11361.886381136082 04:51:30 INFO - PROCESS | 24770 | |3;mootools.html;1462.8317743459502;1468.9485867994622;1606.0925577048965;1689.543823167744;1745.467632372127;7714.382849372051;8031.357491400689;8360.163983601644;8756.299496040325;8906.33202509812;8062.7581172564915;8253.876191857127;8403.789905252372;8411.285040771541;8427.157284271585;2292.3925159832697;2327.092433950752;2331.2889568681544;2333.183385814968;2333.6266197408418;2289.3132060381818;2290.5075408787106;2346.8474549154334;2355.6819829322994;2360.9527809443803;2273.3975496493445;2302.9769702303015;2317.6060069788177;2336.299110266913;2337.9532409351805;2240.764719704432;2258.7402448718362;2299.620562607168;2323.5701395241936;2330.8951097200666;2299.1378233162563;2304;2307.561563302967;2320.2691152286975;2321.0483701682397;8299.83400331996;8400.327973762085;8494.447860889022;8506.659733610648;8510.191531804468;4810.037992401533;4893.119238537062;4929.950700493021;4973.701577905301;4976.4277108132665;3208.1017315151794;3212.4378233809225;3246.7986844867314;3259.7392208623255;3453.879114231015;1096.7916095941825;1122.775444911013;1124.7075760302298;1131.0386171753944;1145.3929417408788;11804.822927656092;12262.141650084408;12279.140460167791;12283.447244873912;12290.324032178227;4624.375709279271;4638.6752927294765;4754.833580824655;4757.215059515211;4776.2119250324;10119.645812396679;10132.746681333025;10135.746606334753;10191.388516689023;10233.283670143019;4906.460289368167;4912.606991440676;4912.6561140719805;4921.458639549646;4935.062338155739;3966.8809935701975;4300.204462174508;4380.649548036149;4496.820127194876;4503.031848152663;3881.2431575843;3930.6855451563806;3945.881623551298;3956.9208615828097;4007.198560287954;1237.5854088880146;1265.5380786013038;1269.8920591749804;1270.9872901271053;1273.3510104414804;995.915347195482;997.2171845101706;1001.84972254161;1002;1012.2205901455837;5911.201987731687;5933.110033495011;5986.9401305986385;6055.515558755289;6118.724657390429;455.58996902787095;458.4773358371459;461.1906104786079;462.9328747331618;471.1613328275675;4148.771817550064;4204.07510347723;4244.893877653083;4251.29853574163;4258.361245813153;10455.065812824652;10773.83839242412;10781.892181078245;10877.0754485868;10895.945520272506;10698.839517407245;10740.731481712863;10743.355398675949;10749.08632766208;10780.892191078146;7750.5737184454265;8116.878246826184;8130.024397072271;8199.385046121564;8236.958815205886;6021.6085954414575;6163.9383606163365;6168.290646575701;6187.102870083902;6227.1282020516255;10031.347962382422;10033.799324013333;10038.347507411994;10118.190544756255;10182.389056656624;10007.249456290661;10113;10278.691639250834;10284.948575257076;10311.22665800053;7133.536320139175;7598.962005189938;7808.258215469521;7825.882611760714;7923.6830526778285;8576.356773242156;8598;8609.182127697859;8632.654693812428;8636.740897773077;7537.359324457482;7848.2544158307155;7861.803454913673;7877.921220787948;7893.565853878092;7456.552606843607;7530.774076777706;7596.24037596258;7730.072391313079;7759.573223472763;7081.539699919489;7194.568325900463;7223.133224013152;7228.746993855189;7248.347648711641;4810.542998415145;4893.584045356185;5025.673331233458;5144.254083157846;5164.406093299319;4984.2025275955675;5092.872678183075;5114.514121158484;5187.766550505312;5189.974050129726 04:51:30 INFO - PROCESS | 24770 | |4;prototype.html;318.6542601277615;328.5154397264036;334.99832500837493;335.3477486289168;335.6509230400384;5363.919541206876;5501.724913754307;5565;5612.214289999398;5622.6826172558185;5564.4713752193475;5581.944180558193;5588.944110558893;5595.692236926968;5636.323641163056;4336.677313419405;4393.692441529094;4395.879050842047;4399.846005389812;4406.911861762763;4086;4309.504406993189;4324.632406245457;4401.933970990438;4405.559444055601;4252.978735106336;4266.701330906838;4274.444322238105;4278.828846846122;4295.892602684927;4271.67962402821;4300.935485967729;4313.956860431387;4324.870253892388;4332.696711230215;3533.3110043541265;3745.606711295329;3755.906102347436;3772.773633581994;3782.432635104729;5416.402161362368;5441.8572099859075;5452.263944367499;5461.836144915659;5469.617126801126;4865.562099411035;4876.366072410599;4948;4965.379327584052;4973.055119527315;5546.389897111315;5826.533877289849;5837.241158649391;5844.678542680151;5860.868087997994;4023.396490526415;4060;4098.7130900836955;4101.938470922939;4112.650424713903;6057.273127224717;6082.422169893853;6085.421884920881;6110.175126357974;6111.816645500642;4131.318332475168;4198.580141985838;4217.430646862635;4217.599328063829;4253;4287.842282583685;4306.676999225071;4311.534078413354;4318.546552611993;4320.071184695305;4910.116179087727;4914.680545764514;4920.917398172396;4921.384826896638;4953.331300274417;5725.76895967369;5867.005218225824;5869.295684517885;5885.558583106199;5892.145638882338;1446.1612264886342;1462.7732701431296;1464.3849583175092;1465.4504560789703;1473.5873955292536;914.5238543128679;938.7795865374985;941.6092321686424;941.9920684867126;947.8578213267928;4968.378952630921;5015.4733752956145;5075.746212689351;5095.770690318945;5135.640505164677;5370.865728356823;5386.272853164773;5399.760143913699;5428.75570599324;5446.509814116669;5072.6195535335;5079.238114282887;5094;5246.921296180561;5713.485786279171;3187.5218717192142;3203.855826487814;3213.196700824794;3215.533747606584;3250.447423937936;6129.509639228941;6223.1287619733275;6275.874482510324;6278.780242691484;6303.180586523723;6169.259688837278;6183.84540386485;6185.938140618537;6197.411245931629;6199.822033813652;6182.165407669997;6259.937400626027;6265.8746825063245;6268.310485846553;6270.592411493239;5707.714614269353;5975.820725378246;5985.221921150222;6043.821454816269;6062.272527296753;5986.551008674454;5990.251218597676;5991.2510936132985;6003.8198854034445;6016.713648813423;5947.650677982259;6272.968635156795;6288.968555157195;6302.369763023661;6303.936960630335;4190.832366705297;4221.324588065895;4243.811732714721;4250.893727656709;4253.766042867672;6057.485113765203;6065.332813390612;6069.211002569814;6079.665618391031;6105.877882442415;5745.482906538432;5820.970895145497;5878.706064696834;5895.29256489224;5932.288125424804;5879.266141244342;5895.233619629421;5898.292204935436;5899.528037756883;5910.202122713378;5576.498115169654;5798.884022319615;5828.912566311424;5842.357340692605;5850.531957443309;5832.387599302012;5869.73586188614;5887.352391236875;5911.723986265233;5939.376365481562;5716.628419152742;5729.2265544151005;5790.884182316246;5796.478316951495;5799.739011744397 04:51:30 INFO - PROCESS | 24770 | |5;yui.html;716.7240612364238;757.0914902117457;772.1043589436251;790.818111834278;801.7674874286457;13812.861871381283;14299.785503217447;14371.71256574868;14465.987380883329;14483.13101213928;14695.77956330656;14914.105153690785;14988.925055374708;14991.875609329316;15004.474843380483;661.5104822431414;786.1391776005265;792.5918152151646;793.2900054451262;799.6041959230189;802.7912742686885;803.2048272210528;805.7542449552884;806.7862016565615;814.6497006287324;857.7298151082421;859.166608389864;863.0937515608617;864.8356812205661;867.8004059066418;853.2576658307281;853.7865533616596;858;859.2610355094614;860.1699360117517;622.1352320274776;624.6814124796387;625.3527598935126;626.1109224900651;626.1984659635674;13617.727645447036;13679.658008549766;13715.245661488614;13772.449102035907;13802.447902083904;15269.694606107927;15594.37622495099;15686.215689215607;15775.447859324868;15879.206039698085;12325.93837030818;12346.774917465407;12595.370231488389;12678.556250531186;12820.61538153857;3868.78721670308;3937.5471820740695;3985.3822657488136;4067.471228740245;4085.89785255371;84410;84599.15400845974;86049.13950860474;86207.13792862116;86854.56572717159;11878.465469053914;11947.342896140795;12012.939935300268;12208.145429820004;12397.690057748448;23505;23530.294091177293;23610.527789444113;23643.40891477727;23786.40533986664;8816.955915220382;8911.331650126136;8911.55442227886;8914.86627700585;9086.091390860862;4815.470298267188;4859.198232291632;4876.122297986397;4935.407751069894;4991.4775993321655;3431.4166591679473;3524.6782456578785;3551.3785087609567;3560.412531932254;3560.5193298904314;576.5272476569173;580.7676929228343;584.9908907135243;595.0211901422136;600.2436929468813;682.8190529509684;750.962451877404;751.196220044558;774.7714424244862;787.7203592724615;9610.95194524023;9836.950815245878;10372.688819335432;10511.868958375611;10801.567937282422;713.6503113474361;738.5863916206941;743.7211045857804;746.3991486853135;766.781467281822;4510.887227819265;4666.113438446684;4866;4872.6589138760655;4888.633352498577;77202;123039;123108;123818;133205;67695.66152169208;110402.44798775954;112542.43728781467;113111;113746.43126784479;94233;94288.52855735677;94659;97073;97852;8677.088905664814;8740.21338079576;8773.42972706772;8991;9361.204297634777;38513;48065.75967120142;51796.741016294676;53137.46862531325;53778.46221537891;71610;79047;79313.60343198247;79953;81535;12379;12517.186382885084;12547.43536540876;12665.250531050857;13051;14224.502142424966;14263.358148883533;14444.711105778037;15114.848851511784;15242.923785381003;13499.86500134986;13648.181109133484;13714.24571648569;13841.79237311421;14160.996148703798;13329.400176992252;13374.799378009144;13769.242691652054;13781.931090344886;13783.586492405244;12791;13403.262820544964;13755.17468951866;13971.161730296215;14112.153270803785;10904;11336.376499292288;11414.201005929504;11608.88391116078;11738.119641027128;10135.695929122137;10339.896601034194;10876;10965.725856853642;11006.449677515931 04:51:30 INFO - PROCESS | 24770 | __end_tp_report 04:51:30 INFO - PROCESS | 24770 | __start_cc_report 04:51:30 INFO - PROCESS | 24770 | _x_x_mozilla_cycle_collect,360 04:51:30 INFO - PROCESS | 24770 | __end_cc_report 04:51:30 INFO - PROCESS | 24770 | __startTimestamp1466682690103__endTimestamp 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | ------- Summary: start ------- 04:51:30 INFO - PROCESS | 24770 | Number of tests: 6 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | [#0] dojo.html Cycles:165 Average:5347.09 Median:5567.33 stddev:596.75 (10.7%) stddev-sans-first:572.11 04:51:30 INFO - PROCESS | 24770 | Values: 3106.4 3110.1 3146.1 3148.9 3151.0 5250.6 5273.6 5352.4 5370.6 5411.9 5263.1 5301.4 5327.0 5367.4 5381.2 4874.0 4887.4 4993.9 5035.1 5078.1 4890.0 5063.1 5096.8 5101.4 5101.4 4823.6 4830.8 4841.9 4949.9 4951.9 4806.7 4818.0 4820.9 4850.2 4872.8 4848.7 4859.5 4861.6 4873.3 4880.4 5288.7 5297.4 5326.5 5360.5 5387.6 5713.0 5752.5 5757.1 5789.6 5800.4 5661.2 5849.9 5855.6 5862.2 5876.9 5403.5 5431.7 5456.2 5456.5 5470.0 5900.4 5926.0 5934.5 5951.6 5958.2 5537.0 5595.4 5708.9 5709.6 5722.7 5627.7 5725.4 5738.7 5739.8 5793.5 5634.9 5685.3 5688.0 5706.9 5727.1 5630.5 5697.8 5732.4 5747.5 5754.4 4385.8 4428.0 4438.4 4440.6 4469.4 3925.1 3943.8 3948.0 3965.7 3983.9 5392.4 5431.5 5441.7 5447.0 5514.7 5783.2 5783.2 5799.6 5828.7 5855.9 5489.5 5496.0 5496.2 5511.8 5530.9 4870.3 4892.4 4895.8 4895.9 4948.9 5854.4 5864.9 5869.3 5877.9 5880.5 5680.6 5686.2 5686.9 5687.9 5694.2 5807.9 5866.5 5871.9 5896.6 5942.1 5625.7 5627.6 5641.1 5642.5 5643.8 5549.7 5691.6 5729.6 5777.4 5779.1 5554.7 5619.0 5619.6 5710.8 5713.8 5567.3 5582.8 5607.0 5617.0 5684.2 5561.1 5565.2 5565.4 5572.3 5574.7 5562.6 5673.9 5687.9 5760.8 5774.9 5635.3 5644.4 5649.6 5654.5 5657.2 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | [#1] ext.html Cycles:180 Average:55987.94 Median:3786.41 stddev:114569.37 (3025.8%) stddev-sans-first:114815.24 04:51:30 INFO - PROCESS | 24770 | Values: 578.8 623.7 626.7 643.2 648.5 37820.8 40899.0 41111.6 41302.6 41360.2 42753.4 43265.4 43426.1 43460.3 43599.1 8667.7 8896.5 8919.7 8925.2 8928.4 8609.8 8627.9 8680.0 8701.3 8718.8 8676.5 8698.5 8702.7 8730.1 8768.8 8562.8 8665.1 8699.3 8713.2 8736.9 8731.5 8815.3 8817.3 8828.6 8849.9 40600.8 40792.2 40894.6 40927.6 41086.2 2883.6 3429.6 3459.9 3861.4 4250.0 30283.5 30701.4 30881.7 31810.2 31962.5 3728.7 3768.9 3785.9 3786.9 3811.2 295621.0 296222.0 298388.0 299545.0 300158.0 33399.0 34146.5 34152.7 34188.0 34274.0 34859.5 35325.5 35395.6 35443.3 36421.6 13762.5 13937.4 14001.4 14015.6 14102.4 11231.4 11302.9 11307.9 11366.6 11387.4 8003.8 8084.2 8111.3 8137.7 8168.6 3210.8 3211.2 3211.8 3214.1 3217.0 1019.4 1033.4 1059.7 1177.6 1181.9 32290.4 32374.7 32375.8 32438.5 32759.3 1118.1 1172.8 1190.6 1192.9 1201.3 17319.3 18003.7 18519.6 18521.0 18669.5 555648.0 557882.0 559341.0 559632.0 561422.0 57052.0 58008.7 58541.0 58593.0 58909.4 1338.7 1367.7 1370.1 1378.2 1382.6 31353.8 32653.2 32906.2 33017.8 33431.5 49650.3 49982.0 50491.7 50515.5 50711.5 356805.0 368176.0 368543.0 371652.0 482792.2 26933.9 26986.9 27137.0 27287.6 27314.5 46279.3 46782.8 47195.0 47925.0 48373.3 39491.8 39968.6 40516.2 40545.6 40926.6 39267.8 39824.8 40058.8 40130.0 40825.8 39717.6 40094.8 40924.4 41091.2 41346.2 33651.3 36615.6 36899.3 37056.6 37595.4 27934.2 28247.6 28452.9 28561.3 28678.9 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | [#2] jquery.html Cycles:180 Average:28330.77 Median:2661.59 stddev:80158.62 (3011.7%) stddev-sans-first:80356.01 04:51:30 INFO - PROCESS | 24770 | Values: 382.9 383.8 387.8 390.7 409.8 18195.7 19198.3 19880.9 19883.0 19932.6 19192.4 19407.3 19678.6 19801.1 20005.5 5326.6 5615.1 5620.6 5636.6 5904.1 5518.7 5611.9 5637.6 5649.5 5653.3 5583.0 5638.4 5782.4 5782.6 5836.4 5320.9 5637.4 5652.5 5722.7 5770.3 5372.5 5387.3 5476.9 5503.3 5592.4 13687.7 13716.2 18999.2 22370.7 23024.5 2190.2 2244.3 2310.9 2431.6 2891.5 9999.5 10070.6 10183.5 10202.7 10331.9 1843.2 1847.5 1927.1 1959.0 1996.9 62620.7 72233.6 75457.2 81787.0 86532.6 9014.9 9494.6 9691.4 10094.0 10633.8 11680.2 11727.9 13160.3 13238.5 13263.8 5631.3 5742.0 6442.9 7480.1 7548.8 7157.4 7266.7 7322.9 7492.2 7499.6 3682.6 4071.1 4073.6 4098.2 4207.9 1913.0 1949.5 1991.9 2058.4 2069.2 860.5 955.2 960.7 968.4 1004.0 18969.6 19357.6 19703.5 19797.0 19885.2 972.1 981.7 1005.9 1015.1 1018.6 10948.7 11221.7 11270.0 11290.8 11341.8 476099.0 479573.0 491246.0 491368.0 492349.0 70328.0 82931.0 97346.0 100312.5 103045.5 1013.6 1049.8 1050.8 1069.4 1075.5 14929.8 16627.9 17847.6 18458.0 18752.8 40216.6 41233.6 42050.6 42268.6 43760.0 54254.0 54382.5 57256.1 57538.4 59536.1 8092.0 8218.2 8354.0 8389.2 8747.0 12363.4 12485.8 12575.2 13208.9 13482.5 11185.6 11302.9 11327.5 11419.5 11493.8 11521.8 11761.3 11761.7 11855.6 12135.6 11253.3 11267.4 11431.7 11459.3 11683.6 8115.5 8350.6 8388.7 8423.0 8553.6 10211.3 10523.6 11087.7 11326.7 11361.9 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | [#3] mootools.html Cycles:180 Average:5716.88 Median:4438.73 stddev:3272.24 (73.7%) stddev-sans-first:3265.80 04:51:30 INFO - PROCESS | 24770 | Values: 1462.8 1468.9 1606.1 1689.5 1745.5 7714.4 8031.4 8360.2 8756.3 8906.3 8062.8 8253.9 8403.8 8411.3 8427.2 2292.4 2327.1 2331.3 2333.2 2333.6 2289.3 2290.5 2346.8 2355.7 2361.0 2273.4 2303.0 2317.6 2336.3 2338.0 2240.8 2258.7 2299.6 2323.6 2330.9 2299.1 2304.0 2307.6 2320.3 2321.0 8299.8 8400.3 8494.4 8506.7 8510.2 4810.0 4893.1 4930.0 4973.7 4976.4 3208.1 3212.4 3246.8 3259.7 3453.9 1096.8 1122.8 1124.7 1131.0 1145.4 11804.8 12262.1 12279.1 12283.4 12290.3 4624.4 4638.7 4754.8 4757.2 4776.2 10119.6 10132.7 10135.7 10191.4 10233.3 4906.5 4912.6 4912.7 4921.5 4935.1 3966.9 4300.2 4380.6 4496.8 4503.0 3881.2 3930.7 3945.9 3956.9 4007.2 1237.6 1265.5 1269.9 1271.0 1273.4 995.9 997.2 1001.8 1002.0 1012.2 5911.2 5933.1 5986.9 6055.5 6118.7 455.6 458.5 461.2 462.9 471.2 4148.8 4204.1 4244.9 4251.3 4258.4 10455.1 10773.8 10781.9 10877.1 10895.9 10698.8 10740.7 10743.4 10749.1 10780.9 7750.6 8116.9 8130.0 8199.4 8237.0 6021.6 6163.9 6168.3 6187.1 6227.1 10031.3 10033.8 10038.3 10118.2 10182.4 10007.2 10113.0 10278.7 10284.9 10311.2 7133.5 7599.0 7808.3 7825.9 7923.7 8576.4 8598.0 8609.2 8632.7 8636.7 7537.4 7848.3 7861.8 7877.9 7893.6 7456.6 7530.8 7596.2 7730.1 7759.6 7081.5 7194.6 7223.1 7228.7 7248.3 4810.5 4893.6 5025.7 5144.3 5164.4 4984.2 5092.9 5114.5 5187.8 5190.0 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | [#4] prototype.html Cycles:180 Average:4881.31 Median:5524.06 stddev:1456.36 (26.4%) stddev-sans-first:1419.61 04:51:30 INFO - PROCESS | 24770 | Values: 318.7 328.5 335.0 335.3 335.7 5363.9 5501.7 5565.0 5612.2 5622.7 5564.5 5581.9 5588.9 5595.7 5636.3 4336.7 4393.7 4395.9 4399.8 4406.9 4086.0 4309.5 4324.6 4401.9 4405.6 4253.0 4266.7 4274.4 4278.8 4295.9 4271.7 4300.9 4314.0 4324.9 4332.7 3533.3 3745.6 3755.9 3772.8 3782.4 5416.4 5441.9 5452.3 5461.8 5469.6 4865.6 4876.4 4948.0 4965.4 4973.1 5546.4 5826.5 5837.2 5844.7 5860.9 4023.4 4060.0 4098.7 4101.9 4112.7 6057.3 6082.4 6085.4 6110.2 6111.8 4131.3 4198.6 4217.4 4217.6 4253.0 4287.8 4306.7 4311.5 4318.5 4320.1 4910.1 4914.7 4920.9 4921.4 4953.3 5725.8 5867.0 5869.3 5885.6 5892.1 1446.2 1462.8 1464.4 1465.5 1473.6 914.5 938.8 941.6 942.0 947.9 4968.4 5015.5 5075.7 5095.8 5135.6 5370.9 5386.3 5399.8 5428.8 5446.5 5072.6 5079.2 5094.0 5246.9 5713.5 3187.5 3203.9 3213.2 3215.5 3250.4 6129.5 6223.1 6275.9 6278.8 6303.2 6169.3 6183.8 6185.9 6197.4 6199.8 6182.2 6259.9 6265.9 6268.3 6270.6 5707.7 5975.8 5985.2 6043.8 6062.3 5986.6 5990.3 5991.3 6003.8 6016.7 5947.7 6273.0 6289.0 6302.4 6303.9 4190.8 4221.3 4243.8 4250.9 4253.8 6057.5 6065.3 6069.2 6079.7 6105.9 5745.5 5821.0 5878.7 5895.3 5932.3 5879.3 5895.2 5898.3 5899.5 5910.2 5576.5 5798.9 5828.9 5842.4 5850.5 5832.4 5869.7 5887.4 5911.7 5939.4 5716.6 5729.2 5790.9 5796.5 5799.7 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - PROCESS | 24770 | [#5] yui.html Cycles:180 Average:21592.56 Median:4076.68 stddev:31894.22 (782.4%) stddev-sans-first:31945.18 04:51:30 INFO - PROCESS | 24770 | Values: 716.7 757.1 772.1 790.8 801.8 13812.9 14299.8 14371.7 14466.0 14483.1 14695.8 14914.1 14988.9 14991.9 15004.5 661.5 786.1 792.6 793.3 799.6 802.8 803.2 805.8 806.8 814.6 857.7 859.2 863.1 864.8 867.8 853.3 853.8 858.0 859.3 860.2 622.1 624.7 625.4 626.1 626.2 13617.7 13679.7 13715.2 13772.4 13802.4 15269.7 15594.4 15686.2 15775.4 15879.2 12325.9 12346.8 12595.4 12678.6 12820.6 3868.8 3937.5 3985.4 4067.5 4085.9 84410.0 84599.2 86049.1 86207.1 86854.6 11878.5 11947.3 12012.9 12208.1 12397.7 23505.0 23530.3 23610.5 23643.4 23786.4 8817.0 8911.3 8911.6 8914.9 9086.1 4815.5 4859.2 4876.1 4935.4 4991.5 3431.4 3524.7 3551.4 3560.4 3560.5 576.5 580.8 585.0 595.0 600.2 682.8 751.0 751.2 774.8 787.7 9611.0 9837.0 10372.7 10511.9 10801.6 713.7 738.6 743.7 746.4 766.8 4510.9 4666.1 4866.0 4872.7 4888.6 77202.0 123039.0 123108.0 123818.0 133205.0 67695.7 110402.4 112542.4 113111.0 113746.4 94233.0 94288.5 94659.0 97073.0 97852.0 8677.1 8740.2 8773.4 8991.0 9361.2 38513.0 48065.8 51796.7 53137.5 53778.5 71610.0 79047.0 79313.6 79953.0 81535.0 12379.0 12517.2 12547.4 12665.3 13051.0 14224.5 14263.4 14444.7 15114.8 15242.9 13499.9 13648.2 13714.2 13841.8 14161.0 13329.4 13374.8 13769.2 13781.9 13783.6 12791.0 13403.3 13755.2 13971.2 14112.2 10904.0 11336.4 11414.2 11608.9 11738.1 10135.7 10339.9 10876.0 10965.7 11006.4 04:51:30 INFO - PROCESS | 24770 | -------- Summary: end -------- 04:51:30 INFO - PROCESS | 24770 | 04:51:30 INFO - TEST-INFO | 24770: exit 0 04:51:30 INFO - TEST-OK | dromaeo_css | took 1111371ms 04:51:30 INFO - TEST-START | kraken 04:51:30 INFO - operating with platform_type : linux_ 04:51:30 INFO - Initialising browser for kraken test... 04:51:30 INFO - TEST-INFO | started process 25007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbF43qy/profile http://localhost:50512/getInfo.html) 04:51:35 INFO - PROCESS | 25007 | __metrics Screen width/height:1600/1200 04:51:35 INFO - PROCESS | 25007 | colorDepth:24 04:51:35 INFO - PROCESS | 25007 | Browser inner width/height: 1024/697 04:51:35 INFO - PROCESS | 25007 | __metrics 04:51:36 ERROR - PROCESS | 25007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:51:37 INFO - TEST-INFO | 25007: exit 0 04:51:37 INFO - Browser initialized. 04:51:37 INFO - Running cycle 1/1 for kraken test... 04:51:37 INFO - TEST-INFO | started process 25126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbF43qy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:49 INFO - PROCESS | 25126 | RSS: Main: 184913920 04:51:49 INFO - PROCESS | 25126 | 04:51:51 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:52 INFO - PROCESS | 25126 | RSS: Main: 190828544 04:51:52 INFO - PROCESS | 25126 | 04:51:55 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-dft) 04:51:55 INFO - PROCESS | 25126 | RSS: Main: 189911040 04:51:55 INFO - PROCESS | 25126 | 04:51:58 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-fft) 04:51:59 INFO - PROCESS | 25126 | RSS: Main: 184655872 04:51:59 INFO - PROCESS | 25126 | 04:52:01 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50512/tests/kraken/driver.html?testName=audio-oscillator) 04:52:02 INFO - PROCESS | 25126 | RSS: Main: 185802752 04:52:02 INFO - PROCESS | 25126 | 04:52:04 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:05 INFO - PROCESS | 25126 | RSS: Main: 186404864 04:52:05 INFO - PROCESS | 25126 | 04:52:08 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50512/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:08 INFO - PROCESS | 25126 | RSS: Main: 186576896 04:52:08 INFO - PROCESS | 25126 | 04:52:12 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50512/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:13 INFO - PROCESS | 25126 | RSS: Main: 183492608 04:52:13 INFO - PROCESS | 25126 | 04:52:15 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50512/tests/kraken/driver.html?testName=json-parse-financial) 04:52:16 INFO - PROCESS | 25126 | RSS: Main: 185102336 04:52:16 INFO - PROCESS | 25126 | 04:52:18 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:18 INFO - PROCESS | 25126 | RSS: Main: 185630720 04:52:18 INFO - PROCESS | 25126 | 04:52:20 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:21 INFO - PROCESS | 25126 | RSS: Main: 185929728 04:52:21 INFO - PROCESS | 25126 | 04:52:23 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:23 INFO - PROCESS | 25126 | RSS: Main: 186269696 04:52:23 INFO - PROCESS | 25126 | 04:52:26 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:27 INFO - PROCESS | 25126 | RSS: Main: 186601472 04:52:27 INFO - PROCESS | 25126 | 04:52:29 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:30 INFO - PROCESS | 25126 | RSS: Main: 186126336 04:52:30 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | Cycle 1(1): loaded http://localhost:50512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50512/tests/kraken/driver.html?testName=ai-astar) 04:52:32 INFO - PROCESS | 25126 | RSS: Main: 186281984 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | __start_tp_report 04:52:32 INFO - PROCESS | 25126 | _x_x_mozilla_page_load 04:52:32 INFO - PROCESS | 25126 | _x_x_mozilla_page_load_details 04:52:32 INFO - PROCESS | 25126 | |i|pagename|runs| 04:52:32 INFO - PROCESS | 25126 | |0;ai-astar;102;116;105;110;111;114;114;110;111;112 04:52:32 INFO - PROCESS | 25126 | |1;audio-beat-detection;158;126;152;187;133;158;160;136;188;127 04:52:32 INFO - PROCESS | 25126 | |2;audio-dft;165;163;163;161;163;177;163;163;163;161 04:52:32 INFO - PROCESS | 25126 | |3;audio-fft;75;75;75;155;76;76;74;76;174;75 04:52:32 INFO - PROCESS | 25126 | |4;audio-oscillator;86;84;140;86;89;87;132;86;85;145 04:52:32 INFO - PROCESS | 25126 | |5;imaging-gaussian-blur;120;117;118;118;117;118;118;117;116;118 04:52:32 INFO - PROCESS | 25126 | |6;imaging-darkroom;147;149;148;147;146;148;148;148;147;146 04:52:32 INFO - PROCESS | 25126 | |7;imaging-desaturate;97;96;96;96;96;96;95;96;96;96 04:52:32 INFO - PROCESS | 25126 | |8;json-parse-financial;58;58;59;55;58;64;58;55;58;55 04:52:32 INFO - PROCESS | 25126 | |9;json-stringify-tinderbox;63;62;63;64;63;62;62;64;65;63 04:52:32 INFO - PROCESS | 25126 | |10;stanford-crypto-aes;80;84;79;81;81;84;80;91;102;80 04:52:32 INFO - PROCESS | 25126 | |11;stanford-crypto-ccm;131;122;123;121;123;141;122;139;141;132 04:52:32 INFO - PROCESS | 25126 | |12;stanford-crypto-pbkdf2;164;159;161;164;158;161;161;159;158;161 04:52:32 INFO - PROCESS | 25126 | |13;stanford-crypto-sha256-iterative;65;65;67;64;66;67;64;64;64;64 04:52:32 INFO - PROCESS | 25126 | __end_tp_report 04:52:32 INFO - PROCESS | 25126 | __start_cc_report 04:52:32 INFO - PROCESS | 25126 | _x_x_mozilla_cycle_collect,909 04:52:32 INFO - PROCESS | 25126 | __end_cc_report 04:52:32 INFO - PROCESS | 25126 | __startTimestamp1466682752419__endTimestamp 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | ------- Summary: start ------- 04:52:32 INFO - PROCESS | 25126 | Number of tests: 14 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:4.22 (3.8%) stddev-sans-first:3.17 04:52:32 INFO - PROCESS | 25126 | Values: 102.0 116.0 105.0 110.0 111.0 114.0 114.0 110.0 111.0 112.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:158.00 stddev:22.54 (14.3%) stddev-sans-first:23.82 04:52:32 INFO - PROCESS | 25126 | Values: 158.0 126.0 152.0 187.0 133.0 158.0 160.0 136.0 188.0 127.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:4.64 (2.8%) stddev-sans-first:4.91 04:52:32 INFO - PROCESS | 25126 | Values: 165.0 163.0 163.0 161.0 163.0 177.0 163.0 163.0 163.0 161.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.90 (50.5%) stddev-sans-first:39.63 04:52:32 INFO - PROCESS | 25126 | Values: 75.0 75.0 75.0 155.0 76.0 76.0 74.0 76.0 174.0 75.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:86.00 stddev:25.75 (29.9%) stddev-sans-first:26.65 04:52:32 INFO - PROCESS | 25126 | Values: 86.0 84.0 140.0 86.0 89.0 87.0 132.0 86.0 85.0 145.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:1.06 (0.9%) stddev-sans-first:0.73 04:52:32 INFO - PROCESS | 25126 | Values: 120.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 116.0 118.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 04:52:32 INFO - PROCESS | 25126 | Values: 147.0 149.0 148.0 147.0 146.0 148.0 148.0 148.0 147.0 146.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 04:52:32 INFO - PROCESS | 25126 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.66 (4.6%) stddev-sans-first:2.82 04:52:32 INFO - PROCESS | 25126 | Values: 58.0 58.0 59.0 55.0 58.0 64.0 58.0 55.0 58.0 55.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 04:52:32 INFO - PROCESS | 25126 | Values: 63.0 62.0 63.0 64.0 63.0 62.0 62.0 64.0 65.0 63.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.00 stddev:7.18 (8.9%) stddev-sans-first:7.45 04:52:32 INFO - PROCESS | 25126 | Values: 80.0 84.0 79.0 81.0 81.0 84.0 80.0 91.0 102.0 80.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:131.50 stddev:8.38 (6.4%) stddev-sans-first:8.87 04:52:32 INFO - PROCESS | 25126 | Values: 131.0 122.0 123.0 121.0 123.0 141.0 122.0 139.0 141.0 132.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.17 (1.3%) stddev-sans-first:1.92 04:52:32 INFO - PROCESS | 25126 | Values: 164.0 159.0 161.0 164.0 158.0 161.0 161.0 159.0 158.0 161.0 04:52:32 INFO - PROCESS | 25126 | 04:52:32 INFO - PROCESS | 25126 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 04:52:32 INFO - PROCESS | 25126 | Values: 65.0 65.0 67.0 64.0 66.0 67.0 64.0 64.0 64.0 64.0 04:52:32 INFO - PROCESS | 25126 | -------- Summary: end -------- 04:52:32 INFO - PROCESS | 25126 | 04:52:33 INFO - TEST-INFO | 25126: exit 0 04:52:33 INFO - TEST-OK | kraken | took 62591ms 04:52:33 INFO - SUITE-END | took 1173s 04:52:33 INFO - Completed test suite (00:19:34) 04:52:33 INFO - javascript benchmark 04:52:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7131.703913676541, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.394253120641, 3110.129163834127, 3146.08763458597, 3148.9212769680753, 3150.968490315097, 5250.6324557281005, 5273.604479664022, 5352.384475785281, 5370.624056316059, 5411.891762164754, 5263.131583288753, 5301.443348448415, 5326.973365133179, 5367.35591728993, 5381.165919282517, 4874.0, 4887.437944636376, 4993.875153121183, 5035.093683137034, 5078.060558796616, 4890.046440943999, 5063.113955057868, 5096.770645320951, 5101.38783345999, 5101.438841727407, 4823.589994850442, 4830.782614782343, 4841.9031619367415, 4949.851504454854, 4951.925721114186, 4806.663533552653, 4818.0, 4820.927686084711, 4850.199717046718, 4872.805087796484, 4848.733319667417, 4859.489753575895, 4861.562459378673, 4873.31773551703, 4880.414350277953, 5288.65623734456, 5297.4437684043005, 5326.520613144797, 5360.463953604608, 5387.568994480433, 5712.971435142797, 5752.539796816244, 5757.136429535562, 5789.623674461189, 5800.448957349087, 5661.179129026268, 5849.85375365615, 5855.560832937546, 5862.20860183874, 5876.941230587725, 5403.540699040586, 5431.701256430894, 5456.208849716769, 5456.48163424474, 5470.015397228537, 5900.380460051632, 5926.0, 5934.465898069195, 5951.642901425928, 5958.225430693982, 5536.972315138479, 5595.4124816894455, 5708.885822283531, 5709.571782116358, 5722.685252311079, 5627.71861406928, 5725.370209276976, 5738.655680659091, 5739.799107031234, 5793.536517078708, 5634.943650563442, 5685.3177618685195, 5687.971560142173, 5706.885862282731, 5727.11229759388, 5630.465105814941, 5697.800576979786, 5732.426757324318, 5747.540196784331, 5754.367019627837, 4385.846495372647, 4427.955720442818, 4438.35643831649, 4440.622547083534, 4469.44131983502, 3925.1364699766004, 3943.783091929914, 3947.973526883031, 3965.6827453804203, 3983.880483585497, 5392.379876314196, 5431.548359489312, 5441.700706461103, 5447.0, 5514.6691198527415, 5783.161441590946, 5783.2192653992015, 5799.594028418054, 5828.679422631796, 5855.941440585625, 5489.505944465017, 5496.0, 5496.203050557727, 5511.751971161227, 5530.86172845674, 4870.269459581091, 4892.363992680928, 4895.779689913962, 4895.853124406273, 4948.876278093005, 5854.385289544536, 5864.853378665567, 5869.325027621793, 5877.941220587825, 5880.529557635379, 5680.573956953162, 5686.2323586315315, 5686.857828554319, 5687.919295333873, 5694.231278777478, 5807.8548036299435, 5866.472017518444, 5871.911921321098, 5896.587238893237, 5942.1383899335215, 5625.690587017753, 5627.634203776742, 5641.12562552805, 5642.5485961122195, 5643.802466913638, 5549.722513874371, 5691.573132015033, 5729.598928074995, 5777.364489906023, 5779.133130030529, 5554.722263886871, 5619.0, 5619.550435965195, 5710.771569137188, 5713.8285851424525, 5567.331920169606, 5582.8325150245555, 5607.046802043744, 5617.045102332695, 5684.232628595087, 5561.110222364402, 5565.220869078251, 5565.387807341108, 5572.275604171432, 5574.665520068809, 5562.582806289625, 5673.858153546029, 5687.914681279867, 5760.798372056958, 5774.9133762994425, 5635.323761148688, 5644.379118296902, 5649.6327738696855, 5654.491095801398, 5657.151427285776], "value": 5307.406110845059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8292453726153, 623.6788054152113, 626.7117126121987, 643.1735220241989, 648.4941745438559, 37820.81089594551, 40899.0, 41111.58888411115, 41302.58697413025, 41360.17279654405, 42753.35869961953, 43265.35101973473, 43426.131477370436, 43460.3480947786, 43599.12801743963, 8667.739967800977, 8896.510691911943, 8919.687810926618, 8925.196732294093, 8928.419652722585, 8609.784755381103, 8627.913720862774, 8679.956600217021, 8701.260392866614, 8718.825623487526, 8676.52279124648, 8698.47809131451, 8702.695405660803, 8730.126987301282, 8768.780780480507, 8562.785930351729, 8665.090165532623, 8699.260562852165, 8713.215810577047, 8736.8689469658, 8731.47611143327, 8815.338849586307, 8817.29461643067, 8828.646854125827, 8849.867251991225, 40600.79699601483, 40792.184156317, 40894.591054089375, 40927.590724092675, 41086.178276434606, 2883.610712553799, 3429.5884493860895, 3459.930801383958, 3861.362875125601, 4250.0, 30283.545746813816, 30701.38597228043, 30881.69118308833, 31810.204744881332, 31962.520562191585, 3728.738988270822, 3768.9057773555605, 3785.8674946376746, 3786.9431958520645, 3811.1615444602144, 295621.0, 296222.0, 298387.99999999785, 299545.0, 300158.0, 33399.0, 34146.48780268298, 34152.658473415446, 34187.974360769214, 34274.0, 34859.477107843406, 35325.47011794825, 35395.637414445584, 35443.29113417717, 36421.635783642356, 13762.518311859038, 13937.442502299997, 14001.369938352798, 14015.649608759863, 14102.435902563988, 11231.38227397501, 11302.886971130349, 11307.943460282646, 11366.602168924048, 11387.373694446886, 8003.759887203393, 8084.191580841869, 8111.310538604284, 8137.715179968673, 8168.632411541495, 3210.775245732776, 3211.245357341023, 3211.823349715741, 3214.148250713563, 3216.986649205493, 1019.4087429290994, 1033.3696445168441, 1059.7456610413599, 1177.581958404754, 1181.9290842549474, 32290.35419291601, 32374.676253237165, 32375.838120809247, 32438.513422298685, 32759.344813103606, 1118.066414543865, 1172.8299396587447, 1190.6309044196328, 1192.8508936382952, 1201.333260040686, 17319.26807319258, 18003.72994405085, 18519.629607407776, 18521.0, 18669.533261668294, 555648.0, 557882.0, 559341.0, 559632.0, 561422.0, 57052.0, 58008.709956450795, 58541.0, 58593.0, 58909.41090589039, 1338.6653336665834, 1367.685432350565, 1370.1436602123672, 1378.1678650373378, 1382.5990462765685, 31353.8432307837, 32653.18367040843, 32906.1901595405, 33017.834910825295, 33431.49852752259, 49650.255246172055, 49982.0, 50491.747541263525, 50515.49484505108, 50711.49288507068, 356805.0, 368176.0, 368543.0, 371652.0, 482792.2045456925, 26933.86533067322, 26986.86506567533, 27137.0, 27287.59068614012, 27314.453710926067, 46279.30581041354, 46782.76608617071, 47195.0, 47925.0, 48373.27440088472, 39491.80254098711, 39968.60031399649, 40516.1896762069, 40545.594544054184, 40926.59073409347, 39267.80366098151, 39824.80087599543, 40058.799706001286, 40130.0, 40825.795871020455, 39717.60282397255, 40094.799526002185, 40924.38613420861, 41091.1781764369, 41346.1730765389, 33651.3269734599, 36615.63384366122, 36899.26201476009, 37056.62943370532, 37595.436068459545, 27934.161975140778, 28247.57628635531, 28452.85773571119, 28561.28596785097, 28678.856605717672], "value": 18277.793583824496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.89470395641195, 383.77384257297933, 387.76263872961556, 390.7382054023804, 409.80739052645265, 18195.727064094033, 19198.328058517956, 19880.90059549702, 19883.0, 19932.60134797303, 19192.424227273204, 19407.32074377397, 19678.606427871433, 19801.108950097245, 20005.499862503446, 5326.573874090063, 5615.073512870372, 5620.57845661575, 5636.577256705743, 5904.084866845625, 5518.724063796814, 5611.9158212626635, 5637.577181711388, 5649.4633009864, 5653.293338332708, 5582.972085139569, 5638.4361563843695, 5782.3639399666, 5782.595218334718, 5836.358000619928, 5320.920186197191, 5637.436256374371, 5652.5195358394585, 5722.7424765885635, 5770.33641131269, 5372.462753724635, 5387.272718183034, 5476.91784623231, 5503.257060296849, 5592.356878958931, 13687.726245475034, 13716.245606491639, 18999.240030398767, 22370.66444003341, 23024.539509209888, 2190.167736260211, 2244.337920313495, 2310.9422264443356, 2431.63525471179, 2891.5373540233463, 9999.50002499872, 10070.597176112946, 10183.490825458697, 10202.744931376701, 10331.89668103317, 1843.2074208090517, 1847.5196448923243, 1927.094265695121, 1958.9902050489657, 1996.8801871887588, 62620.68689656568, 72233.63883180551, 75457.24542754557, 81787.0, 86532.56733716353, 9014.86477702835, 9494.572744226389, 9691.418514888988, 10094.0, 10633.840492392621, 11680.182387232811, 11727.941360293144, 13160.276184809927, 13238.470461181638, 13263.801042984363, 5631.267935168484, 5741.971290143522, 6442.9355706443275, 7480.0649918760155, 7548.773536793905, 7157.4274058075225, 7266.745663901844, 7322.890156647654, 7492.175860655324, 7499.5875226863045, 3682.558093028854, 4071.1247081876945, 4073.551909289976, 4098.241825262336, 4207.852725154666, 1912.9713054304198, 1949.4736421166206, 1991.9203231870852, 2058.433930669048, 2069.1619893942975, 860.4837097741305, 955.1833182628891, 960.7261930349956, 968.4383057826584, 1003.996003996004, 18969.62060758777, 19357.612847743247, 19703.507412314808, 19797.0, 19885.204591816455, 972.0959507657946, 981.7419934151424, 1005.9497025148713, 1015.0712098430001, 1018.6078359831519, 10948.726281842859, 11221.719457013476, 11270.0, 11290.830637540443, 11341.773164536664, 476099.0, 479573.0, 491246.0, 491368.0, 492349.0, 70328.0, 82931.0, 97346.0, 100312.49843750881, 103045.48477257566, 1013.640157744005, 1049.7638031442864, 1050.7740835720356, 1069.3530414099514, 1075.548269726701, 14929.776053358992, 16627.91918525292, 17847.553811154827, 18458.0, 18752.812471875106, 40216.597834022454, 41233.58766412418, 42050.57949420589, 42268.577314226466, 43759.99999999873, 54254.0, 54382.456175437736, 57256.141157883496, 57538.42461575498, 59536.10695839479, 8091.959540202261, 8218.21926916942, 8353.958230209053, 8389.244967952913, 8747.0, 12363.381830908238, 12485.812712809133, 12575.182613130117, 13208.933955330162, 13482.460701571827, 11185.552577896793, 11302.886971130183, 11327.490262938352, 11419.543218271176, 11493.827592586285, 11521.769564608829, 11761.294322340687, 11761.705957351134, 11855.64433066975, 12135.635930922086, 11253.324800511995, 11267.380294083576, 11431.657050288504, 11459.255148415326, 11683.649490515298, 8115.458062968017, 8350.62422191015, 8388.748337549883, 8423.031351394668, 8553.61508732121, 10211.336263142872, 10523.631672891412, 11087.667369978913, 11326.716832079264, 11361.886381136082], "value": 8905.622375255927, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.8317743459502, 1468.9485867994622, 1606.0925577048965, 1689.543823167744, 1745.467632372127, 7714.382849372051, 8031.357491400689, 8360.163983601644, 8756.299496040325, 8906.33202509812, 8062.7581172564915, 8253.876191857127, 8403.789905252372, 8411.285040771541, 8427.157284271585, 2292.3925159832697, 2327.092433950752, 2331.2889568681544, 2333.183385814968, 2333.6266197408418, 2289.3132060381818, 2290.5075408787106, 2346.8474549154334, 2355.6819829322994, 2360.9527809443803, 2273.3975496493445, 2302.9769702303015, 2317.6060069788177, 2336.299110266913, 2337.9532409351805, 2240.764719704432, 2258.7402448718362, 2299.620562607168, 2323.5701395241936, 2330.8951097200666, 2299.1378233162563, 2304.0, 2307.561563302967, 2320.2691152286975, 2321.0483701682397, 8299.83400331996, 8400.327973762085, 8494.447860889022, 8506.659733610648, 8510.191531804468, 4810.037992401533, 4893.119238537062, 4929.950700493021, 4973.701577905301, 4976.4277108132665, 3208.1017315151794, 3212.4378233809225, 3246.7986844867314, 3259.7392208623255, 3453.879114231015, 1096.7916095941825, 1122.775444911013, 1124.7075760302298, 1131.0386171753944, 1145.3929417408788, 11804.822927656092, 12262.141650084408, 12279.140460167791, 12283.447244873912, 12290.324032178227, 4624.375709279271, 4638.6752927294765, 4754.833580824655, 4757.215059515211, 4776.2119250324, 10119.645812396679, 10132.746681333025, 10135.746606334753, 10191.388516689023, 10233.283670143019, 4906.460289368167, 4912.606991440676, 4912.6561140719805, 4921.458639549646, 4935.062338155739, 3966.8809935701975, 4300.204462174508, 4380.649548036149, 4496.820127194876, 4503.031848152663, 3881.2431575843, 3930.6855451563806, 3945.881623551298, 3956.9208615828097, 4007.198560287954, 1237.5854088880146, 1265.5380786013038, 1269.8920591749804, 1270.9872901271053, 1273.3510104414804, 995.915347195482, 997.2171845101706, 1001.84972254161, 1002.0, 1012.2205901455837, 5911.201987731687, 5933.110033495011, 5986.9401305986385, 6055.515558755289, 6118.724657390429, 455.58996902787095, 458.4773358371459, 461.1906104786079, 462.9328747331618, 471.1613328275675, 4148.771817550064, 4204.07510347723, 4244.893877653083, 4251.29853574163, 4258.361245813153, 10455.065812824652, 10773.83839242412, 10781.892181078245, 10877.0754485868, 10895.945520272506, 10698.839517407245, 10740.731481712863, 10743.355398675949, 10749.08632766208, 10780.892191078146, 7750.5737184454265, 8116.878246826184, 8130.024397072271, 8199.385046121564, 8236.958815205886, 6021.6085954414575, 6163.9383606163365, 6168.290646575701, 6187.102870083902, 6227.1282020516255, 10031.347962382422, 10033.799324013333, 10038.347507411994, 10118.190544756255, 10182.389056656624, 10007.249456290661, 10113.0, 10278.691639250834, 10284.948575257076, 10311.22665800053, 7133.536320139175, 7598.962005189938, 7808.258215469521, 7825.882611760714, 7923.6830526778285, 8576.356773242156, 8598.0, 8609.182127697859, 8632.654693812428, 8636.740897773077, 7537.359324457482, 7848.2544158307155, 7861.803454913673, 7877.921220787948, 7893.565853878092, 7456.552606843607, 7530.774076777706, 7596.24037596258, 7730.072391313079, 7759.573223472763, 7081.539699919489, 7194.568325900463, 7223.133224013152, 7228.746993855189, 7248.347648711641, 4810.542998415145, 4893.584045356185, 5025.673331233458, 5144.254083157846, 5164.406093299319, 4984.2025275955675, 5092.872678183075, 5114.514121158484, 5187.766550505312, 5189.974050129726], "value": 4507.658997622212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6542601277615, 328.5154397264036, 334.99832500837493, 335.3477486289168, 335.6509230400384, 5363.919541206876, 5501.724913754307, 5565.0, 5612.214289999398, 5622.6826172558185, 5564.4713752193475, 5581.944180558193, 5588.944110558893, 5595.692236926968, 5636.323641163056, 4336.677313419405, 4393.692441529094, 4395.879050842047, 4399.846005389812, 4406.911861762763, 4086.0, 4309.504406993189, 4324.632406245457, 4401.933970990438, 4405.559444055601, 4252.978735106336, 4266.701330906838, 4274.444322238105, 4278.828846846122, 4295.892602684927, 4271.67962402821, 4300.935485967729, 4313.956860431387, 4324.870253892388, 4332.696711230215, 3533.3110043541265, 3745.606711295329, 3755.906102347436, 3772.773633581994, 3782.432635104729, 5416.402161362368, 5441.8572099859075, 5452.263944367499, 5461.836144915659, 5469.617126801126, 4865.562099411035, 4876.366072410599, 4948.0, 4965.379327584052, 4973.055119527315, 5546.389897111315, 5826.533877289849, 5837.241158649391, 5844.678542680151, 5860.868087997994, 4023.396490526415, 4060.0, 4098.7130900836955, 4101.938470922939, 4112.650424713903, 6057.273127224717, 6082.422169893853, 6085.421884920881, 6110.175126357974, 6111.816645500642, 4131.318332475168, 4198.580141985838, 4217.430646862635, 4217.599328063829, 4253.0, 4287.842282583685, 4306.676999225071, 4311.534078413354, 4318.546552611993, 4320.071184695305, 4910.116179087727, 4914.680545764514, 4920.917398172396, 4921.384826896638, 4953.331300274417, 5725.76895967369, 5867.005218225824, 5869.295684517885, 5885.558583106199, 5892.145638882338, 1446.1612264886342, 1462.7732701431296, 1464.3849583175092, 1465.4504560789703, 1473.5873955292536, 914.5238543128679, 938.7795865374985, 941.6092321686424, 941.9920684867126, 947.8578213267928, 4968.378952630921, 5015.4733752956145, 5075.746212689351, 5095.770690318945, 5135.640505164677, 5370.865728356823, 5386.272853164773, 5399.760143913699, 5428.75570599324, 5446.509814116669, 5072.6195535335, 5079.238114282887, 5094.0, 5246.921296180561, 5713.485786279171, 3187.5218717192142, 3203.855826487814, 3213.196700824794, 3215.533747606584, 3250.447423937936, 6129.509639228941, 6223.1287619733275, 6275.874482510324, 6278.780242691484, 6303.180586523723, 6169.259688837278, 6183.84540386485, 6185.938140618537, 6197.411245931629, 6199.822033813652, 6182.165407669997, 6259.937400626027, 6265.8746825063245, 6268.310485846553, 6270.592411493239, 5707.714614269353, 5975.820725378246, 5985.221921150222, 6043.821454816269, 6062.272527296753, 5986.551008674454, 5990.251218597676, 5991.2510936132985, 6003.8198854034445, 6016.713648813423, 5947.650677982259, 6272.968635156795, 6288.968555157195, 6302.369763023661, 6303.936960630335, 4190.832366705297, 4221.324588065895, 4243.811732714721, 4250.893727656709, 4253.766042867672, 6057.485113765203, 6065.332813390612, 6069.211002569814, 6079.665618391031, 6105.877882442415, 5745.482906538432, 5820.970895145497, 5878.706064696834, 5895.29256489224, 5932.288125424804, 5879.266141244342, 5895.233619629421, 5898.292204935436, 5899.528037756883, 5910.202122713378, 5576.498115169654, 5798.884022319615, 5828.912566311424, 5842.357340692605, 5850.531957443309, 5832.387599302012, 5869.73586188614, 5887.352391236875, 5911.723986265233, 5939.376365481562, 5716.628419152742, 5729.2265544151005, 5790.884182316246, 5796.478316951495, 5799.739011744397], "value": 4409.247237781124, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7240612364238, 757.0914902117457, 772.1043589436251, 790.818111834278, 801.7674874286457, 13812.861871381283, 14299.785503217447, 14371.71256574868, 14465.987380883329, 14483.13101213928, 14695.77956330656, 14914.105153690785, 14988.925055374708, 14991.875609329316, 15004.474843380483, 661.5104822431414, 786.1391776005265, 792.5918152151646, 793.2900054451262, 799.6041959230189, 802.7912742686885, 803.2048272210528, 805.7542449552884, 806.7862016565615, 814.6497006287324, 857.7298151082421, 859.166608389864, 863.0937515608617, 864.8356812205661, 867.8004059066418, 853.2576658307281, 853.7865533616596, 858.0, 859.2610355094614, 860.1699360117517, 622.1352320274776, 624.6814124796387, 625.3527598935126, 626.1109224900651, 626.1984659635674, 13617.727645447036, 13679.658008549766, 13715.245661488614, 13772.449102035907, 13802.447902083904, 15269.694606107927, 15594.37622495099, 15686.215689215607, 15775.447859324868, 15879.206039698085, 12325.93837030818, 12346.774917465407, 12595.370231488389, 12678.556250531186, 12820.61538153857, 3868.78721670308, 3937.5471820740695, 3985.3822657488136, 4067.471228740245, 4085.89785255371, 84410.0, 84599.15400845974, 86049.13950860474, 86207.13792862116, 86854.56572717159, 11878.465469053914, 11947.342896140795, 12012.939935300268, 12208.145429820004, 12397.690057748448, 23505.0, 23530.294091177293, 23610.527789444113, 23643.40891477727, 23786.40533986664, 8816.955915220382, 8911.331650126136, 8911.55442227886, 8914.86627700585, 9086.091390860862, 4815.470298267188, 4859.198232291632, 4876.122297986397, 4935.407751069894, 4991.4775993321655, 3431.4166591679473, 3524.6782456578785, 3551.3785087609567, 3560.412531932254, 3560.5193298904314, 576.5272476569173, 580.7676929228343, 584.9908907135243, 595.0211901422136, 600.2436929468813, 682.8190529509684, 750.962451877404, 751.196220044558, 774.7714424244862, 787.7203592724615, 9610.95194524023, 9836.950815245878, 10372.688819335432, 10511.868958375611, 10801.567937282422, 713.6503113474361, 738.5863916206941, 743.7211045857804, 746.3991486853135, 766.781467281822, 4510.887227819265, 4666.113438446684, 4866.0, 4872.6589138760655, 4888.633352498577, 77202.0, 123039.0, 123108.0, 123818.0, 133205.0, 67695.66152169208, 110402.44798775954, 112542.43728781467, 113111.0, 113746.43126784479, 94233.0, 94288.52855735677, 94659.0, 97073.0, 97852.0, 8677.088905664814, 8740.21338079576, 8773.42972706772, 8991.0, 9361.204297634777, 38513.0, 48065.75967120142, 51796.741016294676, 53137.46862531325, 53778.46221537891, 71610.0, 79047.0, 79313.60343198247, 79953.0, 81535.0, 12379.0, 12517.186382885084, 12547.43536540876, 12665.250531050857, 13051.0, 14224.502142424966, 14263.358148883533, 14444.711105778037, 15114.848851511784, 15242.923785381003, 13499.86500134986, 13648.181109133484, 13714.24571648569, 13841.79237311421, 14160.996148703798, 13329.400176992252, 13374.799378009144, 13769.242691652054, 13781.931090344886, 13783.586492405244, 12791.0, 13403.262820544964, 13755.17468951866, 13971.161730296215, 14112.153270803785, 10904.0, 11336.376499292288, 11414.201005929504, 11608.88391116078, 11738.119641027128, 10135.695929122137, 10339.896601034194, 10876.0, 10965.725856853642, 11006.449677515931], "value": 7661.846808738953, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 105.0, 110.0, 111.0, 114.0, 114.0, 110.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 152.0, 187.0, 133.0, 158.0, 160.0, 136.0, 188.0, 127.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 161.0, 163.0, 177.0, 163.0, 163.0, 163.0, 161.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 155.0, 76.0, 76.0, 74.0, 76.0, 174.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 140.0, 86.0, 89.0, 87.0, 132.0, 86.0, 85.0, 145.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 116.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 147.0, 146.0, 148.0, 148.0, 148.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 55.0, 58.0, 64.0, 58.0, 55.0, 58.0, 55.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 63.0, 62.0, 62.0, 64.0, 65.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 79.0, 81.0, 81.0, 84.0, 80.0, 91.0, 102.0, 80.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 123.0, 121.0, 123.0, 141.0, 122.0, 139.0, 141.0, 132.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 161.0, 164.0, 158.0, 161.0, 161.0, 159.0, 158.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 64.0, 66.0, 67.0, 64.0, 64.0, 64.0, 64.0], "value": 65.0, "unit": "score"}]}]} 04:52:33 INFO - Return code: 0 04:52:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:33 ERROR - # TBPL SUCCESS # 04:52:33 INFO - Running post-action listener: _resource_record_post_action 04:52:33 INFO - ##### 04:52:33 INFO - ##### Finished run-tests step (success) 04:52:33 INFO - ##### 04:52:33 INFO - Running post-run listener: _resource_record_post_run 04:52:33 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 8192; Write bytes: 551661568; Read time: 272; Write time: 549416 04:52:33 INFO - TinderboxPrint: CPU usage
13.5% 04:52:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 272 04:52:33 INFO - TinderboxPrint: I/O write bytes / time
551,661,568 / 549,416 04:52:33 INFO - TinderboxPrint: CPU idle
8,223.0 (86.5%) 04:52:33 INFO - TinderboxPrint: CPU user
1,227.4 (12.9%) 04:52:33 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257142784; Read time: 0; Write time: 326896 04:52:33 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 8192; Write bytes: 294518784; Read time: 272; Write time: 222520 04:52:34 INFO - Running post-run listener: _upload_blobber_files 04:52:34 INFO - Blob upload gear active. 04:52:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:34 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 04:52:34 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:34 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:39 INFO - (blobuploader) - INFO - Done attempting. 04:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:40 INFO - (blobuploader) - INFO - Done attempting. 04:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:40 INFO - (blobuploader) - INFO - Done attempting. 04:52:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:40 INFO - Return code: 0 04:52:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37b36619a163ba70979575b4d3e7ddfd729b75be4235ceb2f97ce268bbb4a2fedb5b172a1677e5e70b6344bad005c9ddd38926b4711ab2c385549449dbc5d205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa50b08ac1e90ad2b6c52992e5e7e2834be314873409dae8f23422298f69079ff163f197d87eb2866d7042ea53f77240b4a16b1116737a06cf6b67ec6b165273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7c4d77a2f48efced944bcfee5ce0d930fbb90452d776f25ddf7ca1ef1722e27d380a27fc6b5cbb99af12d85c814a5bcdcf2630cb2512f555f53b65dd953b867b"} 04:52:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:40 INFO - Contents: 04:52:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37b36619a163ba70979575b4d3e7ddfd729b75be4235ceb2f97ce268bbb4a2fedb5b172a1677e5e70b6344bad005c9ddd38926b4711ab2c385549449dbc5d205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa50b08ac1e90ad2b6c52992e5e7e2834be314873409dae8f23422298f69079ff163f197d87eb2866d7042ea53f77240b4a16b1116737a06cf6b67ec6b165273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7c4d77a2f48efced944bcfee5ce0d930fbb90452d776f25ddf7ca1ef1722e27d380a27fc6b5cbb99af12d85c814a5bcdcf2630cb2512f555f53b65dd953b867b"} 04:52:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:40 INFO - Copying logs to upload dir... 04:52:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.691541 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-23 04:52:39.850094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:52:39.853465) ========= 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=0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37b36619a163ba70979575b4d3e7ddfd729b75be4235ceb2f97ce268bbb4a2fedb5b172a1677e5e70b6344bad005c9ddd38926b4711ab2c385549449dbc5d205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa50b08ac1e90ad2b6c52992e5e7e2834be314873409dae8f23422298f69079ff163f197d87eb2866d7042ea53f77240b4a16b1116737a06cf6b67ec6b165273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7c4d77a2f48efced944bcfee5ce0d930fbb90452d776f25ddf7ca1ef1722e27d380a27fc6b5cbb99af12d85c814a5bcdcf2630cb2512f555f53b65dd953b867b"} build_url:https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/UKaoXROjRcam7m1px_VqWw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/37b36619a163ba70979575b4d3e7ddfd729b75be4235ceb2f97ce268bbb4a2fedb5b172a1677e5e70b6344bad005c9ddd38926b4711ab2c385549449dbc5d205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa50b08ac1e90ad2b6c52992e5e7e2834be314873409dae8f23422298f69079ff163f197d87eb2866d7042ea53f77240b4a16b1116737a06cf6b67ec6b165273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7c4d77a2f48efced944bcfee5ce0d930fbb90452d776f25ddf7ca1ef1722e27d380a27fc6b5cbb99af12d85c814a5bcdcf2630cb2512f555f53b65dd953b867b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:52:39.882482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:52:39.883131) ========= 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=0e2a256762fed810e2f0f810000001b3-1466681524.554513-252413799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:52:39.967945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:52:39.968713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:52:39.969437) ========= ========= Total master_lag: 0.18 =========