builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1466506646.83 results: success (0) buildid: 20160621013014 builduid: 66ee36e837574b70a86b66c26f1b7b88 revision: 333518a265a209bec3a25ef6caeb993292439878 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:26.829772) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:26.835067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:26.835773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:26.859357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:26.859780) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 03:57:26-- 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% 103M=0s 2016-06-21 03:57:27 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.360495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:27.240499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:27.240897) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:27.293158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:27.294038) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 333518a265a209bec3a25ef6caeb993292439878 --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 333518a265a209bec3a25ef6caeb993292439878 --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=9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 03:57:27,419 truncating revision to first 12 chars 2016-06-21 03:57:27,419 Setting DEBUG logging. 2016-06-21 03:57:27,419 attempt 1/10 2016-06-21 03:57:27,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/333518a265a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 03:57:27,721 unpacking tar archive at: mozilla-inbound-333518a265a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:28.041477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:28.041803) ========= script_repo_revision: 333518a265a209bec3a25ef6caeb993292439878 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:28.042260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:28.042628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 03:57:28.055944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 03:57:28.056240) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:57:28 INFO - MultiFileLogger online at 20160621 03:57:28 in /builds/slave/test 03:57:28 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 03:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:28 INFO - {'append_to_log': False, 03:57:28 INFO - 'base_work_dir': '/builds/slave/test', 03:57:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:28 INFO - 'branch': 'Mozilla-Inbound', 03:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:28 INFO - 'config_files': ('talos/linux_config.py',), 03:57:28 INFO - 'default_actions': ('clobber', 03:57:28 INFO - 'read-buildbot-config', 03:57:28 INFO - 'download-and-extract', 03:57:28 INFO - 'populate-webroot', 03:57:28 INFO - 'create-virtualenv', 03:57:28 INFO - 'install', 03:57:28 INFO - 'run-tests'), 03:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:28 INFO - 'download_minidump_stackwalk': True, 03:57:28 INFO - 'download_symbols': 'ondemand', 03:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:28 INFO - 'installer_path': 'installer.exe', 03:57:28 INFO - 'log_level': 'info', 03:57:28 INFO - 'log_name': 'talos', 03:57:28 INFO - 'log_to_console': True, 03:57:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:57:28 INFO - 'opt_config_files': (), 03:57:28 INFO - 'pip_index': False, 03:57:28 INFO - 'sps_profile': False, 03:57:28 INFO - 'sps_profile_interval': 0, 03:57:28 INFO - 'suite': 'dromaeojs-e10s', 03:57:28 INFO - 'system_bits': '32', 03:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:28 INFO - 'title': 'talos-linux64-ix-013', 03:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:28 INFO - 'use_talos_json': True, 03:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:28 INFO - 'work_dir': 'build'} 03:57:28 INFO - ##### 03:57:28 INFO - ##### Running clobber step. 03:57:28 INFO - ##### 03:57:28 INFO - Running pre-action listener: _resource_record_pre_action 03:57:28 INFO - Running main action method: clobber 03:57:28 INFO - rmtree: /builds/slave/test/build 03:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:28 INFO - Running post-action listener: _resource_record_post_action 03:57:28 INFO - ##### 03:57:28 INFO - ##### Finished clobber step (success) 03:57:28 INFO - ##### 03:57:28 INFO - ##### 03:57:28 INFO - ##### Running read-buildbot-config step. 03:57:28 INFO - ##### 03:57:28 INFO - Running pre-action listener: _resource_record_pre_action 03:57:28 INFO - Running main action method: read_buildbot_config 03:57:28 INFO - Using buildbot properties: 03:57:28 INFO - { 03:57:28 INFO - "project": "", 03:57:28 INFO - "product": "firefox", 03:57:28 INFO - "script_repo_revision": "production", 03:57:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:57:28 INFO - "repository": "", 03:57:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:57:28 INFO - "buildid": "20160621013014", 03:57:28 INFO - "pgo_build": "True", 03:57:28 INFO - "basedir": "/builds/slave/test", 03:57:28 INFO - "buildnumber": 746, 03:57:28 INFO - "slavename": "talos-linux64-ix-013", 03:57:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:57:28 INFO - "platform": "ubuntu64_hw", 03:57:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:57:28 INFO - "branch": "mozilla-inbound", 03:57:28 INFO - "repo_path": "integration/mozilla-inbound", 03:57:28 INFO - "revision": "333518a265a209bec3a25ef6caeb993292439878", 03:57:28 INFO - "stage_platform": "linux64-pgo", 03:57:28 INFO - "builduid": "66ee36e837574b70a86b66c26f1b7b88", 03:57:28 INFO - "slavebuilddir": "test" 03:57:28 INFO - } 03:57:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:57:28 INFO - Running post-action listener: _resource_record_post_action 03:57:28 INFO - ##### 03:57:28 INFO - ##### Finished read-buildbot-config step (success) 03:57:28 INFO - ##### 03:57:28 INFO - ##### 03:57:28 INFO - ##### Running download-and-extract step. 03:57:28 INFO - ##### 03:57:28 INFO - Running pre-action listener: _resource_record_pre_action 03:57:28 INFO - Running main action method: download_and_extract 03:57:28 INFO - mkdir: /builds/slave/test/build/tests 03:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:28 INFO - https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:57:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:57:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:57:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:33 INFO - Downloaded 1361 bytes. 03:57:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:57:33 INFO - Using the following test package requirements: 03:57:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:57:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'jsshell-linux-x86_64.zip'], 03:57:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:57:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:57:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57: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')]} 03:57:33 INFO - https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:57:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:57:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:40 INFO - Downloaded 24225376 bytes. 03:57:40 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'] 03:57:40 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 03:57:41 INFO - Return code: 0 03:57:41 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 03:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:41 INFO - https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:42 INFO - Downloaded 24225376 bytes. 03:57:42 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'] 03:57:42 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 03:57:44 INFO - Return code: 0 03:57:44 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')]} 03:57:44 INFO - https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:45 INFO - Downloaded 14405384 bytes. 03:57:45 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'] 03:57:45 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 03:57:45 INFO - Return code: 0 03:57:45 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')]} 03:57:45 INFO - https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ff7PF_RvTX60S1gGrtOVcw/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 03:57:46 INFO - Downloaded 60128460 bytes. 03:57:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:57:46 INFO - mkdir: /builds/slave/test/properties 03:57:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:46 INFO - Contents: 03:57:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:57:47 INFO - Running post-action listener: _resource_record_post_action 03:57:47 INFO - Running post-action listener: set_extra_try_arguments 03:57:47 INFO - ##### 03:57:47 INFO - ##### Finished download-and-extract step (success) 03:57:47 INFO - ##### 03:57:47 INFO - ##### 03:57:47 INFO - ##### Running populate-webroot step. 03:57:47 INFO - ##### 03:57:47 INFO - Running pre-action listener: _resource_record_pre_action 03:57:47 INFO - Running main action method: populate_webroot 03:57:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:57:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:57:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:57:47 INFO - '--tppagecycles', 03:57:47 INFO - '7'], 03:57:47 INFO - 'tests': ['tsvgm']}}, 03:57:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:57:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:57:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:57:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:57:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['damp', 'tps']}, 03:57:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'tests': ['damp', 'tps']}, 03:57:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['dromaeo_dom']}, 03:57:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:57:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['basic_compositor_video']}, 03:57:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:57:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['a11yr', 03:57:47 INFO - 'ts_paint', 03:57:47 INFO - 'tpaint', 03:57:47 INFO - 'sessionrestore', 03:57:47 INFO - 'sessionrestore_no_auto_restore', 03:57:47 INFO - 'tabpaint']}, 03:57:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:57:47 INFO - 'ts_paint', 03:57:47 INFO - 'tpaint', 03:57:47 INFO - 'sessionrestore', 03:57:47 INFO - 'sessionrestore_no_auto_restore', 03:57:47 INFO - 'tabpaint']}, 03:57:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:57:47 INFO - 'ts_paint', 03:57:47 INFO - 'tpaint', 03:57:47 INFO - 'sessionrestore', 03:57:47 INFO - 'sessionrestore_no_auto_restore', 03:57:47 INFO - 'tabpaint']}, 03:57:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:57:47 INFO - 'ts_paint', 03:57:47 INFO - 'tpaint', 03:57:47 INFO - 'sessionrestore', 03:57:47 INFO - 'sessionrestore_no_auto_restore', 03:57:47 INFO - 'tabpaint']}, 03:57:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['a11yr', 03:57:47 INFO - 'ts_paint', 03:57:47 INFO - 'tpaint', 03:57:47 INFO - 'sessionrestore', 03:57:47 INFO - 'sessionrestore_no_auto_restore', 03:57:47 INFO - 'tabpaint']}, 03:57:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['a11yr', 03:57:47 INFO - 'ts_paint', 03:57:47 INFO - 'tpaint', 03:57:47 INFO - 'sessionrestore', 03:57:47 INFO - 'sessionrestore_no_auto_restore', 03:57:47 INFO - 'tabpaint']}, 03:57:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['tsvgx', 03:57:47 INFO - 'tsvgr_opacity', 03:57:47 INFO - 'tart', 03:57:47 INFO - 'tscrollx', 03:57:47 INFO - 'cart']}, 03:57:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:57:47 INFO - 'tsvgr_opacity', 03:57:47 INFO - 'tart', 03:57:47 INFO - 'tscrollx', 03:57:47 INFO - 'cart']}, 03:57:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'talos_options': ['--disable-e10s'], 03:57:47 INFO - 'tests': ['tp5o']}, 03:57:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'tests': ['tp5o']}, 03:57:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'talos_options': ['--disable-e10s', 03:57:47 INFO - '--xperf_path', 03:57:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:47 INFO - 'tests': ['tp5n']}, 03:57:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:47 INFO - 'talos_options': ['--xperf_path', 03:57:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:47 INFO - 'tests': ['tp5n']}}, 03:57:47 INFO - 'talos.zip': {'path': '', 03:57:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:57:47 INFO - Running post-action listener: _resource_record_post_action 03:57:47 INFO - ##### 03:57:47 INFO - ##### Finished populate-webroot step (success) 03:57:47 INFO - ##### 03:57:47 INFO - ##### 03:57:47 INFO - ##### Running create-virtualenv step. 03:57:47 INFO - ##### 03:57:47 INFO - Running pre-action listener: _resource_record_pre_action 03:57:47 INFO - Running main action method: create_virtualenv 03:57:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:47 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 03:57:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:47 INFO - Using real prefix '/usr' 03:57:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:50 INFO - Installing pip.................done. 03:57:50 INFO - Return code: 0 03:57:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57:50 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')]} 03:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:50 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')]} 03:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:50 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:57:50 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 03:57:50 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 03:57:50 INFO - Using env: {'DISPLAY': ':0', 03:57:50 INFO - 'HOME': '/home/cltbld', 03:57:50 INFO - 'LANG': 'en_US.UTF-8', 03:57:50 INFO - 'LANGUAGE': 'en_US:en', 03:57:50 INFO - 'LOGNAME': 'cltbld', 03:57:50 INFO - 'MAIL': '/var/mail/cltbld', 03:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:50 INFO - 'MOZ_NO_REMOTE': '1', 03:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:50 INFO - 'NO_EM_RESTART': '1', 03:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:50 INFO - 'PWD': '/builds/slave/test', 03:57:50 INFO - 'SHELL': '/bin/bash', 03:57:50 INFO - 'SHLVL': '1', 03:57:50 INFO - 'TERM': 'linux', 03:57:50 INFO - 'TMOUT': '86400', 03:57:50 INFO - 'USER': 'cltbld', 03:57:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:50 INFO - '_': '/tools/buildbot/bin/python'} 03:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:50 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 03:57:50 INFO - Cleaning up... 03:57:50 INFO - Return code: 0 03:57:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:57:50 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')]} 03:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:50 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')]} 03:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:50 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:57:50 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 03:57:50 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 03:57:50 INFO - Using env: {'DISPLAY': ':0', 03:57:50 INFO - 'HOME': '/home/cltbld', 03:57:50 INFO - 'LANG': 'en_US.UTF-8', 03:57:50 INFO - 'LANGUAGE': 'en_US:en', 03:57:50 INFO - 'LOGNAME': 'cltbld', 03:57:50 INFO - 'MAIL': '/var/mail/cltbld', 03:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:50 INFO - 'MOZ_NO_REMOTE': '1', 03:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:50 INFO - 'NO_EM_RESTART': '1', 03:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:50 INFO - 'PWD': '/builds/slave/test', 03:57:50 INFO - 'SHELL': '/bin/bash', 03:57:50 INFO - 'SHLVL': '1', 03:57:50 INFO - 'TERM': 'linux', 03:57:50 INFO - 'TMOUT': '86400', 03:57:50 INFO - 'USER': 'cltbld', 03:57:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:50 INFO - '_': '/tools/buildbot/bin/python'} 03:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:50 INFO - Downloading/unpacking psutil>=3.1.1 03:57:50 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 03:57:50 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 03:57:50 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 03:57:50 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 03:57:50 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 03:57:50 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 03:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:52 INFO - Installing collected packages: psutil 03:57:52 INFO - Running setup.py install for psutil 03:57:52 INFO - building 'psutil._psutil_linux' extension 03:57:52 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 03:57:52 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 03:57:52 INFO - building 'psutil._psutil_posix' extension 03:57:52 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 03:57:53 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 03:57:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:53 INFO - Successfully installed psutil 03:57:53 INFO - Cleaning up... 03:57:53 INFO - Return code: 0 03:57:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:57:53 INFO - Using env: {'DISPLAY': ':0', 03:57:53 INFO - 'HOME': '/home/cltbld', 03:57:53 INFO - 'LANG': 'en_US.UTF-8', 03:57:53 INFO - 'LANGUAGE': 'en_US:en', 03:57:53 INFO - 'LOGNAME': 'cltbld', 03:57:53 INFO - 'MAIL': '/var/mail/cltbld', 03:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:53 INFO - 'MOZ_NO_REMOTE': '1', 03:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:53 INFO - 'NO_EM_RESTART': '1', 03:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:53 INFO - 'PWD': '/builds/slave/test', 03:57:53 INFO - 'SHELL': '/bin/bash', 03:57:53 INFO - 'SHLVL': '1', 03:57:53 INFO - 'TERM': 'linux', 03:57:53 INFO - 'TMOUT': '86400', 03:57:53 INFO - 'USER': 'cltbld', 03:57:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:53 INFO - '_': '/tools/buildbot/bin/python'} 03:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:55 INFO - Installing collected packages: mozsystemmonitor 03:57:55 INFO - Running setup.py install for mozsystemmonitor 03:57:55 INFO - Successfully installed mozsystemmonitor 03:57:55 INFO - Cleaning up... 03:57:55 INFO - Return code: 0 03:57:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57:55 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')]} 03:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:55 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')]} 03:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:55 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:57:55 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 03:57:55 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 03:57:55 INFO - Using env: {'DISPLAY': ':0', 03:57:55 INFO - 'HOME': '/home/cltbld', 03:57:55 INFO - 'LANG': 'en_US.UTF-8', 03:57:55 INFO - 'LANGUAGE': 'en_US:en', 03:57:55 INFO - 'LOGNAME': 'cltbld', 03:57:55 INFO - 'MAIL': '/var/mail/cltbld', 03:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:55 INFO - 'MOZ_NO_REMOTE': '1', 03:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:55 INFO - 'NO_EM_RESTART': '1', 03:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:55 INFO - 'PWD': '/builds/slave/test', 03:57:55 INFO - 'SHELL': '/bin/bash', 03:57:55 INFO - 'SHLVL': '1', 03:57:55 INFO - 'TERM': 'linux', 03:57:55 INFO - 'TMOUT': '86400', 03:57:55 INFO - 'USER': 'cltbld', 03:57:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:55 INFO - '_': '/tools/buildbot/bin/python'} 03:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:55 INFO - Downloading/unpacking jsonschema==2.5.1 03:57:55 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 03:57:55 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 03:57:55 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 03:57:55 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 03:57:55 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 03:57:55 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 03:57:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57:57 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 03:57:57 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 03:57:57 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 03:57:57 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 03:57:57 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 03:57:57 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 03:57:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:57 INFO - warning: no files found matching '*.txt' 03:57:57 INFO - no previously-included directories found matching 'build' 03:57:57 INFO - no previously-included directories found matching 'dist' 03:57:57 INFO - no previously-included directories found matching '.git*' 03:57:57 INFO - Installing collected packages: jsonschema, functools32 03:57:57 INFO - Running setup.py install for functools32 03:57:58 INFO - warning: no files found matching '*.txt' 03:57:58 INFO - no previously-included directories found matching 'build' 03:57:58 INFO - no previously-included directories found matching 'dist' 03:57:58 INFO - no previously-included directories found matching '.git*' 03:57:58 INFO - Successfully installed jsonschema functools32 03:57:58 INFO - Cleaning up... 03:57:58 INFO - Return code: 0 03:57:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:57:58 INFO - Using env: {'DISPLAY': ':0', 03:57:58 INFO - 'HOME': '/home/cltbld', 03:57:58 INFO - 'LANG': 'en_US.UTF-8', 03:57:58 INFO - 'LANGUAGE': 'en_US:en', 03:57:58 INFO - 'LOGNAME': 'cltbld', 03:57:58 INFO - 'MAIL': '/var/mail/cltbld', 03:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:58 INFO - 'MOZ_NO_REMOTE': '1', 03:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:58 INFO - 'NO_EM_RESTART': '1', 03:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:58 INFO - 'PWD': '/builds/slave/test', 03:57:58 INFO - 'SHELL': '/bin/bash', 03:57:58 INFO - 'SHLVL': '1', 03:57:58 INFO - 'TERM': 'linux', 03:57:58 INFO - 'TMOUT': '86400', 03:57:58 INFO - 'USER': 'cltbld', 03:57:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:58 INFO - '_': '/tools/buildbot/bin/python'} 03:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:58:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:00 INFO - Downloading docopt-0.6.1.tar.gz 03:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:00 INFO - Running setup.py install for blobuploader 03:58:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:58:01 INFO - Running setup.py install for requests 03:58:01 INFO - Running setup.py install for docopt 03:58:01 INFO - Successfully installed blobuploader requests docopt 03:58:01 INFO - Cleaning up... 03:58:01 INFO - Return code: 0 03:58:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:01 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:58:01 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 03:58:01 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 03:58:01 INFO - Using env: {'DISPLAY': ':0', 03:58:01 INFO - 'HOME': '/home/cltbld', 03:58:01 INFO - 'LANG': 'en_US.UTF-8', 03:58:01 INFO - 'LANGUAGE': 'en_US:en', 03:58:01 INFO - 'LOGNAME': 'cltbld', 03:58:01 INFO - 'MAIL': '/var/mail/cltbld', 03:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:01 INFO - 'MOZ_NO_REMOTE': '1', 03:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:01 INFO - 'NO_EM_RESTART': '1', 03:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:01 INFO - 'PWD': '/builds/slave/test', 03:58:01 INFO - 'SHELL': '/bin/bash', 03:58:01 INFO - 'SHLVL': '1', 03:58:01 INFO - 'TERM': 'linux', 03:58:01 INFO - 'TMOUT': '86400', 03:58:01 INFO - 'USER': 'cltbld', 03:58:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:01 INFO - '_': '/tools/buildbot/bin/python'} 03:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:01 INFO - Running setup.py (path:/tmp/pip-lBMrqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:01 INFO - Running setup.py (path:/tmp/pip-p56SWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:01 INFO - Running setup.py (path:/tmp/pip-m1CKqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:02 INFO - Running setup.py (path:/tmp/pip-FsDwjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:02 INFO - Running setup.py (path:/tmp/pip-nCq0S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:02 INFO - Running setup.py (path:/tmp/pip-7nXzhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:02 INFO - Running setup.py (path:/tmp/pip-N9a2k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:02 INFO - Running setup.py (path:/tmp/pip-G7y8LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:02 INFO - Running setup.py (path:/tmp/pip-CDRmCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:02 INFO - Running setup.py (path:/tmp/pip-AlProp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:02 INFO - Running setup.py (path:/tmp/pip-lQ2kH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:02 INFO - Running setup.py (path:/tmp/pip-honz41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:02 INFO - Running setup.py (path:/tmp/pip-zMWydL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:02 INFO - Running setup.py (path:/tmp/pip-YppSbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:02 INFO - Running setup.py (path:/tmp/pip-Qoz7fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:02 INFO - Running setup.py (path:/tmp/pip-MlXULK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:02 INFO - Running setup.py (path:/tmp/pip-PBeTTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:03 INFO - Running setup.py install for manifestparser 03:58:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Running setup.py install for mozcrash 03:58:03 INFO - Running setup.py install for mozdebug 03:58:03 INFO - Running setup.py install for mozdevice 03:58:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Running setup.py install for mozfile 03:58:03 INFO - Running setup.py install for mozhttpd 03:58:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Running setup.py install for mozinfo 03:58:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Running setup.py install for mozInstall 03:58:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:58:03 INFO - Running setup.py install for mozleak 03:58:03 INFO - Running setup.py install for mozlog 03:58:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Running setup.py install for moznetwork 03:58:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Running setup.py install for mozprocess 03:58:04 INFO - Running setup.py install for mozprofile 03:58:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Running setup.py install for mozrunner 03:58:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Running setup.py install for mozscreenshot 03:58:04 INFO - Running setup.py install for moztest 03:58:04 INFO - Running setup.py install for mozversion 03:58:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:58:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:04 INFO - Cleaning up... 03:58:04 INFO - Return code: 0 03:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:04 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:58:04 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 03:58:04 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 03:58:04 INFO - Using env: {'DISPLAY': ':0', 03:58:04 INFO - 'HOME': '/home/cltbld', 03:58:04 INFO - 'LANG': 'en_US.UTF-8', 03:58:04 INFO - 'LANGUAGE': 'en_US:en', 03:58:04 INFO - 'LOGNAME': 'cltbld', 03:58:04 INFO - 'MAIL': '/var/mail/cltbld', 03:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:04 INFO - 'MOZ_NO_REMOTE': '1', 03:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:04 INFO - 'NO_EM_RESTART': '1', 03:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:04 INFO - 'PWD': '/builds/slave/test', 03:58:04 INFO - 'SHELL': '/bin/bash', 03:58:04 INFO - 'SHLVL': '1', 03:58:04 INFO - 'TERM': 'linux', 03:58:04 INFO - 'TMOUT': '86400', 03:58:04 INFO - 'USER': 'cltbld', 03:58:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:04 INFO - '_': '/tools/buildbot/bin/python'} 03:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:04 INFO - Running setup.py (path:/tmp/pip-9DkTD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:05 INFO - Running setup.py (path:/tmp/pip-4ibmOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:05 INFO - Running setup.py (path:/tmp/pip-kzPhl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:05 INFO - Running setup.py (path:/tmp/pip-ioqkNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:05 INFO - Running setup.py (path:/tmp/pip-F9jiGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:05 INFO - Running setup.py (path:/tmp/pip-qewHVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:05 INFO - Running setup.py (path:/tmp/pip-muoyIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:05 INFO - Running setup.py (path:/tmp/pip-51ozrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:05 INFO - Running setup.py (path:/tmp/pip-yP773p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:05 INFO - Running setup.py (path:/tmp/pip-Q56JuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:05 INFO - Running setup.py (path:/tmp/pip-3v3MoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:05 INFO - Running setup.py (path:/tmp/pip-aRwdvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:05 INFO - Running setup.py (path:/tmp/pip-enjgDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:05 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)) 03:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:05 INFO - Running setup.py (path:/tmp/pip-jgBKRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:06 INFO - Running setup.py (path:/tmp/pip-94LU9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:06 INFO - Running setup.py (path:/tmp/pip-ZAnm1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:06 INFO - Running setup.py (path:/tmp/pip-7Bt9ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:08 INFO - Downloading blessings-1.6.tar.gz 03:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:08 INFO - Installing collected packages: blessings 03:58:08 INFO - Running setup.py install for blessings 03:58:08 INFO - Successfully installed blessings 03:58:08 INFO - Cleaning up... 03:58:08 INFO - Return code: 0 03:58:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:08 INFO - Reading from file tmpfile_stdout 03:58:08 INFO - Current package versions: 03:58:08 INFO - argparse == 1.2.1 03:58:08 INFO - blessings == 1.6 03:58:08 INFO - blobuploader == 1.2.4 03:58:08 INFO - docopt == 0.6.1 03:58:08 INFO - functools32 == 3.2.3-2 03:58:08 INFO - jsonschema == 2.5.1 03:58:08 INFO - manifestparser == 1.1 03:58:08 INFO - mozInstall == 1.12 03:58:08 INFO - mozcrash == 0.17 03:58:08 INFO - mozdebug == 0.1 03:58:08 INFO - mozdevice == 0.48 03:58:08 INFO - mozfile == 1.2 03:58:08 INFO - mozhttpd == 0.7 03:58:08 INFO - mozinfo == 0.9 03:58:08 INFO - mozleak == 0.1 03:58:08 INFO - mozlog == 3.2 03:58:08 INFO - moznetwork == 0.27 03:58:08 INFO - mozprocess == 0.22 03:58:08 INFO - mozprofile == 0.28 03:58:08 INFO - mozrunner == 6.11 03:58:08 INFO - mozscreenshot == 0.1 03:58:08 INFO - mozsystemmonitor == 0.3 03:58:08 INFO - moztest == 0.7 03:58:08 INFO - mozversion == 1.4 03:58:08 INFO - psutil == 3.1.1 03:58:08 INFO - requests == 1.2.3 03:58:08 INFO - wsgiref == 0.1.2 03:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:08 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')]} 03:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:08 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')]} 03:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:08 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:58:08 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 03:58:08 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 03:58:08 INFO - Using env: {'DISPLAY': ':0', 03:58:08 INFO - 'HOME': '/home/cltbld', 03:58:08 INFO - 'LANG': 'en_US.UTF-8', 03:58:08 INFO - 'LANGUAGE': 'en_US:en', 03:58:08 INFO - 'LOGNAME': 'cltbld', 03:58:08 INFO - 'MAIL': '/var/mail/cltbld', 03:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:08 INFO - 'MOZ_NO_REMOTE': '1', 03:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:08 INFO - 'NO_EM_RESTART': '1', 03:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:08 INFO - 'PWD': '/builds/slave/test', 03:58:08 INFO - 'SHELL': '/bin/bash', 03:58:08 INFO - 'SHLVL': '1', 03:58:08 INFO - 'TERM': 'linux', 03:58:08 INFO - 'TMOUT': '86400', 03:58:08 INFO - 'USER': 'cltbld', 03:58:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:08 INFO - '_': '/tools/buildbot/bin/python'} 03:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 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)) 03:58:08 INFO - Cleaning up... 03:58:08 INFO - Return code: 0 03:58:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58:08 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')]} 03:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:08 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')]} 03:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:08 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 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:58:08 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 03:58:08 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 03:58:08 INFO - Using env: {'DISPLAY': ':0', 03:58:08 INFO - 'HOME': '/home/cltbld', 03:58:08 INFO - 'LANG': 'en_US.UTF-8', 03:58:08 INFO - 'LANGUAGE': 'en_US:en', 03:58:08 INFO - 'LOGNAME': 'cltbld', 03:58:08 INFO - 'MAIL': '/var/mail/cltbld', 03:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:08 INFO - 'MOZ_NO_REMOTE': '1', 03:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:08 INFO - 'NO_EM_RESTART': '1', 03:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:08 INFO - 'PWD': '/builds/slave/test', 03:58:08 INFO - 'SHELL': '/bin/bash', 03:58:08 INFO - 'SHLVL': '1', 03:58:08 INFO - 'TERM': 'linux', 03:58:08 INFO - 'TMOUT': '86400', 03:58:08 INFO - 'USER': 'cltbld', 03:58:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:08 INFO - '_': '/tools/buildbot/bin/python'} 03:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:58:09 INFO - Cleaning up... 03:58:09 INFO - Return code: 0 03:58:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1915ce5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2295350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', '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 03:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:58:09 INFO - Using env: {'DISPLAY': ':0', 03:58:09 INFO - 'HOME': '/home/cltbld', 03:58:09 INFO - 'LANG': 'en_US.UTF-8', 03:58:09 INFO - 'LANGUAGE': 'en_US:en', 03:58:09 INFO - 'LOGNAME': 'cltbld', 03:58:09 INFO - 'MAIL': '/var/mail/cltbld', 03:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:09 INFO - 'MOZ_NO_REMOTE': '1', 03:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:09 INFO - 'NO_EM_RESTART': '1', 03:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:09 INFO - 'PWD': '/builds/slave/test', 03:58:09 INFO - 'SHELL': '/bin/bash', 03:58:09 INFO - 'SHLVL': '1', 03:58:09 INFO - 'TERM': 'linux', 03:58:09 INFO - 'TMOUT': '86400', 03:58:09 INFO - 'USER': 'cltbld', 03:58:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:09 INFO - '_': '/tools/buildbot/bin/python'} 03:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:09 INFO - Downloading/unpacking flake8 03:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:58:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:58:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:58:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:58:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:58:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:58:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:58:11 INFO - no previously-included directories found matching 'docs/_build' 03:58:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:58:11 INFO - Running setup.py install for pep8 03:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:58:12 INFO - no previously-included directories found matching 'docs/_build' 03:58:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:58:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:58:12 INFO - Cleaning up... 03:58:12 INFO - Return code: 0 03:58:12 INFO - Running post-action listener: _resource_record_post_action 03:58:12 INFO - Running post-action listener: _start_resource_monitoring 03:58:12 INFO - Starting resource monitoring. 03:58:12 INFO - ##### 03:58:12 INFO - ##### Finished create-virtualenv step (success) 03:58:12 INFO - ##### 03:58:12 INFO - ##### 03:58:12 INFO - ##### Running install step. 03:58:12 INFO - ##### 03:58:12 INFO - Running pre-action listener: _resource_record_pre_action 03:58:12 INFO - Running main action method: install 03:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:12 INFO - Reading from file tmpfile_stdout 03:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:12 INFO - Reading from file tmpfile_stdout 03:58:12 INFO - Output received: 03:58:12 INFO - Usage: mozinstall [options] installer 03:58:12 INFO - Options: 03:58:12 INFO - -h, --help show this help message and exit 03:58:12 INFO - -d DEST, --destination=DEST 03:58:12 INFO - Directory to install application into. [default: 03:58:12 INFO - "/builds/slave/test"] 03:58:12 INFO - --app=APP Application being installed. [default: firefox] 03:58:12 INFO - mkdir: /builds/slave/test/build/application 03:58:12 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'] 03:58:12 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 03:58:29 INFO - Reading from file tmpfile_stdout 03:58:29 INFO - Output received: 03:58:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:58:29 INFO - Running post-action listener: _resource_record_post_action 03:58:29 INFO - ##### 03:58:29 INFO - ##### Finished install step (success) 03:58:29 INFO - ##### 03:58:29 INFO - ##### 03:58:29 INFO - ##### Running run-tests step. 03:58:29 INFO - ##### 03:58:29 INFO - Running pre-action listener: _resource_record_pre_action 03:58:29 INFO - Running main action method: run_tests 03:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:58:29 INFO - Python 2.7.3 03:58:29 INFO - Return code: 0 03:58:29 INFO - grabbing minidump binary from tooltool 03:58:29 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')]} 03:58:29 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 0x23241c0>, '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 0x23250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2325550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:58:29 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 03:58:29 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 03:58:29 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 03:58:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:58:29 INFO - Return code: 0 03:58:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:58:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:58:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:58:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:58:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:58:30 INFO - Return code: 0 03:58:30 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/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 03:58:30 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/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 03:58:30 INFO - Using env: {'DISPLAY': ':0', 03:58:30 INFO - 'HOME': '/home/cltbld', 03:58:30 INFO - 'LANG': 'en_US.UTF-8', 03:58:30 INFO - 'LANGUAGE': 'en_US:en', 03:58:30 INFO - 'LOGNAME': 'cltbld', 03:58:30 INFO - 'MAIL': '/var/mail/cltbld', 03:58:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:58:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:30 INFO - 'MOZ_NO_REMOTE': '1', 03:58:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:30 INFO - 'NO_EM_RESTART': '1', 03:58:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:30 INFO - 'PWD': '/builds/slave/test', 03:58:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:58:30 INFO - 'SHELL': '/bin/bash', 03:58:30 INFO - 'SHLVL': '1', 03:58:30 INFO - 'TERM': 'linux', 03:58:30 INFO - 'TMOUT': '86400', 03:58:30 INFO - 'USER': 'cltbld', 03:58:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224', 03:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:30 INFO - '_': '/tools/buildbot/bin/python'} 03:58:30 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/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 03:58:30 INFO - mozversion application_buildid: 20160621013014 03:58:30 INFO - mozversion application_changeset: 333518a265a209bec3a25ef6caeb993292439878 03:58:30 INFO - mozversion application_display_name: Nightly 03:58:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:58:30 INFO - mozversion application_name: Firefox 03:58:30 INFO - mozversion application_remotingname: firefox 03:58:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:58:30 INFO - mozversion application_vendor: Mozilla 03:58:30 INFO - mozversion application_version: 50.0a1 03:58:30 INFO - mozversion platform_buildid: 20160621013014 03:58:30 INFO - mozversion platform_changeset: 333518a265a209bec3a25ef6caeb993292439878 03:58:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:58:30 INFO - mozversion platform_version: 50.0a1 03:58:30 INFO - using testdate: 1466506710 03:58:30 INFO - actual date: 1466506710 03:58:30 INFO - starting webserver on 'localhost:43856' 03:58:30 INFO - SUITE-START | Running 2 tests 03:58:30 INFO - TEST-START | dromaeo_css 03:58:30 INFO - operating with platform_type : linux_ 03:58:30 INFO - Initialising browser for dromaeo_css test... 03:58:30 INFO - TEST-INFO | started process 20416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYvpyx/profile http://localhost:43856/getInfo.html) 03:58:35 INFO - PROCESS | 20416 | __metrics Screen width/height:1600/1200 03:58:35 INFO - PROCESS | 20416 | colorDepth:24 03:58:35 INFO - PROCESS | 20416 | Browser inner width/height: 1024/697 03:58:35 INFO - PROCESS | 20416 | __metrics 03:58:36 ERROR - PROCESS | 20416 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:58:37 INFO - TEST-INFO | 20416: exit 0 03:58:37 INFO - Browser initialized. 03:58:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:37 INFO - TEST-INFO | started process 20537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYvpyx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:49 INFO - PROCESS | 20537 | RSS: Main: 184561664 03:58:49 INFO - PROCESS | 20537 | 03:59:38 INFO - PROCESS | 20537 | 1466506778739 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:01:47 INFO - PROCESS | 20537 | Cycle 1(1): loaded http://localhost:43856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43856/tests/dromaeo/cssquery-ext.html) 04:01:48 INFO - PROCESS | 20537 | RSS: Main: 188456960 04:01:48 INFO - PROCESS | 20537 | 04:04:50 INFO - PROCESS | 20537 | Cycle 1(1): loaded http://localhost:43856/tests/dromaeo/cssquery-ext.html (next: http://localhost:43856/tests/dromaeo/cssquery-jquery.html) 04:04:50 INFO - PROCESS | 20537 | RSS: Main: 188571648 04:04:50 INFO - PROCESS | 20537 | 04:07:52 INFO - PROCESS | 20537 | Cycle 1(1): loaded http://localhost:43856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43856/tests/dromaeo/cssquery-mootools.html) 04:07:53 INFO - PROCESS | 20537 | RSS: Main: 189235200 04:07:53 INFO - PROCESS | 20537 | 04:10:55 INFO - PROCESS | 20537 | Cycle 1(1): loaded http://localhost:43856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43856/tests/dromaeo/cssquery-prototype.html) 04:10:55 INFO - PROCESS | 20537 | RSS: Main: 186736640 04:10:55 INFO - PROCESS | 20537 | 04:13:58 INFO - PROCESS | 20537 | Cycle 1(1): loaded http://localhost:43856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43856/tests/dromaeo/cssquery-yui.html) 04:13:58 INFO - PROCESS | 20537 | RSS: Main: 188661760 04:13:58 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | Cycle 1(1): loaded http://localhost:43856/tests/dromaeo/cssquery-yui.html (next: http://localhost:43856/tests/dromaeo/cssquery-dojo.html) 04:17:01 INFO - PROCESS | 20537 | RSS: Main: 189378560 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | __start_tp_report 04:17:01 INFO - PROCESS | 20537 | _x_x_mozilla_page_load 04:17:01 INFO - PROCESS | 20537 | _x_x_mozilla_page_load_details 04:17:01 INFO - PROCESS | 20537 | |i|pagename|runs| 04:17:01 INFO - PROCESS | 20537 | |0;dojo.html;3124.6719094495093;3145.858436370364;3171.5401266816307;3176.8570414331352;3183.1405520509447;5364.758585863636;5411.107167317393;5428.647137936036;5470;5480.725963701819;5329.813456529022;5342.626016178869;5381.165919282517;5464.863378415542;5526.171074338851;4913.557779799827;4937.950620493785;5041.143005689023;5116.769745361449;5137.460566640505;748.2533145164624;4881.780319885596;5017.974910125445;5057.747112644372;5060.962502686941;5020.171671674188;5029.044481548494;5040.36995375578;5069.822556210534;5118.07874582575;4962.5533701967;5071.264666623356;5073.289739436482;5079.898402031976;5090.669106508065;4968.8757781055765;5002.674826136289;5014.924776128361;5018.372703412074;5079.034983353151;5511.614187006911;5515.09001014832;5523.2543606613;5535.391106978229;5549.5837812164245;5860.120981852713;5894.410558944114;5916.615419997686;5941.762329506814;5964.493018093423;6018.638881667071;6049.062395328687;6050.54620903434;6077.787277445313;6083.908741368883;5578.44215578443;5634.239377684001;5635.295588051494;5635.6618602883955;5636.15457681347;5832.795852145239;6033.215681961317;6068.150458935753;6105.419985101408;6154.261488621304;5883.941160588425;5892.528597712173;5893.499052580493;5905.379935106838;5908.911366329508;5970.731317090741;5981.79063732776;5984.940150598438;5989.341172471025;5995.2206213192;5716.542676585863;5838.153467747153;5840.970795145997;5900.704964751745;5913.379095195029;5735.053716136791;5851.912221316684;5876.6180198286975;5881.823545293648;5894.056950887923;4504.61710754583;4521.84173553924;4534.387857639243;4535.092981403733;4549.431321084864;3953.446517487554;3957.2876882161486;3964.940525892114;4016.3172260715746;4019.0153412414147;5493.066178749622;5603.3836278009385;5603.775848966077;5606.6916319602815;5607.186957891165;5887.116932460165;5919.644821310649;5920.644761314335;5924.6149000314845;5927.496162826122;5551.306086739158;5567.24842146305;5595.468430499096;5638.154276858504;5648.181013752983;5102.107131252016;5130.640855140179;5140.203268493389;5148.30497882781;5150.922736158961;5915.201447804491;6113.02191649334;6126.540509461808;6136.048912418582;6139.693015349215;5854.326752423441;5861.677607731615;5898.1152827076285;5934.732937017759;5936.020556608111;5970.104484327386;6030.185924900258;6031.125486804476;6043.879122417615;6052.243469566304;5705.429457054262;5725.742341594555;5755.5971082025535;5757.942420575908;5769.019266724583;5846.619969701956;5934.881302374015;5936.347001829881;5948.910766338422;5994.13085102649;5683.71581420919;5758.3090029196765;5759.193712880116;5781.335146458211;5781.392953739797;5603.131514615241;5709.68596727184;5711.200431939449;5717.571182161438;5746.597738158289;5585.553155747449;5615.634983726045;5723.971380143073;5734.7132643368495;5741.45456181662;5846.532277417881;5868.67722275279;5873.647581145145;5879.176915231786;5883;5599.300087489064;5660.20757093999;5737.971310143423;5745.655260684205;5754.741036653444 04:17:01 INFO - PROCESS | 20537 | |1;ext.html;575.7322844877134;612.7977767336773;612.9509639228862;623.2396476298915;645.8127143128492;31743.206419839516;35134.64865351345;40972;41391.379129313085;41572.58427415725;43220.3516947246;43252;43362.7831860841;43459;43527.34708979368;8650.65397384104;8824.426412283181;8829.823403531958;8830.911690883073;8832.028476867572;8715.215630593246;8855.335849811258;8858.822823543525;8872.068432814558;8891.021987581393;8863.29093672508;8950.507722075283;8975.730728078135;8992.190702836744;8998.68504602339;8831;8888.288936885034;8894;8894.510801905924;8899.866502002475;8867;8895.688650897187;8936.240419564345;8936.374453788238;8963.417377870417;41431;41706;41719;41939.7903010483;42101.78949105265;3463.5843698756057;3562.0131815458567;3602.1174812170925;3945.506811648544;4125.690573206992;32139.51790723141;33031.83484082564;33068.17329566756;33164.33671326584;33190.66809331924;4317.913641727179;4556.066006468666;4605.562471565196;4615.399998000238;4618.56123668251;365524;366643;366944;367377;368002;51246.487535124914;55827;58004;58038;63332.683336583024;63077.05384419237;63681.36318636847;63758;63987;64105.67947160234;15789.842101579066;15814;15864.286107125206;15934.52196434109;15948.441804536786;13413.731725365633;13430.731385372434;13554.525591604246;13717.588472345846;13719.588412347646;19089.140988655545;19125.226842107815;19134.330298439767;19226.32707855218;19349.12928918174;7176.96411517939;7230.783076507713;7280.089988751406;7285.672144753393;7364.705411783576;988.4909271725068;1005.2295753822989;1019.719577116299;1130.9708165569293;1148.4831825678477;32538.349233015208;32726.672733272837;32902.3419531608;32965.34069318648;33276.83361583225;1055.0820785916303;1168.9415529223504;1198.38283284107;1209.564556759566;1224.9816252756216;16986.915065424593;17820.643587128186;17859.910700446675;18645.813541864678;18848.34030808915;527689;529142;529729;530363;532170;58041.419585803604;58200;58417;58476;58639.120413193836;1306.9607911762662;1320.6038188543398;1361.795730640392;1366.1939455721172;1385.9722805543834;31430.528542071428;31975.6802431982;32512.67487325191;32799.344013119124;33083.669163308055;49678;49947.500524994284;50233.24650130178;50303.74848125736;50379.24431133462;483201;484407;485249;485511;486199;27121.321966950985;27324.72675273222;27354.726452735216;27494.17517474479;27527.17418477449;46095.769521153525;46361.53638463572;46425.76787116043;46590.534094659975;48263.516997898245;41439;41823.7908810454;42454.57545424506;42515.3622695666;43559.34660980025;41548.58451415568;42168;42247.155056898075;42621.147577048905;43115.13769724525;38826.6117338823;40926;40987.1802563953;41705;41893.37159942542;35313.64686353104;37521.62478375181;37867.431988520744;38258;38565.80717096396;28408.43183136367;28721.56917646195;28745.42509149847;29009.709902901544;29033.419331613673 04:17:01 INFO - PROCESS | 20537 | |2;jquery.html;365.16377495535227;372.64040201205836;383.19146600672576;387.1270285506183;400.1017715229311;17812.821871781278;19084.33204837829;19315.51711207217;19316.90341548292;19545.41363759086;18353.541161470937;18773.342932997348;19084.71372929407;19146.946917919508;19426.70859937102;5040.143175660129;5459.972700136504;5588.86027849305;5605.27131472908;5649.519790817785;5251.86870328241;5259.237410575464;5269.1832765921345;5347.0909945309395;5359.169328754049;5245.26566280721;5641.943580564182;6013.188219590343;6023.277206735198;6063.878722425548;5973.4026597340135;6037.064255040454;6072.210612620375;6079.878402431927;6105.206323177958;5340.439253878326;5414.702191379472;5424.864378390533;5426.9185962210595;5439.945600543983;11366;11907.404629768564;11936.940315298369;11995.94002029993;12052;1947.3087054095874;2072.9378118656464;2223.244097007025;2537.7081635611958;2605.4789042191446;8456.408051436401;9012;9254.352195346328;11464.885351146466;14493.347799349054;1800.3608718904732;1827.1503750755962;1828.7988321284647;1887.3205645967441;1889.3765057531118;83473.58263208646;86689.56655216747;90284;90672.54663726705;92103.07896921012;9729.513524323896;9920;10118.54466549007;10271;10341.896581034094;13448.798268025987;13579.796303055462;13585.660358491117;13661;13726.931365343109;8017.518948863087;8020.43856930021;8033.317168040665;8057.717979870677;8154.510729356139;8090.919090809134;8148.633311500997;8157.592120393957;8292.875606865902;8342.332613390914;4104;4196.874093777192;4243.193793179348;4330.220560299176;4333.566643335641;1743.860491160704;1768.142450911307;1794.8923064616165;1820.8998505082084;1824.1517694272227;936.7845395558924;1003.4130033930232;1057.3391630231106;1061.5912873543741;1076.8115579773507;19030.42908712741;19772.802271977096;19786.90106549458;19943.202271908962;20065.59868802616;955.0974329258784;967.6371360739722;968.8692026576463;971.489967766928;985.2905907746411;10185.236107291983;10867.619633312795;10904.618338358277;10943.124550035978;11071.667849964513;454316;454937;458725;465523.3619159548;514488.9857709924;93366.53316733509;95009.52495237479;96045;97819.16563280077;99268;939.4457270210609;955.574769227687;978.2467500024941;985.5614251658087;985.911267985899;16806.327746889987;16832.915835420743;17265.74101388455;17284.82715172832;17638.73541896847;41145.58854411537;41490.792546037075;42230.15539689128;42446.575534244264;42632;53986.46013539971;55457;58397.4160258392;65043;65396.34603654093;6922.58464492132;7345.118585769742;7404.518706284074;7823.061232652118;7895.68417263303;8789.340799440195;11911.52353905834;12832.230066196058;13061;13286.335683215608;11564.306141631529;11763.117766167401;11917.880821191677;12123.333216673167;12166.209196402206;11456.885431145582;11651.650450486499;11694.415279236175;11969.10231732641;12026.27842329463;11798.646040618794;11800.586979455678;12178.208416452902;12214.633560993185;12346.629601111981;7624.428167887319;7658.310752032344;7673.731419400294;7814.984052073194;7839.294463498084;11095.11239100886;11467.483963221843;11490.138239631893;11618.825717614074;11623 04:17:01 INFO - PROCESS | 20537 | |3;mootools.html;1406.043890154695;1426.837127740891;1532.5325775638426;1692.6953148433277;1692.9576760580992;7707.49901256418;8028.598570071487;8254.380921430886;8861.246794022507;8866.290696744252;8318.251357377834;8501.362397820158;8670.696525621604;8684.652613895436;8709.564521773902;2248.955020899581;2283.4177284792436;2284.417473544244;2287.0851659336317;2288.416453804286;2262.2760716570706;2276.681264622954;2311.630139177732;2319.617263151578;2323.1984965186984;2242.5402792427512;2252.549490101986;2267.875266860322;2294.7819957104048;2298.9425264368356;2179.9455013624706;2199.483121466454;2204.680321353395;2206.5366273082673;2208.1057171845428;2185.65029595264;2210.126999835072;2213.1147540983575;2225.5882661707474;2239.5520895820737;8457.238848503664;8476.66093356265;8493.108223636491;8520.360972927056;8716.866807315071;4985.1774457214515;5114.744262786846;5115.104856650071;5115.104856650109;5131.307273518102;3017.0647099399257;3100.3179300553843;3134.13811201919;3211.6146062472653;3256.218507558193;1002.0830939690175;1025.2310766924807;1026.0662796854826;1027.6351895077214;1027.8612387327764;11415.086793056536;11540.94229528847;11556.035473969445;11608.76782464346;11665.416729163508;4450.621697155713;4472.2620767573635;4628.472604040659;4638.234691275901;4751.738654374042;9490.572924218288;9528.475933823567;9561;9602.471864047544;9653.855192171983;5072.771725272371;5096.082705113041;5104.132297509433;5111.131107711698;5112.974435127875;4360.672949528798;4758.333833263346;4772.379590653193;4782.904341913142;4787.880302992384;3626.655467730561;3693.519842420522;3724.2179142380405;3728.8694895678523;3780.3951367781024;1123.3035517978906;1127.0701671121358;1128.1651577832345;1133.6769020829024;1134.3817619397448;862.6549380247826;865.5931712095305;955.4744890310302;965.1362030982232;985.5515740338129;5886.23478947734;5931.792387266425;5948.970255148696;5956.583039187215;6011.398860114041;436.5459921681479;437.14756225360037;440.85011096226793;450.6732618851372;463.2032903406136;4044.393340998815;4112.547619761824;4159.875203743893;4236.089240813179;4240.151969606091;10349.586016559404;10415;10443.268971171945;10463.686089417177;10527.157827373792;10299.073083422529;10330.96690330976;10350.171986241083;10369;10374.429406382722;7718.073831140299;7939.603019848984;7949.085855126735;7956.840863182704;7971.123176450586;5895.823125306248;6027.246594175728;6058.848528786815;6113.633182008915;6173.012318029094;9392.295577831554;9528.571214295234;9761.609535618496;9761.9023809761;9841.60633574649;9676;9890.159336456481;9955.900440995498;10055.446950417798;10061.144802691853;6894.793156205322;7324.96337518309;7396.741114060982;7422.109346878409;7578.393728501596;8478.57607119654;8509.829803403773;8517;8518.82962340762;8529.786755330919;7514.211007844097;7787.961060194662;7809.609519523888;7818.100918394457;7884.29041386278;7484.139323977813;7579.772606821804;7603.885941710768;7714.5756983366455;7715.884261736191;6856.862862742817;6893.931060689329;6931.09895713554;6975.267596902252;7006.229314775473;4971.080350135237;5138;5277.868053298698;5331.893362132813;5362.65142765719;5253.50091741284;5343.65266257692;5345.064613692666;5358.785648574013;5449.291592093003 04:17:01 INFO - PROCESS | 20537 | |4;prototype.html;304.9344390955944;318.94896816509356;319.5286951746175;320.7321886225002;323.84455461378536;5507.953488837118;5580.944190558103;5666.20673105765;5689.857753556158;5744.79893203738;5633.746481408336;5681.545476361892;5682.346530149034;5689.288838895138;5728.885422291552;4425.645948324134;4440.600345968862;4471.83732229621;4475.149721552911;4484.394606728099;4367.563243675623;4381.277731575768;4410.867673969786;4457.777111144446;4461.486929003174;4382.5398333175035;4386.451693538308;4396.824127034931;4397.802098905557;4424.3142312941545;4411.779411029452;4430.689851710382;4437.733735975852;4453.220686379903;4460.420145381112;3738.495303134069;3847.557530883956;3923.7449565778134;3929.489166408377;3935.527736671589;5563.499285064323;5589.329280486327;5602.635828671123;5609.2514667812475;5617.719114044322;5036.891883785562;5058.392992840846;5073.137566613685;5077.720725360104;5091.23631455281;5672.546196304285;5863.061910094407;5995.250593675791;5995.310539287994;6009.729562169713;4216.873493795191;4252.405347994502;4261.126469073833;4274.29474136767;4274.422952901349;6193.969030154865;6211.409916057967;6219.968900155471;6238.500919926395;6255.280642726054;4190.161967606491;4319.352097185384;4325.978370108192;4337.891552711144;4340.479142502857;4389.18800021997;4393.945453091235;4395.241903238666;4403.647708183337;4408.545180090627;5045.8738531537;5069.493050694901;5088.160453525201;5108.335916330928;5109.007487080042;5794.507466865363;5858.853528661817;5879.412558609151;5902.675352855548;6091.634501929899;1468.574113507071;1489.91060536366;1494.7309484292932;1496.8623845877212;1499.5576304990054;914.4916244643526;926.2127191886977;932.2588542109039;938.6855403439788;945.4232917920064;5036.949630503648;5068.518490743373;5133.511281728257;5164.535191832753;5176.8964620707375;5366.543843773245;5436.3476382834315;5453.863653408617;5466.644668096561;5523.613347065747;4965.453800081988;4978.825741099116;5151.780137414116;5161.845144645667;5219.582433405319;2903.332233586287;2920;2927;2935.706429357047;2938.7942844000713;5589.636673616202;5598.412166722517;5608.383077861432;5618.943810561924;5658.7170641467765;5369.986255154317;5452.482014208644;5629;5629.634073785191;5642.332483885425;5495.972520137374;5499.735060936007;5565.1095824667855;5568.276124103922;5668.48983591487;5386.892262154656;5441.564674826083;5499.780008799603;5620.747066382104;5799.246098007232;6067.180930574493;6136.23297087864;6168.414000669929;6175.876482470415;6200.472959798468;6434.260060092962;6455.419012288917;6467.902981455188;6484.1246431733;6492.383223593751;4174.5616710244985;4267.551907049715;4268.466441694788;4269.40228368035;4288.463942007249;5983.935542237921;6050.394960503914;6224.408681175281;6247.187865577446;6309.558330916975;5996.141196229183;6026.939730602813;6040.214772079602;6049.818505444844;6074.969625152023;5974.581779275409;6029;6030.668313242813;6031.215941927521;6139.508839292756;5679.77280908759;5842.970785146217;5966.791162309299;5971.581509488664;5988.640681559121;5983.461488466059;5998.970005149947;6063.333033366238;6098.847528811638;6115.449609535163;5643.476261409479;5830;5926.066597034495;5939.703014849154;5945.167676525376 04:17:01 INFO - PROCESS | 20537 | |5;yui.html;732.4104096202558;752.4507109809842;766;776.8990031295932;787.063394560473;14771.113733176016;16117.919410402947;16507.58731031725;16552.420665276717;16736.581585460368;15070.321835517429;15187;15284.847151528482;16057.357705691758;16102.275397607107;797.4378063465258;805.2712295372668;809.9878501822477;810.3962547901792;810.9472884262534;791.3036527855479;791.924767147123;809.1382677448528;813.8494378539959;817.2562967699395;828.9544075075869;834.7871292820322;838.5555655502593;838.8993320801482;841.4993079117914;836.1805430677939;836.2640876029117;837.0624900111883;837.3175861672718;838.0027766957362;607.4259824465881;609.1137395090133;610.0696437932145;610.1397030187459;610.2829175718513;14444.205568693718;14518.491852785102;14576.344064517121;14596.927015364961;14626.70746585073;14525.636859078502;14626.414943402251;14766.187859667714;14920.850791492056;14980.625484362869;12366.62900112989;12397.194182378207;12654.114212005163;12666.87333126666;12782.552610658582;3894.2990261752875;3931.253061918226;4022.818973146186;4103.2409004333995;4107.589241075899;82996.92541127598;84077;84293;84883.15116848814;85227.57386213029;11419.543218271176;11750.177487575958;11770.603768340252;11889.464974076187;11981.161318707782;21738.456538586663;21752.891235544037;21845.67231491529;21915.232966846084;22035.66946495804;8395.454295470774;8538.274246689101;8605.31157507398;8835.293176545862;9019.233365163904;4932.1861892788;4960.503949605083;4987.62592805541;5008.223725322581;5046.4953504649975;3641.362761516724;3763.379042457964;3770.8868733938025;3781.0736369589627;3782.111203867089;626.7117126121943;628.6196850905136;635.1235295292466;641.3714559731396;653.6372313366128;602.6504627316147;644.8291202831253;667.3021925643512;721.3147509865648;746.2761121711931;9415.340926135104;9649.228061755042;9730.659426920165;9837;10277.588896444058;736.5764685305863;740.4557650127152;741.9814504637427;742.8440027594157;744.1702501710662;4751.904961900743;4933.112039832865;4985.227289770019;5030.757353124314;5031.723255220998;121675.39162304132;121707;122431;122749;124576.37711811565;105754;108442;108598.45700771446;108681.45659271652;109034;88144.55927720449;90696.54651726832;93496.53251733698;93601;93650.53174734082;9266.351355405057;9345.439273643604;9482.288828337765;9501.619935202514;9587.90412095898;52133;53407;53444.4655553455;53961.73019134879;54618.999999998414;48933.51066489432;77451;77877.22122778927;78178.6091069541;78584;11146.108311335236;11562.190646654653;11752.941235293769;11904.821427678766;12297.077719170918;13435.19388836673;13522;13584.796228056784;13779.448822047007;13842.584722458343;12530.436130374337;12958.740825183255;13056.543020994219;13449.663758406117;13657.453701851815;12562.937185314015;12605.49578016869;12642.810357844455;12768.297743624189;12905.870941290466;12757.170783899388;13162.407691653707;13401.53094641683;13516.797248041485;13819.723605528034;10156.695299141038;10381.84427233577;10433.895661043292;10577.36535807854;10823.458827058457;10426.791464170827;11146.665600032013;11269;11447.885521145015;11495.367754773568 04:17:01 INFO - PROCESS | 20537 | __end_tp_report 04:17:01 INFO - PROCESS | 20537 | __start_cc_report 04:17:01 INFO - PROCESS | 20537 | _x_x_mozilla_cycle_collect,369 04:17:01 INFO - PROCESS | 20537 | __end_cc_report 04:17:01 INFO - PROCESS | 20537 | __startTimestamp1466507821730__endTimestamp 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | ------- Summary: start ------- 04:17:01 INFO - PROCESS | 20537 | Number of tests: 6 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | [#0] dojo.html Cycles:165 Average:5459.75 Median:5711.20 stddev:728.27 (12.8%) stddev-sans-first:707.09 04:17:01 INFO - PROCESS | 20537 | Values: 3124.7 3145.9 3171.5 3176.9 3183.1 5364.8 5411.1 5428.6 5470.0 5480.7 5329.8 5342.6 5381.2 5464.9 5526.2 4913.6 4938.0 5041.1 5116.8 5137.5 748.3 4881.8 5018.0 5057.7 5061.0 5020.2 5029.0 5040.4 5069.8 5118.1 4962.6 5071.3 5073.3 5079.9 5090.7 4968.9 5002.7 5014.9 5018.4 5079.0 5511.6 5515.1 5523.3 5535.4 5549.6 5860.1 5894.4 5916.6 5941.8 5964.5 6018.6 6049.1 6050.5 6077.8 6083.9 5578.4 5634.2 5635.3 5635.7 5636.2 5832.8 6033.2 6068.2 6105.4 6154.3 5883.9 5892.5 5893.5 5905.4 5908.9 5970.7 5981.8 5984.9 5989.3 5995.2 5716.5 5838.2 5841.0 5900.7 5913.4 5735.1 5851.9 5876.6 5881.8 5894.1 4504.6 4521.8 4534.4 4535.1 4549.4 3953.4 3957.3 3964.9 4016.3 4019.0 5493.1 5603.4 5603.8 5606.7 5607.2 5887.1 5919.6 5920.6 5924.6 5927.5 5551.3 5567.2 5595.5 5638.2 5648.2 5102.1 5130.6 5140.2 5148.3 5150.9 5915.2 6113.0 6126.5 6136.0 6139.7 5854.3 5861.7 5898.1 5934.7 5936.0 5970.1 6030.2 6031.1 6043.9 6052.2 5705.4 5725.7 5755.6 5757.9 5769.0 5846.6 5934.9 5936.3 5948.9 5994.1 5683.7 5758.3 5759.2 5781.3 5781.4 5603.1 5709.7 5711.2 5717.6 5746.6 5585.6 5615.6 5724.0 5734.7 5741.5 5846.5 5868.7 5873.6 5879.2 5883.0 5599.3 5660.2 5738.0 5745.7 5754.7 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | [#1] ext.html Cycles:180 Average:61925.71 Median:42020.79 stddev:123501.73 (293.9%) stddev-sans-first:123762.28 04:17:01 INFO - PROCESS | 20537 | Values: 575.7 612.8 613.0 623.2 645.8 31743.2 35134.6 40972.0 41391.4 41572.6 43220.4 43252.0 43362.8 43459.0 43527.3 8650.7 8824.4 8829.8 8830.9 8832.0 8715.2 8855.3 8858.8 8872.1 8891.0 8863.3 8950.5 8975.7 8992.2 8998.7 8831.0 8888.3 8894.0 8894.5 8899.9 8867.0 8895.7 8936.2 8936.4 8963.4 41431.0 41706.0 41719.0 41939.8 42101.8 3463.6 3562.0 3602.1 3945.5 4125.7 32139.5 33031.8 33068.2 33164.3 33190.7 4317.9 4556.1 4605.6 4615.4 4618.6 365524.0 366643.0 366944.0 367377.0 368002.0 51246.5 55827.0 58004.0 58038.0 63332.7 63077.1 63681.4 63758.0 63987.0 64105.7 15789.8 15814.0 15864.3 15934.5 15948.4 13413.7 13430.7 13554.5 13717.6 13719.6 19089.1 19125.2 19134.3 19226.3 19349.1 7177.0 7230.8 7280.1 7285.7 7364.7 988.5 1005.2 1019.7 1131.0 1148.5 32538.3 32726.7 32902.3 32965.3 33276.8 1055.1 1168.9 1198.4 1209.6 1225.0 16986.9 17820.6 17859.9 18645.8 18848.3 527689.0 529142.0 529729.0 530363.0 532170.0 58041.4 58200.0 58417.0 58476.0 58639.1 1307.0 1320.6 1361.8 1366.2 1386.0 31430.5 31975.7 32512.7 32799.3 33083.7 49678.0 49947.5 50233.2 50303.7 50379.2 483201.0 484407.0 485249.0 485511.0 486199.0 27121.3 27324.7 27354.7 27494.2 27527.2 46095.8 46361.5 46425.8 46590.5 48263.5 41439.0 41823.8 42454.6 42515.4 43559.3 41548.6 42168.0 42247.2 42621.1 43115.1 38826.6 40926.0 40987.2 41705.0 41893.4 35313.6 37521.6 37867.4 38258.0 38565.8 28408.4 28721.6 28745.4 29009.7 29033.4 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | [#2] jquery.html Cycles:180 Average:28335.24 Median:22843.83 stddev:78005.14 (341.5%) stddev-sans-first:78195.69 04:17:01 INFO - PROCESS | 20537 | Values: 365.2 372.6 383.2 387.1 400.1 17812.8 19084.3 19315.5 19316.9 19545.4 18353.5 18773.3 19084.7 19146.9 19426.7 5040.1 5460.0 5588.9 5605.3 5649.5 5251.9 5259.2 5269.2 5347.1 5359.2 5245.3 5641.9 6013.2 6023.3 6063.9 5973.4 6037.1 6072.2 6079.9 6105.2 5340.4 5414.7 5424.9 5426.9 5439.9 11366.0 11907.4 11936.9 11995.9 12052.0 1947.3 2072.9 2223.2 2537.7 2605.5 8456.4 9012.0 9254.4 11464.9 14493.3 1800.4 1827.2 1828.8 1887.3 1889.4 83473.6 86689.6 90284.0 90672.5 92103.1 9729.5 9920.0 10118.5 10271.0 10341.9 13448.8 13579.8 13585.7 13661.0 13726.9 8017.5 8020.4 8033.3 8057.7 8154.5 8090.9 8148.6 8157.6 8292.9 8342.3 4104.0 4196.9 4243.2 4330.2 4333.6 1743.9 1768.1 1794.9 1820.9 1824.2 936.8 1003.4 1057.3 1061.6 1076.8 19030.4 19772.8 19786.9 19943.2 20065.6 955.1 967.6 968.9 971.5 985.3 10185.2 10867.6 10904.6 10943.1 11071.7 454316.0 454937.0 458725.0 465523.4 514489.0 93366.5 95009.5 96045.0 97819.2 99268.0 939.4 955.6 978.2 985.6 985.9 16806.3 16832.9 17265.7 17284.8 17638.7 41145.6 41490.8 42230.2 42446.6 42632.0 53986.5 55457.0 58397.4 65043.0 65396.3 6922.6 7345.1 7404.5 7823.1 7895.7 8789.3 11911.5 12832.2 13061.0 13286.3 11564.3 11763.1 11917.9 12123.3 12166.2 11456.9 11651.7 11694.4 11969.1 12026.3 11798.6 11800.6 12178.2 12214.6 12346.6 7624.4 7658.3 7673.7 7815.0 7839.3 11095.1 11467.5 11490.1 11618.8 11623.0 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | [#3] mootools.html Cycles:180 Average:5622.03 Median:5100.11 stddev:3177.65 (62.3%) stddev-sans-first:3170.77 04:17:01 INFO - PROCESS | 20537 | Values: 1406.0 1426.8 1532.5 1692.7 1693.0 7707.5 8028.6 8254.4 8861.2 8866.3 8318.3 8501.4 8670.7 8684.7 8709.6 2249.0 2283.4 2284.4 2287.1 2288.4 2262.3 2276.7 2311.6 2319.6 2323.2 2242.5 2252.5 2267.9 2294.8 2298.9 2179.9 2199.5 2204.7 2206.5 2208.1 2185.7 2210.1 2213.1 2225.6 2239.6 8457.2 8476.7 8493.1 8520.4 8716.9 4985.2 5114.7 5115.1 5115.1 5131.3 3017.1 3100.3 3134.1 3211.6 3256.2 1002.1 1025.2 1026.1 1027.6 1027.9 11415.1 11540.9 11556.0 11608.8 11665.4 4450.6 4472.3 4628.5 4638.2 4751.7 9490.6 9528.5 9561.0 9602.5 9653.9 5072.8 5096.1 5104.1 5111.1 5113.0 4360.7 4758.3 4772.4 4782.9 4787.9 3626.7 3693.5 3724.2 3728.9 3780.4 1123.3 1127.1 1128.2 1133.7 1134.4 862.7 865.6 955.5 965.1 985.6 5886.2 5931.8 5949.0 5956.6 6011.4 436.5 437.1 440.9 450.7 463.2 4044.4 4112.5 4159.9 4236.1 4240.2 10349.6 10415.0 10443.3 10463.7 10527.2 10299.1 10331.0 10350.2 10369.0 10374.4 7718.1 7939.6 7949.1 7956.8 7971.1 5895.8 6027.2 6058.8 6113.6 6173.0 9392.3 9528.6 9761.6 9761.9 9841.6 9676.0 9890.2 9955.9 10055.4 10061.1 6894.8 7325.0 7396.7 7422.1 7578.4 8478.6 8509.8 8517.0 8518.8 8529.8 7514.2 7788.0 7809.6 7818.1 7884.3 7484.1 7579.8 7603.9 7714.6 7715.9 6856.9 6893.9 6931.1 6975.3 7006.2 4971.1 5138.0 5277.9 5331.9 5362.7 5253.5 5343.7 5345.1 5358.8 5449.3 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | [#4] prototype.html Cycles:180 Average:4893.15 Median:5503.87 stddev:1446.45 (26.3%) stddev-sans-first:1408.92 04:17:01 INFO - PROCESS | 20537 | Values: 304.9 318.9 319.5 320.7 323.8 5508.0 5580.9 5666.2 5689.9 5744.8 5633.7 5681.5 5682.3 5689.3 5728.9 4425.6 4440.6 4471.8 4475.1 4484.4 4367.6 4381.3 4410.9 4457.8 4461.5 4382.5 4386.5 4396.8 4397.8 4424.3 4411.8 4430.7 4437.7 4453.2 4460.4 3738.5 3847.6 3923.7 3929.5 3935.5 5563.5 5589.3 5602.6 5609.3 5617.7 5036.9 5058.4 5073.1 5077.7 5091.2 5672.5 5863.1 5995.3 5995.3 6009.7 4216.9 4252.4 4261.1 4274.3 4274.4 6194.0 6211.4 6220.0 6238.5 6255.3 4190.2 4319.4 4326.0 4337.9 4340.5 4389.2 4393.9 4395.2 4403.6 4408.5 5045.9 5069.5 5088.2 5108.3 5109.0 5794.5 5858.9 5879.4 5902.7 6091.6 1468.6 1489.9 1494.7 1496.9 1499.6 914.5 926.2 932.3 938.7 945.4 5036.9 5068.5 5133.5 5164.5 5176.9 5366.5 5436.3 5453.9 5466.6 5523.6 4965.5 4978.8 5151.8 5161.8 5219.6 2903.3 2920.0 2927.0 2935.7 2938.8 5589.6 5598.4 5608.4 5618.9 5658.7 5370.0 5452.5 5629.0 5629.6 5642.3 5496.0 5499.7 5565.1 5568.3 5668.5 5386.9 5441.6 5499.8 5620.7 5799.2 6067.2 6136.2 6168.4 6175.9 6200.5 6434.3 6455.4 6467.9 6484.1 6492.4 4174.6 4267.6 4268.5 4269.4 4288.5 5983.9 6050.4 6224.4 6247.2 6309.6 5996.1 6026.9 6040.2 6049.8 6075.0 5974.6 6029.0 6030.7 6031.2 6139.5 5679.8 5843.0 5966.8 5971.6 5988.6 5983.5 5999.0 6063.3 6098.8 6115.4 5643.5 5830.0 5926.1 5939.7 5945.2 04:17:01 INFO - PROCESS | 20537 | 04:17:01 INFO - PROCESS | 20537 | [#5] yui.html Cycles:180 Average:21619.65 Median:4429.75 stddev:32058.78 (723.7%) stddev-sans-first:32110.35 04:17:01 INFO - PROCESS | 20537 | Values: 732.4 752.5 766.0 776.9 787.1 14771.1 16117.9 16507.6 16552.4 16736.6 15070.3 15187.0 15284.8 16057.4 16102.3 797.4 805.3 810.0 810.4 810.9 791.3 791.9 809.1 813.8 817.3 829.0 834.8 838.6 838.9 841.5 836.2 836.3 837.1 837.3 838.0 607.4 609.1 610.1 610.1 610.3 14444.2 14518.5 14576.3 14596.9 14626.7 14525.6 14626.4 14766.2 14920.9 14980.6 12366.6 12397.2 12654.1 12666.9 12782.6 3894.3 3931.3 4022.8 4103.2 4107.6 82996.9 84077.0 84293.0 84883.2 85227.6 11419.5 11750.2 11770.6 11889.5 11981.2 21738.5 21752.9 21845.7 21915.2 22035.7 8395.5 8538.3 8605.3 8835.3 9019.2 4932.2 4960.5 4987.6 5008.2 5046.5 3641.4 3763.4 3770.9 3781.1 3782.1 626.7 628.6 635.1 641.4 653.6 602.7 644.8 667.3 721.3 746.3 9415.3 9649.2 9730.7 9837.0 10277.6 736.6 740.5 742.0 742.8 744.2 4751.9 4933.1 4985.2 5030.8 5031.7 121675.4 121707.0 122431.0 122749.0 124576.4 105754.0 108442.0 108598.5 108681.5 109034.0 88144.6 90696.5 93496.5 93601.0 93650.5 9266.4 9345.4 9482.3 9501.6 9587.9 52133.0 53407.0 53444.5 53961.7 54619.0 48933.5 77451.0 77877.2 78178.6 78584.0 11146.1 11562.2 11752.9 11904.8 12297.1 13435.2 13522.0 13584.8 13779.4 13842.6 12530.4 12958.7 13056.5 13449.7 13657.5 12562.9 12605.5 12642.8 12768.3 12905.9 12757.2 13162.4 13401.5 13516.8 13819.7 10156.7 10381.8 10433.9 10577.4 10823.5 10426.8 11146.7 11269.0 11447.9 11495.4 04:17:01 INFO - PROCESS | 20537 | -------- Summary: end -------- 04:17:01 INFO - PROCESS | 20537 | 04:17:02 INFO - TEST-INFO | 20537: exit 0 04:17:02 INFO - TEST-OK | dromaeo_css | took 1111795ms 04:17:02 INFO - TEST-START | kraken 04:17:02 INFO - operating with platform_type : linux_ 04:17:02 INFO - Initialising browser for kraken test... 04:17:02 INFO - TEST-INFO | started process 20777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKRifom/profile http://localhost:43856/getInfo.html) 04:17:07 INFO - PROCESS | 20777 | __metrics Screen width/height:1600/1200 04:17:07 INFO - PROCESS | 20777 | colorDepth:24 04:17:07 INFO - PROCESS | 20777 | Browser inner width/height: 1024/697 04:17:07 INFO - PROCESS | 20777 | __metrics 04:17:08 ERROR - PROCESS | 20777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:17:08 INFO - TEST-INFO | 20777: exit 0 04:17:08 INFO - Browser initialized. 04:17:08 INFO - Running cycle 1/1 for kraken test... 04:17:08 INFO - TEST-INFO | started process 20896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKRifom/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:20 INFO - PROCESS | 20896 | RSS: Main: 184807424 04:17:20 INFO - PROCESS | 20896 | 04:17:23 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43856/tests/kraken/driver.html?testName=audio-beat-detection) 04:17:24 INFO - PROCESS | 20896 | RSS: Main: 190623744 04:17:24 INFO - PROCESS | 20896 | 04:17:26 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43856/tests/kraken/driver.html?testName=audio-dft) 04:17:27 INFO - PROCESS | 20896 | RSS: Main: 189837312 04:17:27 INFO - PROCESS | 20896 | 04:17:30 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43856/tests/kraken/driver.html?testName=audio-fft) 04:17:31 INFO - PROCESS | 20896 | RSS: Main: 184791040 04:17:31 INFO - PROCESS | 20896 | 04:17:33 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43856/tests/kraken/driver.html?testName=audio-oscillator) 04:17:33 INFO - PROCESS | 20896 | RSS: Main: 186040320 04:17:33 INFO - PROCESS | 20896 | 04:17:36 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:36 INFO - PROCESS | 20896 | RSS: Main: 185970688 04:17:36 INFO - PROCESS | 20896 | 04:17:39 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43856/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:40 INFO - PROCESS | 20896 | RSS: Main: 186548224 04:17:40 INFO - PROCESS | 20896 | 04:17:43 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43856/tests/kraken/driver.html?testName=imaging-desaturate) 04:17:44 INFO - PROCESS | 20896 | RSS: Main: 184004608 04:17:44 INFO - PROCESS | 20896 | 04:17:47 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43856/tests/kraken/driver.html?testName=json-parse-financial) 04:17:47 INFO - PROCESS | 20896 | RSS: Main: 185102336 04:17:47 INFO - PROCESS | 20896 | 04:17:49 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:17:50 INFO - PROCESS | 20896 | RSS: Main: 185769984 04:17:50 INFO - PROCESS | 20896 | 04:17:51 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:17:52 INFO - PROCESS | 20896 | RSS: Main: 185864192 04:17:52 INFO - PROCESS | 20896 | 04:17:54 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:17:55 INFO - PROCESS | 20896 | RSS: Main: 186298368 04:17:55 INFO - PROCESS | 20896 | 04:17:57 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:17:58 INFO - PROCESS | 20896 | RSS: Main: 186298368 04:17:58 INFO - PROCESS | 20896 | 04:18:01 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:01 INFO - PROCESS | 20896 | RSS: Main: 186085376 04:18:01 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | Cycle 1(1): loaded http://localhost:43856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43856/tests/kraken/driver.html?testName=ai-astar) 04:18:03 INFO - PROCESS | 20896 | RSS: Main: 187715584 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | __start_tp_report 04:18:03 INFO - PROCESS | 20896 | _x_x_mozilla_page_load 04:18:03 INFO - PROCESS | 20896 | _x_x_mozilla_page_load_details 04:18:03 INFO - PROCESS | 20896 | |i|pagename|runs| 04:18:03 INFO - PROCESS | 20896 | |0;ai-astar;112;106;113;109;111;112;110;110;111;110 04:18:03 INFO - PROCESS | 20896 | |1;audio-beat-detection;163;126;152;188;128;160;153;133;201;128 04:18:03 INFO - PROCESS | 20896 | |2;audio-dft;164;161;160;163;163;170;163;162;161;163 04:18:03 INFO - PROCESS | 20896 | |3;audio-fft;75;76;74;151;77;75;77;76;161;76 04:18:03 INFO - PROCESS | 20896 | |4;audio-oscillator;85;84;147;86;87;85;140;86;85;133 04:18:03 INFO - PROCESS | 20896 | |5;imaging-gaussian-blur;118;119;117;118;117;117;118;118;118;119 04:18:03 INFO - PROCESS | 20896 | |6;imaging-darkroom;147;147;146;148;148;146;146;149;146;146 04:18:03 INFO - PROCESS | 20896 | |7;imaging-desaturate;96;97;96;95;96;95;97;96;96;96 04:18:03 INFO - PROCESS | 20896 | |8;json-parse-financial;56;56;56;57;55;55;58;59;55;55 04:18:03 INFO - PROCESS | 20896 | |9;json-stringify-tinderbox;63;63;63;63;64;63;63;63;63;63 04:18:03 INFO - PROCESS | 20896 | |10;stanford-crypto-aes;81;81;82;80;82;86;86;87;104;80 04:18:03 INFO - PROCESS | 20896 | |11;stanford-crypto-ccm;134;126;140;131;131;126;137;137;148;128 04:18:03 INFO - PROCESS | 20896 | |12;stanford-crypto-pbkdf2;163;160;161;163;158;171;157;162;161;161 04:18:03 INFO - PROCESS | 20896 | |13;stanford-crypto-sha256-iterative;64;63;65;64;66;65;66;68;62;70 04:18:03 INFO - PROCESS | 20896 | __end_tp_report 04:18:03 INFO - PROCESS | 20896 | __start_cc_report 04:18:03 INFO - PROCESS | 20896 | _x_x_mozilla_cycle_collect,867 04:18:03 INFO - PROCESS | 20896 | __end_cc_report 04:18:03 INFO - PROCESS | 20896 | __startTimestamp1466507883888__endTimestamp 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | ------- Summary: start ------- 04:18:03 INFO - PROCESS | 20896 | Number of tests: 14 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:1.99 04:18:03 INFO - PROCESS | 20896 | Values: 112.0 106.0 113.0 109.0 111.0 112.0 110.0 110.0 111.0 110.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:156.50 stddev:25.94 (16.6%) stddev-sans-first:27.27 04:18:03 INFO - PROCESS | 20896 | Values: 163.0 126.0 152.0 188.0 128.0 160.0 153.0 133.0 201.0 128.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.75 (1.7%) stddev-sans-first:2.89 04:18:03 INFO - PROCESS | 20896 | Values: 164.0 161.0 160.0 163.0 163.0 170.0 163.0 162.0 161.0 163.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#3] audio-fft Cycles:10 Average:91.80 Median:76.00 stddev:33.93 (44.6%) stddev-sans-first:35.44 04:18:03 INFO - PROCESS | 20896 | Values: 75.0 76.0 74.0 151.0 77.0 75.0 77.0 76.0 161.0 76.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:85.00 stddev:26.58 (31.3%) stddev-sans-first:27.49 04:18:03 INFO - PROCESS | 20896 | Values: 85.0 84.0 147.0 86.0 87.0 85.0 140.0 86.0 85.0 133.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 04:18:03 INFO - PROCESS | 20896 | Values: 118.0 119.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 119.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 04:18:03 INFO - PROCESS | 20896 | Values: 147.0 147.0 146.0 148.0 148.0 146.0 146.0 149.0 146.0 146.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:18:03 INFO - PROCESS | 20896 | Values: 96.0 97.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 96.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 04:18:03 INFO - PROCESS | 20896 | Values: 56.0 56.0 56.0 57.0 55.0 55.0 58.0 59.0 55.0 55.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:18:03 INFO - PROCESS | 20896 | Values: 63.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.00 stddev:7.20 (8.8%) stddev-sans-first:7.50 04:18:03 INFO - PROCESS | 20896 | Values: 81.0 81.0 82.0 80.0 82.0 86.0 86.0 87.0 104.0 80.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:135.50 stddev:6.92 (5.1%) stddev-sans-first:7.34 04:18:03 INFO - PROCESS | 20896 | Values: 134.0 126.0 140.0 131.0 131.0 126.0 137.0 137.0 148.0 128.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.50 stddev:3.80 (2.4%) stddev-sans-first:4.00 04:18:03 INFO - PROCESS | 20896 | Values: 163.0 160.0 161.0 163.0 158.0 171.0 157.0 162.0 161.0 161.0 04:18:03 INFO - PROCESS | 20896 | 04:18:03 INFO - PROCESS | 20896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.36 (3.6%) stddev-sans-first:2.46 04:18:03 INFO - PROCESS | 20896 | Values: 64.0 63.0 65.0 64.0 66.0 65.0 66.0 68.0 62.0 70.0 04:18:03 INFO - PROCESS | 20896 | -------- Summary: end -------- 04:18:03 INFO - PROCESS | 20896 | 04:18:04 INFO - TEST-INFO | 20896: exit 0 04:18:04 INFO - TEST-OK | kraken | took 62410ms 04:18:04 INFO - SUITE-END | took 1174s 04:18:05 INFO - Completed test suite (00:19:34) 04:18:05 INFO - javascript benchmark 04:18:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7250.378380443032, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.6719094495093, 3145.858436370364, 3171.5401266816307, 3176.8570414331352, 3183.1405520509447, 5364.758585863636, 5411.107167317393, 5428.647137936036, 5470.0, 5480.725963701819, 5329.813456529022, 5342.626016178869, 5381.165919282517, 5464.863378415542, 5526.171074338851, 4913.557779799827, 4937.950620493785, 5041.143005689023, 5116.769745361449, 5137.460566640505, 748.2533145164624, 4881.780319885596, 5017.974910125445, 5057.747112644372, 5060.962502686941, 5020.171671674188, 5029.044481548494, 5040.36995375578, 5069.822556210534, 5118.07874582575, 4962.5533701967, 5071.264666623356, 5073.289739436482, 5079.898402031976, 5090.669106508065, 4968.8757781055765, 5002.674826136289, 5014.924776128361, 5018.372703412074, 5079.034983353151, 5511.614187006911, 5515.09001014832, 5523.2543606613, 5535.391106978229, 5549.5837812164245, 5860.120981852713, 5894.410558944114, 5916.615419997686, 5941.762329506814, 5964.493018093423, 6018.638881667071, 6049.062395328687, 6050.54620903434, 6077.787277445313, 6083.908741368883, 5578.44215578443, 5634.239377684001, 5635.295588051494, 5635.6618602883955, 5636.15457681347, 5832.795852145239, 6033.215681961317, 6068.150458935753, 6105.419985101408, 6154.261488621304, 5883.941160588425, 5892.528597712173, 5893.499052580493, 5905.379935106838, 5908.911366329508, 5970.731317090741, 5981.79063732776, 5984.940150598438, 5989.341172471025, 5995.2206213192, 5716.542676585863, 5838.153467747153, 5840.970795145997, 5900.704964751745, 5913.379095195029, 5735.053716136791, 5851.912221316684, 5876.6180198286975, 5881.823545293648, 5894.056950887923, 4504.61710754583, 4521.84173553924, 4534.387857639243, 4535.092981403733, 4549.431321084864, 3953.446517487554, 3957.2876882161486, 3964.940525892114, 4016.3172260715746, 4019.0153412414147, 5493.066178749622, 5603.3836278009385, 5603.775848966077, 5606.6916319602815, 5607.186957891165, 5887.116932460165, 5919.644821310649, 5920.644761314335, 5924.6149000314845, 5927.496162826122, 5551.306086739158, 5567.24842146305, 5595.468430499096, 5638.154276858504, 5648.181013752983, 5102.107131252016, 5130.640855140179, 5140.203268493389, 5148.30497882781, 5150.922736158961, 5915.201447804491, 6113.02191649334, 6126.540509461808, 6136.048912418582, 6139.693015349215, 5854.326752423441, 5861.677607731615, 5898.1152827076285, 5934.732937017759, 5936.020556608111, 5970.104484327386, 6030.185924900258, 6031.125486804476, 6043.879122417615, 6052.243469566304, 5705.429457054262, 5725.742341594555, 5755.5971082025535, 5757.942420575908, 5769.019266724583, 5846.619969701956, 5934.881302374015, 5936.347001829881, 5948.910766338422, 5994.13085102649, 5683.71581420919, 5758.3090029196765, 5759.193712880116, 5781.335146458211, 5781.392953739797, 5603.131514615241, 5709.68596727184, 5711.200431939449, 5717.571182161438, 5746.597738158289, 5585.553155747449, 5615.634983726045, 5723.971380143073, 5734.7132643368495, 5741.45456181662, 5846.532277417881, 5868.67722275279, 5873.647581145145, 5879.176915231786, 5883.0, 5599.300087489064, 5660.20757093999, 5737.971310143423, 5745.655260684205, 5754.741036653444], "value": 5411.663275036588, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7322844877134, 612.7977767336773, 612.9509639228862, 623.2396476298915, 645.8127143128492, 31743.206419839516, 35134.64865351345, 40972.0, 41391.379129313085, 41572.58427415725, 43220.3516947246, 43252.0, 43362.7831860841, 43459.0, 43527.34708979368, 8650.65397384104, 8824.426412283181, 8829.823403531958, 8830.911690883073, 8832.028476867572, 8715.215630593246, 8855.335849811258, 8858.822823543525, 8872.068432814558, 8891.021987581393, 8863.29093672508, 8950.507722075283, 8975.730728078135, 8992.190702836744, 8998.68504602339, 8831.0, 8888.288936885034, 8894.0, 8894.510801905924, 8899.866502002475, 8867.0, 8895.688650897187, 8936.240419564345, 8936.374453788238, 8963.417377870417, 41431.0, 41706.0, 41719.0, 41939.7903010483, 42101.78949105265, 3463.5843698756057, 3562.0131815458567, 3602.1174812170925, 3945.506811648544, 4125.690573206992, 32139.51790723141, 33031.83484082564, 33068.17329566756, 33164.33671326584, 33190.66809331924, 4317.913641727179, 4556.066006468666, 4605.562471565196, 4615.399998000238, 4618.56123668251, 365524.0, 366643.0, 366944.0, 367377.0, 368002.0, 51246.487535124914, 55827.0, 58004.0, 58038.0, 63332.683336583024, 63077.05384419237, 63681.36318636847, 63758.0, 63987.0, 64105.67947160234, 15789.842101579066, 15814.0, 15864.286107125206, 15934.52196434109, 15948.441804536786, 13413.731725365633, 13430.731385372434, 13554.525591604246, 13717.588472345846, 13719.588412347646, 19089.140988655545, 19125.226842107815, 19134.330298439767, 19226.32707855218, 19349.12928918174, 7176.96411517939, 7230.783076507713, 7280.089988751406, 7285.672144753393, 7364.705411783576, 988.4909271725068, 1005.2295753822989, 1019.719577116299, 1130.9708165569293, 1148.4831825678477, 32538.349233015208, 32726.672733272837, 32902.3419531608, 32965.34069318648, 33276.83361583225, 1055.0820785916303, 1168.9415529223504, 1198.38283284107, 1209.564556759566, 1224.9816252756216, 16986.915065424593, 17820.643587128186, 17859.910700446675, 18645.813541864678, 18848.34030808915, 527689.0, 529142.0, 529729.0, 530363.0, 532170.0, 58041.419585803604, 58200.0, 58417.0, 58476.0, 58639.120413193836, 1306.9607911762662, 1320.6038188543398, 1361.795730640392, 1366.1939455721172, 1385.9722805543834, 31430.528542071428, 31975.6802431982, 32512.67487325191, 32799.344013119124, 33083.669163308055, 49678.0, 49947.500524994284, 50233.24650130178, 50303.74848125736, 50379.24431133462, 483201.0, 484407.0, 485249.0, 485511.0, 486199.0, 27121.321966950985, 27324.72675273222, 27354.726452735216, 27494.17517474479, 27527.17418477449, 46095.769521153525, 46361.53638463572, 46425.76787116043, 46590.534094659975, 48263.516997898245, 41439.0, 41823.7908810454, 42454.57545424506, 42515.3622695666, 43559.34660980025, 41548.58451415568, 42168.0, 42247.155056898075, 42621.147577048905, 43115.13769724525, 38826.6117338823, 40926.0, 40987.1802563953, 41705.0, 41893.37159942542, 35313.64686353104, 37521.62478375181, 37867.431988520744, 38258.0, 38565.80717096396, 28408.43183136367, 28721.56917646195, 28745.42509149847, 29009.709902901544, 29033.419331613673], "value": 20352.891079824243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.16377495535227, 372.64040201205836, 383.19146600672576, 387.1270285506183, 400.1017715229311, 17812.821871781278, 19084.33204837829, 19315.51711207217, 19316.90341548292, 19545.41363759086, 18353.541161470937, 18773.342932997348, 19084.71372929407, 19146.946917919508, 19426.70859937102, 5040.143175660129, 5459.972700136504, 5588.86027849305, 5605.27131472908, 5649.519790817785, 5251.86870328241, 5259.237410575464, 5269.1832765921345, 5347.0909945309395, 5359.169328754049, 5245.26566280721, 5641.943580564182, 6013.188219590343, 6023.277206735198, 6063.878722425548, 5973.4026597340135, 6037.064255040454, 6072.210612620375, 6079.878402431927, 6105.206323177958, 5340.439253878326, 5414.702191379472, 5424.864378390533, 5426.9185962210595, 5439.945600543983, 11366.0, 11907.404629768564, 11936.940315298369, 11995.94002029993, 12052.0, 1947.3087054095874, 2072.9378118656464, 2223.244097007025, 2537.7081635611958, 2605.4789042191446, 8456.408051436401, 9012.0, 9254.352195346328, 11464.885351146466, 14493.347799349054, 1800.3608718904732, 1827.1503750755962, 1828.7988321284647, 1887.3205645967441, 1889.3765057531118, 83473.58263208646, 86689.56655216747, 90284.0, 90672.54663726705, 92103.07896921012, 9729.513524323896, 9920.0, 10118.54466549007, 10271.0, 10341.896581034094, 13448.798268025987, 13579.796303055462, 13585.660358491117, 13661.0, 13726.931365343109, 8017.518948863087, 8020.43856930021, 8033.317168040665, 8057.717979870677, 8154.510729356139, 8090.919090809134, 8148.633311500997, 8157.592120393957, 8292.875606865902, 8342.332613390914, 4104.0, 4196.874093777192, 4243.193793179348, 4330.220560299176, 4333.566643335641, 1743.860491160704, 1768.142450911307, 1794.8923064616165, 1820.8998505082084, 1824.1517694272227, 936.7845395558924, 1003.4130033930232, 1057.3391630231106, 1061.5912873543741, 1076.8115579773507, 19030.42908712741, 19772.802271977096, 19786.90106549458, 19943.202271908962, 20065.59868802616, 955.0974329258784, 967.6371360739722, 968.8692026576463, 971.489967766928, 985.2905907746411, 10185.236107291983, 10867.619633312795, 10904.618338358277, 10943.124550035978, 11071.667849964513, 454316.0, 454937.0, 458725.0, 465523.3619159548, 514488.9857709924, 93366.53316733509, 95009.52495237479, 96045.0, 97819.16563280077, 99268.0, 939.4457270210609, 955.574769227687, 978.2467500024941, 985.5614251658087, 985.911267985899, 16806.327746889987, 16832.915835420743, 17265.74101388455, 17284.82715172832, 17638.73541896847, 41145.58854411537, 41490.792546037075, 42230.15539689128, 42446.575534244264, 42632.0, 53986.46013539971, 55457.0, 58397.4160258392, 65043.0, 65396.34603654093, 6922.58464492132, 7345.118585769742, 7404.518706284074, 7823.061232652118, 7895.68417263303, 8789.340799440195, 11911.52353905834, 12832.230066196058, 13061.0, 13286.335683215608, 11564.306141631529, 11763.117766167401, 11917.880821191677, 12123.333216673167, 12166.209196402206, 11456.885431145582, 11651.650450486499, 11694.415279236175, 11969.10231732641, 12026.27842329463, 11798.646040618794, 11800.586979455678, 12178.208416452902, 12214.633560993185, 12346.629601111981, 7624.428167887319, 7658.310752032344, 7673.731419400294, 7814.984052073194, 7839.294463498084, 11095.11239100886, 11467.483963221843, 11490.138239631893, 11618.825717614074, 11623.0], "value": 8864.3555396364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.043890154695, 1426.837127740891, 1532.5325775638426, 1692.6953148433277, 1692.9576760580992, 7707.49901256418, 8028.598570071487, 8254.380921430886, 8861.246794022507, 8866.290696744252, 8318.251357377834, 8501.362397820158, 8670.696525621604, 8684.652613895436, 8709.564521773902, 2248.955020899581, 2283.4177284792436, 2284.417473544244, 2287.0851659336317, 2288.416453804286, 2262.2760716570706, 2276.681264622954, 2311.630139177732, 2319.617263151578, 2323.1984965186984, 2242.5402792427512, 2252.549490101986, 2267.875266860322, 2294.7819957104048, 2298.9425264368356, 2179.9455013624706, 2199.483121466454, 2204.680321353395, 2206.5366273082673, 2208.1057171845428, 2185.65029595264, 2210.126999835072, 2213.1147540983575, 2225.5882661707474, 2239.5520895820737, 8457.238848503664, 8476.66093356265, 8493.108223636491, 8520.360972927056, 8716.866807315071, 4985.1774457214515, 5114.744262786846, 5115.104856650071, 5115.104856650109, 5131.307273518102, 3017.0647099399257, 3100.3179300553843, 3134.13811201919, 3211.6146062472653, 3256.218507558193, 1002.0830939690175, 1025.2310766924807, 1026.0662796854826, 1027.6351895077214, 1027.8612387327764, 11415.086793056536, 11540.94229528847, 11556.035473969445, 11608.76782464346, 11665.416729163508, 4450.621697155713, 4472.2620767573635, 4628.472604040659, 4638.234691275901, 4751.738654374042, 9490.572924218288, 9528.475933823567, 9561.0, 9602.471864047544, 9653.855192171983, 5072.771725272371, 5096.082705113041, 5104.132297509433, 5111.131107711698, 5112.974435127875, 4360.672949528798, 4758.333833263346, 4772.379590653193, 4782.904341913142, 4787.880302992384, 3626.655467730561, 3693.519842420522, 3724.2179142380405, 3728.8694895678523, 3780.3951367781024, 1123.3035517978906, 1127.0701671121358, 1128.1651577832345, 1133.6769020829024, 1134.3817619397448, 862.6549380247826, 865.5931712095305, 955.4744890310302, 965.1362030982232, 985.5515740338129, 5886.23478947734, 5931.792387266425, 5948.970255148696, 5956.583039187215, 6011.398860114041, 436.5459921681479, 437.14756225360037, 440.85011096226793, 450.6732618851372, 463.2032903406136, 4044.393340998815, 4112.547619761824, 4159.875203743893, 4236.089240813179, 4240.151969606091, 10349.586016559404, 10415.0, 10443.268971171945, 10463.686089417177, 10527.157827373792, 10299.073083422529, 10330.96690330976, 10350.171986241083, 10369.0, 10374.429406382722, 7718.073831140299, 7939.603019848984, 7949.085855126735, 7956.840863182704, 7971.123176450586, 5895.823125306248, 6027.246594175728, 6058.848528786815, 6113.633182008915, 6173.012318029094, 9392.295577831554, 9528.571214295234, 9761.609535618496, 9761.9023809761, 9841.60633574649, 9676.0, 9890.159336456481, 9955.900440995498, 10055.446950417798, 10061.144802691853, 6894.793156205322, 7324.96337518309, 7396.741114060982, 7422.109346878409, 7578.393728501596, 8478.57607119654, 8509.829803403773, 8517.0, 8518.82962340762, 8529.786755330919, 7514.211007844097, 7787.961060194662, 7809.609519523888, 7818.100918394457, 7884.29041386278, 7484.139323977813, 7579.772606821804, 7603.885941710768, 7714.5756983366455, 7715.884261736191, 6856.862862742817, 6893.931060689329, 6931.09895713554, 6975.267596902252, 7006.229314775473, 4971.080350135237, 5138.0, 5277.868053298698, 5331.893362132813, 5362.65142765719, 5253.50091741284, 5343.65266257692, 5345.064613692666, 5358.785648574013, 5449.291592093003], "value": 4415.40206431805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.9344390955944, 318.94896816509356, 319.5286951746175, 320.7321886225002, 323.84455461378536, 5507.953488837118, 5580.944190558103, 5666.20673105765, 5689.857753556158, 5744.79893203738, 5633.746481408336, 5681.545476361892, 5682.346530149034, 5689.288838895138, 5728.885422291552, 4425.645948324134, 4440.600345968862, 4471.83732229621, 4475.149721552911, 4484.394606728099, 4367.563243675623, 4381.277731575768, 4410.867673969786, 4457.777111144446, 4461.486929003174, 4382.5398333175035, 4386.451693538308, 4396.824127034931, 4397.802098905557, 4424.3142312941545, 4411.779411029452, 4430.689851710382, 4437.733735975852, 4453.220686379903, 4460.420145381112, 3738.495303134069, 3847.557530883956, 3923.7449565778134, 3929.489166408377, 3935.527736671589, 5563.499285064323, 5589.329280486327, 5602.635828671123, 5609.2514667812475, 5617.719114044322, 5036.891883785562, 5058.392992840846, 5073.137566613685, 5077.720725360104, 5091.23631455281, 5672.546196304285, 5863.061910094407, 5995.250593675791, 5995.310539287994, 6009.729562169713, 4216.873493795191, 4252.405347994502, 4261.126469073833, 4274.29474136767, 4274.422952901349, 6193.969030154865, 6211.409916057967, 6219.968900155471, 6238.500919926395, 6255.280642726054, 4190.161967606491, 4319.352097185384, 4325.978370108192, 4337.891552711144, 4340.479142502857, 4389.18800021997, 4393.945453091235, 4395.241903238666, 4403.647708183337, 4408.545180090627, 5045.8738531537, 5069.493050694901, 5088.160453525201, 5108.335916330928, 5109.007487080042, 5794.507466865363, 5858.853528661817, 5879.412558609151, 5902.675352855548, 6091.634501929899, 1468.574113507071, 1489.91060536366, 1494.7309484292932, 1496.8623845877212, 1499.5576304990054, 914.4916244643526, 926.2127191886977, 932.2588542109039, 938.6855403439788, 945.4232917920064, 5036.949630503648, 5068.518490743373, 5133.511281728257, 5164.535191832753, 5176.8964620707375, 5366.543843773245, 5436.3476382834315, 5453.863653408617, 5466.644668096561, 5523.613347065747, 4965.453800081988, 4978.825741099116, 5151.780137414116, 5161.845144645667, 5219.582433405319, 2903.332233586287, 2920.0, 2927.0, 2935.706429357047, 2938.7942844000713, 5589.636673616202, 5598.412166722517, 5608.383077861432, 5618.943810561924, 5658.7170641467765, 5369.986255154317, 5452.482014208644, 5629.0, 5629.634073785191, 5642.332483885425, 5495.972520137374, 5499.735060936007, 5565.1095824667855, 5568.276124103922, 5668.48983591487, 5386.892262154656, 5441.564674826083, 5499.780008799603, 5620.747066382104, 5799.246098007232, 6067.180930574493, 6136.23297087864, 6168.414000669929, 6175.876482470415, 6200.472959798468, 6434.260060092962, 6455.419012288917, 6467.902981455188, 6484.1246431733, 6492.383223593751, 4174.5616710244985, 4267.551907049715, 4268.466441694788, 4269.40228368035, 4288.463942007249, 5983.935542237921, 6050.394960503914, 6224.408681175281, 6247.187865577446, 6309.558330916975, 5996.141196229183, 6026.939730602813, 6040.214772079602, 6049.818505444844, 6074.969625152023, 5974.581779275409, 6029.0, 6030.668313242813, 6031.215941927521, 6139.508839292756, 5679.77280908759, 5842.970785146217, 5966.791162309299, 5971.581509488664, 5988.640681559121, 5983.461488466059, 5998.970005149947, 6063.333033366238, 6098.847528811638, 6115.449609535163, 5643.476261409479, 5830.0, 5926.066597034495, 5939.703014849154, 5945.167676525376], "value": 4417.628820191749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.4104096202558, 752.4507109809842, 766.0, 776.8990031295932, 787.063394560473, 14771.113733176016, 16117.919410402947, 16507.58731031725, 16552.420665276717, 16736.581585460368, 15070.321835517429, 15187.0, 15284.847151528482, 16057.357705691758, 16102.275397607107, 797.4378063465258, 805.2712295372668, 809.9878501822477, 810.3962547901792, 810.9472884262534, 791.3036527855479, 791.924767147123, 809.1382677448528, 813.8494378539959, 817.2562967699395, 828.9544075075869, 834.7871292820322, 838.5555655502593, 838.8993320801482, 841.4993079117914, 836.1805430677939, 836.2640876029117, 837.0624900111883, 837.3175861672718, 838.0027766957362, 607.4259824465881, 609.1137395090133, 610.0696437932145, 610.1397030187459, 610.2829175718513, 14444.205568693718, 14518.491852785102, 14576.344064517121, 14596.927015364961, 14626.70746585073, 14525.636859078502, 14626.414943402251, 14766.187859667714, 14920.850791492056, 14980.625484362869, 12366.62900112989, 12397.194182378207, 12654.114212005163, 12666.87333126666, 12782.552610658582, 3894.2990261752875, 3931.253061918226, 4022.818973146186, 4103.2409004333995, 4107.589241075899, 82996.92541127598, 84077.0, 84293.0, 84883.15116848814, 85227.57386213029, 11419.543218271176, 11750.177487575958, 11770.603768340252, 11889.464974076187, 11981.161318707782, 21738.456538586663, 21752.891235544037, 21845.67231491529, 21915.232966846084, 22035.66946495804, 8395.454295470774, 8538.274246689101, 8605.31157507398, 8835.293176545862, 9019.233365163904, 4932.1861892788, 4960.503949605083, 4987.62592805541, 5008.223725322581, 5046.4953504649975, 3641.362761516724, 3763.379042457964, 3770.8868733938025, 3781.0736369589627, 3782.111203867089, 626.7117126121943, 628.6196850905136, 635.1235295292466, 641.3714559731396, 653.6372313366128, 602.6504627316147, 644.8291202831253, 667.3021925643512, 721.3147509865648, 746.2761121711931, 9415.340926135104, 9649.228061755042, 9730.659426920165, 9837.0, 10277.588896444058, 736.5764685305863, 740.4557650127152, 741.9814504637427, 742.8440027594157, 744.1702501710662, 4751.904961900743, 4933.112039832865, 4985.227289770019, 5030.757353124314, 5031.723255220998, 121675.39162304132, 121707.0, 122431.0, 122749.0, 124576.37711811565, 105754.0, 108442.0, 108598.45700771446, 108681.45659271652, 109034.0, 88144.55927720449, 90696.54651726832, 93496.53251733698, 93601.0, 93650.53174734082, 9266.351355405057, 9345.439273643604, 9482.288828337765, 9501.619935202514, 9587.90412095898, 52133.0, 53407.0, 53444.4655553455, 53961.73019134879, 54618.999999998414, 48933.51066489432, 77451.0, 77877.22122778927, 78178.6091069541, 78584.0, 11146.108311335236, 11562.190646654653, 11752.941235293769, 11904.821427678766, 12297.077719170918, 13435.19388836673, 13522.0, 13584.796228056784, 13779.448822047007, 13842.584722458343, 12530.436130374337, 12958.740825183255, 13056.543020994219, 13449.663758406117, 13657.453701851815, 12562.937185314015, 12605.49578016869, 12642.810357844455, 12768.297743624189, 12905.870941290466, 12757.170783899388, 13162.407691653707, 13401.53094641683, 13516.797248041485, 13819.723605528034, 10156.695299141038, 10381.84427233577, 10433.895661043292, 10577.36535807854, 10823.458827058457, 10426.791464170827, 11146.665600032013, 11269.0, 11447.885521145015, 11495.367754773568], "value": 7627.034799381661, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 113.0, 109.0, 111.0, 112.0, 110.0, 110.0, 111.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 152.0, 188.0, 128.0, 160.0, 153.0, 133.0, 201.0, 128.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 160.0, 163.0, 163.0, 170.0, 163.0, 162.0, 161.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 151.0, 77.0, 75.0, 77.0, 76.0, 161.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 147.0, 86.0, 87.0, 85.0, 140.0, 86.0, 85.0, 133.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 148.0, 146.0, 146.0, 149.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 55.0, 55.0, 58.0, 59.0, 55.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 80.0, 82.0, 86.0, 86.0, 87.0, 104.0, 80.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 126.0, 140.0, 131.0, 131.0, 126.0, 137.0, 137.0, 148.0, 128.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 163.0, 158.0, 171.0, 157.0, 162.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 66.0, 65.0, 66.0, 68.0, 62.0, 70.0], "value": 65.3, "unit": "score"}]}]} 04:18:05 INFO - Return code: 0 04:18:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:18:05 ERROR - # TBPL SUCCESS # 04:18:05 INFO - Running post-action listener: _resource_record_post_action 04:18:05 INFO - ##### 04:18:05 INFO - ##### Finished run-tests step (success) 04:18:05 INFO - ##### 04:18:05 INFO - Running post-run listener: _resource_record_post_run 04:18:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 550891520; Read time: 28; Write time: 554936 04:18:05 INFO - TinderboxPrint: CPU usage
13.5% 04:18:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 04:18:05 INFO - TinderboxPrint: I/O write bytes / time
550,891,520 / 554,936 04:18:05 INFO - TinderboxPrint: CPU idle
8,229.0 (86.5%) 04:18:05 INFO - TinderboxPrint: CPU user
1,229.1 (12.9%) 04:18:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:18:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256634880; Read time: 0; Write time: 343796 04:18:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294256640; Read time: 28; Write time: 211140 04:18:05 INFO - Running post-run listener: _upload_blobber_files 04:18:05 INFO - Blob upload gear active. 04:18:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:18:05 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:18:05 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:18:05 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:18:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:06 INFO - (blobuploader) - INFO - Done attempting. 04:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:18:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:07 INFO - (blobuploader) - INFO - Done attempting. 04:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:18:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:13 INFO - (blobuploader) - INFO - Done attempting. 04:18:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:18:13 INFO - Return code: 0 04:18:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:18:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:18:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ffb2139d01996ca403def47a07a57ca5b769172c7d884460010ff0f44d151ba07a98439a2a2057934aa6f29cc3b9a817a78e4e82c9894d1540648b2d88657b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18edbbae6a652860f1f8620fd518523601f77e00156e9bdcb43d147c026dae5817dcd58416efed15449c2fffba8e415d84b762754f5addc0a81635eec3c8e0c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69495227225fc89ee8b7f22e5ec510d99b678feae910463f77bac65e361b58ea3cbc569b75a6b5804990010d1b8710e9c8d0a36f0e46b4d8e4a0c3494b61c3ef"} 04:18:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:18:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:18:13 INFO - Contents: 04:18:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1ffb2139d01996ca403def47a07a57ca5b769172c7d884460010ff0f44d151ba07a98439a2a2057934aa6f29cc3b9a817a78e4e82c9894d1540648b2d88657b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18edbbae6a652860f1f8620fd518523601f77e00156e9bdcb43d147c026dae5817dcd58416efed15449c2fffba8e415d84b762754f5addc0a81635eec3c8e0c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69495227225fc89ee8b7f22e5ec510d99b678feae910463f77bac65e361b58ea3cbc569b75a6b5804990010d1b8710e9c8d0a36f0e46b4d8e4a0c3494b61c3ef"} 04:18:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:18:13 INFO - Copying logs to upload dir... 04:18:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:18:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.947691 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 04:18:13.024339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:18:13.028014) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224 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/1ffb2139d01996ca403def47a07a57ca5b769172c7d884460010ff0f44d151ba07a98439a2a2057934aa6f29cc3b9a817a78e4e82c9894d1540648b2d88657b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18edbbae6a652860f1f8620fd518523601f77e00156e9bdcb43d147c026dae5817dcd58416efed15449c2fffba8e415d84b762754f5addc0a81635eec3c8e0c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69495227225fc89ee8b7f22e5ec510d99b678feae910463f77bac65e361b58ea3cbc569b75a6b5804990010d1b8710e9c8d0a36f0e46b4d8e4a0c3494b61c3ef"} build_url:https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/ff7PF_RvTX60S1gGrtOVcw/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/1ffb2139d01996ca403def47a07a57ca5b769172c7d884460010ff0f44d151ba07a98439a2a2057934aa6f29cc3b9a817a78e4e82c9894d1540648b2d88657b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18edbbae6a652860f1f8620fd518523601f77e00156e9bdcb43d147c026dae5817dcd58416efed15449c2fffba8e415d84b762754f5addc0a81635eec3c8e0c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69495227225fc89ee8b7f22e5ec510d99b678feae910463f77bac65e361b58ea3cbc569b75a6b5804990010d1b8710e9c8d0a36f0e46b4d8e4a0c3494b61c3ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 04:18:13.053336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:18:13.053690) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466506072.947392-1146345224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:18:13.137545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:18:13.137963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 04:18:13.138254) ========= ========= Total master_lag: 0.18 =========