builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1466205364.54 results: success (0) buildid: 20160617133046 builduid: 2c36dd6d609f4f318a2f3c24dd8aa725 revision: c583dc0f3f4a2fd3e0d4b478a599c1f613085d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.538793) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.539288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.539763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.601388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.601703) ========= 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=62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 16:16:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 123M=0s 2016-06-17 16:16:05 (123 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128448 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.744435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.744760) ========= 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=62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:04.794343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-17 16:16:04.794703) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c583dc0f3f4a2fd3e0d4b478a599c1f613085d52 --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 c583dc0f3f4a2fd3e0d4b478a599c1f613085d52 --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=62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 16:16:05,848 truncating revision to first 12 chars 2016-06-17 16:16:05,848 Setting DEBUG logging. 2016-06-17 16:16:05,848 attempt 1/10 2016-06-17 16:16:05,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c583dc0f3f4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 16:16:07,191 unpacking tar archive at: mozilla-inbound-c583dc0f3f4a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.690614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-17 16:16:06.498873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:06.499182) ========= script_repo_revision: c583dc0f3f4a2fd3e0d4b478a599c1f613085d52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:06.499605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:06.499881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 16:16:06.513078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-17 16:16:06.513468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:16:07 INFO - MultiFileLogger online at 20160617 16:16:07 in /builds/slave/test 16:16:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:16:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:16:07 INFO - {'append_to_log': False, 16:16:07 INFO - 'base_work_dir': '/builds/slave/test', 16:16:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:16:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:16:07 INFO - 'branch': 'Mozilla-Inbound', 16:16:07 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:07 INFO - 'config_files': ('talos/linux_config.py',), 16:16:07 INFO - 'default_actions': ('clobber', 16:16:07 INFO - 'read-buildbot-config', 16:16:07 INFO - 'download-and-extract', 16:16:07 INFO - 'populate-webroot', 16:16:07 INFO - 'create-virtualenv', 16:16:07 INFO - 'install', 16:16:07 INFO - 'run-tests'), 16:16:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:07 INFO - 'download_minidump_stackwalk': True, 16:16:07 INFO - 'download_symbols': 'ondemand', 16:16:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:07 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:07 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:07 INFO - 'installer_path': 'installer.exe', 16:16:07 INFO - 'log_level': 'info', 16:16:07 INFO - 'log_name': 'talos', 16:16:07 INFO - 'log_to_console': True, 16:16:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:16:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:16:07 INFO - 'opt_config_files': (), 16:16:07 INFO - 'pip_index': False, 16:16:07 INFO - 'sps_profile': False, 16:16:07 INFO - 'sps_profile_interval': 0, 16:16:07 INFO - 'suite': 'dromaeojs', 16:16:07 INFO - 'system_bits': '32', 16:16:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:07 INFO - 'title': 'talos-linux64-ix-018', 16:16:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:07 INFO - 'use_talos_json': True, 16:16:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:16:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:07 INFO - 'work_dir': 'build'} 16:16:07 INFO - ##### 16:16:07 INFO - ##### Running clobber step. 16:16:07 INFO - ##### 16:16:07 INFO - Running pre-action listener: _resource_record_pre_action 16:16:07 INFO - Running main action method: clobber 16:16:07 INFO - rmtree: /builds/slave/test/build 16:16:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:08 INFO - Running post-action listener: _resource_record_post_action 16:16:08 INFO - ##### 16:16:08 INFO - ##### Finished clobber step (success) 16:16:08 INFO - ##### 16:16:08 INFO - ##### 16:16:08 INFO - ##### Running read-buildbot-config step. 16:16:08 INFO - ##### 16:16:08 INFO - Running pre-action listener: _resource_record_pre_action 16:16:08 INFO - Running main action method: read_buildbot_config 16:16:08 INFO - Using buildbot properties: 16:16:08 INFO - { 16:16:08 INFO - "project": "", 16:16:08 INFO - "product": "firefox", 16:16:08 INFO - "script_repo_revision": "production", 16:16:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:16:08 INFO - "repository": "", 16:16:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:16:08 INFO - "buildid": "20160617133046", 16:16:08 INFO - "pgo_build": "True", 16:16:08 INFO - "basedir": "/builds/slave/test", 16:16:08 INFO - "buildnumber": 1198, 16:16:08 INFO - "slavename": "talos-linux64-ix-018", 16:16:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:16:08 INFO - "platform": "ubuntu64_hw", 16:16:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:16:08 INFO - "branch": "mozilla-inbound", 16:16:08 INFO - "repo_path": "integration/mozilla-inbound", 16:16:08 INFO - "revision": "c583dc0f3f4a2fd3e0d4b478a599c1f613085d52", 16:16:08 INFO - "stage_platform": "linux64-pgo", 16:16:08 INFO - "builduid": "2c36dd6d609f4f318a2f3c24dd8aa725", 16:16:08 INFO - "slavebuilddir": "test" 16:16:08 INFO - } 16:16:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:16:08 INFO - Running post-action listener: _resource_record_post_action 16:16:08 INFO - ##### 16:16:08 INFO - ##### Finished read-buildbot-config step (success) 16:16:08 INFO - ##### 16:16:08 INFO - ##### 16:16:08 INFO - ##### Running download-and-extract step. 16:16:08 INFO - ##### 16:16:08 INFO - Running pre-action listener: _resource_record_pre_action 16:16:08 INFO - Running main action method: download_and_extract 16:16:08 INFO - mkdir: /builds/slave/test/build/tests 16:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:08 INFO - https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:09 INFO - Downloaded 1361 bytes. 16:16:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:09 INFO - Using the following test package requirements: 16:16:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:16:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:16:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'jsshell-linux-x86_64.zip'], 16:16:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:16:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:16:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:16:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:16:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:16:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:09 INFO - https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:10 INFO - Downloaded 24221045 bytes. 16:16:10 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:16:10 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:16:12 INFO - Return code: 0 16:16:12 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:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:12 INFO - https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:13 INFO - Downloaded 24221045 bytes. 16:16:13 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:16:13 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:16:14 INFO - Return code: 0 16:16: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:16:14 INFO - https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:15 INFO - Downloaded 14405384 bytes. 16:16:15 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:16:15 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:16:15 INFO - Return code: 0 16:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:15 INFO - https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/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:16:17 INFO - Downloaded 60121442 bytes. 16:16:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:17 INFO - mkdir: /builds/slave/test/properties 16:16:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:17 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:17 INFO - Contents: 16:16:17 INFO - build_url:https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:18 INFO - Running post-action listener: _resource_record_post_action 16:16:18 INFO - Running post-action listener: set_extra_try_arguments 16:16:18 INFO - ##### 16:16:18 INFO - ##### Finished download-and-extract step (success) 16:16:18 INFO - ##### 16:16:18 INFO - ##### 16:16:18 INFO - ##### Running populate-webroot step. 16:16:18 INFO - ##### 16:16:18 INFO - Running pre-action listener: _resource_record_pre_action 16:16:18 INFO - Running main action method: populate_webroot 16:16:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:18 INFO - '--tppagecycles', 16:16:18 INFO - '7'], 16:16:18 INFO - 'tests': ['tsvgm']}}, 16:16:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:16:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:16:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:16:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['damp', 'tps']}, 16:16:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'tests': ['damp', 'tps']}, 16:16:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['dromaeo_dom']}, 16:16:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['basic_compositor_video']}, 16:16:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:16:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['a11yr', 16:16:18 INFO - 'ts_paint', 16:16:18 INFO - 'tpaint', 16:16:18 INFO - 'sessionrestore', 16:16:18 INFO - 'sessionrestore_no_auto_restore', 16:16:18 INFO - 'tabpaint']}, 16:16:18 INFO - 'other-e10s': {'tests': ['a11yr', 16:16:18 INFO - 'ts_paint', 16:16:18 INFO - 'tpaint', 16:16:18 INFO - 'sessionrestore', 16:16:18 INFO - 'sessionrestore_no_auto_restore', 16:16:18 INFO - 'tabpaint']}, 16:16:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:16:18 INFO - 'ts_paint', 16:16:18 INFO - 'tpaint', 16:16:18 INFO - 'sessionrestore', 16:16:18 INFO - 'sessionrestore_no_auto_restore', 16:16:18 INFO - 'tabpaint']}, 16:16:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:16:18 INFO - 'ts_paint', 16:16:18 INFO - 'tpaint', 16:16:18 INFO - 'sessionrestore', 16:16:18 INFO - 'sessionrestore_no_auto_restore', 16:16:18 INFO - 'tabpaint']}, 16:16:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['a11yr', 16:16:18 INFO - 'ts_paint', 16:16:18 INFO - 'tpaint', 16:16:18 INFO - 'sessionrestore', 16:16:18 INFO - 'sessionrestore_no_auto_restore', 16:16:18 INFO - 'tabpaint']}, 16:16:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['a11yr', 16:16:18 INFO - 'ts_paint', 16:16:18 INFO - 'tpaint', 16:16:18 INFO - 'sessionrestore', 16:16:18 INFO - 'sessionrestore_no_auto_restore', 16:16:18 INFO - 'tabpaint']}, 16:16:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['tsvgx', 16:16:18 INFO - 'tsvgr_opacity', 16:16:18 INFO - 'tart', 16:16:18 INFO - 'tscrollx', 16:16:18 INFO - 'cart']}, 16:16:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:16:18 INFO - 'tsvgr_opacity', 16:16:18 INFO - 'tart', 16:16:18 INFO - 'tscrollx', 16:16:18 INFO - 'cart']}, 16:16:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'talos_options': ['--disable-e10s'], 16:16:18 INFO - 'tests': ['tp5o']}, 16:16:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'tests': ['tp5o']}, 16:16:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'talos_options': ['--disable-e10s', 16:16:18 INFO - '--xperf_path', 16:16:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:18 INFO - 'tests': ['tp5n']}, 16:16:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:18 INFO - 'talos_options': ['--xperf_path', 16:16:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:18 INFO - 'tests': ['tp5n']}}, 16:16:18 INFO - 'talos.zip': {'path': '', 16:16:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:18 INFO - Running post-action listener: _resource_record_post_action 16:16:18 INFO - ##### 16:16:18 INFO - ##### Finished populate-webroot step (success) 16:16:18 INFO - ##### 16:16:18 INFO - ##### 16:16:18 INFO - ##### Running create-virtualenv step. 16:16:18 INFO - ##### 16:16:18 INFO - Running pre-action listener: _resource_record_pre_action 16:16:18 INFO - Running main action method: create_virtualenv 16:16:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:18 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:16:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:18 INFO - Using real prefix '/usr' 16:16:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:20 INFO - Installing pip.................done. 16:16:20 INFO - Return code: 0 16:16:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:20 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:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:20 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:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:20 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:20 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:16:20 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:16:20 INFO - Using env: {'DISPLAY': ':0', 16:16:20 INFO - 'HOME': '/home/cltbld', 16:16:20 INFO - 'LANG': 'en_US.UTF-8', 16:16:20 INFO - 'LANGUAGE': 'en_US:en', 16:16:20 INFO - 'LOGNAME': 'cltbld', 16:16:20 INFO - 'MAIL': '/var/mail/cltbld', 16:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:20 INFO - 'MOZ_NO_REMOTE': '1', 16:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:20 INFO - 'NO_EM_RESTART': '1', 16:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:20 INFO - 'PWD': '/builds/slave/test', 16:16:20 INFO - 'SHELL': '/bin/bash', 16:16:20 INFO - 'SHLVL': '1', 16:16:20 INFO - 'TERM': 'linux', 16:16:20 INFO - 'TMOUT': '86400', 16:16:20 INFO - 'USER': 'cltbld', 16:16:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:20 INFO - '_': '/tools/buildbot/bin/python'} 16:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:20 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:16:20 INFO - Cleaning up... 16:16:20 INFO - Return code: 0 16:16:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:20 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:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:20 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:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:20 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:20 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:16:20 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:16:20 INFO - Using env: {'DISPLAY': ':0', 16:16:20 INFO - 'HOME': '/home/cltbld', 16:16:20 INFO - 'LANG': 'en_US.UTF-8', 16:16:20 INFO - 'LANGUAGE': 'en_US:en', 16:16:20 INFO - 'LOGNAME': 'cltbld', 16:16:20 INFO - 'MAIL': '/var/mail/cltbld', 16:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:20 INFO - 'MOZ_NO_REMOTE': '1', 16:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:20 INFO - 'NO_EM_RESTART': '1', 16:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:20 INFO - 'PWD': '/builds/slave/test', 16:16:20 INFO - 'SHELL': '/bin/bash', 16:16:20 INFO - 'SHLVL': '1', 16:16:20 INFO - 'TERM': 'linux', 16:16:20 INFO - 'TMOUT': '86400', 16:16:20 INFO - 'USER': 'cltbld', 16:16:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:20 INFO - '_': '/tools/buildbot/bin/python'} 16:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:21 INFO - Downloading/unpacking psutil>=3.1.1 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:23 INFO - Installing collected packages: psutil 16:16:23 INFO - Running setup.py install for psutil 16:16:23 INFO - building 'psutil._psutil_linux' extension 16:16:23 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:16:23 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:16:23 INFO - building 'psutil._psutil_posix' extension 16:16:23 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:16:23 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:16:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:23 INFO - Successfully installed psutil 16:16:23 INFO - Cleaning up... 16:16:23 INFO - Return code: 0 16:16:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16:23 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:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:23 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:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:23 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:23 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:16:23 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:16:23 INFO - Using env: {'DISPLAY': ':0', 16:16:23 INFO - 'HOME': '/home/cltbld', 16:16:23 INFO - 'LANG': 'en_US.UTF-8', 16:16:23 INFO - 'LANGUAGE': 'en_US:en', 16:16:23 INFO - 'LOGNAME': 'cltbld', 16:16:23 INFO - 'MAIL': '/var/mail/cltbld', 16:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:23 INFO - 'MOZ_NO_REMOTE': '1', 16:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:23 INFO - 'NO_EM_RESTART': '1', 16:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:23 INFO - 'PWD': '/builds/slave/test', 16:16:23 INFO - 'SHELL': '/bin/bash', 16:16:23 INFO - 'SHLVL': '1', 16:16:23 INFO - 'TERM': 'linux', 16:16:23 INFO - 'TMOUT': '86400', 16:16:23 INFO - 'USER': 'cltbld', 16:16:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:23 INFO - '_': '/tools/buildbot/bin/python'} 16:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16:23 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:16:23 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:16:23 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:16:23 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:16:23 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:16:23 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:16:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:25 INFO - Installing collected packages: mozsystemmonitor 16:16:25 INFO - Running setup.py install for mozsystemmonitor 16:16:25 INFO - Successfully installed mozsystemmonitor 16:16:25 INFO - Cleaning up... 16:16:26 INFO - Return code: 0 16:16:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:16:26 INFO - Using env: {'DISPLAY': ':0', 16:16:26 INFO - 'HOME': '/home/cltbld', 16:16:26 INFO - 'LANG': 'en_US.UTF-8', 16:16:26 INFO - 'LANGUAGE': 'en_US:en', 16:16:26 INFO - 'LOGNAME': 'cltbld', 16:16:26 INFO - 'MAIL': '/var/mail/cltbld', 16:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:26 INFO - 'MOZ_NO_REMOTE': '1', 16:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:26 INFO - 'NO_EM_RESTART': '1', 16:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:26 INFO - 'PWD': '/builds/slave/test', 16:16:26 INFO - 'SHELL': '/bin/bash', 16:16:26 INFO - 'SHLVL': '1', 16:16:26 INFO - 'TERM': 'linux', 16:16:26 INFO - 'TMOUT': '86400', 16:16:26 INFO - 'USER': 'cltbld', 16:16:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:26 INFO - '_': '/tools/buildbot/bin/python'} 16:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:26 INFO - Downloading/unpacking jsonschema==2.5.1 16:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:28 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:28 INFO - warning: no files found matching '*.txt' 16:16:28 INFO - no previously-included directories found matching 'build' 16:16:28 INFO - no previously-included directories found matching 'dist' 16:16:28 INFO - no previously-included directories found matching '.git*' 16:16:28 INFO - Installing collected packages: jsonschema, functools32 16:16:28 INFO - Running setup.py install for functools32 16:16:28 INFO - warning: no files found matching '*.txt' 16:16:28 INFO - no previously-included directories found matching 'build' 16:16:28 INFO - no previously-included directories found matching 'dist' 16:16:28 INFO - no previously-included directories found matching '.git*' 16:16:28 INFO - Successfully installed jsonschema functools32 16:16:28 INFO - Cleaning up... 16:16:28 INFO - Return code: 0 16:16:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:16:28 INFO - Using env: {'DISPLAY': ':0', 16:16:28 INFO - 'HOME': '/home/cltbld', 16:16:28 INFO - 'LANG': 'en_US.UTF-8', 16:16:28 INFO - 'LANGUAGE': 'en_US:en', 16:16:28 INFO - 'LOGNAME': 'cltbld', 16:16:28 INFO - 'MAIL': '/var/mail/cltbld', 16:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:28 INFO - 'MOZ_NO_REMOTE': '1', 16:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:28 INFO - 'NO_EM_RESTART': '1', 16:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:28 INFO - 'PWD': '/builds/slave/test', 16:16:28 INFO - 'SHELL': '/bin/bash', 16:16:28 INFO - 'SHLVL': '1', 16:16:28 INFO - 'TERM': 'linux', 16:16:28 INFO - 'TMOUT': '86400', 16:16:28 INFO - 'USER': 'cltbld', 16:16:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:28 INFO - '_': '/tools/buildbot/bin/python'} 16:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:31 INFO - Downloading docopt-0.6.1.tar.gz 16:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:31 INFO - Running setup.py install for blobuploader 16:16:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:31 INFO - Running setup.py install for requests 16:16:32 INFO - Running setup.py install for docopt 16:16:32 INFO - Successfully installed blobuploader requests docopt 16:16:32 INFO - Cleaning up... 16:16:32 INFO - Return code: 0 16:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:32 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:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:32 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:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:32 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:32 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:16:32 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:16:32 INFO - Using env: {'DISPLAY': ':0', 16:16:32 INFO - 'HOME': '/home/cltbld', 16:16:32 INFO - 'LANG': 'en_US.UTF-8', 16:16:32 INFO - 'LANGUAGE': 'en_US:en', 16:16:32 INFO - 'LOGNAME': 'cltbld', 16:16:32 INFO - 'MAIL': '/var/mail/cltbld', 16:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:32 INFO - 'MOZ_NO_REMOTE': '1', 16:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:32 INFO - 'NO_EM_RESTART': '1', 16:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:32 INFO - 'PWD': '/builds/slave/test', 16:16:32 INFO - 'SHELL': '/bin/bash', 16:16:32 INFO - 'SHLVL': '1', 16:16:32 INFO - 'TERM': 'linux', 16:16:32 INFO - 'TMOUT': '86400', 16:16:32 INFO - 'USER': 'cltbld', 16:16:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:32 INFO - '_': '/tools/buildbot/bin/python'} 16:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:32 INFO - Running setup.py (path:/tmp/pip-Ur0BaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:32 INFO - Running setup.py (path:/tmp/pip-YqtqQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:32 INFO - Running setup.py (path:/tmp/pip-9dPOL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:32 INFO - Running setup.py (path:/tmp/pip-jXiYxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:32 INFO - Running setup.py (path:/tmp/pip-gIq1MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:32 INFO - Running setup.py (path:/tmp/pip-62sdvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:32 INFO - Running setup.py (path:/tmp/pip-z_Ve9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:32 INFO - Running setup.py (path:/tmp/pip-kDuMTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:32 INFO - Running setup.py (path:/tmp/pip-Ilyadw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:33 INFO - Running setup.py (path:/tmp/pip-KQ6K1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:33 INFO - Running setup.py (path:/tmp/pip-RAdu2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:33 INFO - Running setup.py (path:/tmp/pip-sFiGvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:33 INFO - Running setup.py (path:/tmp/pip-xJfG3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:33 INFO - Running setup.py (path:/tmp/pip-CqvP2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:33 INFO - Running setup.py (path:/tmp/pip-ntv_IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:33 INFO - Running setup.py (path:/tmp/pip-hse2pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:33 INFO - Running setup.py (path:/tmp/pip-itpACu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:33 INFO - Running setup.py install for manifestparser 16:16:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:33 INFO - Running setup.py install for mozcrash 16:16:33 INFO - Running setup.py install for mozdebug 16:16:33 INFO - Running setup.py install for mozdevice 16:16:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for mozfile 16:16:34 INFO - Running setup.py install for mozhttpd 16:16:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for mozinfo 16:16:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for mozInstall 16:16:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for mozleak 16:16:34 INFO - Running setup.py install for mozlog 16:16:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for moznetwork 16:16:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for mozprocess 16:16:34 INFO - Running setup.py install for mozprofile 16:16:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:34 INFO - Running setup.py install for mozrunner 16:16:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:35 INFO - Running setup.py install for mozscreenshot 16:16:35 INFO - Running setup.py install for moztest 16:16:35 INFO - Running setup.py install for mozversion 16:16:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:35 INFO - Cleaning up... 16:16:35 INFO - Return code: 0 16:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:35 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:35 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:16:35 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:16:35 INFO - Using env: {'DISPLAY': ':0', 16:16:35 INFO - 'HOME': '/home/cltbld', 16:16:35 INFO - 'LANG': 'en_US.UTF-8', 16:16:35 INFO - 'LANGUAGE': 'en_US:en', 16:16:35 INFO - 'LOGNAME': 'cltbld', 16:16:35 INFO - 'MAIL': '/var/mail/cltbld', 16:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:35 INFO - 'MOZ_NO_REMOTE': '1', 16:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:35 INFO - 'NO_EM_RESTART': '1', 16:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:35 INFO - 'PWD': '/builds/slave/test', 16:16:35 INFO - 'SHELL': '/bin/bash', 16:16:35 INFO - 'SHLVL': '1', 16:16:35 INFO - 'TERM': 'linux', 16:16:35 INFO - 'TMOUT': '86400', 16:16:35 INFO - 'USER': 'cltbld', 16:16:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:35 INFO - '_': '/tools/buildbot/bin/python'} 16:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:35 INFO - Running setup.py (path:/tmp/pip-NKwFjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:35 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:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:35 INFO - Running setup.py (path:/tmp/pip-bUX0Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:35 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:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:35 INFO - Running setup.py (path:/tmp/pip-Vgh9YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:35 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:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:35 INFO - Running setup.py (path:/tmp/pip-1aOWSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:35 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:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:35 INFO - Running setup.py (path:/tmp/pip-yiLDSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:35 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:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:35 INFO - Running setup.py (path:/tmp/pip-6s5PgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:36 INFO - Running setup.py (path:/tmp/pip-wJgSEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:36 INFO - Running setup.py (path:/tmp/pip-r2172b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:36 INFO - Running setup.py (path:/tmp/pip-30nMsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:36 INFO - Running setup.py (path:/tmp/pip-DVU91v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:36 INFO - Running setup.py (path:/tmp/pip-yl3c0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:36 INFO - Running setup.py (path:/tmp/pip-pQ9aV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:36 INFO - Running setup.py (path:/tmp/pip-kbiU_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:36 INFO - Running setup.py (path:/tmp/pip-UMklON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:36 INFO - Running setup.py (path:/tmp/pip-PL4vjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:36 INFO - Running setup.py (path:/tmp/pip-JmN_SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:36 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:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:36 INFO - Running setup.py (path:/tmp/pip-MKw7Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:36 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:16:36 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:16:36 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:16:36 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:16:36 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:16:36 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:16:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:36 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:16:36 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:16:36 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:16:36 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:16:36 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:16:36 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:16:38 INFO - Downloading blessings-1.6.tar.gz 16:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:38 INFO - Installing collected packages: blessings 16:16:38 INFO - Running setup.py install for blessings 16:16:38 INFO - Successfully installed blessings 16:16:38 INFO - Cleaning up... 16:16:39 INFO - Return code: 0 16:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:39 INFO - Reading from file tmpfile_stdout 16:16:39 INFO - Current package versions: 16:16:39 INFO - argparse == 1.2.1 16:16:39 INFO - blessings == 1.6 16:16:39 INFO - blobuploader == 1.2.4 16:16:39 INFO - docopt == 0.6.1 16:16:39 INFO - functools32 == 3.2.3-2 16:16:39 INFO - jsonschema == 2.5.1 16:16:39 INFO - manifestparser == 1.1 16:16:39 INFO - mozInstall == 1.12 16:16:39 INFO - mozcrash == 0.17 16:16:39 INFO - mozdebug == 0.1 16:16:39 INFO - mozdevice == 0.48 16:16:39 INFO - mozfile == 1.2 16:16:39 INFO - mozhttpd == 0.7 16:16:39 INFO - mozinfo == 0.9 16:16:39 INFO - mozleak == 0.1 16:16:39 INFO - mozlog == 3.2 16:16:39 INFO - moznetwork == 0.27 16:16:39 INFO - mozprocess == 0.22 16:16:39 INFO - mozprofile == 0.28 16:16:39 INFO - mozrunner == 6.11 16:16:39 INFO - mozscreenshot == 0.1 16:16:39 INFO - mozsystemmonitor == 0.3 16:16:39 INFO - moztest == 0.7 16:16:39 INFO - mozversion == 1.4 16:16:39 INFO - psutil == 3.1.1 16:16:39 INFO - requests == 1.2.3 16:16:39 INFO - wsgiref == 0.1.2 16:16:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:39 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:39 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:16:39 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:16:39 INFO - Using env: {'DISPLAY': ':0', 16:16:39 INFO - 'HOME': '/home/cltbld', 16:16:39 INFO - 'LANG': 'en_US.UTF-8', 16:16:39 INFO - 'LANGUAGE': 'en_US:en', 16:16:39 INFO - 'LOGNAME': 'cltbld', 16:16:39 INFO - 'MAIL': '/var/mail/cltbld', 16:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:39 INFO - 'MOZ_NO_REMOTE': '1', 16:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:39 INFO - 'NO_EM_RESTART': '1', 16:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:39 INFO - 'PWD': '/builds/slave/test', 16:16:39 INFO - 'SHELL': '/bin/bash', 16:16:39 INFO - 'SHLVL': '1', 16:16:39 INFO - 'TERM': 'linux', 16:16:39 INFO - 'TMOUT': '86400', 16:16:39 INFO - 'USER': 'cltbld', 16:16:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:39 INFO - '_': '/tools/buildbot/bin/python'} 16:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 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:16:39 INFO - Cleaning up... 16:16:39 INFO - Return code: 0 16:16:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:39 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:39 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:16:39 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:16:39 INFO - Using env: {'DISPLAY': ':0', 16:16:39 INFO - 'HOME': '/home/cltbld', 16:16:39 INFO - 'LANG': 'en_US.UTF-8', 16:16:39 INFO - 'LANGUAGE': 'en_US:en', 16:16:39 INFO - 'LOGNAME': 'cltbld', 16:16:39 INFO - 'MAIL': '/var/mail/cltbld', 16:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:39 INFO - 'MOZ_NO_REMOTE': '1', 16:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:39 INFO - 'NO_EM_RESTART': '1', 16:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:39 INFO - 'PWD': '/builds/slave/test', 16:16:39 INFO - 'SHELL': '/bin/bash', 16:16:39 INFO - 'SHLVL': '1', 16:16:39 INFO - 'TERM': 'linux', 16:16:39 INFO - 'TMOUT': '86400', 16:16:39 INFO - 'USER': 'cltbld', 16:16:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:39 INFO - '_': '/tools/buildbot/bin/python'} 16:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:16:39 INFO - Cleaning up... 16:16:39 INFO - Return code: 0 16:16:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:39 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 0x7f7d8df59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, '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': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', '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:16:39 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:16:39 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:16:39 INFO - Using env: {'DISPLAY': ':0', 16:16:39 INFO - 'HOME': '/home/cltbld', 16:16:39 INFO - 'LANG': 'en_US.UTF-8', 16:16:39 INFO - 'LANGUAGE': 'en_US:en', 16:16:39 INFO - 'LOGNAME': 'cltbld', 16:16:39 INFO - 'MAIL': '/var/mail/cltbld', 16:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:39 INFO - 'MOZ_NO_REMOTE': '1', 16:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:39 INFO - 'NO_EM_RESTART': '1', 16:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:39 INFO - 'PWD': '/builds/slave/test', 16:16:39 INFO - 'SHELL': '/bin/bash', 16:16:39 INFO - 'SHLVL': '1', 16:16:39 INFO - 'TERM': 'linux', 16:16:39 INFO - 'TMOUT': '86400', 16:16:39 INFO - 'USER': 'cltbld', 16:16:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:39 INFO - '_': '/tools/buildbot/bin/python'} 16:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:39 INFO - Downloading/unpacking flake8 16:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:16:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:16:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 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:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:16:42 INFO - no previously-included directories found matching 'docs/_build' 16:16:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:16:42 INFO - Running setup.py install for pep8 16:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:16:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:16:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:16:42 INFO - no previously-included directories found matching 'docs/_build' 16:16:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:16:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:16:42 INFO - Cleaning up... 16:16:42 INFO - Return code: 0 16:16:42 INFO - Running post-action listener: _resource_record_post_action 16:16:42 INFO - Running post-action listener: _start_resource_monitoring 16:16:42 INFO - Starting resource monitoring. 16:16:42 INFO - ##### 16:16:42 INFO - ##### Finished create-virtualenv step (success) 16:16:42 INFO - ##### 16:16:42 INFO - ##### 16:16:42 INFO - ##### Running install step. 16:16:42 INFO - ##### 16:16:42 INFO - Running pre-action listener: _resource_record_pre_action 16:16:42 INFO - Running main action method: install 16:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:43 INFO - Reading from file tmpfile_stdout 16:16:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:43 INFO - Reading from file tmpfile_stdout 16:16:43 INFO - Output received: 16:16:43 INFO - Usage: mozinstall [options] installer 16:16:43 INFO - Options: 16:16:43 INFO - -h, --help show this help message and exit 16:16:43 INFO - -d DEST, --destination=DEST 16:16:43 INFO - Directory to install application into. [default: 16:16:43 INFO - "/builds/slave/test"] 16:16:43 INFO - --app=APP Application being installed. [default: firefox] 16:16:43 INFO - mkdir: /builds/slave/test/build/application 16:16:43 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:16:43 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:17:00 INFO - Reading from file tmpfile_stdout 16:17:00 INFO - Output received: 16:17:00 INFO - /builds/slave/test/build/application/firefox/firefox 16:17:00 INFO - Running post-action listener: _resource_record_post_action 16:17:00 INFO - ##### 16:17:00 INFO - ##### Finished install step (success) 16:17:00 INFO - ##### 16:17:00 INFO - ##### 16:17:00 INFO - ##### Running run-tests step. 16:17:00 INFO - ##### 16:17:00 INFO - Running pre-action listener: _resource_record_pre_action 16:17:00 INFO - Running main action method: run_tests 16:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:00 INFO - Python 2.7.3 16:17:00 INFO - Return code: 0 16:17:00 INFO - grabbing minidump binary from tooltool 16:17:00 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:17:00 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 0x2b121c0>, '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 0x2b130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b13550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:00 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:17:00 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:17:00 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:17:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:00 INFO - Return code: 0 16:17:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:17:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:17:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:17:01 INFO - Return code: 0 16:17:01 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:17:01 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:17:01 INFO - Using env: {'DISPLAY': ':0', 16:17:01 INFO - 'HOME': '/home/cltbld', 16:17:01 INFO - 'LANG': 'en_US.UTF-8', 16:17:01 INFO - 'LANGUAGE': 'en_US:en', 16:17:01 INFO - 'LOGNAME': 'cltbld', 16:17:01 INFO - 'MAIL': '/var/mail/cltbld', 16:17:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:01 INFO - 'MOZ_NO_REMOTE': '1', 16:17:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:01 INFO - 'NO_EM_RESTART': '1', 16:17:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:01 INFO - 'PWD': '/builds/slave/test', 16:17:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:01 INFO - 'SHELL': '/bin/bash', 16:17:01 INFO - 'SHLVL': '1', 16:17:01 INFO - 'TERM': 'linux', 16:17:01 INFO - 'TMOUT': '86400', 16:17:01 INFO - 'USER': 'cltbld', 16:17:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179', 16:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:01 INFO - '_': '/tools/buildbot/bin/python'} 16:17:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:17:01 INFO - mozversion application_buildid: 20160617133046 16:17:01 INFO - mozversion application_changeset: c583dc0f3f4a2fd3e0d4b478a599c1f613085d52 16:17:01 INFO - mozversion application_display_name: Nightly 16:17:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:01 INFO - mozversion application_name: Firefox 16:17:01 INFO - mozversion application_remotingname: firefox 16:17:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:17:01 INFO - mozversion application_vendor: Mozilla 16:17:01 INFO - mozversion application_version: 50.0a1 16:17:01 INFO - mozversion platform_buildid: 20160617133046 16:17:01 INFO - mozversion platform_changeset: c583dc0f3f4a2fd3e0d4b478a599c1f613085d52 16:17:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:17:01 INFO - mozversion platform_version: 50.0a1 16:17:01 INFO - using testdate: 1466205421 16:17:01 INFO - actual date: 1466205421 16:17:01 INFO - starting webserver on 'localhost:49315' 16:17:01 INFO - SUITE-START | Running 2 tests 16:17:01 INFO - TEST-START | dromaeo_css 16:17:01 INFO - operating with platform_type : linux_ 16:17:01 INFO - Initialising browser for dromaeo_css test... 16:17:01 INFO - TEST-INFO | started process 13526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWkTcAV/profile http://localhost:49315/getInfo.html) 16:17:05 INFO - PROCESS | 13526 | __metrics Screen width/height:1600/1200 16:17:05 INFO - PROCESS | 13526 | colorDepth:24 16:17:05 INFO - PROCESS | 13526 | Browser inner width/height: 1024/697 16:17:05 INFO - PROCESS | 13526 | __metrics 16:17:06 INFO - PROCESS | 13526 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:17:07 INFO - TEST-INFO | 13526: exit 0 16:17:07 INFO - Browser initialized. 16:17:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:07 INFO - TEST-INFO | started process 13606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWkTcAV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:19 INFO - PROCESS | 13606 | RSS: Main: 174354432 16:17:19 INFO - PROCESS | 13606 | 16:18:10 INFO - PROCESS | 13606 | 1466205490713 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:20:18 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49315/tests/dromaeo/cssquery-ext.html) 16:20:19 INFO - PROCESS | 13606 | RSS: Main: 299253760 16:20:19 INFO - PROCESS | 13606 | 16:23:22 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-ext.html (next: http://localhost:49315/tests/dromaeo/cssquery-jquery.html) 16:23:23 INFO - PROCESS | 13606 | RSS: Main: 260440064 16:23:23 INFO - PROCESS | 13606 | 16:26:25 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49315/tests/dromaeo/cssquery-mootools.html) 16:26:25 INFO - PROCESS | 13606 | RSS: Main: 261443584 16:26:25 INFO - PROCESS | 13606 | 16:29:27 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49315/tests/dromaeo/cssquery-prototype.html) 16:29:28 INFO - PROCESS | 13606 | RSS: Main: 256569344 16:29:28 INFO - PROCESS | 13606 | 16:32:30 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49315/tests/dromaeo/cssquery-yui.html) 16:32:31 INFO - PROCESS | 13606 | RSS: Main: 227868672 16:32:31 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | Cycle 1(1): loaded http://localhost:49315/tests/dromaeo/cssquery-yui.html (next: http://localhost:49315/tests/dromaeo/cssquery-dojo.html) 16:35:34 INFO - PROCESS | 13606 | RSS: Main: 290430976 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | __start_tp_report 16:35:34 INFO - PROCESS | 13606 | _x_x_mozilla_page_load 16:35:34 INFO - PROCESS | 13606 | _x_x_mozilla_page_load_details 16:35:34 INFO - PROCESS | 13606 | |i|pagename|runs| 16:35:34 INFO - PROCESS | 13606 | |0;dojo.html;3107.316390394114;3107.3474570340227;3138;3154.1168472827617;3175.317306779042;5310.654807437523;5342.412334643191;5372.247885296062;5477.260569823073;5481.040817856869;5337.279467271917;5339.866503337418;5432.70120143392;5482.451754824526;5489.807856725015;4791.2334026555845;4878.926816097762;4896.216605343146;4899.265110233458;5150.536451719345;5045.419776725668;5046.520580544842;5075.441701412841;5090.414602320743;5108.565771909392;4818.975905120469;4824.686395384307;4875.829345972892;4898.608111351084;4943.060818444484;4911.68074075184;4915.115279249733;4915.827946021872;4980.103581355354;5018.749062546858;4920.975395123037;4949.430815456197;4961.479044700291;4967.652264341497;5001.199808030734;5320.654157479751;5355.196720491918;5413.404525502192;5421.322334708161;5457.590680698963;5824.563157763142;5826.941730582682;5833;5857.941420585825;5878.382769809151;5660.915086273709;5870.501007414375;5913.231279933581;5920.615160014585;5925.407459254083;5346.198070289449;5398.703071331075;5412.891742165174;5475.397706252309;5478.45215478453;5959.165716799652;5971.820845374646;5974.492168165668;5977.790777322773;5978.760849565969;5603.887922241533;5653;5763.971180144073;5790.913136302875;5791.131330300489;5758.424157584208;5801;5816.505597024216;5819.73811178498;5820.592558520862;5764.394738552475;5803.390643982406;5814.30228372598;5816.098504731774;5816.854578635568;5814.04068328721;5831.358550559435;5832.562557808182;5834.5624078194305;5838.67887266196;4416.3596278539435;4471.329300604935;4478.193925093449;4484.990877052637;4485.035717320791;3965.841366345314;3971.8808435746973;3985.740926839746;3996.820143093568;4004.1391100913443;5475.09660905954;5488.204210389471;5489.34127904654;5493.066178749622;5536.086545719992;5648.322201335784;5703.857403564944;5707.229524014288;5760.94239057604;5856.12158176277;5408.1887716842;5413.377461591888;5413.83758487246;5423.593230507728;5457.836264912059;4995.900081998339;4997.9500204997485;5013.473585273567;5017.9247311290355;5057.494250574913;5750.482456578928;5935.258092738408;5940.70296485174;5968.731407086691;6017.729202185999;5852.795152169653;5855.853603659943;5863.560232982458;5864.32560255576;5865.618734782225;6018.247719035121;6018.488428483628;6021.729022194099;6027.336992930686;6032.065029920369;5455.181722741462;5658;5715.257016587817;5723.771049157987;5757.280339957505;5820.854478638068;5829.6793676346515;5834.94165058361;5837.328707198726;5841.4450627190345;5585.106382978704;5651.576131790214;5711.771529138954;5715.885682286248;5721.628094173865;5618;5670.858228544319;5675.347335056521;5694.430556944272;5698.886022279448;5573.860653483695;5605;5611.775528978795;5613.550915926798;5620.803271885465;5505.449455054622;5583.804566840141;5729.140628905698;5734.5125664319;5821.505172060253;5489.313835770528;5549.112142057252;5559.749811258423;5568.693721845338;5610.13042978339 16:35:34 INFO - PROCESS | 13606 | |1;ext.html;580.3847921203525;625.9749610015599;632.984175395615;634.2832599162942;644.9036637715884;30779.384412311767;41801.58198418015;42898.785506072425;43018.35472467911;45715;45025.77487112568;45360.546394536046;45410.31884521727;45441.54558454415;45453.318200227026;8779.692710755126;8956.641734330618;8989.820203595957;8991;8997.145271199226;8872.245859101984;8976;8977.057408972061;8978.326625503081;8981.550922453884;9038.367314288002;9050.728478145666;9078.500682462462;9079.727608171732;9082.818343633124;8979.551022448884;9015.323850711224;9024.639014439415;9024.684136055206;9026.413283136608;8942.955285223597;9005;9009.774755631097;9019.549022548912;9020.278377729766;42666.57333426657;42778.786106069274;42914.141717165796;42975.35536966948;43084.78457607692;3292.3250733599793;3408.5739282589675;3430.2967891582416;3618.330608837347;3658.487811706363;32291.36994447861;32779.6722032779;33188.50217246719;33917;34609.30781384358;3870.3033453978273;3928.607139286077;3928.981837537741;4054.4121102440276;4148.709590328678;348387;348406;349129;349411;349997;56593.43406565964;56629.43370566241;56744.43255567474;56850.715746421;57089.14366284509;57929;58502.12246816301;59467.70266148728;59638.10542841861;59755.40244597585;15889.569938705341;16191.190440477929;16228.918855405884;16230.756538651929;16250;12328.630141095782;12485.31330776816;12521.186122901981;12524;12529.060320476001;14755.336009879582;15878.126703031214;16360.754588681179;16454.259558319904;16731.498055058368;6095.146679464879;6184.628922264678;6223.190985171898;6336.651484168415;6441;926.4626516620344;938.3009657804979;1049.4175732468552;1063.6170978447753;1129.9265547739371;28958.855205723838;30579.541306880416;30886.073417797503;31136.377272454425;31374;1042.6924057403085;1053.431147180514;1087.5921529426464;1094.0591091661165;1123.5112725964232;15835.366585336687;15966.680666386606;16023.759643605355;16154.757678634829;16275.755863662054;163155.1842240781;163999;164795;164825.17587411986;165439;57935.13097303544;58080.4191958075;58134;58160;58271;1213.0659392267905;1328.8471825740164;1337.739140867541;1350.2791874373147;1354.9796753048909;31147.84426077855;31837.20406989751;32171.839140804146;32172.51741223837;32790.5081423774;47170.76414617905;47366.28950565813;47559.52440475551;47625.52374476211;47713.76143119262;379025;390970;391232;391790;392318;24559.263222103367;27012.72987270102;27439.862800685867;27797.722022779515;29399.412011760072;47634.285485717046;48411.27383089327;48582.75708621434;49124;49835;39387.793651267246;40078.79960600295;40143.39784903287;40183.59816401915;40531.39202912018;39714.40428393519;39808.80095599504;40848.59151408448;41034.589654103074;41450.37824432696;38329.6167038326;39976;40648.390274146506;40961.795191023855;41167.1766564673;35621.46567801537;36477.27045459129;36748;36892.26215475729;37277.440838387985;27871.303217419725;27916.860415697793;27995.860020699765;28182;28401.857990709916 16:35:34 INFO - PROCESS | 13606 | |2;jquery.html;385.649059355986;387.4266086192433;390.84756944791536;404.8340180525984;416.18427881352545;14003;14067.437302507888;18816.4355069348;19241.037948102592;19304.90347548262;16630.75053874193;17606;17712.20295086721;17718.20268087936;18488.168032438538;5610.382857885629;5757.453041961007;5916;5918.437748413915;5962.940370596303;5772.797952071678;5800.709964501779;5842.240508733858;5866.501347385477;5868.207791948075;5704.204939579597;5778.942210577903;5809.215755872945;5817.331006934193;5819.418058194189;5802.738876750556;5827.35899051104;5830.82507524775;5888.617239879415;5888.911666325009;5160.251763494272;5203.739813009334;5212.29633999409;5224.425313215544;5248.763805628756;22236.110555577758;22580.435489112904;22668;22683.659745103836;22743.203987860346;2521.5461216980934;2527.3555243412998;2918.883244670211;3033.453978283908;3070.9846450767827;13173.802392964113;14228.786568201485;14562.927185364006;14625.414983400651;14678.853211467855;1884.4723477426342;1905.3712274949235;1914.2534411579495;1939.3309308288617;2061.4846288427893;48926.7553662233;67353.32646673569;67373;76204.61897690476;80541.19458805454;10257.94871025655;10285.7428564285;10374.844377334346;10431.634892778717;10538;14630.414783408758;14762.114273143647;14768.409263629335;14791.112533248039;14800.777988330183;7733.226677332222;7856.25365590268;7919.168487308865;8043.919560804317;8132.186781321939;7476.327130558276;7551.358134558624;7612.3148916596665;7624.656890439833;7966.522008679498;6411.3971507123215;6569.408753212234;6599.340065993459;6633.568818026813;6664.400203981568;1895.175598614607;1901.9524511887037;1906.790253072161;1907.6661584222707;1914.636219118363;945.7588314979636;997.0577803975174;1018.2414101494434;1052.032130439997;1057.5241141486363;18749.156287967075;19256.22975080981;19289.131989060526;19328.2803838114;19529.902350488155;986.225812736998;986.4870267461024;1033.1734612310122;1050.1441325319993;1075.602027249907;10445.477726113664;11005.944970275257;11112.11103111749;11151.498182581803;11194.66416007521;475381;481764;489197;490554;491384;79557.20442795497;83016.58491707503;85758.57120714357;86350.56824715836;86866;1016.4358780876685;1021.0759262867117;1021.4484178543652;1031.3708637730979;1033.994830025845;17021;17085.145742712564;17284.222210000327;17316.30734770595;17473.82526174773;33615.32769344648;39903.40144897887;40560.79719601383;41791.7910410446;43673.78163109164;56490.71754641201;56746.43253567412;57577.71211143918;57778;57858.421415785306;8059.717909873127;8234.135415781257;8330.083690793886;8371.497710137412;8406.789830254293;9443.527823608654;13107.049868322125;13423.127496712683;13476;13833.377498012413;11209.439528023404;11614.245074070159;11955.940220298842;12029.218100823418;12099.153059285765;11722.94138529302;11893.940530297294;11915.093585026701;12000.279983201035;12096.092793040732;11806.881931180922;12005.699857503632;12023.879761202275;12058.939705301418;12065.215760975509;8092.878606820785;8116.878246826421;8324;8588.65645374203;8717.564121794012;8618.181272779077;10733.892661073289;10944.890551094388;11384.772304554028;11802.52789888395 16:35:34 INFO - PROCESS | 13606 | |3;mootools.html;1307.0654482045336;1428.1930709149333;1478.2682572126798;1586.595418168367;1729.6973029719788;8328.042275138361;8330.625121869516;8406.78983025424;8544.74365769028;8545.957270213656;8096.5951702414795;8265.876011859827;8318.41771076025;8343.249107580317;8351.91648083519;2330.19608235159;2360.988195059031;2361.4568649210605;2362.196853069956;2363.9763602364014;2278.5670722562745;2336.3458231695154;2357.6581395697613;2363.184701278065;2365.254944692425;2294.3231746634783;2298.747137814839;2316.6756654068445;2317.884105794712;2330.6387509935985;2245.5845668551287;2253.43664083979;2265.161890100673;2268.7617800130997;2279.076973825595;2235.1953296813135;2246.5169988452562;2247.6179049561615;2247.9662805057937;2248.336740661509;8116.472429292077;8318.958405207995;8383.95808020962;8413.368997325226;8437.409381343308;5095.79616815327;5222.0861349264105;5223.921641175385;5224.268602395668;5227.843164705065;3378.341223461426;3387.4580067189377;3407.931841363159;3469.202083520779;3476.9130771730656;1062.8405739139114;1074.237291523012;2119.629064913634;2148.366231961575;2214.9889250553642;12934.870651293555;13057.738845223137;13099.738005239937;13146.342682865914;13161.144525605805;4525.705829121097;4559.658025648089;4664.766761661904;4672;4673.112108699336;9819.656312029045;9826.06652368024;9845.212383009342;9859.30984831055;9863.16163126128;5385.8114965976;5390.97304513475;5390.97304513475;5394.244805727201;5397;4361.105973275471;4806.206975849016;4874.36633237684;5038.622103342264;5070.569001634829;3632.5277713897026;3680;3720.8511659533315;3740.682042026404;3782.7730336179916;1104.6133853151332;1105.6793529876245;1108.711734948919;1114.420501339299;1114.6878873915316;809.3760976792171;945.2485274207022;1002.3935519011039;1019.0522813783105;1031.5254982707888;6038.849028774316;6136.202293701879;6273.309935907047;6286.842828929313;6420.646864422408;965.4496936746128;985.4333758088984;991.4596544883057;1012.6708819633649;1026.097034609539;4125.8968525786495;4264.7654379009455;4284.785760711952;4288.120935208337;4290.721103128287;10877.456127193609;11018.283811552223;11077.335359878432;11167.218294719292;11179.83230251547;10403.84394234087;11062.778744425066;11068.944655276671;11078;11123.499442525106;7950.1254861965135;8090;8139.982502187227;8157.265846073763;8159.143289954469;6025.096235564701;6341.746330146742;6364.395382438661;6404.935950640434;6425.036244563166;9826.9017309826;10142;10219.693409197736;10249.180065594586;10255.384676919408;10017.298789084694;10142.89857101449;10313.22650801178;10405.167586592903;10406.167506599606;7667.539947603162;7688.730894418893;7810.531368117931;7816.570088644951;7823.804404889924;8281.710140145065;8341.16588341161;8385.916140838757;8452.070272269922;8518.574071296534;7508.849823003618;7617.27635874591;7655.1962043986805;7668.539887606761;7698.230176982257;7518.774436766906;7528.473006889684;7567.886481702669;7618.504797188165;7787.688492460238;7065.929340706527;7077.893831592633;7080.468964827555;7095.645217738989;7178.928210717826;5254.13306804373;5256.526912577886;5317.574594032545;5378.462153784591;5389.541888939484;5345.839624811262;5385.946140538701;5527.032769265443;5558.277423934863;5559.33288005442 16:35:34 INFO - PROCESS | 13606 | |4;prototype.html;288.3799830364714;302.21725730358395;302.6096335726912;309.86520863424414;315.0736833708896;5163.277141200235;5171.637985341028;5327.413984461706;5398.838034858951;5400.324959380077;5241.9213711794255;5287.788488460457;5297.788088476456;5298.814541491049;5314.893702125955;4145.362581780195;4146.108586653869;4148.045949431633;4155.210510003105;4183.560726123759;3834.5398552173638;3966.4050392441222;4111.951452379654;4183.970774174523;4223.873283801491;4065.654419374342;4094.242565125461;4130.793460326987;4139.937900931488;4151.750894946298;4073.40935564343;4100.7334523255895;4105.363668631367;4131.938020929659;4208.053188032699;3444.156181735466;3693.279810436966;3700.1674623209833;3708.091517578184;3724.0689827543115;5185.974070129663;5191.351081114861;5203.531682148625;5210.817621383271;5211.1922651989;4709.1994360958715;4724.338592597039;4737.26572381278;4762.214234651278;4773.4510531289;5393.9730301348245;5509.696966666832;5523.25436066134;5558.166275058733;5577.721113944286;3965.167314863882;3976.9858686035163;3978;4020.6984476164403;4033.6168064034164;5773.711314434304;5782.3639399666;5790.899729051467;5798.478136967693;5805.245318108661;3851.9229615408094;3992.620701033455;4010.47863777707;4017.493439960015;4024.1951609677594;4015.4779878616177;4025.5370632377067;4026.4966879140106;4033.8991525212105;4046.959530404717;4646.930296045562;4649.3026046093355;4678.134545109166;4686.882827929329;4688.320193571913;5602.38373778884;5623.634463759842;5625.212470254086;5628.099504079328;5696;1358.44303835427;1406.3811922753955;1407.774756039029;1412.4491448334952;1417.971640567183;858.9742307730778;866.328595338605;877.9692710755093;886.822635472908;888.1784349476708;4766.285057241442;4803.663743537919;4813.326134341195;4815.253635686474;4832.685875418087;5068.366454193226;5092.414372347153;5105.540501354896;5112.00947445741;5159.793608255703;4736.905261894743;4894.363732714724;4899.191633380452;4901.926471102936;4964.453910069889;3060.7704422168426;3087.521434177706;3089.9845500772803;3095.6904309568863;3117.0960421477516;5990.221271234712;5998.49012833914;6003.219581454383;6006.609570377911;6024.608400453956;5651.965292494699;5954.880902382015;5967.671778052249;5978;5978.940210597925;5928.073376152682;5940.287165540163;5953.970230148821;5983.311919129356;6005.519558435315;5594.9720251398485;5799.797007104731;5802.709864506842;5842.444967728059;5851.561132914963;5720.256366672306;5739.253896993364;5745.2818397700285;5750.338711048283;5763.7406316715005;5954.583179177416;5956.642601443928;5957.195778569838;5960.314563825215;6001.969990150022;3856.402257650069;3988.720789544704;4052.412400202013;4068.3287257602165;4092.959070409258;5634.549236061023;5653.632513886584;5772.365039845529;5778.335491418541;5809.593328466966;5623.971880140573;5634.85912852182;5669;5677.205191273308;5694;5366.919496207638;5652.660840349592;5664.546836253007;5668.69619987397;5670.773169073191;5532.723363831873;5542.61201715876;5576.776928922797;5660.9150862737915;5660.943390566042;5410.323709536308;5650.259624082399;5656.462636049569;5716.857078573069;5721.370649228665;5523.8895222096135;5536.833894983157;5554.055810512304;5566.192902029264;5575.080111781511 16:35:34 INFO - PROCESS | 13606 | |5;yui.html;757.3070640364064;785.8094986096065;812.1594150054693;840.9159084091588;847.4999750147414;15111.471098511554;16250.674986500293;16262.593435164097;16292.185390730461;16294.348226070973;14324.641883952907;15347.923260383683;15354.309056092474;15366.078035317889;15382.846171538282;680.3672584496417;807.2895851650569;831.3100126894662;842.4187310755559;851.1998721202082;825.0923983618002;845.9492430454162;846.8094678697305;846.9957650211741;847.8728190771403;877.9824403511926;884.5488800711652;889.4218757807445;892.1747383670079;893.7318804358666;710.2294010998047;838.1827717974986;868.3747701654798;878.4114643189047;884.0275696733573;633.8478765096389;634.1629049654458;634.2959315160168;634.3973225435808;634.4797266241684;15247.923760381238;15277;15303.617409564738;15304.923475382551;15324;14178.43286268548;14604.34280457382;14630.780538291934;14709.632259193499;14764.926175369163;12739;12764.17032892859;12883.291418971952;12910.22538647684;13477.86522134776;4505.256632655608;4589.724616523019;4648.023914977859;4713.449885419716;4760.452547956995;73093.26906730917;73282.26717732807;73911.63044184745;74057.62971185164;74111;10305.278630495794;10903.221949907289;11233.55065797359;11317.886821131848;11504.539818407336;20927.26754563583;21020.47448813792;21145.471363215736;21212.46968825761;21249.36251912445;8364.330853531703;8395.118512556215;8446.324294056461;8570.271526920156;8611;4783.6651434399255;4833.661643684908;4874.512548745097;5002.299678045077;5053.1157047516535;3477.23500829817;3623.9456408153897;3625.3474374612297;3647.5258216432226;3656.1773600939578;600.6576251536583;612.2775125352039;622.5331001748689;626.9905951410733;636.9299377068519;654.5156584127807;663.6913835066717;685.0466088710072;693.3690341789048;708.3412426443354;8774.122587741174;8790.384673072951;8818.382713210141;9047.954760226157;9066.909330906738;603.384547761281;661.7319985405918;666.540087339734;689.4966674327769;695.3359541637724;4181.665466762652;4221.5778422158155;4271.295236286041;4272.5727427257025;4380.824767009284;67167.66416167986;67225.6638716813;67780;86542;112698;58446.707766460895;59050.40949590535;59424.40575594275;60074;61183;55138.448615514135;74311.62844185745;88511.55744221238;88681.11318886858;89832.10167898238;8953.686620968236;9098.36311458218;9200.35597508168;9206.17144457002;9253.722418226353;51445.22832157446;52392;52907.73546132399;52984;53259.46740532545;68937;69951.6502417505;76105.61947190229;78417.21582784099;79755;10666;10902.345859248471;10933.398663073607;11137;11320.26418282809;12415.93792031034;12430.192037517894;12562.37188140571;12720.936395317964;13134.737305254033;11445.713857153638;11532.077433805107;11695.532178712756;11985.880141198826;12376.938115309365;11093.278936869077;11122.44387780624;11321.094312455149;11364.204505684853;11687.415629218334;11100.666979990614;11115.555377784798;11393.202475826612;11570.479328430409;11778.352190629255;9491.620335186515;9527.57125929321;9728.12446879756;9912.107910288109;10003.14973227284;9151.725448236564;9926.354786938826;11293.43532823339;11826.34955077479;11861.822072669089 16:35:34 INFO - PROCESS | 13606 | __end_tp_report 16:35:34 INFO - PROCESS | 13606 | __start_cc_report 16:35:34 INFO - PROCESS | 13606 | _x_x_mozilla_cycle_collect,1103 16:35:34 INFO - PROCESS | 13606 | __end_cc_report 16:35:34 INFO - PROCESS | 13606 | __startTimestamp1466206534582__endTimestamp 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | ------- Summary: start ------- 16:35:34 INFO - PROCESS | 13606 | Number of tests: 6 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | [#0] dojo.html Cycles:165 Average:5393.44 Median:5583.80 stddev:608.45 (10.9%) stddev-sans-first:583.29 16:35:34 INFO - PROCESS | 13606 | Values: 3107.3 3107.3 3138.0 3154.1 3175.3 5310.7 5342.4 5372.2 5477.3 5481.0 5337.3 5339.9 5432.7 5482.5 5489.8 4791.2 4878.9 4896.2 4899.3 5150.5 5045.4 5046.5 5075.4 5090.4 5108.6 4819.0 4824.7 4875.8 4898.6 4943.1 4911.7 4915.1 4915.8 4980.1 5018.7 4921.0 4949.4 4961.5 4967.7 5001.2 5320.7 5355.2 5413.4 5421.3 5457.6 5824.6 5826.9 5833.0 5857.9 5878.4 5660.9 5870.5 5913.2 5920.6 5925.4 5346.2 5398.7 5412.9 5475.4 5478.5 5959.2 5971.8 5974.5 5977.8 5978.8 5603.9 5653.0 5764.0 5790.9 5791.1 5758.4 5801.0 5816.5 5819.7 5820.6 5764.4 5803.4 5814.3 5816.1 5816.9 5814.0 5831.4 5832.6 5834.6 5838.7 4416.4 4471.3 4478.2 4485.0 4485.0 3965.8 3971.9 3985.7 3996.8 4004.1 5475.1 5488.2 5489.3 5493.1 5536.1 5648.3 5703.9 5707.2 5760.9 5856.1 5408.2 5413.4 5413.8 5423.6 5457.8 4995.9 4998.0 5013.5 5017.9 5057.5 5750.5 5935.3 5940.7 5968.7 6017.7 5852.8 5855.9 5863.6 5864.3 5865.6 6018.2 6018.5 6021.7 6027.3 6032.1 5455.2 5658.0 5715.3 5723.8 5757.3 5820.9 5829.7 5834.9 5837.3 5841.4 5585.1 5651.6 5711.8 5715.9 5721.6 5618.0 5670.9 5675.3 5694.4 5698.9 5573.9 5605.0 5611.8 5613.6 5620.8 5505.4 5583.8 5729.1 5734.5 5821.5 5489.3 5549.1 5559.7 5568.7 5610.1 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | [#1] ext.html Cycles:180 Average:48166.94 Median:39892.40 stddev:83449.01 (209.2%) stddev-sans-first:83606.62 16:35:34 INFO - PROCESS | 13606 | Values: 580.4 626.0 633.0 634.3 644.9 30779.4 41801.6 42898.8 43018.4 45715.0 45025.8 45360.5 45410.3 45441.5 45453.3 8779.7 8956.6 8989.8 8991.0 8997.1 8872.2 8976.0 8977.1 8978.3 8981.6 9038.4 9050.7 9078.5 9079.7 9082.8 8979.6 9015.3 9024.6 9024.7 9026.4 8943.0 9005.0 9009.8 9019.5 9020.3 42666.6 42778.8 42914.1 42975.4 43084.8 3292.3 3408.6 3430.3 3618.3 3658.5 32291.4 32779.7 33188.5 33917.0 34609.3 3870.3 3928.6 3929.0 4054.4 4148.7 348387.0 348406.0 349129.0 349411.0 349997.0 56593.4 56629.4 56744.4 56850.7 57089.1 57929.0 58502.1 59467.7 59638.1 59755.4 15889.6 16191.2 16228.9 16230.8 16250.0 12328.6 12485.3 12521.2 12524.0 12529.1 14755.3 15878.1 16360.8 16454.3 16731.5 6095.1 6184.6 6223.2 6336.7 6441.0 926.5 938.3 1049.4 1063.6 1129.9 28958.9 30579.5 30886.1 31136.4 31374.0 1042.7 1053.4 1087.6 1094.1 1123.5 15835.4 15966.7 16023.8 16154.8 16275.8 163155.2 163999.0 164795.0 164825.2 165439.0 57935.1 58080.4 58134.0 58160.0 58271.0 1213.1 1328.8 1337.7 1350.3 1355.0 31147.8 31837.2 32171.8 32172.5 32790.5 47170.8 47366.3 47559.5 47625.5 47713.8 379025.0 390970.0 391232.0 391790.0 392318.0 24559.3 27012.7 27439.9 27797.7 29399.4 47634.3 48411.3 48582.8 49124.0 49835.0 39387.8 40078.8 40143.4 40183.6 40531.4 39714.4 39808.8 40848.6 41034.6 41450.4 38329.6 39976.0 40648.4 40961.8 41167.2 35621.5 36477.3 36748.0 36892.3 37277.4 27871.3 27916.9 27995.9 28182.0 28401.9 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | [#2] jquery.html Cycles:180 Average:28218.48 Median:2723.12 stddev:79736.44 (2928.1%) stddev-sans-first:79932.74 16:35:34 INFO - PROCESS | 13606 | Values: 385.6 387.4 390.8 404.8 416.2 14003.0 14067.4 18816.4 19241.0 19304.9 16630.8 17606.0 17712.2 17718.2 18488.2 5610.4 5757.5 5916.0 5918.4 5962.9 5772.8 5800.7 5842.2 5866.5 5868.2 5704.2 5778.9 5809.2 5817.3 5819.4 5802.7 5827.4 5830.8 5888.6 5888.9 5160.3 5203.7 5212.3 5224.4 5248.8 22236.1 22580.4 22668.0 22683.7 22743.2 2521.5 2527.4 2918.9 3033.5 3071.0 13173.8 14228.8 14562.9 14625.4 14678.9 1884.5 1905.4 1914.3 1939.3 2061.5 48926.8 67353.3 67373.0 76204.6 80541.2 10257.9 10285.7 10374.8 10431.6 10538.0 14630.4 14762.1 14768.4 14791.1 14800.8 7733.2 7856.3 7919.2 8043.9 8132.2 7476.3 7551.4 7612.3 7624.7 7966.5 6411.4 6569.4 6599.3 6633.6 6664.4 1895.2 1902.0 1906.8 1907.7 1914.6 945.8 997.1 1018.2 1052.0 1057.5 18749.2 19256.2 19289.1 19328.3 19529.9 986.2 986.5 1033.2 1050.1 1075.6 10445.5 11005.9 11112.1 11151.5 11194.7 475381.0 481764.0 489197.0 490554.0 491384.0 79557.2 83016.6 85758.6 86350.6 86866.0 1016.4 1021.1 1021.4 1031.4 1034.0 17021.0 17085.1 17284.2 17316.3 17473.8 33615.3 39903.4 40560.8 41791.8 43673.8 56490.7 56746.4 57577.7 57778.0 57858.4 8059.7 8234.1 8330.1 8371.5 8406.8 9443.5 13107.0 13423.1 13476.0 13833.4 11209.4 11614.2 11955.9 12029.2 12099.2 11722.9 11893.9 11915.1 12000.3 12096.1 11806.9 12005.7 12023.9 12058.9 12065.2 8092.9 8116.9 8324.0 8588.7 8717.6 8618.2 10733.9 10944.9 11384.8 11802.5 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | [#3] mootools.html Cycles:180 Average:5820.47 Median:4840.29 stddev:3288.97 (67.9%) stddev-sans-first:3280.70 16:35:34 INFO - PROCESS | 13606 | Values: 1307.1 1428.2 1478.3 1586.6 1729.7 8328.0 8330.6 8406.8 8544.7 8546.0 8096.6 8265.9 8318.4 8343.2 8351.9 2330.2 2361.0 2361.5 2362.2 2364.0 2278.6 2336.3 2357.7 2363.2 2365.3 2294.3 2298.7 2316.7 2317.9 2330.6 2245.6 2253.4 2265.2 2268.8 2279.1 2235.2 2246.5 2247.6 2248.0 2248.3 8116.5 8319.0 8384.0 8413.4 8437.4 5095.8 5222.1 5223.9 5224.3 5227.8 3378.3 3387.5 3407.9 3469.2 3476.9 1062.8 1074.2 2119.6 2148.4 2215.0 12934.9 13057.7 13099.7 13146.3 13161.1 4525.7 4559.7 4664.8 4672.0 4673.1 9819.7 9826.1 9845.2 9859.3 9863.2 5385.8 5391.0 5391.0 5394.2 5397.0 4361.1 4806.2 4874.4 5038.6 5070.6 3632.5 3680.0 3720.9 3740.7 3782.8 1104.6 1105.7 1108.7 1114.4 1114.7 809.4 945.2 1002.4 1019.1 1031.5 6038.8 6136.2 6273.3 6286.8 6420.6 965.4 985.4 991.5 1012.7 1026.1 4125.9 4264.8 4284.8 4288.1 4290.7 10877.5 11018.3 11077.3 11167.2 11179.8 10403.8 11062.8 11068.9 11078.0 11123.5 7950.1 8090.0 8140.0 8157.3 8159.1 6025.1 6341.7 6364.4 6404.9 6425.0 9826.9 10142.0 10219.7 10249.2 10255.4 10017.3 10142.9 10313.2 10405.2 10406.2 7667.5 7688.7 7810.5 7816.6 7823.8 8281.7 8341.2 8385.9 8452.1 8518.6 7508.8 7617.3 7655.2 7668.5 7698.2 7518.8 7528.5 7567.9 7618.5 7787.7 7065.9 7077.9 7080.5 7095.6 7178.9 5254.1 5256.5 5317.6 5378.5 5389.5 5345.8 5385.9 5527.0 5558.3 5559.3 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | [#4] prototype.html Cycles:180 Average:4662.66 Median:5211.00 stddev:1394.37 (26.8%) stddev-sans-first:1359.08 16:35:34 INFO - PROCESS | 13606 | Values: 288.4 302.2 302.6 309.9 315.1 5163.3 5171.6 5327.4 5398.8 5400.3 5241.9 5287.8 5297.8 5298.8 5314.9 4145.4 4146.1 4148.0 4155.2 4183.6 3834.5 3966.4 4112.0 4184.0 4223.9 4065.7 4094.2 4130.8 4139.9 4151.8 4073.4 4100.7 4105.4 4131.9 4208.1 3444.2 3693.3 3700.2 3708.1 3724.1 5186.0 5191.4 5203.5 5210.8 5211.2 4709.2 4724.3 4737.3 4762.2 4773.5 5394.0 5509.7 5523.3 5558.2 5577.7 3965.2 3977.0 3978.0 4020.7 4033.6 5773.7 5782.4 5790.9 5798.5 5805.2 3851.9 3992.6 4010.5 4017.5 4024.2 4015.5 4025.5 4026.5 4033.9 4047.0 4646.9 4649.3 4678.1 4686.9 4688.3 5602.4 5623.6 5625.2 5628.1 5696.0 1358.4 1406.4 1407.8 1412.4 1418.0 859.0 866.3 878.0 886.8 888.2 4766.3 4803.7 4813.3 4815.3 4832.7 5068.4 5092.4 5105.5 5112.0 5159.8 4736.9 4894.4 4899.2 4901.9 4964.5 3060.8 3087.5 3090.0 3095.7 3117.1 5990.2 5998.5 6003.2 6006.6 6024.6 5652.0 5954.9 5967.7 5978.0 5978.9 5928.1 5940.3 5954.0 5983.3 6005.5 5595.0 5799.8 5802.7 5842.4 5851.6 5720.3 5739.3 5745.3 5750.3 5763.7 5954.6 5956.6 5957.2 5960.3 6002.0 3856.4 3988.7 4052.4 4068.3 4093.0 5634.5 5653.6 5772.4 5778.3 5809.6 5624.0 5634.9 5669.0 5677.2 5694.0 5366.9 5652.7 5664.5 5668.7 5670.8 5532.7 5542.6 5576.8 5660.9 5660.9 5410.3 5650.3 5656.5 5716.9 5721.4 5523.9 5536.8 5554.1 5566.2 5575.1 16:35:34 INFO - PROCESS | 13606 | 16:35:34 INFO - PROCESS | 13606 | [#5] yui.html Cycles:180 Average:18215.17 Median:56792.58 stddev:24510.25 (43.2%) stddev-sans-first:24543.95 16:35:34 INFO - PROCESS | 13606 | Values: 757.3 785.8 812.2 840.9 847.5 15111.5 16250.7 16262.6 16292.2 16294.3 14324.6 15347.9 15354.3 15366.1 15382.8 680.4 807.3 831.3 842.4 851.2 825.1 845.9 846.8 847.0 847.9 878.0 884.5 889.4 892.2 893.7 710.2 838.2 868.4 878.4 884.0 633.8 634.2 634.3 634.4 634.5 15247.9 15277.0 15303.6 15304.9 15324.0 14178.4 14604.3 14630.8 14709.6 14764.9 12739.0 12764.2 12883.3 12910.2 13477.9 4505.3 4589.7 4648.0 4713.4 4760.5 73093.3 73282.3 73911.6 74057.6 74111.0 10305.3 10903.2 11233.6 11317.9 11504.5 20927.3 21020.5 21145.5 21212.5 21249.4 8364.3 8395.1 8446.3 8570.3 8611.0 4783.7 4833.7 4874.5 5002.3 5053.1 3477.2 3623.9 3625.3 3647.5 3656.2 600.7 612.3 622.5 627.0 636.9 654.5 663.7 685.0 693.4 708.3 8774.1 8790.4 8818.4 9048.0 9066.9 603.4 661.7 666.5 689.5 695.3 4181.7 4221.6 4271.3 4272.6 4380.8 67167.7 67225.7 67780.0 86542.0 112698.0 58446.7 59050.4 59424.4 60074.0 61183.0 55138.4 74311.6 88511.6 88681.1 89832.1 8953.7 9098.4 9200.4 9206.2 9253.7 51445.2 52392.0 52907.7 52984.0 53259.5 68937.0 69951.7 76105.6 78417.2 79755.0 10666.0 10902.3 10933.4 11137.0 11320.3 12415.9 12430.2 12562.4 12720.9 13134.7 11445.7 11532.1 11695.5 11985.9 12376.9 11093.3 11122.4 11321.1 11364.2 11687.4 11100.7 11115.6 11393.2 11570.5 11778.4 9491.6 9527.6 9728.1 9912.1 10003.1 9151.7 9926.4 11293.4 11826.3 11861.8 16:35:34 INFO - PROCESS | 13606 | -------- Summary: end -------- 16:35:34 INFO - PROCESS | 13606 | 16:35:35 INFO - TEST-INFO | 13606: exit 0 16:35:35 INFO - TEST-OK | dromaeo_css | took 1114058ms 16:35:35 INFO - TEST-START | kraken 16:35:35 INFO - operating with platform_type : linux_ 16:35:35 INFO - Initialising browser for kraken test... 16:35:35 INFO - TEST-INFO | started process 13783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzrMEu/profile http://localhost:49315/getInfo.html) 16:35:39 INFO - PROCESS | 13783 | __metrics Screen width/height:1600/1200 16:35:39 INFO - PROCESS | 13783 | colorDepth:24 16:35:39 INFO - PROCESS | 13783 | Browser inner width/height: 1024/697 16:35:39 INFO - PROCESS | 13783 | __metrics 16:35:40 INFO - PROCESS | 13783 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:41 INFO - TEST-INFO | 13783: exit 0 16:35:41 INFO - Browser initialized. 16:35:41 INFO - Running cycle 1/1 for kraken test... 16:35:41 INFO - TEST-INFO | started process 13862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzrMEu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:53 INFO - PROCESS | 13862 | RSS: Main: 174149632 16:35:53 INFO - PROCESS | 13862 | 16:35:55 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:56 INFO - PROCESS | 13862 | RSS: Main: 232939520 16:35:56 INFO - PROCESS | 13862 | 16:35:59 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-dft) 16:35:59 INFO - PROCESS | 13862 | RSS: Main: 220803072 16:35:59 INFO - PROCESS | 13862 | 16:36:02 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-fft) 16:36:03 INFO - PROCESS | 13862 | RSS: Main: 287006720 16:36:03 INFO - PROCESS | 13862 | 16:36:05 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49315/tests/kraken/driver.html?testName=audio-oscillator) 16:36:06 INFO - PROCESS | 13862 | RSS: Main: 198090752 16:36:06 INFO - PROCESS | 13862 | 16:36:08 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:08 INFO - PROCESS | 13862 | RSS: Main: 201678848 16:36:08 INFO - PROCESS | 13862 | 16:36:11 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49315/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:12 INFO - PROCESS | 13862 | RSS: Main: 236212224 16:36:12 INFO - PROCESS | 13862 | 16:36:16 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49315/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:16 INFO - PROCESS | 13862 | RSS: Main: 239210496 16:36:16 INFO - PROCESS | 13862 | 16:36:19 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49315/tests/kraken/driver.html?testName=json-parse-financial) 16:36:20 INFO - PROCESS | 13862 | RSS: Main: 238567424 16:36:20 INFO - PROCESS | 13862 | 16:36:21 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:22 INFO - PROCESS | 13862 | RSS: Main: 226074624 16:36:22 INFO - PROCESS | 13862 | 16:36:23 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:24 INFO - PROCESS | 13862 | RSS: Main: 231686144 16:36:24 INFO - PROCESS | 13862 | 16:36:26 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:27 INFO - PROCESS | 13862 | RSS: Main: 239501312 16:36:27 INFO - PROCESS | 13862 | 16:36:29 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:30 INFO - PROCESS | 13862 | RSS: Main: 239919104 16:36:30 INFO - PROCESS | 13862 | 16:36:33 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:33 INFO - PROCESS | 13862 | RSS: Main: 239685632 16:36:33 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:49315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49315/tests/kraken/driver.html?testName=ai-astar) 16:36:35 INFO - PROCESS | 13862 | RSS: Main: 283201536 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | __start_tp_report 16:36:35 INFO - PROCESS | 13862 | _x_x_mozilla_page_load 16:36:35 INFO - PROCESS | 13862 | _x_x_mozilla_page_load_details 16:36:35 INFO - PROCESS | 13862 | |i|pagename|runs| 16:36:35 INFO - PROCESS | 13862 | |0;ai-astar;109;105;109;111;109;109;110;109;111;110 16:36:35 INFO - PROCESS | 13862 | |1;audio-beat-detection;162;126;131;178;130;132;155;123;183;132 16:36:35 INFO - PROCESS | 13862 | |2;audio-dft;161;161;160;160;162;162;161;161;162;160 16:36:35 INFO - PROCESS | 13862 | |3;audio-fft;74;76;77;137;76;76;76;75;98;76 16:36:35 INFO - PROCESS | 13862 | |4;audio-oscillator;85;85;123;86;86;85;128;85;85;121 16:36:35 INFO - PROCESS | 13862 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;118;117 16:36:35 INFO - PROCESS | 13862 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;146;146 16:36:35 INFO - PROCESS | 13862 | |7;imaging-desaturate;95;95;94;94;94;95;94;95;95;94 16:36:35 INFO - PROCESS | 13862 | |8;json-parse-financial;59;53;51;52;52;57;55;54;53;55 16:36:35 INFO - PROCESS | 13862 | |9;json-stringify-tinderbox;62;62;63;62;62;62;62;62;63;62 16:36:35 INFO - PROCESS | 13862 | |10;stanford-crypto-aes;86;80;78;79;79;80;81;85;109;80 16:36:35 INFO - PROCESS | 13862 | |11;stanford-crypto-ccm;132;121;122;124;127;125;119;124;137;125 16:36:35 INFO - PROCESS | 13862 | |12;stanford-crypto-pbkdf2;164;166;160;161;166;165;165;162;162;160 16:36:35 INFO - PROCESS | 13862 | |13;stanford-crypto-sha256-iterative;65;62;64;62;65;66;63;62;63;62 16:36:35 INFO - PROCESS | 13862 | __end_tp_report 16:36:35 INFO - PROCESS | 13862 | __start_cc_report 16:36:35 INFO - PROCESS | 13862 | _x_x_mozilla_cycle_collect,1619 16:36:35 INFO - PROCESS | 13862 | __end_cc_report 16:36:35 INFO - PROCESS | 13862 | __startTimestamp1466206595702__endTimestamp 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | ------- Summary: start ------- 16:36:35 INFO - PROCESS | 13862 | Number of tests: 14 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.69 (1.5%) stddev-sans-first:1.79 16:36:35 INFO - PROCESS | 13862 | Values: 109.0 105.0 109.0 111.0 109.0 109.0 110.0 109.0 111.0 110.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:143.50 stddev:22.42 (15.6%) stddev-sans-first:22.95 16:36:35 INFO - PROCESS | 13862 | Values: 162.0 126.0 131.0 178.0 130.0 132.0 155.0 123.0 183.0 132.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 16:36:35 INFO - PROCESS | 13862 | Values: 161.0 161.0 160.0 160.0 162.0 162.0 161.0 161.0 162.0 160.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#3] audio-fft Cycles:10 Average:84.10 Median:76.00 stddev:19.87 (26.2%) stddev-sans-first:20.74 16:36:35 INFO - PROCESS | 13862 | Values: 74.0 76.0 77.0 137.0 76.0 76.0 76.0 75.0 98.0 76.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.00 stddev:18.78 (22.1%) stddev-sans-first:19.42 16:36:35 INFO - PROCESS | 13862 | Values: 85.0 85.0 123.0 86.0 86.0 85.0 128.0 85.0 85.0 121.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:36:35 INFO - PROCESS | 13862 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 16:36:35 INFO - PROCESS | 13862 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:36:35 INFO - PROCESS | 13862 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:2.47 (4.5%) stddev-sans-first:1.88 16:36:35 INFO - PROCESS | 13862 | Values: 59.0 53.0 51.0 52.0 52.0 57.0 55.0 54.0 53.0 55.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:36:35 INFO - PROCESS | 13862 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:80.00 stddev:9.26 (11.6%) stddev-sans-first:9.79 16:36:35 INFO - PROCESS | 13862 | Values: 86.0 80.0 78.0 79.0 79.0 80.0 81.0 85.0 109.0 80.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:125.00 stddev:5.34 (4.3%) stddev-sans-first:5.13 16:36:35 INFO - PROCESS | 13862 | Values: 132.0 121.0 122.0 124.0 127.0 125.0 119.0 124.0 137.0 125.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.50 stddev:2.38 (1.4%) stddev-sans-first:2.50 16:36:35 INFO - PROCESS | 13862 | Values: 164.0 166.0 160.0 161.0 166.0 165.0 165.0 162.0 162.0 160.0 16:36:35 INFO - PROCESS | 13862 | 16:36:35 INFO - PROCESS | 13862 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.51 (2.4%) stddev-sans-first:1.48 16:36:35 INFO - PROCESS | 13862 | Values: 65.0 62.0 64.0 62.0 65.0 66.0 63.0 62.0 63.0 62.0 16:36:35 INFO - PROCESS | 13862 | -------- Summary: end -------- 16:36:35 INFO - PROCESS | 13862 | 16:36:36 INFO - TEST-INFO | 13862: exit 0 16:36:36 INFO - TEST-OK | kraken | took 61319ms 16:36:36 INFO - SUITE-END | took 1175s 16:36:36 INFO - Completed test suite (00:19:35) 16:36:36 INFO - javascript benchmark 16:36:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.316390394114, 3107.3474570340227, 3138.0, 3154.1168472827617, 3175.317306779042, 5310.654807437523, 5342.412334643191, 5372.247885296062, 5477.260569823073, 5481.040817856869, 5337.279467271917, 5339.866503337418, 5432.70120143392, 5482.451754824526, 5489.807856725015, 4791.2334026555845, 4878.926816097762, 4896.216605343146, 4899.265110233458, 5150.536451719345, 5045.419776725668, 5046.520580544842, 5075.441701412841, 5090.414602320743, 5108.565771909392, 4818.975905120469, 4824.686395384307, 4875.829345972892, 4898.608111351084, 4943.060818444484, 4911.68074075184, 4915.115279249733, 4915.827946021872, 4980.103581355354, 5018.749062546858, 4920.975395123037, 4949.430815456197, 4961.479044700291, 4967.652264341497, 5001.199808030734, 5320.654157479751, 5355.196720491918, 5413.404525502192, 5421.322334708161, 5457.590680698963, 5824.563157763142, 5826.941730582682, 5833.0, 5857.941420585825, 5878.382769809151, 5660.915086273709, 5870.501007414375, 5913.231279933581, 5920.615160014585, 5925.407459254083, 5346.198070289449, 5398.703071331075, 5412.891742165174, 5475.397706252309, 5478.45215478453, 5959.165716799652, 5971.820845374646, 5974.492168165668, 5977.790777322773, 5978.760849565969, 5603.887922241533, 5653.0, 5763.971180144073, 5790.913136302875, 5791.131330300489, 5758.424157584208, 5801.0, 5816.505597024216, 5819.73811178498, 5820.592558520862, 5764.394738552475, 5803.390643982406, 5814.30228372598, 5816.098504731774, 5816.854578635568, 5814.04068328721, 5831.358550559435, 5832.562557808182, 5834.5624078194305, 5838.67887266196, 4416.3596278539435, 4471.329300604935, 4478.193925093449, 4484.990877052637, 4485.035717320791, 3965.841366345314, 3971.8808435746973, 3985.740926839746, 3996.820143093568, 4004.1391100913443, 5475.09660905954, 5488.204210389471, 5489.34127904654, 5493.066178749622, 5536.086545719992, 5648.322201335784, 5703.857403564944, 5707.229524014288, 5760.94239057604, 5856.12158176277, 5408.1887716842, 5413.377461591888, 5413.83758487246, 5423.593230507728, 5457.836264912059, 4995.900081998339, 4997.9500204997485, 5013.473585273567, 5017.9247311290355, 5057.494250574913, 5750.482456578928, 5935.258092738408, 5940.70296485174, 5968.731407086691, 6017.729202185999, 5852.795152169653, 5855.853603659943, 5863.560232982458, 5864.32560255576, 5865.618734782225, 6018.247719035121, 6018.488428483628, 6021.729022194099, 6027.336992930686, 6032.065029920369, 5455.181722741462, 5658.0, 5715.257016587817, 5723.771049157987, 5757.280339957505, 5820.854478638068, 5829.6793676346515, 5834.94165058361, 5837.328707198726, 5841.4450627190345, 5585.106382978704, 5651.576131790214, 5711.771529138954, 5715.885682286248, 5721.628094173865, 5618.0, 5670.858228544319, 5675.347335056521, 5694.430556944272, 5698.886022279448, 5573.860653483695, 5605.0, 5611.775528978795, 5613.550915926798, 5620.803271885465, 5505.449455054622, 5583.804566840141, 5729.140628905698, 5734.5125664319, 5821.505172060253, 5489.313835770528, 5549.112142057252, 5559.749811258423, 5568.693721845338, 5610.13042978339], "value": 5352.600749247641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.3847921203525, 625.9749610015599, 632.984175395615, 634.2832599162942, 644.9036637715884, 30779.384412311767, 41801.58198418015, 42898.785506072425, 43018.35472467911, 45715.0, 45025.77487112568, 45360.546394536046, 45410.31884521727, 45441.54558454415, 45453.318200227026, 8779.692710755126, 8956.641734330618, 8989.820203595957, 8991.0, 8997.145271199226, 8872.245859101984, 8976.0, 8977.057408972061, 8978.326625503081, 8981.550922453884, 9038.367314288002, 9050.728478145666, 9078.500682462462, 9079.727608171732, 9082.818343633124, 8979.551022448884, 9015.323850711224, 9024.639014439415, 9024.684136055206, 9026.413283136608, 8942.955285223597, 9005.0, 9009.774755631097, 9019.549022548912, 9020.278377729766, 42666.57333426657, 42778.786106069274, 42914.141717165796, 42975.35536966948, 43084.78457607692, 3292.3250733599793, 3408.5739282589675, 3430.2967891582416, 3618.330608837347, 3658.487811706363, 32291.36994447861, 32779.6722032779, 33188.50217246719, 33917.0, 34609.30781384358, 3870.3033453978273, 3928.607139286077, 3928.981837537741, 4054.4121102440276, 4148.709590328678, 348387.0, 348406.0, 349129.0, 349411.0, 349997.0, 56593.43406565964, 56629.43370566241, 56744.43255567474, 56850.715746421, 57089.14366284509, 57929.0, 58502.12246816301, 59467.70266148728, 59638.10542841861, 59755.40244597585, 15889.569938705341, 16191.190440477929, 16228.918855405884, 16230.756538651929, 16250.0, 12328.630141095782, 12485.31330776816, 12521.186122901981, 12524.0, 12529.060320476001, 14755.336009879582, 15878.126703031214, 16360.754588681179, 16454.259558319904, 16731.498055058368, 6095.146679464879, 6184.628922264678, 6223.190985171898, 6336.651484168415, 6441.0, 926.4626516620344, 938.3009657804979, 1049.4175732468552, 1063.6170978447753, 1129.9265547739371, 28958.855205723838, 30579.541306880416, 30886.073417797503, 31136.377272454425, 31374.0, 1042.6924057403085, 1053.431147180514, 1087.5921529426464, 1094.0591091661165, 1123.5112725964232, 15835.366585336687, 15966.680666386606, 16023.759643605355, 16154.757678634829, 16275.755863662054, 163155.1842240781, 163999.0, 164795.0, 164825.17587411986, 165439.0, 57935.13097303544, 58080.4191958075, 58134.0, 58160.0, 58271.0, 1213.0659392267905, 1328.8471825740164, 1337.739140867541, 1350.2791874373147, 1354.9796753048909, 31147.84426077855, 31837.20406989751, 32171.839140804146, 32172.51741223837, 32790.5081423774, 47170.76414617905, 47366.28950565813, 47559.52440475551, 47625.52374476211, 47713.76143119262, 379025.0, 390970.0, 391232.0, 391790.0, 392318.0, 24559.263222103367, 27012.72987270102, 27439.862800685867, 27797.722022779515, 29399.412011760072, 47634.285485717046, 48411.27383089327, 48582.75708621434, 49124.0, 49835.0, 39387.793651267246, 40078.79960600295, 40143.39784903287, 40183.59816401915, 40531.39202912018, 39714.40428393519, 39808.80095599504, 40848.59151408448, 41034.589654103074, 41450.37824432696, 38329.6167038326, 39976.0, 40648.390274146506, 40961.795191023855, 41167.1766564673, 35621.46567801537, 36477.27045459129, 36748.0, 36892.26215475729, 37277.440838387985, 27871.303217419725, 27916.860415697793, 27995.860020699765, 28182.0, 28401.857990709916], "value": 19033.546667237064, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.649059355986, 387.4266086192433, 390.84756944791536, 404.8340180525984, 416.18427881352545, 14003.0, 14067.437302507888, 18816.4355069348, 19241.037948102592, 19304.90347548262, 16630.75053874193, 17606.0, 17712.20295086721, 17718.20268087936, 18488.168032438538, 5610.382857885629, 5757.453041961007, 5916.0, 5918.437748413915, 5962.940370596303, 5772.797952071678, 5800.709964501779, 5842.240508733858, 5866.501347385477, 5868.207791948075, 5704.204939579597, 5778.942210577903, 5809.215755872945, 5817.331006934193, 5819.418058194189, 5802.738876750556, 5827.35899051104, 5830.82507524775, 5888.617239879415, 5888.911666325009, 5160.251763494272, 5203.739813009334, 5212.29633999409, 5224.425313215544, 5248.763805628756, 22236.110555577758, 22580.435489112904, 22668.0, 22683.659745103836, 22743.203987860346, 2521.5461216980934, 2527.3555243412998, 2918.883244670211, 3033.453978283908, 3070.9846450767827, 13173.802392964113, 14228.786568201485, 14562.927185364006, 14625.414983400651, 14678.853211467855, 1884.4723477426342, 1905.3712274949235, 1914.2534411579495, 1939.3309308288617, 2061.4846288427893, 48926.7553662233, 67353.32646673569, 67373.0, 76204.61897690476, 80541.19458805454, 10257.94871025655, 10285.7428564285, 10374.844377334346, 10431.634892778717, 10538.0, 14630.414783408758, 14762.114273143647, 14768.409263629335, 14791.112533248039, 14800.777988330183, 7733.226677332222, 7856.25365590268, 7919.168487308865, 8043.919560804317, 8132.186781321939, 7476.327130558276, 7551.358134558624, 7612.3148916596665, 7624.656890439833, 7966.522008679498, 6411.3971507123215, 6569.408753212234, 6599.340065993459, 6633.568818026813, 6664.400203981568, 1895.175598614607, 1901.9524511887037, 1906.790253072161, 1907.6661584222707, 1914.636219118363, 945.7588314979636, 997.0577803975174, 1018.2414101494434, 1052.032130439997, 1057.5241141486363, 18749.156287967075, 19256.22975080981, 19289.131989060526, 19328.2803838114, 19529.902350488155, 986.225812736998, 986.4870267461024, 1033.1734612310122, 1050.1441325319993, 1075.602027249907, 10445.477726113664, 11005.944970275257, 11112.11103111749, 11151.498182581803, 11194.66416007521, 475381.0, 481764.0, 489197.0, 490554.0, 491384.0, 79557.20442795497, 83016.58491707503, 85758.57120714357, 86350.56824715836, 86866.0, 1016.4358780876685, 1021.0759262867117, 1021.4484178543652, 1031.3708637730979, 1033.994830025845, 17021.0, 17085.145742712564, 17284.222210000327, 17316.30734770595, 17473.82526174773, 33615.32769344648, 39903.40144897887, 40560.79719601383, 41791.7910410446, 43673.78163109164, 56490.71754641201, 56746.43253567412, 57577.71211143918, 57778.0, 57858.421415785306, 8059.717909873127, 8234.135415781257, 8330.083690793886, 8371.497710137412, 8406.789830254293, 9443.527823608654, 13107.049868322125, 13423.127496712683, 13476.0, 13833.377498012413, 11209.439528023404, 11614.245074070159, 11955.940220298842, 12029.218100823418, 12099.153059285765, 11722.94138529302, 11893.940530297294, 11915.093585026701, 12000.279983201035, 12096.092793040732, 11806.881931180922, 12005.699857503632, 12023.879761202275, 12058.939705301418, 12065.215760975509, 8092.878606820785, 8116.878246826421, 8324.0, 8588.65645374203, 8717.564121794012, 8618.181272779077, 10733.892661073289, 10944.890551094388, 11384.772304554028, 11802.52789888395], "value": 9238.263449452801, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.0654482045336, 1428.1930709149333, 1478.2682572126798, 1586.595418168367, 1729.6973029719788, 8328.042275138361, 8330.625121869516, 8406.78983025424, 8544.74365769028, 8545.957270213656, 8096.5951702414795, 8265.876011859827, 8318.41771076025, 8343.249107580317, 8351.91648083519, 2330.19608235159, 2360.988195059031, 2361.4568649210605, 2362.196853069956, 2363.9763602364014, 2278.5670722562745, 2336.3458231695154, 2357.6581395697613, 2363.184701278065, 2365.254944692425, 2294.3231746634783, 2298.747137814839, 2316.6756654068445, 2317.884105794712, 2330.6387509935985, 2245.5845668551287, 2253.43664083979, 2265.161890100673, 2268.7617800130997, 2279.076973825595, 2235.1953296813135, 2246.5169988452562, 2247.6179049561615, 2247.9662805057937, 2248.336740661509, 8116.472429292077, 8318.958405207995, 8383.95808020962, 8413.368997325226, 8437.409381343308, 5095.79616815327, 5222.0861349264105, 5223.921641175385, 5224.268602395668, 5227.843164705065, 3378.341223461426, 3387.4580067189377, 3407.931841363159, 3469.202083520779, 3476.9130771730656, 1062.8405739139114, 1074.237291523012, 2119.629064913634, 2148.366231961575, 2214.9889250553642, 12934.870651293555, 13057.738845223137, 13099.738005239937, 13146.342682865914, 13161.144525605805, 4525.705829121097, 4559.658025648089, 4664.766761661904, 4672.0, 4673.112108699336, 9819.656312029045, 9826.06652368024, 9845.212383009342, 9859.30984831055, 9863.16163126128, 5385.8114965976, 5390.97304513475, 5390.97304513475, 5394.244805727201, 5397.0, 4361.105973275471, 4806.206975849016, 4874.36633237684, 5038.622103342264, 5070.569001634829, 3632.5277713897026, 3680.0, 3720.8511659533315, 3740.682042026404, 3782.7730336179916, 1104.6133853151332, 1105.6793529876245, 1108.711734948919, 1114.420501339299, 1114.6878873915316, 809.3760976792171, 945.2485274207022, 1002.3935519011039, 1019.0522813783105, 1031.5254982707888, 6038.849028774316, 6136.202293701879, 6273.309935907047, 6286.842828929313, 6420.646864422408, 965.4496936746128, 985.4333758088984, 991.4596544883057, 1012.6708819633649, 1026.097034609539, 4125.8968525786495, 4264.7654379009455, 4284.785760711952, 4288.120935208337, 4290.721103128287, 10877.456127193609, 11018.283811552223, 11077.335359878432, 11167.218294719292, 11179.83230251547, 10403.84394234087, 11062.778744425066, 11068.944655276671, 11078.0, 11123.499442525106, 7950.1254861965135, 8090.0, 8139.982502187227, 8157.265846073763, 8159.143289954469, 6025.096235564701, 6341.746330146742, 6364.395382438661, 6404.935950640434, 6425.036244563166, 9826.9017309826, 10142.0, 10219.693409197736, 10249.180065594586, 10255.384676919408, 10017.298789084694, 10142.89857101449, 10313.22650801178, 10405.167586592903, 10406.167506599606, 7667.539947603162, 7688.730894418893, 7810.531368117931, 7816.570088644951, 7823.804404889924, 8281.710140145065, 8341.16588341161, 8385.916140838757, 8452.070272269922, 8518.574071296534, 7508.849823003618, 7617.27635874591, 7655.1962043986805, 7668.539887606761, 7698.230176982257, 7518.774436766906, 7528.473006889684, 7567.886481702669, 7618.504797188165, 7787.688492460238, 7065.929340706527, 7077.893831592633, 7080.468964827555, 7095.645217738989, 7178.928210717826, 5254.13306804373, 5256.526912577886, 5317.574594032545, 5378.462153784591, 5389.541888939484, 5345.839624811262, 5385.946140538701, 5527.032769265443, 5558.277423934863, 5559.33288005442], "value": 4687.098475063257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.3799830364714, 302.21725730358395, 302.6096335726912, 309.86520863424414, 315.0736833708896, 5163.277141200235, 5171.637985341028, 5327.413984461706, 5398.838034858951, 5400.324959380077, 5241.9213711794255, 5287.788488460457, 5297.788088476456, 5298.814541491049, 5314.893702125955, 4145.362581780195, 4146.108586653869, 4148.045949431633, 4155.210510003105, 4183.560726123759, 3834.5398552173638, 3966.4050392441222, 4111.951452379654, 4183.970774174523, 4223.873283801491, 4065.654419374342, 4094.242565125461, 4130.793460326987, 4139.937900931488, 4151.750894946298, 4073.40935564343, 4100.7334523255895, 4105.363668631367, 4131.938020929659, 4208.053188032699, 3444.156181735466, 3693.279810436966, 3700.1674623209833, 3708.091517578184, 3724.0689827543115, 5185.974070129663, 5191.351081114861, 5203.531682148625, 5210.817621383271, 5211.1922651989, 4709.1994360958715, 4724.338592597039, 4737.26572381278, 4762.214234651278, 4773.4510531289, 5393.9730301348245, 5509.696966666832, 5523.25436066134, 5558.166275058733, 5577.721113944286, 3965.167314863882, 3976.9858686035163, 3978.0, 4020.6984476164403, 4033.6168064034164, 5773.711314434304, 5782.3639399666, 5790.899729051467, 5798.478136967693, 5805.245318108661, 3851.9229615408094, 3992.620701033455, 4010.47863777707, 4017.493439960015, 4024.1951609677594, 4015.4779878616177, 4025.5370632377067, 4026.4966879140106, 4033.8991525212105, 4046.959530404717, 4646.930296045562, 4649.3026046093355, 4678.134545109166, 4686.882827929329, 4688.320193571913, 5602.38373778884, 5623.634463759842, 5625.212470254086, 5628.099504079328, 5696.0, 1358.44303835427, 1406.3811922753955, 1407.774756039029, 1412.4491448334952, 1417.971640567183, 858.9742307730778, 866.328595338605, 877.9692710755093, 886.822635472908, 888.1784349476708, 4766.285057241442, 4803.663743537919, 4813.326134341195, 4815.253635686474, 4832.685875418087, 5068.366454193226, 5092.414372347153, 5105.540501354896, 5112.00947445741, 5159.793608255703, 4736.905261894743, 4894.363732714724, 4899.191633380452, 4901.926471102936, 4964.453910069889, 3060.7704422168426, 3087.521434177706, 3089.9845500772803, 3095.6904309568863, 3117.0960421477516, 5990.221271234712, 5998.49012833914, 6003.219581454383, 6006.609570377911, 6024.608400453956, 5651.965292494699, 5954.880902382015, 5967.671778052249, 5978.0, 5978.940210597925, 5928.073376152682, 5940.287165540163, 5953.970230148821, 5983.311919129356, 6005.519558435315, 5594.9720251398485, 5799.797007104731, 5802.709864506842, 5842.444967728059, 5851.561132914963, 5720.256366672306, 5739.253896993364, 5745.2818397700285, 5750.338711048283, 5763.7406316715005, 5954.583179177416, 5956.642601443928, 5957.195778569838, 5960.314563825215, 6001.969990150022, 3856.402257650069, 3988.720789544704, 4052.412400202013, 4068.3287257602165, 4092.959070409258, 5634.549236061023, 5653.632513886584, 5772.365039845529, 5778.335491418541, 5809.593328466966, 5623.971880140573, 5634.85912852182, 5669.0, 5677.205191273308, 5694.0, 5366.919496207638, 5652.660840349592, 5664.546836253007, 5668.69619987397, 5670.773169073191, 5532.723363831873, 5542.61201715876, 5576.776928922797, 5660.9150862737915, 5660.943390566042, 5410.323709536308, 5650.259624082399, 5656.462636049569, 5716.857078573069, 5721.370649228665, 5523.8895222096135, 5536.833894983157, 5554.055810512304, 5566.192902029264, 5575.080111781511], "value": 4205.723049290987, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.3070640364064, 785.8094986096065, 812.1594150054693, 840.9159084091588, 847.4999750147414, 15111.471098511554, 16250.674986500293, 16262.593435164097, 16292.185390730461, 16294.348226070973, 14324.641883952907, 15347.923260383683, 15354.309056092474, 15366.078035317889, 15382.846171538282, 680.3672584496417, 807.2895851650569, 831.3100126894662, 842.4187310755559, 851.1998721202082, 825.0923983618002, 845.9492430454162, 846.8094678697305, 846.9957650211741, 847.8728190771403, 877.9824403511926, 884.5488800711652, 889.4218757807445, 892.1747383670079, 893.7318804358666, 710.2294010998047, 838.1827717974986, 868.3747701654798, 878.4114643189047, 884.0275696733573, 633.8478765096389, 634.1629049654458, 634.2959315160168, 634.3973225435808, 634.4797266241684, 15247.923760381238, 15277.0, 15303.617409564738, 15304.923475382551, 15324.0, 14178.43286268548, 14604.34280457382, 14630.780538291934, 14709.632259193499, 14764.926175369163, 12739.0, 12764.17032892859, 12883.291418971952, 12910.22538647684, 13477.86522134776, 4505.256632655608, 4589.724616523019, 4648.023914977859, 4713.449885419716, 4760.452547956995, 73093.26906730917, 73282.26717732807, 73911.63044184745, 74057.62971185164, 74111.0, 10305.278630495794, 10903.221949907289, 11233.55065797359, 11317.886821131848, 11504.539818407336, 20927.26754563583, 21020.47448813792, 21145.471363215736, 21212.46968825761, 21249.36251912445, 8364.330853531703, 8395.118512556215, 8446.324294056461, 8570.271526920156, 8611.0, 4783.6651434399255, 4833.661643684908, 4874.512548745097, 5002.299678045077, 5053.1157047516535, 3477.23500829817, 3623.9456408153897, 3625.3474374612297, 3647.5258216432226, 3656.1773600939578, 600.6576251536583, 612.2775125352039, 622.5331001748689, 626.9905951410733, 636.9299377068519, 654.5156584127807, 663.6913835066717, 685.0466088710072, 693.3690341789048, 708.3412426443354, 8774.122587741174, 8790.384673072951, 8818.382713210141, 9047.954760226157, 9066.909330906738, 603.384547761281, 661.7319985405918, 666.540087339734, 689.4966674327769, 695.3359541637724, 4181.665466762652, 4221.5778422158155, 4271.295236286041, 4272.5727427257025, 4380.824767009284, 67167.66416167986, 67225.6638716813, 67780.0, 86542.0, 112698.0, 58446.707766460895, 59050.40949590535, 59424.40575594275, 60074.0, 61183.0, 55138.448615514135, 74311.62844185745, 88511.55744221238, 88681.11318886858, 89832.10167898238, 8953.686620968236, 9098.36311458218, 9200.35597508168, 9206.17144457002, 9253.722418226353, 51445.22832157446, 52392.0, 52907.73546132399, 52984.0, 53259.46740532545, 68937.0, 69951.6502417505, 76105.61947190229, 78417.21582784099, 79755.0, 10666.0, 10902.345859248471, 10933.398663073607, 11137.0, 11320.26418282809, 12415.93792031034, 12430.192037517894, 12562.37188140571, 12720.936395317964, 13134.737305254033, 11445.713857153638, 11532.077433805107, 11695.532178712756, 11985.880141198826, 12376.938115309365, 11093.278936869077, 11122.44387780624, 11321.094312455149, 11364.204505684853, 11687.415629218334, 11100.666979990614, 11115.555377784798, 11393.202475826612, 11570.479328430409, 11778.352190629255, 9491.620335186515, 9527.57125929321, 9728.12446879756, 9912.107910288109, 10003.14973227284, 9151.725448236564, 9926.354786938826, 11293.43532823339, 11826.34955077479, 11861.822072669089], "value": 7192.780461411815, "unit": "score"}], "name": "dromaeo_css", "value": 7148.691164555004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 109.0, 111.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 131.0, 178.0, 130.0, 132.0, 155.0, 123.0, 183.0, 132.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 161.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 137.0, 76.0, 76.0, 76.0, 75.0, 98.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 123.0, 86.0, 86.0, 85.0, 128.0, 85.0, 85.0, 121.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 51.0, 52.0, 52.0, 57.0, 55.0, 54.0, 53.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 78.0, 79.0, 79.0, 80.0, 81.0, 85.0, 109.0, 80.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 122.0, 124.0, 127.0, 125.0, 119.0, 124.0, 137.0, 125.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 160.0, 161.0, 166.0, 165.0, 165.0, 162.0, 162.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 62.0, 65.0, 66.0, 63.0, 62.0, 63.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1505.6999999999998, "alertThreshold": 2.0}]} 16:36:36 INFO - Return code: 0 16:36:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:36 INFO - # TBPL SUCCESS # 16:36:36 INFO - Running post-action listener: _resource_record_post_action 16:36:36 INFO - ##### 16:36:36 INFO - ##### Finished run-tests step (success) 16:36:36 INFO - ##### 16:36:36 INFO - Running post-run listener: _resource_record_post_run 16:36:37 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 558333952; Read time: 0; Write time: 706256 16:36:37 INFO - TinderboxPrint: CPU usage
13.2% 16:36:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:36:37 INFO - TinderboxPrint: I/O write bytes / time
558,333,952 / 706,256 16:36:37 INFO - TinderboxPrint: CPU idle
8,270.7 (86.8%) 16:36:37 INFO - TinderboxPrint: CPU user
1,208.6 (12.7%) 16:36:37 INFO - TinderboxPrint: Swap in / out
0 / 0 16:36:37 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 263245824; Read time: 0; Write time: 463352 16:36:37 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 295088128; Read time: 0; Write time: 242904 16:36:37 INFO - Running post-run listener: _upload_blobber_files 16:36:37 INFO - Blob upload gear active. 16:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:37 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:36:37 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:36:37 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:36:38 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:39 INFO - (blobuploader) - INFO - Done attempting. 16:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:40 INFO - (blobuploader) - INFO - Done attempting. 16:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:36:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:43 INFO - (blobuploader) - INFO - Done attempting. 16:36:43 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:43 INFO - Return code: 0 16:36:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da7e088e19ef130814c18a2ec41109f333e8639e562aac82f731083bcfceedd39ef31defb2699b86fffceb80fd07531edcf4faa5f7c0ea23bc8178f72d2b128f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c4fcbeac77cf0436dbf8dcca2bbc8b4dbbf7c377b2555bc6d3a29646fa457057ff55b21c1eeaeb2d4f8471e8406ac826fa49a7d8939d96a717e2f6089c7e6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f87d85b191be7559c61d412c43c1a76cc8f2cf168ae1be19dfc6976181d7f6b52bb5350106224c9e43156eb2e5bf17f32b19b3c482178ab43d008cf9b506fda"} 16:36:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:43 INFO - Contents: 16:36:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da7e088e19ef130814c18a2ec41109f333e8639e562aac82f731083bcfceedd39ef31defb2699b86fffceb80fd07531edcf4faa5f7c0ea23bc8178f72d2b128f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c4fcbeac77cf0436dbf8dcca2bbc8b4dbbf7c377b2555bc6d3a29646fa457057ff55b21c1eeaeb2d4f8471e8406ac826fa49a7d8939d96a717e2f6089c7e6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f87d85b191be7559c61d412c43c1a76cc8f2cf168ae1be19dfc6976181d7f6b52bb5350106224c9e43156eb2e5bf17f32b19b3c482178ab43d008cf9b506fda"} 16:36:43 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:43 INFO - Copying logs to upload dir... 16:36:43 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.222601 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-17 16:36:42.755772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 16:36:42.759762) ========= 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=62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da7e088e19ef130814c18a2ec41109f333e8639e562aac82f731083bcfceedd39ef31defb2699b86fffceb80fd07531edcf4faa5f7c0ea23bc8178f72d2b128f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c4fcbeac77cf0436dbf8dcca2bbc8b4dbbf7c377b2555bc6d3a29646fa457057ff55b21c1eeaeb2d4f8471e8406ac826fa49a7d8939d96a717e2f6089c7e6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f87d85b191be7559c61d412c43c1a76cc8f2cf168ae1be19dfc6976181d7f6b52bb5350106224c9e43156eb2e5bf17f32b19b3c482178ab43d008cf9b506fda"} build_url:https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/ZA3FKiGoT0KbbxrKjww1GQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da7e088e19ef130814c18a2ec41109f333e8639e562aac82f731083bcfceedd39ef31defb2699b86fffceb80fd07531edcf4faa5f7c0ea23bc8178f72d2b128f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e8c4fcbeac77cf0436dbf8dcca2bbc8b4dbbf7c377b2555bc6d3a29646fa457057ff55b21c1eeaeb2d4f8471e8406ac826fa49a7d8939d96a717e2f6089c7e6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4f87d85b191be7559c61d412c43c1a76cc8f2cf168ae1be19dfc6976181d7f6b52bb5350106224c9e43156eb2e5bf17f32b19b3c482178ab43d008cf9b506fda"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 16:36:42.785372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 16:36:42.785680) ========= 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=62c568580acbfdaac3eec7be000001dc-1466192604.975585-1293656179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 16:36:42.871311) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 16:36:42.871638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 16:36:42.871936) ========= ========= Total master_lag: 0.17 =========