builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1465946305.59 results: success (0) buildid: 20160614133054 builduid: fcd2e73300e84f128b5048584409dabd revision: 248457986c11278a57928e75218f4fce5fc8ac60 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.594595) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.594956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.595240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.620763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.621166) ========= 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=eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 16:18: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% 46.8M=0s 2016-06-14 16:18:26 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.801482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.801809) ========= 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=eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020093 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.852374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:25.852686) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 248457986c11278a57928e75218f4fce5fc8ac60 --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 248457986c11278a57928e75218f4fce5fc8ac60 --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=eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 16:18:26,285 truncating revision to first 12 chars 2016-06-14 16:18:26,285 Setting DEBUG logging. 2016-06-14 16:18:26,285 attempt 1/10 2016-06-14 16:18:26,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/248457986c11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 16:18:26,596 unpacking tar archive at: mozilla-inbound-248457986c11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:26.513097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:26.513363) ========= script_repo_revision: 248457986c11278a57928e75218f4fce5fc8ac60 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:26.513738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:26.514003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 16:18:26.526291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-14 16:18:26.526568) ========= /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=eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:18:27 INFO - MultiFileLogger online at 20160614 16:18:27 in /builds/slave/test 16:18:27 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 16:18:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:27 INFO - {'append_to_log': False, 16:18:27 INFO - 'base_work_dir': '/builds/slave/test', 16:18:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:18:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:27 INFO - 'branch': 'Mozilla-Inbound', 16:18:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:27 INFO - 'config_files': ('talos/linux_config.py',), 16:18:27 INFO - 'default_actions': ('clobber', 16:18:27 INFO - 'read-buildbot-config', 16:18:27 INFO - 'download-and-extract', 16:18:27 INFO - 'populate-webroot', 16:18:27 INFO - 'create-virtualenv', 16:18:27 INFO - 'install', 16:18:27 INFO - 'run-tests'), 16:18:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:27 INFO - 'download_minidump_stackwalk': True, 16:18:27 INFO - 'download_symbols': 'ondemand', 16:18:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:27 INFO - 'installer_path': 'installer.exe', 16:18:27 INFO - 'log_level': 'info', 16:18:27 INFO - 'log_name': 'talos', 16:18:27 INFO - 'log_to_console': True, 16:18:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:18:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:18:27 INFO - 'opt_config_files': (), 16:18:27 INFO - 'pip_index': False, 16:18:27 INFO - 'sps_profile': False, 16:18:27 INFO - 'sps_profile_interval': 0, 16:18:27 INFO - 'suite': 'dromaeojs-e10s', 16:18:27 INFO - 'system_bits': '32', 16:18:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:27 INFO - 'title': 'talos-linux64-ix-010', 16:18:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:27 INFO - 'use_talos_json': True, 16:18:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:27 INFO - 'work_dir': 'build'} 16:18:27 INFO - ##### 16:18:27 INFO - ##### Running clobber step. 16:18:27 INFO - ##### 16:18:27 INFO - Running pre-action listener: _resource_record_pre_action 16:18:27 INFO - Running main action method: clobber 16:18:27 INFO - rmtree: /builds/slave/test/build 16:18:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:27 INFO - Running post-action listener: _resource_record_post_action 16:18:27 INFO - ##### 16:18:27 INFO - ##### Finished clobber step (success) 16:18:27 INFO - ##### 16:18:27 INFO - ##### 16:18:27 INFO - ##### Running read-buildbot-config step. 16:18:27 INFO - ##### 16:18:27 INFO - Running pre-action listener: _resource_record_pre_action 16:18:27 INFO - Running main action method: read_buildbot_config 16:18:27 INFO - Using buildbot properties: 16:18:27 INFO - { 16:18:27 INFO - "project": "", 16:18:27 INFO - "product": "firefox", 16:18:27 INFO - "script_repo_revision": "production", 16:18:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:18:27 INFO - "repository": "", 16:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:18:27 INFO - "buildid": "20160614133054", 16:18:27 INFO - "pgo_build": "True", 16:18:27 INFO - "basedir": "/builds/slave/test", 16:18:27 INFO - "buildnumber": 703, 16:18:27 INFO - "slavename": "talos-linux64-ix-010", 16:18:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:18:27 INFO - "platform": "ubuntu64_hw", 16:18:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:18:27 INFO - "branch": "mozilla-inbound", 16:18:27 INFO - "repo_path": "integration/mozilla-inbound", 16:18:27 INFO - "revision": "248457986c11278a57928e75218f4fce5fc8ac60", 16:18:27 INFO - "stage_platform": "linux64-pgo", 16:18:27 INFO - "builduid": "fcd2e73300e84f128b5048584409dabd", 16:18:27 INFO - "slavebuilddir": "test" 16:18:27 INFO - } 16:18:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:18:27 INFO - Running post-action listener: _resource_record_post_action 16:18:27 INFO - ##### 16:18:27 INFO - ##### Finished read-buildbot-config step (success) 16:18:27 INFO - ##### 16:18:27 INFO - ##### 16:18:27 INFO - ##### Running download-and-extract step. 16:18:27 INFO - ##### 16:18:27 INFO - Running pre-action listener: _resource_record_pre_action 16:18:27 INFO - Running main action method: download_and_extract 16:18:27 INFO - mkdir: /builds/slave/test/build/tests 16:18:27 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')]} 16:18:27 INFO - https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:36 INFO - Downloaded 1361 bytes. 16:18:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:18:36 INFO - Using the following test package requirements: 16:18:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:18:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:18:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'jsshell-linux-x86_64.zip'], 16:18:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:18:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:18:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:18:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:18:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:18:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:18:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:18:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:18:36 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')]} 16:18:36 INFO - https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:18:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:18:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:18:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:39 INFO - Downloaded 24220706 bytes. 16:18:39 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'] 16:18:39 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 16:18:40 INFO - Return code: 0 16:18:40 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 16:18:40 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')]} 16:18:40 INFO - https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:46 INFO - Downloaded 24220706 bytes. 16:18:46 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'] 16:18:46 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 16:18:48 INFO - Return code: 0 16:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:48 INFO - https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:18:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:18:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:18:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:49 INFO - Downloaded 14405384 bytes. 16:18:49 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'] 16:18:49 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 16:18:49 INFO - Return code: 0 16:18:49 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')]} 16:18:49 INFO - https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:18:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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 16:18:56 INFO - Downloaded 59386674 bytes. 16:18:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:56 INFO - mkdir: /builds/slave/test/properties 16:18:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:56 INFO - Contents: 16:18:56 INFO - build_url:https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:57 INFO - Running post-action listener: _resource_record_post_action 16:18:57 INFO - Running post-action listener: set_extra_try_arguments 16:18:57 INFO - ##### 16:18:57 INFO - ##### Finished download-and-extract step (success) 16:18:57 INFO - ##### 16:18:57 INFO - ##### 16:18:57 INFO - ##### Running populate-webroot step. 16:18:57 INFO - ##### 16:18:57 INFO - Running pre-action listener: _resource_record_pre_action 16:18:57 INFO - Running main action method: populate_webroot 16:18:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:57 INFO - '--tppagecycles', 16:18:57 INFO - '7'], 16:18:57 INFO - 'tests': ['tsvgm']}}, 16:18:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['damp', 'tps']}, 16:18:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'tests': ['damp', 'tps']}, 16:18:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['dromaeo_dom']}, 16:18:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['basic_compositor_video']}, 16:18:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:18:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['tsvgx', 16:18:57 INFO - 'tsvgr_opacity', 16:18:57 INFO - 'tart', 16:18:57 INFO - 'tscrollx', 16:18:57 INFO - 'cart']}, 16:18:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:57 INFO - 'tsvgr_opacity', 16:18:57 INFO - 'tart', 16:18:57 INFO - 'tscrollx', 16:18:57 INFO - 'cart']}, 16:18:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--disable-e10s'], 16:18:57 INFO - 'tests': ['tp5o']}, 16:18:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'tests': ['tp5o']}, 16:18:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--disable-e10s', 16:18:57 INFO - '--xperf_path', 16:18:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:57 INFO - 'tests': ['tp5n']}, 16:18:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--xperf_path', 16:18:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:57 INFO - 'tests': ['tp5n']}}, 16:18:57 INFO - 'talos.zip': {'path': '', 16:18:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:57 INFO - Running post-action listener: _resource_record_post_action 16:18:57 INFO - ##### 16:18:57 INFO - ##### Finished populate-webroot step (success) 16:18:57 INFO - ##### 16:18:57 INFO - ##### 16:18:57 INFO - ##### Running create-virtualenv step. 16:18:57 INFO - ##### 16:18:57 INFO - Running pre-action listener: _resource_record_pre_action 16:18:57 INFO - Running main action method: create_virtualenv 16:18:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:57 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 16:18:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:57 INFO - Using real prefix '/usr' 16:18:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:59 INFO - Installing pip.................done. 16:18:59 INFO - Return code: 0 16:18:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:59 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')]} 16:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:59 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')]} 16:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:59 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:18:59 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 16:18:59 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 16:18:59 INFO - Using env: {'DISPLAY': ':0', 16:18:59 INFO - 'HOME': '/home/cltbld', 16:18:59 INFO - 'LANG': 'en_US.UTF-8', 16:18:59 INFO - 'LANGUAGE': 'en_US:en', 16:18:59 INFO - 'LOGNAME': 'cltbld', 16:18:59 INFO - 'MAIL': '/var/mail/cltbld', 16:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:59 INFO - 'MOZ_NO_REMOTE': '1', 16:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:59 INFO - 'NO_EM_RESTART': '1', 16:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:59 INFO - 'PWD': '/builds/slave/test', 16:18:59 INFO - 'SHELL': '/bin/bash', 16:18:59 INFO - 'SHLVL': '1', 16:18:59 INFO - 'TERM': 'linux', 16:18:59 INFO - 'TMOUT': '86400', 16:18:59 INFO - 'USER': 'cltbld', 16:18:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:59 INFO - '_': '/tools/buildbot/bin/python'} 16:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:59 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 16:18:59 INFO - Cleaning up... 16:18:59 INFO - Return code: 0 16:18:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:18:59 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')]} 16:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:59 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')]} 16:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:59 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:18:59 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 16:18:59 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 16:18:59 INFO - Using env: {'DISPLAY': ':0', 16:18:59 INFO - 'HOME': '/home/cltbld', 16:18:59 INFO - 'LANG': 'en_US.UTF-8', 16:18:59 INFO - 'LANGUAGE': 'en_US:en', 16:18:59 INFO - 'LOGNAME': 'cltbld', 16:18:59 INFO - 'MAIL': '/var/mail/cltbld', 16:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:59 INFO - 'MOZ_NO_REMOTE': '1', 16:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:59 INFO - 'NO_EM_RESTART': '1', 16:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:59 INFO - 'PWD': '/builds/slave/test', 16:18:59 INFO - 'SHELL': '/bin/bash', 16:18:59 INFO - 'SHLVL': '1', 16:18:59 INFO - 'TERM': 'linux', 16:18:59 INFO - 'TMOUT': '86400', 16:18:59 INFO - 'USER': 'cltbld', 16:18:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:59 INFO - '_': '/tools/buildbot/bin/python'} 16:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:00 INFO - Downloading/unpacking psutil>=3.1.1 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:02 INFO - Installing collected packages: psutil 16:19:02 INFO - Running setup.py install for psutil 16:19:02 INFO - building 'psutil._psutil_linux' extension 16:19:02 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 16:19:02 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 16:19:02 INFO - building 'psutil._psutil_posix' extension 16:19:02 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 16:19:02 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 16:19:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:02 INFO - Successfully installed psutil 16:19:02 INFO - Cleaning up... 16:19:02 INFO - Return code: 0 16:19:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:02 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:02 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 16:19:02 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 16:19:02 INFO - Using env: {'DISPLAY': ':0', 16:19:02 INFO - 'HOME': '/home/cltbld', 16:19:02 INFO - 'LANG': 'en_US.UTF-8', 16:19:02 INFO - 'LANGUAGE': 'en_US:en', 16:19:02 INFO - 'LOGNAME': 'cltbld', 16:19:02 INFO - 'MAIL': '/var/mail/cltbld', 16:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:02 INFO - 'MOZ_NO_REMOTE': '1', 16:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:02 INFO - 'NO_EM_RESTART': '1', 16:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:02 INFO - 'PWD': '/builds/slave/test', 16:19:02 INFO - 'SHELL': '/bin/bash', 16:19:02 INFO - 'SHLVL': '1', 16:19:02 INFO - 'TERM': 'linux', 16:19:02 INFO - 'TMOUT': '86400', 16:19:02 INFO - 'USER': 'cltbld', 16:19:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:02 INFO - '_': '/tools/buildbot/bin/python'} 16:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:19:02 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 16:19:02 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 16:19:02 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 16:19:02 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 16:19:02 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 16:19:02 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 16:19:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:19:04 INFO - Installing collected packages: mozsystemmonitor 16:19:04 INFO - Running setup.py install for mozsystemmonitor 16:19:04 INFO - Successfully installed mozsystemmonitor 16:19:04 INFO - Cleaning up... 16:19:04 INFO - Return code: 0 16:19:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19: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')]} 16:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:04 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:04 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 16:19:04 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 16:19:04 INFO - Using env: {'DISPLAY': ':0', 16:19:04 INFO - 'HOME': '/home/cltbld', 16:19:04 INFO - 'LANG': 'en_US.UTF-8', 16:19:04 INFO - 'LANGUAGE': 'en_US:en', 16:19:04 INFO - 'LOGNAME': 'cltbld', 16:19:04 INFO - 'MAIL': '/var/mail/cltbld', 16:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:04 INFO - 'MOZ_NO_REMOTE': '1', 16:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:04 INFO - 'NO_EM_RESTART': '1', 16:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:04 INFO - 'PWD': '/builds/slave/test', 16:19:04 INFO - 'SHELL': '/bin/bash', 16:19:04 INFO - 'SHLVL': '1', 16:19:04 INFO - 'TERM': 'linux', 16:19:04 INFO - 'TMOUT': '86400', 16:19:04 INFO - 'USER': 'cltbld', 16:19:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:04 INFO - '_': '/tools/buildbot/bin/python'} 16:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:05 INFO - Downloading/unpacking jsonschema==2.5.1 16:19:05 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 16:19:05 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 16:19:05 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 16:19:05 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 16:19:05 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 16:19:05 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 16:19:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:07 INFO - warning: no files found matching '*.txt' 16:19:07 INFO - no previously-included directories found matching 'build' 16:19:07 INFO - no previously-included directories found matching 'dist' 16:19:07 INFO - no previously-included directories found matching '.git*' 16:19:07 INFO - Installing collected packages: jsonschema, functools32 16:19:07 INFO - Running setup.py install for functools32 16:19:07 INFO - warning: no files found matching '*.txt' 16:19:07 INFO - no previously-included directories found matching 'build' 16:19:07 INFO - no previously-included directories found matching 'dist' 16:19:07 INFO - no previously-included directories found matching '.git*' 16:19:07 INFO - Successfully installed jsonschema functools32 16:19:07 INFO - Cleaning up... 16:19:07 INFO - Return code: 0 16:19:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:07 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:07 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 16:19:07 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 16:19:07 INFO - Using env: {'DISPLAY': ':0', 16:19:07 INFO - 'HOME': '/home/cltbld', 16:19:07 INFO - 'LANG': 'en_US.UTF-8', 16:19:07 INFO - 'LANGUAGE': 'en_US:en', 16:19:07 INFO - 'LOGNAME': 'cltbld', 16:19:07 INFO - 'MAIL': '/var/mail/cltbld', 16:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:07 INFO - 'MOZ_NO_REMOTE': '1', 16:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:07 INFO - 'NO_EM_RESTART': '1', 16:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:07 INFO - 'PWD': '/builds/slave/test', 16:19:07 INFO - 'SHELL': '/bin/bash', 16:19:07 INFO - 'SHLVL': '1', 16:19:07 INFO - 'TERM': 'linux', 16:19:07 INFO - 'TMOUT': '86400', 16:19:07 INFO - 'USER': 'cltbld', 16:19:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:07 INFO - '_': '/tools/buildbot/bin/python'} 16:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 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 16:19:07 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 16:19:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:10 INFO - Downloading docopt-0.6.1.tar.gz 16:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:10 INFO - Running setup.py install for blobuploader 16:19:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:10 INFO - Running setup.py install for requests 16:19:10 INFO - Running setup.py install for docopt 16:19:10 INFO - Successfully installed blobuploader requests docopt 16:19:10 INFO - Cleaning up... 16:19:10 INFO - Return code: 0 16:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:10 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')]} 16:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:10 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')]} 16:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:10 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:10 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 16:19:10 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 16:19:10 INFO - Using env: {'DISPLAY': ':0', 16:19:10 INFO - 'HOME': '/home/cltbld', 16:19:10 INFO - 'LANG': 'en_US.UTF-8', 16:19:10 INFO - 'LANGUAGE': 'en_US:en', 16:19:10 INFO - 'LOGNAME': 'cltbld', 16:19:10 INFO - 'MAIL': '/var/mail/cltbld', 16:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:10 INFO - 'MOZ_NO_REMOTE': '1', 16:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:10 INFO - 'NO_EM_RESTART': '1', 16:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:10 INFO - 'PWD': '/builds/slave/test', 16:19:10 INFO - 'SHELL': '/bin/bash', 16:19:10 INFO - 'SHLVL': '1', 16:19:10 INFO - 'TERM': 'linux', 16:19:10 INFO - 'TMOUT': '86400', 16:19:10 INFO - 'USER': 'cltbld', 16:19:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:10 INFO - '_': '/tools/buildbot/bin/python'} 16:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:11 INFO - Running setup.py (path:/tmp/pip-5rERKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:11 INFO - Running setup.py (path:/tmp/pip-gUOXK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:11 INFO - Running setup.py (path:/tmp/pip-J0Hleu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:11 INFO - Running setup.py (path:/tmp/pip-XVIwOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:11 INFO - Running setup.py (path:/tmp/pip-PpOzAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:11 INFO - Running setup.py (path:/tmp/pip-IXORkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:11 INFO - Running setup.py (path:/tmp/pip-d0Wllu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:11 INFO - Running setup.py (path:/tmp/pip-a9Af7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:11 INFO - Running setup.py (path:/tmp/pip-7NXYnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:11 INFO - Running setup.py (path:/tmp/pip-rQxdVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:11 INFO - Running setup.py (path:/tmp/pip-RisX4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:11 INFO - Running setup.py (path:/tmp/pip-U0NwMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:11 INFO - Running setup.py (path:/tmp/pip-uwemMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:12 INFO - Running setup.py (path:/tmp/pip-LJljAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:12 INFO - Running setup.py (path:/tmp/pip-fevR06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:12 INFO - Running setup.py (path:/tmp/pip-EJ5fHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:12 INFO - Running setup.py (path:/tmp/pip-V8LOtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:12 INFO - Running setup.py install for manifestparser 16:19:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozcrash 16:19:12 INFO - Running setup.py install for mozdebug 16:19:12 INFO - Running setup.py install for mozdevice 16:19:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozfile 16:19:12 INFO - Running setup.py install for mozhttpd 16:19:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozinfo 16:19:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozInstall 16:19:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozleak 16:19:13 INFO - Running setup.py install for mozlog 16:19:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for moznetwork 16:19:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozprocess 16:19:13 INFO - Running setup.py install for mozprofile 16:19:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozrunner 16:19:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozscreenshot 16:19:13 INFO - Running setup.py install for moztest 16:19:13 INFO - Running setup.py install for mozversion 16:19:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:14 INFO - Cleaning up... 16:19:14 INFO - Return code: 0 16:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:14 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')]} 16:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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')]} 16:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:14 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 16:19:14 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 16:19:14 INFO - Using env: {'DISPLAY': ':0', 16:19:14 INFO - 'HOME': '/home/cltbld', 16:19:14 INFO - 'LANG': 'en_US.UTF-8', 16:19:14 INFO - 'LANGUAGE': 'en_US:en', 16:19:14 INFO - 'LOGNAME': 'cltbld', 16:19:14 INFO - 'MAIL': '/var/mail/cltbld', 16:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:14 INFO - 'MOZ_NO_REMOTE': '1', 16:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:14 INFO - 'NO_EM_RESTART': '1', 16:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:14 INFO - 'PWD': '/builds/slave/test', 16:19:14 INFO - 'SHELL': '/bin/bash', 16:19:14 INFO - 'SHLVL': '1', 16:19:14 INFO - 'TERM': 'linux', 16:19:14 INFO - 'TMOUT': '86400', 16:19:14 INFO - 'USER': 'cltbld', 16:19:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:14 INFO - '_': '/tools/buildbot/bin/python'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 INFO - Running setup.py (path:/tmp/pip-tCHqoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Running setup.py (path:/tmp/pip-X2k8VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 INFO - Running setup.py (path:/tmp/pip-EMIxTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 INFO - Running setup.py (path:/tmp/pip-froOr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:14 INFO - Running setup.py (path:/tmp/pip-y8U9SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 INFO - Running setup.py (path:/tmp/pip-0T_Z3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:14 INFO - Running setup.py (path:/tmp/pip-aQi3e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:14 INFO - Running setup.py (path:/tmp/pip-1MGChz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:14 INFO - Running setup.py (path:/tmp/pip-IT455B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:14 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)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:14 INFO - Running setup.py (path:/tmp/pip-Tb129B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 INFO - Running setup.py (path:/tmp/pip-PF0pR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Running setup.py (path:/tmp/pip-jCL68A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 INFO - Running setup.py (path:/tmp/pip-lCrtHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Running setup.py (path:/tmp/pip-denNfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 INFO - Running setup.py (path:/tmp/pip-n3ZObE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:15 INFO - Running setup.py (path:/tmp/pip-zi4AJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:15 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)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:15 INFO - Running setup.py (path:/tmp/pip-QS_3NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:15 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)) 16:19:15 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)) 16:19:15 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)) 16:19:15 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)) 16:19:15 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)) 16:19:15 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)) 16:19:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:17 INFO - Downloading blessings-1.6.tar.gz 16:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:17 INFO - Installing collected packages: blessings 16:19:17 INFO - Running setup.py install for blessings 16:19:17 INFO - Successfully installed blessings 16:19:17 INFO - Cleaning up... 16:19:17 INFO - Return code: 0 16:19:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:17 INFO - Reading from file tmpfile_stdout 16:19:17 INFO - Current package versions: 16:19:17 INFO - argparse == 1.2.1 16:19:17 INFO - blessings == 1.6 16:19:17 INFO - blobuploader == 1.2.4 16:19:17 INFO - docopt == 0.6.1 16:19:17 INFO - functools32 == 3.2.3-2 16:19:17 INFO - jsonschema == 2.5.1 16:19:17 INFO - manifestparser == 1.1 16:19:17 INFO - mozInstall == 1.12 16:19:17 INFO - mozcrash == 0.17 16:19:17 INFO - mozdebug == 0.1 16:19:17 INFO - mozdevice == 0.48 16:19:17 INFO - mozfile == 1.2 16:19:17 INFO - mozhttpd == 0.7 16:19:17 INFO - mozinfo == 0.9 16:19:17 INFO - mozleak == 0.1 16:19:17 INFO - mozlog == 3.2 16:19:17 INFO - moznetwork == 0.27 16:19:17 INFO - mozprocess == 0.22 16:19:17 INFO - mozprofile == 0.28 16:19:17 INFO - mozrunner == 6.11 16:19:17 INFO - mozscreenshot == 0.1 16:19:17 INFO - mozsystemmonitor == 0.3 16:19:17 INFO - moztest == 0.7 16:19:17 INFO - mozversion == 1.4 16:19:17 INFO - psutil == 3.1.1 16:19:17 INFO - requests == 1.2.3 16:19:17 INFO - wsgiref == 0.1.2 16:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:17 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 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:17 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 16:19:17 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 16:19:17 INFO - Using env: {'DISPLAY': ':0', 16:19:17 INFO - 'HOME': '/home/cltbld', 16:19:17 INFO - 'LANG': 'en_US.UTF-8', 16:19:17 INFO - 'LANGUAGE': 'en_US:en', 16:19:17 INFO - 'LOGNAME': 'cltbld', 16:19:17 INFO - 'MAIL': '/var/mail/cltbld', 16:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:17 INFO - 'MOZ_NO_REMOTE': '1', 16:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:17 INFO - 'NO_EM_RESTART': '1', 16:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:17 INFO - 'PWD': '/builds/slave/test', 16:19:17 INFO - 'SHELL': '/bin/bash', 16:19:17 INFO - 'SHLVL': '1', 16:19:17 INFO - 'TERM': 'linux', 16:19:17 INFO - 'TMOUT': '86400', 16:19:17 INFO - 'USER': 'cltbld', 16:19:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:17 INFO - '_': '/tools/buildbot/bin/python'} 16:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 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)) 16:19:18 INFO - Cleaning up... 16:19:18 INFO - Return code: 0 16:19:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:19:18 INFO - Using env: {'DISPLAY': ':0', 16:19:18 INFO - 'HOME': '/home/cltbld', 16:19:18 INFO - 'LANG': 'en_US.UTF-8', 16:19:18 INFO - 'LANGUAGE': 'en_US:en', 16:19:18 INFO - 'LOGNAME': 'cltbld', 16:19:18 INFO - 'MAIL': '/var/mail/cltbld', 16:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:18 INFO - 'MOZ_NO_REMOTE': '1', 16:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:18 INFO - 'NO_EM_RESTART': '1', 16:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:18 INFO - 'PWD': '/builds/slave/test', 16:19:18 INFO - 'SHELL': '/bin/bash', 16:19:18 INFO - 'SHLVL': '1', 16:19:18 INFO - 'TERM': 'linux', 16:19:18 INFO - 'TMOUT': '86400', 16:19:18 INFO - 'USER': 'cltbld', 16:19:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:18 INFO - '_': '/tools/buildbot/bin/python'} 16:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:19:18 INFO - Cleaning up... 16:19:18 INFO - Return code: 0 16:19:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe07f1d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f08020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', '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 16:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:19:18 INFO - Using env: {'DISPLAY': ':0', 16:19:18 INFO - 'HOME': '/home/cltbld', 16:19:18 INFO - 'LANG': 'en_US.UTF-8', 16:19:18 INFO - 'LANGUAGE': 'en_US:en', 16:19:18 INFO - 'LOGNAME': 'cltbld', 16:19:18 INFO - 'MAIL': '/var/mail/cltbld', 16:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:18 INFO - 'MOZ_NO_REMOTE': '1', 16:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:18 INFO - 'NO_EM_RESTART': '1', 16:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:18 INFO - 'PWD': '/builds/slave/test', 16:19:18 INFO - 'SHELL': '/bin/bash', 16:19:18 INFO - 'SHLVL': '1', 16:19:18 INFO - 'TERM': 'linux', 16:19:18 INFO - 'TMOUT': '86400', 16:19:18 INFO - 'USER': 'cltbld', 16:19:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:18 INFO - '_': '/tools/buildbot/bin/python'} 16:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:18 INFO - Downloading/unpacking flake8 16:19:18 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 16:19:18 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 16:19:18 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 16:19:18 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 16:19:18 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 16:19:18 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 16:19:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:19:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:19:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:21 INFO - no previously-included directories found matching 'docs/_build' 16:19:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:19:21 INFO - Running setup.py install for pep8 16:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:21 INFO - no previously-included directories found matching 'docs/_build' 16:19:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:19:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:19:21 INFO - Cleaning up... 16:19:22 INFO - Return code: 0 16:19:22 INFO - Running post-action listener: _resource_record_post_action 16:19:22 INFO - Running post-action listener: _start_resource_monitoring 16:19:22 INFO - Starting resource monitoring. 16:19:22 INFO - ##### 16:19:22 INFO - ##### Finished create-virtualenv step (success) 16:19:22 INFO - ##### 16:19:22 INFO - ##### 16:19:22 INFO - ##### Running install step. 16:19:22 INFO - ##### 16:19:22 INFO - Running pre-action listener: _resource_record_pre_action 16:19:22 INFO - Running main action method: install 16:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:22 INFO - Reading from file tmpfile_stdout 16:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:22 INFO - Reading from file tmpfile_stdout 16:19:22 INFO - Output received: 16:19:22 INFO - Usage: mozinstall [options] installer 16:19:22 INFO - Options: 16:19:22 INFO - -h, --help show this help message and exit 16:19:22 INFO - -d DEST, --destination=DEST 16:19:22 INFO - Directory to install application into. [default: 16:19:22 INFO - "/builds/slave/test"] 16:19:22 INFO - --app=APP Application being installed. [default: firefox] 16:19:22 INFO - mkdir: /builds/slave/test/build/application 16:19:23 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'] 16:19:23 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 16:19:40 INFO - Reading from file tmpfile_stdout 16:19:40 INFO - Output received: 16:19:40 INFO - /builds/slave/test/build/application/firefox/firefox 16:19:40 INFO - Running post-action listener: _resource_record_post_action 16:19:40 INFO - ##### 16:19:40 INFO - ##### Finished install step (success) 16:19:40 INFO - ##### 16:19:40 INFO - ##### 16:19:40 INFO - ##### Running run-tests step. 16:19:40 INFO - ##### 16:19:40 INFO - Running pre-action listener: _resource_record_pre_action 16:19:40 INFO - Running main action method: run_tests 16:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:40 INFO - Python 2.7.3 16:19:40 INFO - Return code: 0 16:19:40 INFO - grabbing minidump binary from tooltool 16:19:40 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')]} 16:19:40 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 0x1f9a2e0>, '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 0x1f06140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f065d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:40 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 16:19:40 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 16:19:40 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 16:19:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:40 INFO - Return code: 0 16:19:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:19:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:19:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:19:41 INFO - Return code: 0 16:19:41 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/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 16:19:41 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/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 16:19:41 INFO - Using env: {'DISPLAY': ':0', 16:19:41 INFO - 'HOME': '/home/cltbld', 16:19:41 INFO - 'LANG': 'en_US.UTF-8', 16:19:41 INFO - 'LANGUAGE': 'en_US:en', 16:19:41 INFO - 'LOGNAME': 'cltbld', 16:19:41 INFO - 'MAIL': '/var/mail/cltbld', 16:19:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:41 INFO - 'MOZ_NO_REMOTE': '1', 16:19:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:41 INFO - 'NO_EM_RESTART': '1', 16:19:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:41 INFO - 'PWD': '/builds/slave/test', 16:19:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:41 INFO - 'SHELL': '/bin/bash', 16:19:41 INFO - 'SHLVL': '1', 16:19:41 INFO - 'TERM': 'linux', 16:19:41 INFO - 'TMOUT': '86400', 16:19:41 INFO - 'USER': 'cltbld', 16:19:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353', 16:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:41 INFO - '_': '/tools/buildbot/bin/python'} 16:19:41 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/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 16:19:41 INFO - mozversion application_buildid: 20160614133054 16:19:41 INFO - mozversion application_changeset: 248457986c11278a57928e75218f4fce5fc8ac60 16:19:41 INFO - mozversion application_display_name: Nightly 16:19:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:41 INFO - mozversion application_name: Firefox 16:19:41 INFO - mozversion application_remotingname: firefox 16:19:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:19:41 INFO - mozversion application_vendor: Mozilla 16:19:41 INFO - mozversion application_version: 50.0a1 16:19:41 INFO - mozversion platform_buildid: 20160614133054 16:19:41 INFO - mozversion platform_changeset: 248457986c11278a57928e75218f4fce5fc8ac60 16:19:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:19:41 INFO - mozversion platform_version: 50.0a1 16:19:41 INFO - using testdate: 1465946381 16:19:41 INFO - actual date: 1465946381 16:19:41 INFO - starting webserver on 'localhost:34366' 16:19:41 INFO - SUITE-START | Running 2 tests 16:19:41 INFO - TEST-START | dromaeo_css 16:19:41 INFO - operating with platform_type : linux_ 16:19:41 INFO - Initialising browser for dromaeo_css test... 16:19:41 INFO - TEST-INFO | started process 17764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Yawqf/profile http://localhost:34366/getInfo.html) 16:19:47 INFO - PROCESS | 17764 | __metrics Screen width/height:1600/1200 16:19:47 INFO - PROCESS | 17764 | colorDepth:24 16:19:47 INFO - PROCESS | 17764 | Browser inner width/height: 1024/697 16:19:47 INFO - PROCESS | 17764 | __metrics 16:19:48 ERROR - PROCESS | 17764 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:19:48 INFO - TEST-INFO | 17764: exit 0 16:19:48 INFO - Browser initialized. 16:19:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:19:48 INFO - TEST-INFO | started process 17883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Yawqf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:00 INFO - PROCESS | 17883 | RSS: Main: 184791040 16:20:00 INFO - PROCESS | 17883 | 16:20:50 INFO - PROCESS | 17883 | 1465946450562 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] 16:22:58 INFO - PROCESS | 17883 | Cycle 1(1): loaded http://localhost:34366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34366/tests/dromaeo/cssquery-ext.html) 16:22:59 INFO - PROCESS | 17883 | RSS: Main: 188481536 16:22:59 INFO - PROCESS | 17883 | 16:26:01 INFO - PROCESS | 17883 | Cycle 1(1): loaded http://localhost:34366/tests/dromaeo/cssquery-ext.html (next: http://localhost:34366/tests/dromaeo/cssquery-jquery.html) 16:26:02 INFO - PROCESS | 17883 | RSS: Main: 187019264 16:26:02 INFO - PROCESS | 17883 | 16:29:04 INFO - PROCESS | 17883 | Cycle 1(1): loaded http://localhost:34366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34366/tests/dromaeo/cssquery-mootools.html) 16:29:04 INFO - PROCESS | 17883 | RSS: Main: 188534784 16:29:04 INFO - PROCESS | 17883 | 16:32:06 INFO - PROCESS | 17883 | Cycle 1(1): loaded http://localhost:34366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34366/tests/dromaeo/cssquery-prototype.html) 16:32:07 INFO - PROCESS | 17883 | RSS: Main: 186515456 16:32:07 INFO - PROCESS | 17883 | 16:35:09 INFO - PROCESS | 17883 | Cycle 1(1): loaded http://localhost:34366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34366/tests/dromaeo/cssquery-yui.html) 16:35:10 INFO - PROCESS | 17883 | RSS: Main: 188469248 16:35:10 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | Cycle 1(1): loaded http://localhost:34366/tests/dromaeo/cssquery-yui.html (next: http://localhost:34366/tests/dromaeo/cssquery-dojo.html) 16:38:12 INFO - PROCESS | 17883 | RSS: Main: 188964864 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | __start_tp_report 16:38:12 INFO - PROCESS | 17883 | _x_x_mozilla_page_load 16:38:12 INFO - PROCESS | 17883 | _x_x_mozilla_page_load_details 16:38:12 INFO - PROCESS | 17883 | |i|pagename|runs| 16:38:12 INFO - PROCESS | 17883 | |0;dojo.html;3105.254738862673;3158.573592565003;3181.7454603631704;3189.553462515247;3193.121891479843;5432.483914028166;5449.373322067963;5494.972525137374;5524.640898341615;5530.6128571000045;5325.573954083674;5465.262189604402;5485.533729632986;5559.972200138994;5637.689927054011;4857.635677324206;4870.58600018997;4895.779689913962;5032.245163225509;5032.345795046639;4930.80276788928;5091.083604951107;5122.871928201787;5123.795048198068;5134.768935397916;4895.216765317532;4901.191303434929;4932.358793356859;4966.826161084363;5046.82336118236;4930.778114984834;4937.333459982892;4946.035523073002;4954.3063971044085;4956.677815941988;4882.780274887638;4894.755262236874;4897.559219670211;4932.506749325074;4954.653174277802;5340.439253878326;5406.972965135188;5481.451854814487;5504.752286147133;5523.585731070146;5863.941360586425;5891.086881533369;5900.114982752579;5904.409559044104;5907.763689452417;5943.494802941756;5959.314678811948;5960.105984102376;5960.284765828085;5963.46328830403;5347.171188465794;5445.754941027623;5460.426655201226;5514.6139770216105;5518.310211223597;5937.465628093406;5954.10688396744;5955.940440595538;5983.970080149571;6030.095485677183;5530.170474428787;5756.798512052058;5757.827265182052;5763.711814409263;5767.134929760486;5778.27771528559;5809.970950145223;5853;5883.529317654577;5914.201582786355;5595.832125036255;5736.082226843685;5848.88302233953;5857.150713146655;5857.209276747584;5629.240052592848;5797.826065218051;5840.503557197686;5851.619644723164;5859.267591551056;4394.099209662011;4438.1567502174485;4449.466064072268;4453.710508816916;4454.57681520255;3968.6031396860085;3981.3231750602467;3986;3986.720929534905;4018.176273863851;5544.085225937675;5544.750486228129;5545.140503222007;5564.221009058735;5600.943990560124;5854.385289544622;5856.238688970407;5880.705964701748;5916.171735956969;5949.405059494016;5577.414371491016;5593.161025846074;5596.524295434852;5597.496225339739;5618.297712785902;4882;5004.223500657287;5013.348264725635;5039.395272567315;5052.873678158002;6011.939880601226;6049.879002419927;6059.151718759377;6062.42406971337;6084.11780291864;5865.794697185664;5889.322727886177;5892.9116063258225;5901.557383196192;5905.970470147622;5883.911741323798;5931.13998470228;5974.701264936823;5994.160817485643;6015.939840601538;5681.204631351531;5687.431256874445;5692.6299790513485;5697.772089116389;5698.54411647059;5608.355039170548;5781.739821707949;5800.7099645018425;5803.65178089316;5813.418658134153;5715.457031581993;5742.0812669974275;5769.596128271149;5770.990076736471;5777.94222057774;5506.1190209566275;5630.493255607015;5658.179563963285;5661.801836935688;5695.458931401676;5642.435756424325;5669.829905102853;5679.659220446786;5685;5697.515711164431;5541.778328866801;5590.133529302964;5609.691466969356;5656.490915817431;5667.574931880208;5497.065498865122;5513.889722205614;5529.751161197836;5549.528290095225;5551.528120109674 16:38:12 INFO - PROCESS | 17883 | |1;ext.html;577.4831525784423;600.6816387314722;608.7595399817072;622.3527531367378;626.1015442839526;37387.62612373875;41513;41774.791126044365;41779;41979.790101049526;41671.58328416715;42386.78806605963;42468.78765606168;42803.14393712124;42890.57109428905;8740.34447416443;8824;8896.421732587394;8903.688370907019;8904.688335908244;8667.739967800977;8675.219230269275;8719.912800871973;8738.169873861973;8769.342299327544;8801.207891289783;8801.427907186044;8803;8812.427192232517;8834.11658834118;8806.603702833356;8822.558872056403;8851.601677924444;8864.468131912041;8872.15714507124;8777.122287771235;8835.646574137027;8851.955740221321;8860;8876.556172191365;40503;40617.39073913894;41066.38400423996;41155.1768964622;41185.1762964742;3360.1095709636966;3437.071990562559;3439.4423813968288;3465.54947856777;3481.9651803481893;31752.841235793905;32190.35619287601;32456.188595285308;32816.6718332816;33157.6684233157;4376.343548467724;4432;4465.866024019285;4468.19572476954;4492.568028820978;236914;236919.89240322818;237230;237729;237940;55751.721241393534;55824.16263756047;55998.440015600136;56153;56232;34614.82692586521;35223.471647925304;35276.82361588176;36876.07809804723;59828.70085649544;15282.083075015535;15304;15310.693786124215;15355.61610959735;15411;12705.047121465743;12725.300108493937;12812.231266124063;12812.359382030862;12852.935735321264;18576.628467430575;18753.906230469034;18800.52998675044;18800.905995469937;18838.81161188398;7042.366187043191;7082.681279342442;7085.89371159433;7125.876500789104;7213.4589905757275;948.9952550237205;1027.9463549861453;1055.4300677634146;1082.4371326909963;1099.0657940750298;31843.20391990219;31864;32402.513962290584;32613.51079733806;32991.83504082464;1081.967540973772;1102.5204036244259;1105.5522513382093;1119.5018216893404;1201.5554244929433;16249.59376015609;16818.66362672764;16850.662986740197;17018.829811701973;17026.31894724222;537790;537876;539898;540927;544819;56498.717506412206;57939.42060579424;58134.70932645394;58650.41349586535;58651.70674146602;1311.0887932886742;1322.9206247624982;1339.7052648417332;1341.9597412077653;1346.4950643508685;30336.241593959443;31940.5208921871;32038.67961320357;32185.873494427582;32330.16263875881;50582.74708626433;50678;50954.49045509497;50962;51015.9390436575;427279;430675;430890;431512;431701;25228.747712523375;25850.35374115587;25857.87071064708;27799;28094.85952570224;45361.54638453573;46225.30662040005;46310;46551;47133.528664714286;38716.41925371178;39544;41336.58663413327;41648.3752743703;44740.55259447364;41318.1736365277;41621.58378416177;41983;42131.36802947897;42176;41112.79443602763;41227;42047.789761051;42174.57825421829;42223;33673;36984.07539811526;37094.44358334681;37476.62523374731;37495.812520938314;28077.298067548476;28508.85745571259;28643.14070577886;28685.28286792847;28851.422971540873 16:38:12 INFO - PROCESS | 17883 | |2;jquery.html;368.40502588319856;384.6442041111971;390.71087395327453;391.62795344422807;406.6259041681653;17584.296628134874;20136.899315503437;20240.39278821636;20243.39269821908;20270.189192432284;18656.720149197772;18778;19142.71285930709;19407.611847763037;19459.708104378446;5555.166724991263;5580.218769372291;5771.922108041102;5800.9129863052085;5866.325372582165;5692.715364231793;5751.194832723422;5758.913616295759;5773.538116950634;5786.797462088828;5525.171224316345;5714.371419143911;5723.942760572382;5730.05454100073;5736.483716465517;5613.186088017235;5628.943710562903;5682.062459694145;5707.343655479632;5723.856903577403;5098.439171691111;5125.6155788315655;5143.022825663112;5143.074246635604;5153.433122356538;22801.20195793156;22912.54174916509;23738.406539836644;24184.758152418603;24889.377765556004;2463.064035666453;2587.3014286142825;2595.6755405574113;2598.2075466982565;2747.0385365122247;14972.925135374362;15704.921475392664;15879.364825407085;16036.599085022968;16322.75515867263;2051.2615458434952;2120.5758848230416;2133.8079572838365;2175.8259339252822;2190.1786829938774;93902;95126.52436737771;97741.5112924438;98337;99135.50432247865;17412.564685882702;17436.389726359517;17471.301147954193;17530.561735956704;18126.818731812513;30577.38845223083;31480;31594.842025789723;32086.19784505406;32127.678723212935;10021.448820314952;10063.496825158712;10143.64497242593;10179.7455063624;10275.897241027644;8491.278241349431;8565.100664430145;8600.311975041981;8614.913850861536;8648.351373647001;8727.904040404086;8919.509426981449;8932.19610235082;8950.418222815626;9058.456492610465;3254.1864533866533;3312.2216279174377;3321.966780332166;3499.9300013999577;3555.8933232003083;892.3396686451979;942.8727121838464;949.5489642419933;997.8253805583994;1040.1159014837328;18524.518038556882;19457.708134377997;19625.411237662607;19818.90090549567;19822.50443738918;983.3018556824592;1004.1063453526367;1007.8034783217349;1009.9192064634811;1017.3234798858824;10783.83824242637;10809.78380432387;11085.667429977113;11094.1124710023;11116.499757510932;437649;448738.75630621635;452665.6300466487;457215;459834;57075.714621426625;72588.63705681438;82266;91809.54095229482;93672;954.5275088831073;968.6319198704447;975.8194733974237;983.5279066048337;987.5259875259916;17475.82524174742;17573.297068117132;17803.287868485633;18547.72178417298;18572.628547428707;43511.78244108759;44167.33748993832;44777.32834007427;45471.77264113658;45941;54018.459815401344;54049.45950540444;54960.725196373765;59822;60743.39256607377;7204.747833825791;7560.546367217985;8348.74953751364;8464.365172611955;8531.146885311418;13040.54358097462;13170.473181073034;13174.538891138764;13641.249731264876;13654;12001.519939202683;12021.879781202077;12158.513659453523;12231.204971676812;12288.40625998068;11735.23720958135;11804.822927656263;11924.105692072955;11964.820527692265;12178.269303841798;11676.182667213214;11856.525738970344;11994.460249288977;12039.879601203877;12284.631461056182;7763.883541746765;7791.220877912164;7801.882971755314;7842.803929901798;7960.562169080757;8735.170158835155;11129.721756956142;12128.211666241667;12206.572769953009;12229.715879832846 16:38:12 INFO - PROCESS | 17883 | |3;mootools.html;1416.2564653556885;1448.268624344706;1505.2022428113105;1655.9254833532498;1663.2764747334918;7342.632868356587;7841.960790196048;7945.4438189326775;8388.58057097145;8399.28606068484;8006.399520036006;8212.09666936638;8251;8296.91703082969;8297.419180657356;2223.7442694090146;2247.0674670011927;2255.548890221962;2256.0411824974403;2265.252466685998;2234.6089434348924;2258.616035273999;2265.750767415583;2294.231432470116;2297.264875239924;2230.821534277262;2240.6639004149347;2243.573720993006;2255.7969782719633;2273.4998300373973;2209.3482422685265;2211.1045026764186;2213.690083388335;2216.900239489227;2226.476777957195;2206.3491270075365;2209.812165965895;2218.523017551218;2218.689383486313;2233.229535810159;8259.256666900008;8316;8326.750197494024;8328.708495202638;8339.45793523419;4843.321934929113;4976.129177393977;4989.201727723546;4997.250412438127;5003.474635163292;3034.317278612317;3115.735162511189;3154.542591324245;3232.563603913489;3253.8210398428077;1033.5194134727312;1059.1473863539925;1063.7340664833791;1065.03082195202;1067.1089640150406;10962.232643714942;11021.614243501439;11022.779544409148;11071.557137714562;11186.888131118665;4224.408582798411;4305.268104422193;4378.584034516716;4404.163208990281;4416.558344165558;9387.483688397067;9501;9519.476428796344;9553.90446095544;9582.089701478348;4992.600591952635;5001;5006.349174607278;5020.548150666457;5050.217216331474;4056.7971601419813;4403.251447253974;4466.3747075409465;4646.83736069236;4647.395838541036;3641.10792855752;3716.4611131385795;3761.774293542396;3765.435184722259;3822.522184726909;1210.7154818617619;1221.2123180548497;1222.6148763139583;1227.2759072147476;1239.578543295266;848.410354803418;949.4588084791602;961.7289330850606;962.4081190068058;984.2667212926416;5641.379448260688;5680.801171959044;5743.483086522233;5822.592418530747;5847.619904706181;430.184799804369;440.3043191757016;441.5562359828352;452.69669321554636;460.38998327215904;3916.5300163980505;3975.7018223632763;3982.681385489154;4021.758694478282;4095.4266402703647;9918.107370336704;10071.244656650633;10095.7476063099;10185;10203.795924081625;10074.345167564084;10079.899201008042;10088.646897358558;10103.797924041624;10117.595296188218;7425.925740742631;7672.884906726404;7720.922790772132;7731.536107833548;7840.686372545034;5567.610267281251;5586.525145362527;5593.776248950159;5794.536437084938;5884.499817515388;8857.867131992896;9246.936602290554;9264.490453025148;9323.440593564408;9404.764880878032;9467.573959171992;9481.715548533555;9509.904900950902;9520.761980950532;9852.359596626196;6646.90029649546;7022.789316320519;7249.855002900018;7311.8537629248185;7473.17795042534;8144.104148543537;8148.1037085919315;8150.144234855255;8202.917970820454;8251.83496330082;7147.642617868982;7303.233160518069;7382.889256661262;7458.179600244077;7474.364679002346;7229.927700723136;7301.160366557914;7367.852642947219;7488.700451981859;7513.511621744569;6277.2781130170615;6329.272133704499;6335.651539165206;6416.358364163733;6459.160309159779;4657.301404789308;4954.281629163823;5030.220315851049;5053;5140.56305214046;4933.580645645016;4937.925931111108;5063.645544811828;5133.794648214179;5203.16749320107 16:38:12 INFO - PROCESS | 17883 | |4;prototype.html;316.5504982924249;317.4793338924163;322.9709326160645;326.76309675485277;327.3796156283842;5617.241672374228;5629.35262444819;5696.658200507967;5696.743646535905;5702.45826646468;5586.547497650609;5612.747426365813;5612.887742245152;5644.79852857386;5656.519195868356;4147.232761939036;4185.811638476261;4263.957360426402;4281.828726850922;4299.161663475624;4239.9576004240025;4261.893452663693;4274.7862606869685;4299.570042995691;4309.134425606968;4256.2338779019765;4258.701890867641;4262.296721041024;4270.743755374688;4302.655787537005;4013.237484877864;4251.065765076883;4252.957470425287;4260.318349064166;4284.264872726535;3692.2061756722164;3711.2206436648335;3717.237966216946;3718.791392797352;3723.925521489582;5452.500562345347;5502.147167189092;5516.531094856942;5519.199716041192;5550.500454959073;4841.661083724141;4866.172750632366;4899.632527560448;4940.431850337185;4941.158833670654;5816.418358164192;5837.678927658977;5851.444112809277;5932.644041357532;5940.881182376328;4171.10321280923;4181.414601955728;4193;4201.7268877522865;4208.116295577902;5936.762529498815;6039.5772295939305;6055.303640081359;6064;6187.628742275478;4108.6918481114035;4109.691773117028;4134.193832202752;4150.750954942713;4157.91684166315;4201.894952626209;4202.600752928467;4238.851640192578;4239.194553034913;4244.490661120685;4709.458412282563;4914.189158788759;4923.384576927884;4968.22992436173;4974.9751251243515;5882.264716910387;5912.645241285537;5925.614835035795;5942.168096466498;5950.166976623276;1511.168857128575;1518.7494063479403;1524.8246451658201;1539.58431223569;1544.4440001599414;981.8821741391079;983.2822039910762;994.7662299359645;997.9750506237402;1002.7944271424341;5019.9960007997815;5060.240963855451;5083.796648134107;5097.108006098992;5108.923366149511;5356.79472118778;5367.141257398797;5377.919331209957;5381.9461805382225;5433.673979561239;5126.641135120506;5128.256402821645;5396.2984811974975;5759.942400576025;5850;3279.262166012628;3292.539044533767;3297.653746356646;3300.339932013607;3314.7016768490953;6082.422169893853;6227.377262273736;6339.8127645962995;6363.395477429637;6387.904181437282;6215.502759779207;6223.222097237845;6233.501319894398;6282.780102696383;6293.937060629335;6307.202447302497;6312.652804095819;6315.684215789192;6319.526035547352;6338.7464501420345;5823.8835223294445;6132.601380910405;6138.5396095292135;6139.539534534839;6152.907706384497;6089.969550152221;6153.600015998945;6159.753609855556;6164.938350616437;6169.938300617116;6062.939370606414;6282.780102696566;6300.180976473029;6382.904256436064;6399.088414771361;4248.385613466863;4283.357496375444;4285.16439294347;4311.892202694958;4319.308910574293;5941.732622031933;5969.8806023878415;6175.166352542349;6278;6287.559870809182;5958;5960.821175364746;5997.55018373615;6033.698315084141;6050.878982420415;5867;5896.675682837314;5910.408959104056;5943.197668314722;6015.879682406415;5568.359638641446;5774.682392468455;5813.418658134153;5868.210195890124;5929.584929054925;5964.165016897551;6025.337212906489;6071.876702809995;6087.817365479043;6101.2068431105445;5621.883177800852;5844;5874.295084589706;5893.970530147493;5906.350301466921 16:38:12 INFO - PROCESS | 17883 | |5;yui.html;717.2146499582958;784.5253621558957;799.8320352725927;802.6267785479752;832.604512856393;15029;15098.773518397205;15138.848611513882;15229.543113706579;15433.614159646015;15325;15345.846541534582;15363.462278820243;15460.845391546081;15467.690646187099;647.090837373491;749.8125468632842;756.5007095317092;774.6320497763545;778.1168373895641;758.4728613613513;759.0625577411892;759.10425697677;764.2777575191446;764.4228607401432;821.4701517521225;821.7124006597703;822.8313195794877;826.0459169659053;826.4875777018257;813.251808336332;814.0231721933674;815.6125840225905;816.5753808019856;820.3314298846451;597.4055814464635;598.1327075740194;598.775459202799;600.1148306248249;600.8648054187817;15751.842481575151;15804.367825286974;15886.682266354725;15928.12395318257;15940.760888586681;15267.694646107127;15712.214389280605;15826.129562874037;16223.837761622352;16236;12916.935415322958;12949;13000.934995325057;13334.266615336153;13461.596152115451;3872.883813485572;3980.6218409251364;4010.1578668479656;4034.9193016139807;4050.18996200761;82515.22876827796;83811.5809420949;86392.5680371594;86449.70325445186;86849.39451816455;10655.946720266504;10878.238523303293;10917.508712107974;11195.944020280009;11212.27120237182;23363.182288620155;23366.64950025751;23813.404664883517;23826.52346953051;23852.880735596213;8311.293540049164;8352.707655232038;8398.958005210057;8416.621252043673;8666.739997800076;4743.193657078305;4758.904821903542;4766.189747742892;4782.760861956958;5038.269450929668;3390.593128824557;3491.354099491602;3503.054175372686;3503.9474407883904;3505.9123521912156;588.3263663105805;592;593.7239183779564;600.6126048698565;604.0033943992447;579.939106393831;748.7903387051525;753.7399597138979;767.2533122404521;778.4706399648294;10023.198144148451;10122.544485498023;10314.948425257826;10383.169346452265;10493.422861742525;719.5610677486729;745.3515441565872;749.2170681637592;764.9847003059907;765.162147448543;4817.6530790544;5048.7475626219275;5050.334738408133;5078.162103252996;5078.365204349457;122834;126812.36593816972;128699;130589.34705326603;131544;110782.44608776904;113277.4336128314;113567.43216284031;113836;114479.42760286311;90565.54717226372;92112;94339.52830235942;95395;96315.51842240884;9493.506493506493;9622;9636.807263854824;9649.758756031155;9683.711857322012;53223.46776532185;53382.46617533775;54837.725811370685;55492.72253638706;55629.1655625174;64733;79970;80530;80707;81926.59036705017;11802.291862488279;11924.880751192377;12136.211146275464;12137.939310303393;12453.00375969902;12831.615051548468;12971.675708107372;13029.47882084706;13165.736685266433;13673.726525469236;10851.348919064882;11047.944760276147;11066.336019838835;11415.200935934405;11533.653990380302;11545.166914186106;11599.594014209462;11637.301761893974;11677.416129193676;11758.470868811095;12519.687007824878;12520.87479125197;12606.243625382507;12654.177478463871;12708.491660333853;11077.335359878432;11188.720281993015;11352.489137988645;11444.713882153013;11930;10811.567537298735;11023.17326200522;11267.661970140582;11303.830442543533;11532.654020379403 16:38:12 INFO - PROCESS | 17883 | __end_tp_report 16:38:12 INFO - PROCESS | 17883 | __start_cc_report 16:38:12 INFO - PROCESS | 17883 | _x_x_mozilla_cycle_collect,358 16:38:12 INFO - PROCESS | 17883 | __end_cc_report 16:38:12 INFO - PROCESS | 17883 | __startTimestamp1465947492953__endTimestamp 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | ------- Summary: start ------- 16:38:12 INFO - PROCESS | 17883 | Number of tests: 6 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | [#0] dojo.html Cycles:165 Average:5420.38 Median:5600.94 stddev:615.80 (11.0%) stddev-sans-first:590.30 16:38:12 INFO - PROCESS | 17883 | Values: 3105.3 3158.6 3181.7 3189.6 3193.1 5432.5 5449.4 5495.0 5524.6 5530.6 5325.6 5465.3 5485.5 5560.0 5637.7 4857.6 4870.6 4895.8 5032.2 5032.3 4930.8 5091.1 5122.9 5123.8 5134.8 4895.2 4901.2 4932.4 4966.8 5046.8 4930.8 4937.3 4946.0 4954.3 4956.7 4882.8 4894.8 4897.6 4932.5 4954.7 5340.4 5407.0 5481.5 5504.8 5523.6 5863.9 5891.1 5900.1 5904.4 5907.8 5943.5 5959.3 5960.1 5960.3 5963.5 5347.2 5445.8 5460.4 5514.6 5518.3 5937.5 5954.1 5955.9 5984.0 6030.1 5530.2 5756.8 5757.8 5763.7 5767.1 5778.3 5810.0 5853.0 5883.5 5914.2 5595.8 5736.1 5848.9 5857.2 5857.2 5629.2 5797.8 5840.5 5851.6 5859.3 4394.1 4438.2 4449.5 4453.7 4454.6 3968.6 3981.3 3986.0 3986.7 4018.2 5544.1 5544.8 5545.1 5564.2 5600.9 5854.4 5856.2 5880.7 5916.2 5949.4 5577.4 5593.2 5596.5 5597.5 5618.3 4882.0 5004.2 5013.3 5039.4 5052.9 6011.9 6049.9 6059.2 6062.4 6084.1 5865.8 5889.3 5892.9 5901.6 5906.0 5883.9 5931.1 5974.7 5994.2 6015.9 5681.2 5687.4 5692.6 5697.8 5698.5 5608.4 5781.7 5800.7 5803.7 5813.4 5715.5 5742.1 5769.6 5771.0 5777.9 5506.1 5630.5 5658.2 5661.8 5695.5 5642.4 5669.8 5679.7 5685.0 5697.5 5541.8 5590.1 5609.7 5656.5 5667.6 5497.1 5513.9 5529.8 5549.5 5551.5 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | [#1] ext.html Cycles:180 Average:56211.45 Median:41567.29 stddev:112178.23 (269.9%) stddev-sans-first:112415.15 16:38:12 INFO - PROCESS | 17883 | Values: 577.5 600.7 608.8 622.4 626.1 37387.6 41513.0 41774.8 41779.0 41979.8 41671.6 42386.8 42468.8 42803.1 42890.6 8740.3 8824.0 8896.4 8903.7 8904.7 8667.7 8675.2 8719.9 8738.2 8769.3 8801.2 8801.4 8803.0 8812.4 8834.1 8806.6 8822.6 8851.6 8864.5 8872.2 8777.1 8835.6 8852.0 8860.0 8876.6 40503.0 40617.4 41066.4 41155.2 41185.2 3360.1 3437.1 3439.4 3465.5 3482.0 31752.8 32190.4 32456.2 32816.7 33157.7 4376.3 4432.0 4465.9 4468.2 4492.6 236914.0 236919.9 237230.0 237729.0 237940.0 55751.7 55824.2 55998.4 56153.0 56232.0 34614.8 35223.5 35276.8 36876.1 59828.7 15282.1 15304.0 15310.7 15355.6 15411.0 12705.0 12725.3 12812.2 12812.4 12852.9 18576.6 18753.9 18800.5 18800.9 18838.8 7042.4 7082.7 7085.9 7125.9 7213.5 949.0 1027.9 1055.4 1082.4 1099.1 31843.2 31864.0 32402.5 32613.5 32991.8 1082.0 1102.5 1105.6 1119.5 1201.6 16249.6 16818.7 16850.7 17018.8 17026.3 537790.0 537876.0 539898.0 540927.0 544819.0 56498.7 57939.4 58134.7 58650.4 58651.7 1311.1 1322.9 1339.7 1342.0 1346.5 30336.2 31940.5 32038.7 32185.9 32330.2 50582.7 50678.0 50954.5 50962.0 51015.9 427279.0 430675.0 430890.0 431512.0 431701.0 25228.7 25850.4 25857.9 27799.0 28094.9 45361.5 46225.3 46310.0 46551.0 47133.5 38716.4 39544.0 41336.6 41648.4 44740.6 41318.2 41621.6 41983.0 42131.4 42176.0 41112.8 41227.0 42047.8 42174.6 42223.0 33673.0 36984.1 37094.4 37476.6 37495.8 28077.3 28508.9 28643.1 28685.3 28851.4 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | [#2] jquery.html Cycles:180 Average:29124.01 Median:3317.09 stddev:74601.18 (2249.0%) stddev-sans-first:74779.21 16:38:12 INFO - PROCESS | 17883 | Values: 368.4 384.6 390.7 391.6 406.6 17584.3 20136.9 20240.4 20243.4 20270.2 18656.7 18778.0 19142.7 19407.6 19459.7 5555.2 5580.2 5771.9 5800.9 5866.3 5692.7 5751.2 5758.9 5773.5 5786.8 5525.2 5714.4 5723.9 5730.1 5736.5 5613.2 5628.9 5682.1 5707.3 5723.9 5098.4 5125.6 5143.0 5143.1 5153.4 22801.2 22912.5 23738.4 24184.8 24889.4 2463.1 2587.3 2595.7 2598.2 2747.0 14972.9 15704.9 15879.4 16036.6 16322.8 2051.3 2120.6 2133.8 2175.8 2190.2 93902.0 95126.5 97741.5 98337.0 99135.5 17412.6 17436.4 17471.3 17530.6 18126.8 30577.4 31480.0 31594.8 32086.2 32127.7 10021.4 10063.5 10143.6 10179.7 10275.9 8491.3 8565.1 8600.3 8614.9 8648.4 8727.9 8919.5 8932.2 8950.4 9058.5 3254.2 3312.2 3322.0 3499.9 3555.9 892.3 942.9 949.5 997.8 1040.1 18524.5 19457.7 19625.4 19818.9 19822.5 983.3 1004.1 1007.8 1009.9 1017.3 10783.8 10809.8 11085.7 11094.1 11116.5 437649.0 448738.8 452665.6 457215.0 459834.0 57075.7 72588.6 82266.0 91809.5 93672.0 954.5 968.6 975.8 983.5 987.5 17475.8 17573.3 17803.3 18547.7 18572.6 43511.8 44167.3 44777.3 45471.8 45941.0 54018.5 54049.5 54960.7 59822.0 60743.4 7204.7 7560.5 8348.7 8464.4 8531.1 13040.5 13170.5 13174.5 13641.2 13654.0 12001.5 12021.9 12158.5 12231.2 12288.4 11735.2 11804.8 11924.1 11964.8 12178.3 11676.2 11856.5 11994.5 12039.9 12284.6 7763.9 7791.2 7801.9 7842.8 7960.6 8735.2 11129.7 12128.2 12206.6 12229.7 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | [#3] mootools.html Cycles:180 Average:5435.19 Median:4990.90 stddev:3041.60 (60.9%) stddev-sans-first:3035.13 16:38:12 INFO - PROCESS | 17883 | Values: 1416.3 1448.3 1505.2 1655.9 1663.3 7342.6 7842.0 7945.4 8388.6 8399.3 8006.4 8212.1 8251.0 8296.9 8297.4 2223.7 2247.1 2255.5 2256.0 2265.3 2234.6 2258.6 2265.8 2294.2 2297.3 2230.8 2240.7 2243.6 2255.8 2273.5 2209.3 2211.1 2213.7 2216.9 2226.5 2206.3 2209.8 2218.5 2218.7 2233.2 8259.3 8316.0 8326.8 8328.7 8339.5 4843.3 4976.1 4989.2 4997.3 5003.5 3034.3 3115.7 3154.5 3232.6 3253.8 1033.5 1059.1 1063.7 1065.0 1067.1 10962.2 11021.6 11022.8 11071.6 11186.9 4224.4 4305.3 4378.6 4404.2 4416.6 9387.5 9501.0 9519.5 9553.9 9582.1 4992.6 5001.0 5006.3 5020.5 5050.2 4056.8 4403.3 4466.4 4646.8 4647.4 3641.1 3716.5 3761.8 3765.4 3822.5 1210.7 1221.2 1222.6 1227.3 1239.6 848.4 949.5 961.7 962.4 984.3 5641.4 5680.8 5743.5 5822.6 5847.6 430.2 440.3 441.6 452.7 460.4 3916.5 3975.7 3982.7 4021.8 4095.4 9918.1 10071.2 10095.7 10185.0 10203.8 10074.3 10079.9 10088.6 10103.8 10117.6 7425.9 7672.9 7720.9 7731.5 7840.7 5567.6 5586.5 5593.8 5794.5 5884.5 8857.9 9246.9 9264.5 9323.4 9404.8 9467.6 9481.7 9509.9 9520.8 9852.4 6646.9 7022.8 7249.9 7311.9 7473.2 8144.1 8148.1 8150.1 8202.9 8251.8 7147.6 7303.2 7382.9 7458.2 7474.4 7229.9 7301.2 7367.9 7488.7 7513.5 6277.3 6329.3 6335.7 6416.4 6459.2 4657.3 4954.3 5030.2 5053.0 5140.6 4933.6 4937.9 5063.6 5133.8 5203.2 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | [#4] prototype.html Cycles:180 Average:4920.30 Median:5599.65 stddev:1477.62 (26.4%) stddev-sans-first:1440.80 16:38:12 INFO - PROCESS | 17883 | Values: 316.6 317.5 323.0 326.8 327.4 5617.2 5629.4 5696.7 5696.7 5702.5 5586.5 5612.7 5612.9 5644.8 5656.5 4147.2 4185.8 4264.0 4281.8 4299.2 4240.0 4261.9 4274.8 4299.6 4309.1 4256.2 4258.7 4262.3 4270.7 4302.7 4013.2 4251.1 4253.0 4260.3 4284.3 3692.2 3711.2 3717.2 3718.8 3723.9 5452.5 5502.1 5516.5 5519.2 5550.5 4841.7 4866.2 4899.6 4940.4 4941.2 5816.4 5837.7 5851.4 5932.6 5940.9 4171.1 4181.4 4193.0 4201.7 4208.1 5936.8 6039.6 6055.3 6064.0 6187.6 4108.7 4109.7 4134.2 4150.8 4157.9 4201.9 4202.6 4238.9 4239.2 4244.5 4709.5 4914.2 4923.4 4968.2 4975.0 5882.3 5912.6 5925.6 5942.2 5950.2 1511.2 1518.7 1524.8 1539.6 1544.4 981.9 983.3 994.8 998.0 1002.8 5020.0 5060.2 5083.8 5097.1 5108.9 5356.8 5367.1 5377.9 5381.9 5433.7 5126.6 5128.3 5396.3 5759.9 5850.0 3279.3 3292.5 3297.7 3300.3 3314.7 6082.4 6227.4 6339.8 6363.4 6387.9 6215.5 6223.2 6233.5 6282.8 6293.9 6307.2 6312.7 6315.7 6319.5 6338.7 5823.9 6132.6 6138.5 6139.5 6152.9 6090.0 6153.6 6159.8 6164.9 6169.9 6062.9 6282.8 6300.2 6382.9 6399.1 4248.4 4283.4 4285.2 4311.9 4319.3 5941.7 5969.9 6175.2 6278.0 6287.6 5958.0 5960.8 5997.6 6033.7 6050.9 5867.0 5896.7 5910.4 5943.2 6015.9 5568.4 5774.7 5813.4 5868.2 5929.6 5964.2 6025.3 6071.9 6087.8 6101.2 5621.9 5844.0 5874.3 5894.0 5906.4 16:38:12 INFO - PROCESS | 17883 | 16:38:12 INFO - PROCESS | 17883 | [#5] yui.html Cycles:180 Average:22161.58 Median:3926.75 stddev:33344.48 (849.2%) stddev-sans-first:33399.15 16:38:12 INFO - PROCESS | 17883 | Values: 717.2 784.5 799.8 802.6 832.6 15029.0 15098.8 15138.8 15229.5 15433.6 15325.0 15345.8 15363.5 15460.8 15467.7 647.1 749.8 756.5 774.6 778.1 758.5 759.1 759.1 764.3 764.4 821.5 821.7 822.8 826.0 826.5 813.3 814.0 815.6 816.6 820.3 597.4 598.1 598.8 600.1 600.9 15751.8 15804.4 15886.7 15928.1 15940.8 15267.7 15712.2 15826.1 16223.8 16236.0 12916.9 12949.0 13000.9 13334.3 13461.6 3872.9 3980.6 4010.2 4034.9 4050.2 82515.2 83811.6 86392.6 86449.7 86849.4 10655.9 10878.2 10917.5 11195.9 11212.3 23363.2 23366.6 23813.4 23826.5 23852.9 8311.3 8352.7 8399.0 8416.6 8666.7 4743.2 4758.9 4766.2 4782.8 5038.3 3390.6 3491.4 3503.1 3503.9 3505.9 588.3 592.0 593.7 600.6 604.0 579.9 748.8 753.7 767.3 778.5 10023.2 10122.5 10314.9 10383.2 10493.4 719.6 745.4 749.2 765.0 765.2 4817.7 5048.7 5050.3 5078.2 5078.4 122834.0 126812.4 128699.0 130589.3 131544.0 110782.4 113277.4 113567.4 113836.0 114479.4 90565.5 92112.0 94339.5 95395.0 96315.5 9493.5 9622.0 9636.8 9649.8 9683.7 53223.5 53382.5 54837.7 55492.7 55629.2 64733.0 79970.0 80530.0 80707.0 81926.6 11802.3 11924.9 12136.2 12137.9 12453.0 12831.6 12971.7 13029.5 13165.7 13673.7 10851.3 11047.9 11066.3 11415.2 11533.7 11545.2 11599.6 11637.3 11677.4 11758.5 12519.7 12520.9 12606.2 12654.2 12708.5 11077.3 11188.7 11352.5 11444.7 11930.0 10811.6 11023.2 11267.7 11303.8 11532.7 16:38:12 INFO - PROCESS | 17883 | -------- Summary: end -------- 16:38:12 INFO - PROCESS | 17883 | 16:38:13 INFO - TEST-INFO | 17883: exit 0 16:38:13 INFO - TEST-OK | dromaeo_css | took 1111788ms 16:38:13 INFO - TEST-START | kraken 16:38:13 INFO - operating with platform_type : linux_ 16:38:13 INFO - Initialising browser for kraken test... 16:38:13 INFO - TEST-INFO | started process 18116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiH8x_d/profile http://localhost:34366/getInfo.html) 16:38:18 INFO - PROCESS | 18116 | __metrics Screen width/height:1600/1200 16:38:18 INFO - PROCESS | 18116 | colorDepth:24 16:38:18 INFO - PROCESS | 18116 | Browser inner width/height: 1024/697 16:38:18 INFO - PROCESS | 18116 | __metrics 16:38:19 ERROR - PROCESS | 18116 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:38:20 INFO - TEST-INFO | 18116: exit 0 16:38:20 INFO - Browser initialized. 16:38:20 INFO - Running cycle 1/1 for kraken test... 16:38:20 INFO - TEST-INFO | started process 18237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiH8x_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:32 INFO - PROCESS | 18237 | RSS: Main: 185425920 16:38:32 INFO - PROCESS | 18237 | 16:38:34 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34366/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:35 INFO - PROCESS | 18237 | RSS: Main: 190971904 16:38:35 INFO - PROCESS | 18237 | 16:38:38 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34366/tests/kraken/driver.html?testName=audio-dft) 16:38:39 INFO - PROCESS | 18237 | RSS: Main: 190468096 16:38:39 INFO - PROCESS | 18237 | 16:38:42 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34366/tests/kraken/driver.html?testName=audio-fft) 16:38:42 INFO - PROCESS | 18237 | RSS: Main: 185384960 16:38:42 INFO - PROCESS | 18237 | 16:38:45 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34366/tests/kraken/driver.html?testName=audio-oscillator) 16:38:45 INFO - PROCESS | 18237 | RSS: Main: 186322944 16:38:45 INFO - PROCESS | 18237 | 16:38:47 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:48 INFO - PROCESS | 18237 | RSS: Main: 186314752 16:38:48 INFO - PROCESS | 18237 | 16:38:51 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34366/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:52 INFO - PROCESS | 18237 | RSS: Main: 186757120 16:38:52 INFO - PROCESS | 18237 | 16:38:55 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34366/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:56 INFO - PROCESS | 18237 | RSS: Main: 183615488 16:38:56 INFO - PROCESS | 18237 | 16:38:59 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34366/tests/kraken/driver.html?testName=json-parse-financial) 16:38:59 INFO - PROCESS | 18237 | RSS: Main: 185438208 16:38:59 INFO - PROCESS | 18237 | 16:39:01 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:02 INFO - PROCESS | 18237 | RSS: Main: 185835520 16:39:02 INFO - PROCESS | 18237 | 16:39:03 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:04 INFO - PROCESS | 18237 | RSS: Main: 186204160 16:39:04 INFO - PROCESS | 18237 | 16:39:06 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:07 INFO - PROCESS | 18237 | RSS: Main: 186691584 16:39:07 INFO - PROCESS | 18237 | 16:39:09 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:10 INFO - PROCESS | 18237 | RSS: Main: 187121664 16:39:10 INFO - PROCESS | 18237 | 16:39:13 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:13 INFO - PROCESS | 18237 | RSS: Main: 186441728 16:39:13 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | Cycle 1(1): loaded http://localhost:34366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34366/tests/kraken/driver.html?testName=ai-astar) 16:39:15 INFO - PROCESS | 18237 | RSS: Main: 187506688 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | __start_tp_report 16:39:15 INFO - PROCESS | 18237 | _x_x_mozilla_page_load 16:39:15 INFO - PROCESS | 18237 | _x_x_mozilla_page_load_details 16:39:15 INFO - PROCESS | 18237 | |i|pagename|runs| 16:39:15 INFO - PROCESS | 18237 | |0;ai-astar;112;107;111;110;111;114;113;109;112;112 16:39:15 INFO - PROCESS | 18237 | |1;audio-beat-detection;158;140;159;178;129;152;159;127;190;126 16:39:15 INFO - PROCESS | 18237 | |2;audio-dft;164;161;162;161;165;176;166;163;164;166 16:39:15 INFO - PROCESS | 18237 | |3;audio-fft;76;76;75;176;77;75;75;75;169;75 16:39:15 INFO - PROCESS | 18237 | |4;audio-oscillator;85;83;147;85;86;85;147;85;85;140 16:39:15 INFO - PROCESS | 18237 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;118;117;118 16:39:15 INFO - PROCESS | 18237 | |6;imaging-darkroom;148;148;146;147;147;151;147;148;147;147 16:39:15 INFO - PROCESS | 18237 | |7;imaging-desaturate;96;95;95;95;96;96;97;96;98;95 16:39:15 INFO - PROCESS | 18237 | |8;json-parse-financial;56;56;55;56;56;57;56;60;56;56 16:39:15 INFO - PROCESS | 18237 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;60;62;62 16:39:15 INFO - PROCESS | 18237 | |10;stanford-crypto-aes;80;78;81;80;81;81;81;81;104;80 16:39:15 INFO - PROCESS | 18237 | |11;stanford-crypto-ccm;123;132;131;136;127;133;123;125;126;123 16:39:15 INFO - PROCESS | 18237 | |12;stanford-crypto-pbkdf2;161;158;162;162;162;161;159;161;162;157 16:39:15 INFO - PROCESS | 18237 | |13;stanford-crypto-sha256-iterative;66;72;63;63;63;63;62;63;61;62 16:39:15 INFO - PROCESS | 18237 | __end_tp_report 16:39:15 INFO - PROCESS | 18237 | __start_cc_report 16:39:15 INFO - PROCESS | 18237 | _x_x_mozilla_cycle_collect,889 16:39:15 INFO - PROCESS | 18237 | __end_cc_report 16:39:15 INFO - PROCESS | 18237 | __startTimestamp1465947555672__endTimestamp 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | ------- Summary: start ------- 16:39:15 INFO - PROCESS | 18237 | Number of tests: 14 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.02 (1.8%) stddev-sans-first:2.12 16:39:15 INFO - PROCESS | 18237 | Values: 112.0 107.0 111.0 110.0 111.0 114.0 113.0 109.0 112.0 112.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.50 stddev:21.67 (13.7%) stddev-sans-first:22.87 16:39:15 INFO - PROCESS | 18237 | Values: 158.0 140.0 159.0 178.0 129.0 152.0 159.0 127.0 190.0 126.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:4.34 (2.6%) stddev-sans-first:4.59 16:39:15 INFO - PROCESS | 18237 | Values: 164.0 161.0 162.0 161.0 165.0 176.0 166.0 163.0 164.0 166.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.00 stddev:40.94 (54.6%) stddev-sans-first:42.85 16:39:15 INFO - PROCESS | 18237 | Values: 76.0 76.0 75.0 176.0 77.0 75.0 75.0 75.0 169.0 75.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.00 stddev:28.96 (34.1%) stddev-sans-first:29.99 16:39:15 INFO - PROCESS | 18237 | Values: 85.0 83.0 147.0 85.0 86.0 85.0 147.0 85.0 85.0 140.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:39:15 INFO - PROCESS | 18237 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.42 16:39:15 INFO - PROCESS | 18237 | Values: 148.0 148.0 146.0 147.0 147.0 151.0 147.0 148.0 147.0 147.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 16:39:15 INFO - PROCESS | 18237 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 97.0 96.0 98.0 95.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 16:39:15 INFO - PROCESS | 18237 | Values: 56.0 56.0 55.0 56.0 56.0 57.0 56.0 60.0 56.0 56.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:39:15 INFO - PROCESS | 18237 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 62.0 62.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:81.00 stddev:7.54 (9.3%) stddev-sans-first:7.94 16:39:15 INFO - PROCESS | 18237 | Values: 80.0 78.0 81.0 80.0 81.0 81.0 81.0 81.0 104.0 80.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.00 stddev:4.75 (3.7%) stddev-sans-first:4.69 16:39:15 INFO - PROCESS | 18237 | Values: 123.0 132.0 131.0 136.0 127.0 133.0 123.0 125.0 126.0 123.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 16:39:15 INFO - PROCESS | 18237 | Values: 161.0 158.0 162.0 162.0 162.0 161.0 159.0 161.0 162.0 157.0 16:39:15 INFO - PROCESS | 18237 | 16:39:15 INFO - PROCESS | 18237 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:3.16 (5.0%) stddev-sans-first:3.24 16:39:15 INFO - PROCESS | 18237 | Values: 66.0 72.0 63.0 63.0 63.0 63.0 62.0 63.0 61.0 62.0 16:39:15 INFO - PROCESS | 18237 | -------- Summary: end -------- 16:39:15 INFO - PROCESS | 18237 | 16:39:16 INFO - TEST-INFO | 18237: exit 0 16:39:16 INFO - TEST-OK | kraken | took 62961ms 16:39:16 INFO - SUITE-END | took 1174s 16:39:16 INFO - Completed test suite (00:19:34) 16:39:16 INFO - javascript benchmark 16:39:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7320.45871050029, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.254738862673, 3158.573592565003, 3181.7454603631704, 3189.553462515247, 3193.121891479843, 5432.483914028166, 5449.373322067963, 5494.972525137374, 5524.640898341615, 5530.6128571000045, 5325.573954083674, 5465.262189604402, 5485.533729632986, 5559.972200138994, 5637.689927054011, 4857.635677324206, 4870.58600018997, 4895.779689913962, 5032.245163225509, 5032.345795046639, 4930.80276788928, 5091.083604951107, 5122.871928201787, 5123.795048198068, 5134.768935397916, 4895.216765317532, 4901.191303434929, 4932.358793356859, 4966.826161084363, 5046.82336118236, 4930.778114984834, 4937.333459982892, 4946.035523073002, 4954.3063971044085, 4956.677815941988, 4882.780274887638, 4894.755262236874, 4897.559219670211, 4932.506749325074, 4954.653174277802, 5340.439253878326, 5406.972965135188, 5481.451854814487, 5504.752286147133, 5523.585731070146, 5863.941360586425, 5891.086881533369, 5900.114982752579, 5904.409559044104, 5907.763689452417, 5943.494802941756, 5959.314678811948, 5960.105984102376, 5960.284765828085, 5963.46328830403, 5347.171188465794, 5445.754941027623, 5460.426655201226, 5514.6139770216105, 5518.310211223597, 5937.465628093406, 5954.10688396744, 5955.940440595538, 5983.970080149571, 6030.095485677183, 5530.170474428787, 5756.798512052058, 5757.827265182052, 5763.711814409263, 5767.134929760486, 5778.27771528559, 5809.970950145223, 5853.0, 5883.529317654577, 5914.201582786355, 5595.832125036255, 5736.082226843685, 5848.88302233953, 5857.150713146655, 5857.209276747584, 5629.240052592848, 5797.826065218051, 5840.503557197686, 5851.619644723164, 5859.267591551056, 4394.099209662011, 4438.1567502174485, 4449.466064072268, 4453.710508816916, 4454.57681520255, 3968.6031396860085, 3981.3231750602467, 3986.0, 3986.720929534905, 4018.176273863851, 5544.085225937675, 5544.750486228129, 5545.140503222007, 5564.221009058735, 5600.943990560124, 5854.385289544622, 5856.238688970407, 5880.705964701748, 5916.171735956969, 5949.405059494016, 5577.414371491016, 5593.161025846074, 5596.524295434852, 5597.496225339739, 5618.297712785902, 4882.0, 5004.223500657287, 5013.348264725635, 5039.395272567315, 5052.873678158002, 6011.939880601226, 6049.879002419927, 6059.151718759377, 6062.42406971337, 6084.11780291864, 5865.794697185664, 5889.322727886177, 5892.9116063258225, 5901.557383196192, 5905.970470147622, 5883.911741323798, 5931.13998470228, 5974.701264936823, 5994.160817485643, 6015.939840601538, 5681.204631351531, 5687.431256874445, 5692.6299790513485, 5697.772089116389, 5698.54411647059, 5608.355039170548, 5781.739821707949, 5800.7099645018425, 5803.65178089316, 5813.418658134153, 5715.457031581993, 5742.0812669974275, 5769.596128271149, 5770.990076736471, 5777.94222057774, 5506.1190209566275, 5630.493255607015, 5658.179563963285, 5661.801836935688, 5695.458931401676, 5642.435756424325, 5669.829905102853, 5679.659220446786, 5685.0, 5697.515711164431, 5541.778328866801, 5590.133529302964, 5609.691466969356, 5656.490915817431, 5667.574931880208, 5497.065498865122, 5513.889722205614, 5529.751161197836, 5549.528290095225, 5551.528120109674], "value": 5378.835113357293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.4831525784423, 600.6816387314722, 608.7595399817072, 622.3527531367378, 626.1015442839526, 37387.62612373875, 41513.0, 41774.791126044365, 41779.0, 41979.790101049526, 41671.58328416715, 42386.78806605963, 42468.78765606168, 42803.14393712124, 42890.57109428905, 8740.34447416443, 8824.0, 8896.421732587394, 8903.688370907019, 8904.688335908244, 8667.739967800977, 8675.219230269275, 8719.912800871973, 8738.169873861973, 8769.342299327544, 8801.207891289783, 8801.427907186044, 8803.0, 8812.427192232517, 8834.11658834118, 8806.603702833356, 8822.558872056403, 8851.601677924444, 8864.468131912041, 8872.15714507124, 8777.122287771235, 8835.646574137027, 8851.955740221321, 8860.0, 8876.556172191365, 40503.0, 40617.39073913894, 41066.38400423996, 41155.1768964622, 41185.1762964742, 3360.1095709636966, 3437.071990562559, 3439.4423813968288, 3465.54947856777, 3481.9651803481893, 31752.841235793905, 32190.35619287601, 32456.188595285308, 32816.6718332816, 33157.6684233157, 4376.343548467724, 4432.0, 4465.866024019285, 4468.19572476954, 4492.568028820978, 236914.0, 236919.89240322818, 237230.0, 237729.0, 237940.0, 55751.721241393534, 55824.16263756047, 55998.440015600136, 56153.0, 56232.0, 34614.82692586521, 35223.471647925304, 35276.82361588176, 36876.07809804723, 59828.70085649544, 15282.083075015535, 15304.0, 15310.693786124215, 15355.61610959735, 15411.0, 12705.047121465743, 12725.300108493937, 12812.231266124063, 12812.359382030862, 12852.935735321264, 18576.628467430575, 18753.906230469034, 18800.52998675044, 18800.905995469937, 18838.81161188398, 7042.366187043191, 7082.681279342442, 7085.89371159433, 7125.876500789104, 7213.4589905757275, 948.9952550237205, 1027.9463549861453, 1055.4300677634146, 1082.4371326909963, 1099.0657940750298, 31843.20391990219, 31864.0, 32402.513962290584, 32613.51079733806, 32991.83504082464, 1081.967540973772, 1102.5204036244259, 1105.5522513382093, 1119.5018216893404, 1201.5554244929433, 16249.59376015609, 16818.66362672764, 16850.662986740197, 17018.829811701973, 17026.31894724222, 537790.0, 537876.0, 539898.0, 540927.0, 544819.0, 56498.717506412206, 57939.42060579424, 58134.70932645394, 58650.41349586535, 58651.70674146602, 1311.0887932886742, 1322.9206247624982, 1339.7052648417332, 1341.9597412077653, 1346.4950643508685, 30336.241593959443, 31940.5208921871, 32038.67961320357, 32185.873494427582, 32330.16263875881, 50582.74708626433, 50678.0, 50954.49045509497, 50962.0, 51015.9390436575, 427279.0, 430675.0, 430890.0, 431512.0, 431701.0, 25228.747712523375, 25850.35374115587, 25857.87071064708, 27799.0, 28094.85952570224, 45361.54638453573, 46225.30662040005, 46310.0, 46551.0, 47133.528664714286, 38716.41925371178, 39544.0, 41336.58663413327, 41648.3752743703, 44740.55259447364, 41318.1736365277, 41621.58378416177, 41983.0, 42131.36802947897, 42176.0, 41112.79443602763, 41227.0, 42047.789761051, 42174.57825421829, 42223.0, 33673.0, 36984.07539811526, 37094.44358334681, 37476.62523374731, 37495.812520938314, 28077.298067548476, 28508.85745571259, 28643.14070577886, 28685.28286792847, 28851.422971540873], "value": 19493.069735588033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.40502588319856, 384.6442041111971, 390.71087395327453, 391.62795344422807, 406.6259041681653, 17584.296628134874, 20136.899315503437, 20240.39278821636, 20243.39269821908, 20270.189192432284, 18656.720149197772, 18778.0, 19142.71285930709, 19407.611847763037, 19459.708104378446, 5555.166724991263, 5580.218769372291, 5771.922108041102, 5800.9129863052085, 5866.325372582165, 5692.715364231793, 5751.194832723422, 5758.913616295759, 5773.538116950634, 5786.797462088828, 5525.171224316345, 5714.371419143911, 5723.942760572382, 5730.05454100073, 5736.483716465517, 5613.186088017235, 5628.943710562903, 5682.062459694145, 5707.343655479632, 5723.856903577403, 5098.439171691111, 5125.6155788315655, 5143.022825663112, 5143.074246635604, 5153.433122356538, 22801.20195793156, 22912.54174916509, 23738.406539836644, 24184.758152418603, 24889.377765556004, 2463.064035666453, 2587.3014286142825, 2595.6755405574113, 2598.2075466982565, 2747.0385365122247, 14972.925135374362, 15704.921475392664, 15879.364825407085, 16036.599085022968, 16322.75515867263, 2051.2615458434952, 2120.5758848230416, 2133.8079572838365, 2175.8259339252822, 2190.1786829938774, 93902.0, 95126.52436737771, 97741.5112924438, 98337.0, 99135.50432247865, 17412.564685882702, 17436.389726359517, 17471.301147954193, 17530.561735956704, 18126.818731812513, 30577.38845223083, 31480.0, 31594.842025789723, 32086.19784505406, 32127.678723212935, 10021.448820314952, 10063.496825158712, 10143.64497242593, 10179.7455063624, 10275.897241027644, 8491.278241349431, 8565.100664430145, 8600.311975041981, 8614.913850861536, 8648.351373647001, 8727.904040404086, 8919.509426981449, 8932.19610235082, 8950.418222815626, 9058.456492610465, 3254.1864533866533, 3312.2216279174377, 3321.966780332166, 3499.9300013999577, 3555.8933232003083, 892.3396686451979, 942.8727121838464, 949.5489642419933, 997.8253805583994, 1040.1159014837328, 18524.518038556882, 19457.708134377997, 19625.411237662607, 19818.90090549567, 19822.50443738918, 983.3018556824592, 1004.1063453526367, 1007.8034783217349, 1009.9192064634811, 1017.3234798858824, 10783.83824242637, 10809.78380432387, 11085.667429977113, 11094.1124710023, 11116.499757510932, 437649.0, 448738.75630621635, 452665.6300466487, 457215.0, 459834.0, 57075.714621426625, 72588.63705681438, 82266.0, 91809.54095229482, 93672.0, 954.5275088831073, 968.6319198704447, 975.8194733974237, 983.5279066048337, 987.5259875259916, 17475.82524174742, 17573.297068117132, 17803.287868485633, 18547.72178417298, 18572.628547428707, 43511.78244108759, 44167.33748993832, 44777.32834007427, 45471.77264113658, 45941.0, 54018.459815401344, 54049.45950540444, 54960.725196373765, 59822.0, 60743.39256607377, 7204.747833825791, 7560.546367217985, 8348.74953751364, 8464.365172611955, 8531.146885311418, 13040.54358097462, 13170.473181073034, 13174.538891138764, 13641.249731264876, 13654.0, 12001.519939202683, 12021.879781202077, 12158.513659453523, 12231.204971676812, 12288.40625998068, 11735.23720958135, 11804.822927656263, 11924.105692072955, 11964.820527692265, 12178.269303841798, 11676.182667213214, 11856.525738970344, 11994.460249288977, 12039.879601203877, 12284.631461056182, 7763.883541746765, 7791.220877912164, 7801.882971755314, 7842.803929901798, 7960.562169080757, 8735.170158835155, 11129.721756956142, 12128.211666241667, 12206.572769953009, 12229.715879832846], "value": 10066.400642065257, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.2564653556885, 1448.268624344706, 1505.2022428113105, 1655.9254833532498, 1663.2764747334918, 7342.632868356587, 7841.960790196048, 7945.4438189326775, 8388.58057097145, 8399.28606068484, 8006.399520036006, 8212.09666936638, 8251.0, 8296.91703082969, 8297.419180657356, 2223.7442694090146, 2247.0674670011927, 2255.548890221962, 2256.0411824974403, 2265.252466685998, 2234.6089434348924, 2258.616035273999, 2265.750767415583, 2294.231432470116, 2297.264875239924, 2230.821534277262, 2240.6639004149347, 2243.573720993006, 2255.7969782719633, 2273.4998300373973, 2209.3482422685265, 2211.1045026764186, 2213.690083388335, 2216.900239489227, 2226.476777957195, 2206.3491270075365, 2209.812165965895, 2218.523017551218, 2218.689383486313, 2233.229535810159, 8259.256666900008, 8316.0, 8326.750197494024, 8328.708495202638, 8339.45793523419, 4843.321934929113, 4976.129177393977, 4989.201727723546, 4997.250412438127, 5003.474635163292, 3034.317278612317, 3115.735162511189, 3154.542591324245, 3232.563603913489, 3253.8210398428077, 1033.5194134727312, 1059.1473863539925, 1063.7340664833791, 1065.03082195202, 1067.1089640150406, 10962.232643714942, 11021.614243501439, 11022.779544409148, 11071.557137714562, 11186.888131118665, 4224.408582798411, 4305.268104422193, 4378.584034516716, 4404.163208990281, 4416.558344165558, 9387.483688397067, 9501.0, 9519.476428796344, 9553.90446095544, 9582.089701478348, 4992.600591952635, 5001.0, 5006.349174607278, 5020.548150666457, 5050.217216331474, 4056.7971601419813, 4403.251447253974, 4466.3747075409465, 4646.83736069236, 4647.395838541036, 3641.10792855752, 3716.4611131385795, 3761.774293542396, 3765.435184722259, 3822.522184726909, 1210.7154818617619, 1221.2123180548497, 1222.6148763139583, 1227.2759072147476, 1239.578543295266, 848.410354803418, 949.4588084791602, 961.7289330850606, 962.4081190068058, 984.2667212926416, 5641.379448260688, 5680.801171959044, 5743.483086522233, 5822.592418530747, 5847.619904706181, 430.184799804369, 440.3043191757016, 441.5562359828352, 452.69669321554636, 460.38998327215904, 3916.5300163980505, 3975.7018223632763, 3982.681385489154, 4021.758694478282, 4095.4266402703647, 9918.107370336704, 10071.244656650633, 10095.7476063099, 10185.0, 10203.795924081625, 10074.345167564084, 10079.899201008042, 10088.646897358558, 10103.797924041624, 10117.595296188218, 7425.925740742631, 7672.884906726404, 7720.922790772132, 7731.536107833548, 7840.686372545034, 5567.610267281251, 5586.525145362527, 5593.776248950159, 5794.536437084938, 5884.499817515388, 8857.867131992896, 9246.936602290554, 9264.490453025148, 9323.440593564408, 9404.764880878032, 9467.573959171992, 9481.715548533555, 9509.904900950902, 9520.761980950532, 9852.359596626196, 6646.90029649546, 7022.789316320519, 7249.855002900018, 7311.8537629248185, 7473.17795042534, 8144.104148543537, 8148.1037085919315, 8150.144234855255, 8202.917970820454, 8251.83496330082, 7147.642617868982, 7303.233160518069, 7382.889256661262, 7458.179600244077, 7474.364679002346, 7229.927700723136, 7301.160366557914, 7367.852642947219, 7488.700451981859, 7513.511621744569, 6277.2781130170615, 6329.272133704499, 6335.651539165206, 6416.358364163733, 6459.160309159779, 4657.301404789308, 4954.281629163823, 5030.220315851049, 5053.0, 5140.56305214046, 4933.580645645016, 4937.925931111108, 5063.645544811828, 5133.794648214179, 5203.16749320107], "value": 4311.335792756992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.5504982924249, 317.4793338924163, 322.9709326160645, 326.76309675485277, 327.3796156283842, 5617.241672374228, 5629.35262444819, 5696.658200507967, 5696.743646535905, 5702.45826646468, 5586.547497650609, 5612.747426365813, 5612.887742245152, 5644.79852857386, 5656.519195868356, 4147.232761939036, 4185.811638476261, 4263.957360426402, 4281.828726850922, 4299.161663475624, 4239.9576004240025, 4261.893452663693, 4274.7862606869685, 4299.570042995691, 4309.134425606968, 4256.2338779019765, 4258.701890867641, 4262.296721041024, 4270.743755374688, 4302.655787537005, 4013.237484877864, 4251.065765076883, 4252.957470425287, 4260.318349064166, 4284.264872726535, 3692.2061756722164, 3711.2206436648335, 3717.237966216946, 3718.791392797352, 3723.925521489582, 5452.500562345347, 5502.147167189092, 5516.531094856942, 5519.199716041192, 5550.500454959073, 4841.661083724141, 4866.172750632366, 4899.632527560448, 4940.431850337185, 4941.158833670654, 5816.418358164192, 5837.678927658977, 5851.444112809277, 5932.644041357532, 5940.881182376328, 4171.10321280923, 4181.414601955728, 4193.0, 4201.7268877522865, 4208.116295577902, 5936.762529498815, 6039.5772295939305, 6055.303640081359, 6064.0, 6187.628742275478, 4108.6918481114035, 4109.691773117028, 4134.193832202752, 4150.750954942713, 4157.91684166315, 4201.894952626209, 4202.600752928467, 4238.851640192578, 4239.194553034913, 4244.490661120685, 4709.458412282563, 4914.189158788759, 4923.384576927884, 4968.22992436173, 4974.9751251243515, 5882.264716910387, 5912.645241285537, 5925.614835035795, 5942.168096466498, 5950.166976623276, 1511.168857128575, 1518.7494063479403, 1524.8246451658201, 1539.58431223569, 1544.4440001599414, 981.8821741391079, 983.2822039910762, 994.7662299359645, 997.9750506237402, 1002.7944271424341, 5019.9960007997815, 5060.240963855451, 5083.796648134107, 5097.108006098992, 5108.923366149511, 5356.79472118778, 5367.141257398797, 5377.919331209957, 5381.9461805382225, 5433.673979561239, 5126.641135120506, 5128.256402821645, 5396.2984811974975, 5759.942400576025, 5850.0, 3279.262166012628, 3292.539044533767, 3297.653746356646, 3300.339932013607, 3314.7016768490953, 6082.422169893853, 6227.377262273736, 6339.8127645962995, 6363.395477429637, 6387.904181437282, 6215.502759779207, 6223.222097237845, 6233.501319894398, 6282.780102696383, 6293.937060629335, 6307.202447302497, 6312.652804095819, 6315.684215789192, 6319.526035547352, 6338.7464501420345, 5823.8835223294445, 6132.601380910405, 6138.5396095292135, 6139.539534534839, 6152.907706384497, 6089.969550152221, 6153.600015998945, 6159.753609855556, 6164.938350616437, 6169.938300617116, 6062.939370606414, 6282.780102696566, 6300.180976473029, 6382.904256436064, 6399.088414771361, 4248.385613466863, 4283.357496375444, 4285.16439294347, 4311.892202694958, 4319.308910574293, 5941.732622031933, 5969.8806023878415, 6175.166352542349, 6278.0, 6287.559870809182, 5958.0, 5960.821175364746, 5997.55018373615, 6033.698315084141, 6050.878982420415, 5867.0, 5896.675682837314, 5910.408959104056, 5943.197668314722, 6015.879682406415, 5568.359638641446, 5774.682392468455, 5813.418658134153, 5868.210195890124, 5929.584929054925, 5964.165016897551, 6025.337212906489, 6071.876702809995, 6087.817365479043, 6101.2068431105445, 5621.883177800852, 5844.0, 5874.295084589706, 5893.970530147493, 5906.350301466921], "value": 4444.820879314947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2146499582958, 784.5253621558957, 799.8320352725927, 802.6267785479752, 832.604512856393, 15029.0, 15098.773518397205, 15138.848611513882, 15229.543113706579, 15433.614159646015, 15325.0, 15345.846541534582, 15363.462278820243, 15460.845391546081, 15467.690646187099, 647.090837373491, 749.8125468632842, 756.5007095317092, 774.6320497763545, 778.1168373895641, 758.4728613613513, 759.0625577411892, 759.10425697677, 764.2777575191446, 764.4228607401432, 821.4701517521225, 821.7124006597703, 822.8313195794877, 826.0459169659053, 826.4875777018257, 813.251808336332, 814.0231721933674, 815.6125840225905, 816.5753808019856, 820.3314298846451, 597.4055814464635, 598.1327075740194, 598.775459202799, 600.1148306248249, 600.8648054187817, 15751.842481575151, 15804.367825286974, 15886.682266354725, 15928.12395318257, 15940.760888586681, 15267.694646107127, 15712.214389280605, 15826.129562874037, 16223.837761622352, 16236.0, 12916.935415322958, 12949.0, 13000.934995325057, 13334.266615336153, 13461.596152115451, 3872.883813485572, 3980.6218409251364, 4010.1578668479656, 4034.9193016139807, 4050.18996200761, 82515.22876827796, 83811.5809420949, 86392.5680371594, 86449.70325445186, 86849.39451816455, 10655.946720266504, 10878.238523303293, 10917.508712107974, 11195.944020280009, 11212.27120237182, 23363.182288620155, 23366.64950025751, 23813.404664883517, 23826.52346953051, 23852.880735596213, 8311.293540049164, 8352.707655232038, 8398.958005210057, 8416.621252043673, 8666.739997800076, 4743.193657078305, 4758.904821903542, 4766.189747742892, 4782.760861956958, 5038.269450929668, 3390.593128824557, 3491.354099491602, 3503.054175372686, 3503.9474407883904, 3505.9123521912156, 588.3263663105805, 592.0, 593.7239183779564, 600.6126048698565, 604.0033943992447, 579.939106393831, 748.7903387051525, 753.7399597138979, 767.2533122404521, 778.4706399648294, 10023.198144148451, 10122.544485498023, 10314.948425257826, 10383.169346452265, 10493.422861742525, 719.5610677486729, 745.3515441565872, 749.2170681637592, 764.9847003059907, 765.162147448543, 4817.6530790544, 5048.7475626219275, 5050.334738408133, 5078.162103252996, 5078.365204349457, 122834.0, 126812.36593816972, 128699.0, 130589.34705326603, 131544.0, 110782.44608776904, 113277.4336128314, 113567.43216284031, 113836.0, 114479.42760286311, 90565.54717226372, 92112.0, 94339.52830235942, 95395.0, 96315.51842240884, 9493.506493506493, 9622.0, 9636.807263854824, 9649.758756031155, 9683.711857322012, 53223.46776532185, 53382.46617533775, 54837.725811370685, 55492.72253638706, 55629.1655625174, 64733.0, 79970.0, 80530.0, 80707.0, 81926.59036705017, 11802.291862488279, 11924.880751192377, 12136.211146275464, 12137.939310303393, 12453.00375969902, 12831.615051548468, 12971.675708107372, 13029.47882084706, 13165.736685266433, 13673.726525469236, 10851.348919064882, 11047.944760276147, 11066.336019838835, 11415.200935934405, 11533.653990380302, 11545.166914186106, 11599.594014209462, 11637.301761893974, 11677.416129193676, 11758.470868811095, 12519.687007824878, 12520.87479125197, 12606.243625382507, 12654.177478463871, 12708.491660333853, 11077.335359878432, 11188.720281993015, 11352.489137988645, 11444.713882153013, 11930.0, 10811.567537298735, 11023.17326200522, 11267.661970140582, 11303.830442543533, 11532.654020379403], "value": 7608.083328611177, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 110.0, 111.0, 114.0, 113.0, 109.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 140.0, 159.0, 178.0, 129.0, 152.0, 159.0, 127.0, 190.0, 126.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 161.0, 165.0, 176.0, 166.0, 163.0, 164.0, 166.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 176.0, 77.0, 75.0, 75.0, 75.0, 169.0, 75.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 147.0, 85.0, 86.0, 85.0, 147.0, 85.0, 85.0, 140.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 151.0, 147.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 98.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 56.0, 60.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 62.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 81.0, 80.0, 81.0, 81.0, 81.0, 81.0, 104.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 131.0, 136.0, 127.0, 133.0, 123.0, 125.0, 126.0, 123.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 162.0, 162.0, 162.0, 161.0, 159.0, 161.0, 162.0, 157.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 61.0, 62.0], "value": 63.8, "unit": "score"}]}]} 16:39:16 INFO - Return code: 0 16:39:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:39:16 ERROR - # TBPL SUCCESS # 16:39:16 INFO - Running post-action listener: _resource_record_post_action 16:39:16 INFO - ##### 16:39:16 INFO - ##### Finished run-tests step (success) 16:39:16 INFO - ##### 16:39:16 INFO - Running post-run listener: _resource_record_post_run 16:39:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 412409856; Read time: 0; Write time: 469456 16:39:17 INFO - TinderboxPrint: CPU usage
13.5% 16:39:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:39:17 INFO - TinderboxPrint: I/O write bytes / time
412,409,856 / 469,456 16:39:17 INFO - TinderboxPrint: CPU idle
8,239.0 (86.5%) 16:39:17 INFO - TinderboxPrint: CPU user
1,223.2 (12.8%) 16:39:17 INFO - TinderboxPrint: Swap in / out
0 / 0 16:39:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 38658048; Read time: 0; Write time: 48316 16:39:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 287567872; Read time: 0; Write time: 276068 16:39:17 INFO - Running post-run listener: _upload_blobber_files 16:39:17 INFO - Blob upload gear active. 16:39:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:17 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 16:39:17 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'] 16:39:17 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 16:39:18 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:21 INFO - (blobuploader) - INFO - Done attempting. 16:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:22 INFO - (blobuploader) - INFO - Done attempting. 16:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:23 INFO - (blobuploader) - INFO - Done attempting. 16:39:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:23 INFO - Return code: 0 16:39:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/590c944c37e16381810419a291ab8e9bbb561954f6b06690a2799bc4525d4e9d9afb4649aa8ee7c7ba1debd54ee60dc6c637be92e2d02093bea4315bfd6c9332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75e18323dec5bc6ebfaa6fb10154089a6a3def4e34b5a8d1e225685e40b03de81c105ef3511710247388b7dbe0bc80d0e9534337e91d3d60062206bc27d1b8ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c16dc7ee42d7430854cf2ca01a8b24a37019a48062b99769ee7dcefc7d922cfebba5f7c51f664ac8a6a6440172d57fdea78730226cd3251610efed8f67adab"} 16:39:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:23 INFO - Contents: 16:39:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/590c944c37e16381810419a291ab8e9bbb561954f6b06690a2799bc4525d4e9d9afb4649aa8ee7c7ba1debd54ee60dc6c637be92e2d02093bea4315bfd6c9332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75e18323dec5bc6ebfaa6fb10154089a6a3def4e34b5a8d1e225685e40b03de81c105ef3511710247388b7dbe0bc80d0e9534337e91d3d60062206bc27d1b8ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c16dc7ee42d7430854cf2ca01a8b24a37019a48062b99769ee7dcefc7d922cfebba5f7c51f664ac8a6a6440172d57fdea78730226cd3251610efed8f67adab"} 16:39:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:23 INFO - Copying logs to upload dir... 16:39:23 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.496182 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-14 16:39:23.036545) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 16:39:23.039932) ========= 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=eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353 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/590c944c37e16381810419a291ab8e9bbb561954f6b06690a2799bc4525d4e9d9afb4649aa8ee7c7ba1debd54ee60dc6c637be92e2d02093bea4315bfd6c9332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75e18323dec5bc6ebfaa6fb10154089a6a3def4e34b5a8d1e225685e40b03de81c105ef3511710247388b7dbe0bc80d0e9534337e91d3d60062206bc27d1b8ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c16dc7ee42d7430854cf2ca01a8b24a37019a48062b99769ee7dcefc7d922cfebba5f7c51f664ac8a6a6440172d57fdea78730226cd3251610efed8f67adab"} build_url:https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/QuMqrqqbQWqSrrk3rd1fRg/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/590c944c37e16381810419a291ab8e9bbb561954f6b06690a2799bc4525d4e9d9afb4649aa8ee7c7ba1debd54ee60dc6c637be92e2d02093bea4315bfd6c9332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/75e18323dec5bc6ebfaa6fb10154089a6a3def4e34b5a8d1e225685e40b03de81c105ef3511710247388b7dbe0bc80d0e9534337e91d3d60062206bc27d1b8ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14c16dc7ee42d7430854cf2ca01a8b24a37019a48062b99769ee7dcefc7d922cfebba5f7c51f664ac8a6a6440172d57fdea78730226cd3251610efed8f67adab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 16:39:23.064802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:39:23.065112) ========= 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=eca2ab57546de7b41f256b19000001ef-1465944083.408171-294434353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 16:39:23.148663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 16:39:23.149259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 16:39:23.149880) ========= ========= Total master_lag: 0.17 =========