builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1466064844.52 results: success (0) buildid: 20160615223049 builduid: 9fb24984afce4492ba7de007916ad9bf revision: b4867459589df246d85972669074233b8d2e23b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.520994) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.521673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.521962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.564394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.564677) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 01:14:04-- 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% 113M=0s 2016-06-16 01:14:04 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084508 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.662841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.663125) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.713109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:04.713444) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b4867459589df246d85972669074233b8d2e23b8 --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 b4867459589df246d85972669074233b8d2e23b8 --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=edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 01:14:04,839 truncating revision to first 12 chars 2016-06-16 01:14:04,840 Setting DEBUG logging. 2016-06-16 01:14:04,840 attempt 1/10 2016-06-16 01:14:04,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b4867459589d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 01:14:05,372 unpacking tar archive at: mozilla-inbound-b4867459589d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:05.605831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:05.606181) ========= script_repo_revision: b4867459589df246d85972669074233b8d2e23b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:05.606613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:05.606906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:14:05.617658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-16 01:14:05.618045) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:14:05 INFO - MultiFileLogger online at 20160616 01:14:05 in /builds/slave/test 01:14:05 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 01:14:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:14:05 INFO - {'append_to_log': False, 01:14:05 INFO - 'base_work_dir': '/builds/slave/test', 01:14:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:14:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:14:05 INFO - 'branch': 'Mozilla-Inbound', 01:14:05 INFO - 'buildbot_json_path': 'buildprops.json', 01:14:05 INFO - 'config_files': ('talos/linux_config.py',), 01:14:05 INFO - 'default_actions': ('clobber', 01:14:05 INFO - 'read-buildbot-config', 01:14:05 INFO - 'download-and-extract', 01:14:05 INFO - 'populate-webroot', 01:14:05 INFO - 'create-virtualenv', 01:14:05 INFO - 'install', 01:14:05 INFO - 'run-tests'), 01:14:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:14:05 INFO - 'download_minidump_stackwalk': True, 01:14:05 INFO - 'download_symbols': 'ondemand', 01:14:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:14:05 INFO - 'tooltool.py': '/tools/tooltool.py', 01:14:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:14:05 INFO - '/tools/misc-python/virtualenv.py')}, 01:14:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:14:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:14:05 INFO - 'installer_path': 'installer.exe', 01:14:05 INFO - 'log_level': 'info', 01:14:05 INFO - 'log_name': 'talos', 01:14:05 INFO - 'log_to_console': True, 01:14:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:14:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:14:05 INFO - 'opt_config_files': (), 01:14:05 INFO - 'pip_index': False, 01:14:05 INFO - 'sps_profile': False, 01:14:05 INFO - 'sps_profile_interval': 0, 01:14:05 INFO - 'suite': 'dromaeojs', 01:14:05 INFO - 'system_bits': '32', 01:14:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:14:05 INFO - 'title': 'talos-linux64-ix-033', 01:14:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:14:05 INFO - 'use_talos_json': True, 01:14:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:14:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:14:05 INFO - 'work_dir': 'build'} 01:14:05 INFO - ##### 01:14:05 INFO - ##### Running clobber step. 01:14:05 INFO - ##### 01:14:05 INFO - Running pre-action listener: _resource_record_pre_action 01:14:05 INFO - Running main action method: clobber 01:14:05 INFO - rmtree: /builds/slave/test/build 01:14:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:14:06 INFO - Running post-action listener: _resource_record_post_action 01:14:06 INFO - ##### 01:14:06 INFO - ##### Finished clobber step (success) 01:14:06 INFO - ##### 01:14:06 INFO - ##### 01:14:06 INFO - ##### Running read-buildbot-config step. 01:14:06 INFO - ##### 01:14:06 INFO - Running pre-action listener: _resource_record_pre_action 01:14:06 INFO - Running main action method: read_buildbot_config 01:14:06 INFO - Using buildbot properties: 01:14:06 INFO - { 01:14:06 INFO - "project": "", 01:14:06 INFO - "product": "firefox", 01:14:06 INFO - "script_repo_revision": "production", 01:14:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:14:06 INFO - "repository": "", 01:14:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:14:06 INFO - "buildid": "20160615223049", 01:14:06 INFO - "pgo_build": "True", 01:14:06 INFO - "basedir": "/builds/slave/test", 01:14:06 INFO - "buildnumber": 1187, 01:14:06 INFO - "slavename": "talos-linux64-ix-033", 01:14:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:14:06 INFO - "platform": "ubuntu64_hw", 01:14:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:14:06 INFO - "branch": "mozilla-inbound", 01:14:06 INFO - "repo_path": "integration/mozilla-inbound", 01:14:06 INFO - "revision": "b4867459589df246d85972669074233b8d2e23b8", 01:14:06 INFO - "stage_platform": "linux64-pgo", 01:14:06 INFO - "builduid": "9fb24984afce4492ba7de007916ad9bf", 01:14:06 INFO - "slavebuilddir": "test" 01:14:06 INFO - } 01:14:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:14:06 INFO - Running post-action listener: _resource_record_post_action 01:14:06 INFO - ##### 01:14:06 INFO - ##### Finished read-buildbot-config step (success) 01:14:06 INFO - ##### 01:14:06 INFO - ##### 01:14:06 INFO - ##### Running download-and-extract step. 01:14:06 INFO - ##### 01:14:06 INFO - Running pre-action listener: _resource_record_pre_action 01:14:06 INFO - Running main action method: download_and_extract 01:14:06 INFO - mkdir: /builds/slave/test/build/tests 01:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:06 INFO - https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:07 INFO - Downloaded 1361 bytes. 01:14:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:07 INFO - Using the following test package requirements: 01:14:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:14:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:14:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'jsshell-linux-x86_64.zip'], 01:14:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:14:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:14:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:14:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:14:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:14:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:07 INFO - https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:08 INFO - Downloaded 24220768 bytes. 01:14:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:14:10 INFO - Return code: 0 01:14:10 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 01:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:10 INFO - https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:11 INFO - Downloaded 24220768 bytes. 01:14:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:14:12 INFO - Return code: 0 01:14: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')]} 01:14:12 INFO - https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:13 INFO - Downloaded 14405384 bytes. 01:14:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:14:14 INFO - Return code: 0 01:14: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')]} 01:14:14 INFO - https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZwdI_woSm2jZED4B8dsxw/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 01:14:16 INFO - Downloaded 59413636 bytes. 01:14:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:16 INFO - mkdir: /builds/slave/test/properties 01:14:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:14:16 INFO - Writing to file /builds/slave/test/properties/build_url 01:14:16 INFO - Contents: 01:14:16 INFO - build_url:https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:17 INFO - Running post-action listener: _resource_record_post_action 01:14:17 INFO - Running post-action listener: set_extra_try_arguments 01:14:17 INFO - ##### 01:14:17 INFO - ##### Finished download-and-extract step (success) 01:14:17 INFO - ##### 01:14:17 INFO - ##### 01:14:17 INFO - ##### Running populate-webroot step. 01:14:17 INFO - ##### 01:14:17 INFO - Running pre-action listener: _resource_record_pre_action 01:14:17 INFO - Running main action method: populate_webroot 01:14:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:14:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:14:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:14:17 INFO - '--tppagecycles', 01:14:17 INFO - '7'], 01:14:17 INFO - 'tests': ['tsvgm']}}, 01:14:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:14:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:14:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:14:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:14:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['damp', 'tps']}, 01:14:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'tests': ['damp', 'tps']}, 01:14:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['dromaeo_dom']}, 01:14:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:14:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['basic_compositor_video']}, 01:14:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:14:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['a11yr', 01:14:17 INFO - 'ts_paint', 01:14:17 INFO - 'tpaint', 01:14:17 INFO - 'sessionrestore', 01:14:17 INFO - 'sessionrestore_no_auto_restore', 01:14:17 INFO - 'tabpaint']}, 01:14:17 INFO - 'other-e10s': {'tests': ['a11yr', 01:14:17 INFO - 'ts_paint', 01:14:17 INFO - 'tpaint', 01:14:17 INFO - 'sessionrestore', 01:14:17 INFO - 'sessionrestore_no_auto_restore', 01:14:17 INFO - 'tabpaint']}, 01:14:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:14:17 INFO - 'ts_paint', 01:14:17 INFO - 'tpaint', 01:14:17 INFO - 'sessionrestore', 01:14:17 INFO - 'sessionrestore_no_auto_restore', 01:14:17 INFO - 'tabpaint']}, 01:14:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:14:17 INFO - 'ts_paint', 01:14:17 INFO - 'tpaint', 01:14:17 INFO - 'sessionrestore', 01:14:17 INFO - 'sessionrestore_no_auto_restore', 01:14:17 INFO - 'tabpaint']}, 01:14:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['a11yr', 01:14:17 INFO - 'ts_paint', 01:14:17 INFO - 'tpaint', 01:14:17 INFO - 'sessionrestore', 01:14:17 INFO - 'sessionrestore_no_auto_restore', 01:14:17 INFO - 'tabpaint']}, 01:14:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['a11yr', 01:14:17 INFO - 'ts_paint', 01:14:17 INFO - 'tpaint', 01:14:17 INFO - 'sessionrestore', 01:14:17 INFO - 'sessionrestore_no_auto_restore', 01:14:17 INFO - 'tabpaint']}, 01:14:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['tsvgx', 01:14:17 INFO - 'tsvgr_opacity', 01:14:17 INFO - 'tart', 01:14:17 INFO - 'tscrollx', 01:14:17 INFO - 'cart']}, 01:14:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:14:17 INFO - 'tsvgr_opacity', 01:14:17 INFO - 'tart', 01:14:17 INFO - 'tscrollx', 01:14:17 INFO - 'cart']}, 01:14:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'talos_options': ['--disable-e10s'], 01:14:17 INFO - 'tests': ['tp5o']}, 01:14:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'tests': ['tp5o']}, 01:14:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'talos_options': ['--disable-e10s', 01:14:17 INFO - '--xperf_path', 01:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:17 INFO - 'tests': ['tp5n']}, 01:14:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:17 INFO - 'talos_options': ['--xperf_path', 01:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:17 INFO - 'tests': ['tp5n']}}, 01:14:17 INFO - 'talos.zip': {'path': '', 01:14:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:14:17 INFO - Running post-action listener: _resource_record_post_action 01:14:17 INFO - ##### 01:14:17 INFO - ##### Finished populate-webroot step (success) 01:14:17 INFO - ##### 01:14:17 INFO - ##### 01:14:17 INFO - ##### Running create-virtualenv step. 01:14:17 INFO - ##### 01:14:17 INFO - Running pre-action listener: _resource_record_pre_action 01:14:17 INFO - Running main action method: create_virtualenv 01:14:17 INFO - Creating virtualenv /builds/slave/test/build/venv 01:14:17 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 01:14:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:14:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:14:17 INFO - Using real prefix '/usr' 01:14:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:14:18 INFO - Installing distribute.............................................................................................................................................................................................done. 01:14:20 INFO - Installing pip.................done. 01:14:20 INFO - Return code: 0 01:14:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14: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 01:14: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 01:14:20 INFO - Using env: {'DISPLAY': ':0', 01:14:20 INFO - 'HOME': '/home/cltbld', 01:14:20 INFO - 'LANG': 'en_US.UTF-8', 01:14:20 INFO - 'LANGUAGE': 'en_US:en', 01:14:20 INFO - 'LOGNAME': 'cltbld', 01:14:20 INFO - 'MAIL': '/var/mail/cltbld', 01:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:20 INFO - 'MOZ_NO_REMOTE': '1', 01:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:20 INFO - 'NO_EM_RESTART': '1', 01:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:20 INFO - 'PWD': '/builds/slave/test', 01:14:20 INFO - 'SHELL': '/bin/bash', 01:14:20 INFO - 'SHLVL': '1', 01:14:20 INFO - 'TERM': 'linux', 01:14:20 INFO - 'TMOUT': '86400', 01:14:20 INFO - 'USER': 'cltbld', 01:14:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:20 INFO - '_': '/tools/buildbot/bin/python'} 01:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14: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 01:14:20 INFO - Cleaning up... 01:14:20 INFO - Return code: 0 01:14:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14: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 01:14: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 01:14:20 INFO - Using env: {'DISPLAY': ':0', 01:14:20 INFO - 'HOME': '/home/cltbld', 01:14:20 INFO - 'LANG': 'en_US.UTF-8', 01:14:20 INFO - 'LANGUAGE': 'en_US:en', 01:14:20 INFO - 'LOGNAME': 'cltbld', 01:14:20 INFO - 'MAIL': '/var/mail/cltbld', 01:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:20 INFO - 'MOZ_NO_REMOTE': '1', 01:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:20 INFO - 'NO_EM_RESTART': '1', 01:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:20 INFO - 'PWD': '/builds/slave/test', 01:14:20 INFO - 'SHELL': '/bin/bash', 01:14:20 INFO - 'SHLVL': '1', 01:14:20 INFO - 'TERM': 'linux', 01:14:20 INFO - 'TMOUT': '86400', 01:14:20 INFO - 'USER': 'cltbld', 01:14:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:20 INFO - '_': '/tools/buildbot/bin/python'} 01:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:20 INFO - Downloading/unpacking psutil>=3.1.1 01:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:22 INFO - Installing collected packages: psutil 01:14:22 INFO - Running setup.py install for psutil 01:14:22 INFO - building 'psutil._psutil_linux' extension 01:14:22 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 01:14:22 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 01:14:22 INFO - building 'psutil._psutil_posix' extension 01:14:22 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 01:14: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 01:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:23 INFO - Successfully installed psutil 01:14:23 INFO - Cleaning up... 01:14:23 INFO - Return code: 0 01:14:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14: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 01:14: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 01:14:23 INFO - Using env: {'DISPLAY': ':0', 01:14:23 INFO - 'HOME': '/home/cltbld', 01:14:23 INFO - 'LANG': 'en_US.UTF-8', 01:14:23 INFO - 'LANGUAGE': 'en_US:en', 01:14:23 INFO - 'LOGNAME': 'cltbld', 01:14:23 INFO - 'MAIL': '/var/mail/cltbld', 01:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:23 INFO - 'MOZ_NO_REMOTE': '1', 01:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:23 INFO - 'NO_EM_RESTART': '1', 01:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:23 INFO - 'PWD': '/builds/slave/test', 01:14:23 INFO - 'SHELL': '/bin/bash', 01:14:23 INFO - 'SHLVL': '1', 01:14:23 INFO - 'TERM': 'linux', 01:14:23 INFO - 'TMOUT': '86400', 01:14:23 INFO - 'USER': 'cltbld', 01:14:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:23 INFO - '_': '/tools/buildbot/bin/python'} 01:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:14:25 INFO - Installing collected packages: mozsystemmonitor 01:14:25 INFO - Running setup.py install for mozsystemmonitor 01:14:25 INFO - Successfully installed mozsystemmonitor 01:14:25 INFO - Cleaning up... 01:14:25 INFO - Return code: 0 01:14:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:14:25 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')]} 01:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:25 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')]} 01:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:25 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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14:25 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 01:14:25 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 01:14:25 INFO - Using env: {'DISPLAY': ':0', 01:14:25 INFO - 'HOME': '/home/cltbld', 01:14:25 INFO - 'LANG': 'en_US.UTF-8', 01:14:25 INFO - 'LANGUAGE': 'en_US:en', 01:14:25 INFO - 'LOGNAME': 'cltbld', 01:14:25 INFO - 'MAIL': '/var/mail/cltbld', 01:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:25 INFO - 'MOZ_NO_REMOTE': '1', 01:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:25 INFO - 'NO_EM_RESTART': '1', 01:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:25 INFO - 'PWD': '/builds/slave/test', 01:14:25 INFO - 'SHELL': '/bin/bash', 01:14:25 INFO - 'SHLVL': '1', 01:14:25 INFO - 'TERM': 'linux', 01:14:25 INFO - 'TMOUT': '86400', 01:14:25 INFO - 'USER': 'cltbld', 01:14:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:25 INFO - '_': '/tools/buildbot/bin/python'} 01:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:25 INFO - Downloading/unpacking jsonschema==2.5.1 01:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:14:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 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 01:14:27 INFO - Downloading functools32-3.2.3-2.tar.gz 01:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:27 INFO - warning: no files found matching '*.txt' 01:14:27 INFO - no previously-included directories found matching 'build' 01:14:27 INFO - no previously-included directories found matching 'dist' 01:14:27 INFO - no previously-included directories found matching '.git*' 01:14:27 INFO - Installing collected packages: jsonschema, functools32 01:14:27 INFO - Running setup.py install for functools32 01:14:27 INFO - warning: no files found matching '*.txt' 01:14:27 INFO - no previously-included directories found matching 'build' 01:14:27 INFO - no previously-included directories found matching 'dist' 01:14:27 INFO - no previously-included directories found matching '.git*' 01:14:27 INFO - Successfully installed jsonschema functools32 01:14:27 INFO - Cleaning up... 01:14:28 INFO - Return code: 0 01:14:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14: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 01:14: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 01:14:28 INFO - Using env: {'DISPLAY': ':0', 01:14:28 INFO - 'HOME': '/home/cltbld', 01:14:28 INFO - 'LANG': 'en_US.UTF-8', 01:14:28 INFO - 'LANGUAGE': 'en_US:en', 01:14:28 INFO - 'LOGNAME': 'cltbld', 01:14:28 INFO - 'MAIL': '/var/mail/cltbld', 01:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:28 INFO - 'MOZ_NO_REMOTE': '1', 01:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:28 INFO - 'NO_EM_RESTART': '1', 01:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:28 INFO - 'PWD': '/builds/slave/test', 01:14:28 INFO - 'SHELL': '/bin/bash', 01:14:28 INFO - 'SHLVL': '1', 01:14:28 INFO - 'TERM': 'linux', 01:14:28 INFO - 'TMOUT': '86400', 01:14:28 INFO - 'USER': 'cltbld', 01:14:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:28 INFO - '_': '/tools/buildbot/bin/python'} 01:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:30 INFO - Downloading blobuploader-1.2.4.tar.gz 01:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:14:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:30 INFO - Downloading docopt-0.6.1.tar.gz 01:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:14:30 INFO - Installing collected packages: blobuploader, requests, docopt 01:14:30 INFO - Running setup.py install for blobuploader 01:14:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:14:30 INFO - Running setup.py install for requests 01:14:31 INFO - Running setup.py install for docopt 01:14:31 INFO - Successfully installed blobuploader requests docopt 01:14:31 INFO - Cleaning up... 01:14:31 INFO - Return code: 0 01:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:31 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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14:31 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 01:14:31 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 01:14:31 INFO - Using env: {'DISPLAY': ':0', 01:14:31 INFO - 'HOME': '/home/cltbld', 01:14:31 INFO - 'LANG': 'en_US.UTF-8', 01:14:31 INFO - 'LANGUAGE': 'en_US:en', 01:14:31 INFO - 'LOGNAME': 'cltbld', 01:14:31 INFO - 'MAIL': '/var/mail/cltbld', 01:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:31 INFO - 'MOZ_NO_REMOTE': '1', 01:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:31 INFO - 'NO_EM_RESTART': '1', 01:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:31 INFO - 'PWD': '/builds/slave/test', 01:14:31 INFO - 'SHELL': '/bin/bash', 01:14:31 INFO - 'SHLVL': '1', 01:14:31 INFO - 'TERM': 'linux', 01:14:31 INFO - 'TMOUT': '86400', 01:14:31 INFO - 'USER': 'cltbld', 01:14:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:31 INFO - '_': '/tools/buildbot/bin/python'} 01:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:31 INFO - Running setup.py (path:/tmp/pip-JNHKFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:31 INFO - Running setup.py (path:/tmp/pip-th_l_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:31 INFO - Running setup.py (path:/tmp/pip-2FnApL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:31 INFO - Running setup.py (path:/tmp/pip-4XjVLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:31 INFO - Running setup.py (path:/tmp/pip-18ZZoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:32 INFO - Running setup.py (path:/tmp/pip-pJEIpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:32 INFO - Running setup.py (path:/tmp/pip-Dqd2Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:32 INFO - Running setup.py (path:/tmp/pip-RfcDo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:32 INFO - Running setup.py (path:/tmp/pip-gkAdi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:32 INFO - Running setup.py (path:/tmp/pip-2PMRmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:32 INFO - Running setup.py (path:/tmp/pip-9Cm6H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:32 INFO - Running setup.py (path:/tmp/pip-HqUBAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:32 INFO - Running setup.py (path:/tmp/pip-a6gW9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:32 INFO - Running setup.py (path:/tmp/pip-bSQoAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:32 INFO - Running setup.py (path:/tmp/pip-3_yMjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:32 INFO - Running setup.py (path:/tmp/pip-4Adhzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:32 INFO - Running setup.py (path:/tmp/pip-etxpb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:14:32 INFO - Running setup.py install for manifestparser 01:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Running setup.py install for mozcrash 01:14:33 INFO - Running setup.py install for mozdebug 01:14:33 INFO - Running setup.py install for mozdevice 01:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Running setup.py install for mozfile 01:14:33 INFO - Running setup.py install for mozhttpd 01:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Running setup.py install for mozinfo 01:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Running setup.py install for mozInstall 01:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Running setup.py install for mozleak 01:14:33 INFO - Running setup.py install for mozlog 01:14:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:14:33 INFO - Running setup.py install for moznetwork 01:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Running setup.py install for mozprocess 01:14:34 INFO - Running setup.py install for mozprofile 01:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Running setup.py install for mozrunner 01:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Running setup.py install for mozscreenshot 01:14:34 INFO - Running setup.py install for moztest 01:14:34 INFO - Running setup.py install for mozversion 01:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:14:34 INFO - Cleaning up... 01:14:34 INFO - Return code: 0 01:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:34 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')]} 01:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:34 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')]} 01:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:34 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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14:34 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 01:14:34 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 01:14:34 INFO - Using env: {'DISPLAY': ':0', 01:14:34 INFO - 'HOME': '/home/cltbld', 01:14:34 INFO - 'LANG': 'en_US.UTF-8', 01:14:34 INFO - 'LANGUAGE': 'en_US:en', 01:14:34 INFO - 'LOGNAME': 'cltbld', 01:14:34 INFO - 'MAIL': '/var/mail/cltbld', 01:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:34 INFO - 'MOZ_NO_REMOTE': '1', 01:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:34 INFO - 'NO_EM_RESTART': '1', 01:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:34 INFO - 'PWD': '/builds/slave/test', 01:14:34 INFO - 'SHELL': '/bin/bash', 01:14:34 INFO - 'SHLVL': '1', 01:14:34 INFO - 'TERM': 'linux', 01:14:34 INFO - 'TMOUT': '86400', 01:14:34 INFO - 'USER': 'cltbld', 01:14:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:34 INFO - '_': '/tools/buildbot/bin/python'} 01:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:34 INFO - Running setup.py (path:/tmp/pip-1n6g5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:34 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)) 01:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:34 INFO - Running setup.py (path:/tmp/pip-BrJkNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14: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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:35 INFO - Running setup.py (path:/tmp/pip-c38Yl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14: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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:35 INFO - Running setup.py (path:/tmp/pip-a3CwLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14: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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:35 INFO - Running setup.py (path:/tmp/pip-6gr7R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14: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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:35 INFO - Running setup.py (path:/tmp/pip-AlnqXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:35 INFO - Running setup.py (path:/tmp/pip-ou6fHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:35 INFO - Running setup.py (path:/tmp/pip-ZvNnWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:35 INFO - Running setup.py (path:/tmp/pip-zpwY2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:35 INFO - Running setup.py (path:/tmp/pip-YtTyyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:35 INFO - Running setup.py (path:/tmp/pip-j6bz_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:35 INFO - Running setup.py (path:/tmp/pip-WiXM5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:35 INFO - Running setup.py (path:/tmp/pip-5KLXvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:35 INFO - Running setup.py (path:/tmp/pip-2Tv3a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:35 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)) 01:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:35 INFO - Running setup.py (path:/tmp/pip-14t0do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14: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)) 01:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:36 INFO - Running setup.py (path:/tmp/pip-CQz7Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14: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)) 01:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:36 INFO - Running setup.py (path:/tmp/pip-e_p80p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14: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)) 01:14: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)) 01:14: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)) 01:14: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)) 01:14: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)) 01:14: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)) 01:14:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:38 INFO - Downloading blessings-1.6.tar.gz 01:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:14:38 INFO - Installing collected packages: blessings 01:14:38 INFO - Running setup.py install for blessings 01:14:38 INFO - Successfully installed blessings 01:14:38 INFO - Cleaning up... 01:14:38 INFO - Return code: 0 01:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:38 INFO - Reading from file tmpfile_stdout 01:14:38 INFO - Current package versions: 01:14:38 INFO - argparse == 1.2.1 01:14:38 INFO - blessings == 1.6 01:14:38 INFO - blobuploader == 1.2.4 01:14:38 INFO - docopt == 0.6.1 01:14:38 INFO - functools32 == 3.2.3-2 01:14:38 INFO - jsonschema == 2.5.1 01:14:38 INFO - manifestparser == 1.1 01:14:38 INFO - mozInstall == 1.12 01:14:38 INFO - mozcrash == 0.17 01:14:38 INFO - mozdebug == 0.1 01:14:38 INFO - mozdevice == 0.48 01:14:38 INFO - mozfile == 1.2 01:14:38 INFO - mozhttpd == 0.7 01:14:38 INFO - mozinfo == 0.9 01:14:38 INFO - mozleak == 0.1 01:14:38 INFO - mozlog == 3.2 01:14:38 INFO - moznetwork == 0.27 01:14:38 INFO - mozprocess == 0.22 01:14:38 INFO - mozprofile == 0.28 01:14:38 INFO - mozrunner == 6.11 01:14:38 INFO - mozscreenshot == 0.1 01:14:38 INFO - mozsystemmonitor == 0.3 01:14:38 INFO - moztest == 0.7 01:14:38 INFO - mozversion == 1.4 01:14:38 INFO - psutil == 3.1.1 01:14:38 INFO - requests == 1.2.3 01:14:38 INFO - wsgiref == 0.1.2 01:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:38 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')]} 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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')]} 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14:38 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 01:14:38 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 01:14:38 INFO - Using env: {'DISPLAY': ':0', 01:14:38 INFO - 'HOME': '/home/cltbld', 01:14:38 INFO - 'LANG': 'en_US.UTF-8', 01:14:38 INFO - 'LANGUAGE': 'en_US:en', 01:14:38 INFO - 'LOGNAME': 'cltbld', 01:14:38 INFO - 'MAIL': '/var/mail/cltbld', 01:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:38 INFO - 'MOZ_NO_REMOTE': '1', 01:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:38 INFO - 'NO_EM_RESTART': '1', 01:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:38 INFO - 'PWD': '/builds/slave/test', 01:14:38 INFO - 'SHELL': '/bin/bash', 01:14:38 INFO - 'SHLVL': '1', 01:14:38 INFO - 'TERM': 'linux', 01:14:38 INFO - 'TMOUT': '86400', 01:14:38 INFO - 'USER': 'cltbld', 01:14:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:38 INFO - '_': '/tools/buildbot/bin/python'} 01:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 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)) 01:14:38 INFO - Cleaning up... 01:14:38 INFO - Return code: 0 01:14:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:14:38 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')]} 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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')]} 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14:38 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 01:14:38 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 01:14:38 INFO - Using env: {'DISPLAY': ':0', 01:14:38 INFO - 'HOME': '/home/cltbld', 01:14:38 INFO - 'LANG': 'en_US.UTF-8', 01:14:38 INFO - 'LANGUAGE': 'en_US:en', 01:14:38 INFO - 'LOGNAME': 'cltbld', 01:14:38 INFO - 'MAIL': '/var/mail/cltbld', 01:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:38 INFO - 'MOZ_NO_REMOTE': '1', 01:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:38 INFO - 'NO_EM_RESTART': '1', 01:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:38 INFO - 'PWD': '/builds/slave/test', 01:14:38 INFO - 'SHELL': '/bin/bash', 01:14:38 INFO - 'SHLVL': '1', 01:14:38 INFO - 'TERM': 'linux', 01:14:38 INFO - 'TMOUT': '86400', 01:14:38 INFO - 'USER': 'cltbld', 01:14:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:38 INFO - '_': '/tools/buildbot/bin/python'} 01:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:14:38 INFO - Cleaning up... 01:14:38 INFO - Return code: 0 01:14:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:14:38 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')]} 01:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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')]} 01:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:38 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 0x7f252b894f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xce78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', '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 01:14:38 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 01:14:38 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 01:14:38 INFO - Using env: {'DISPLAY': ':0', 01:14:38 INFO - 'HOME': '/home/cltbld', 01:14:38 INFO - 'LANG': 'en_US.UTF-8', 01:14:38 INFO - 'LANGUAGE': 'en_US:en', 01:14:38 INFO - 'LOGNAME': 'cltbld', 01:14:38 INFO - 'MAIL': '/var/mail/cltbld', 01:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:38 INFO - 'MOZ_NO_REMOTE': '1', 01:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:38 INFO - 'NO_EM_RESTART': '1', 01:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:38 INFO - 'PWD': '/builds/slave/test', 01:14:38 INFO - 'SHELL': '/bin/bash', 01:14:38 INFO - 'SHLVL': '1', 01:14:38 INFO - 'TERM': 'linux', 01:14:38 INFO - 'TMOUT': '86400', 01:14:38 INFO - 'USER': 'cltbld', 01:14:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:38 INFO - '_': '/tools/buildbot/bin/python'} 01:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:39 INFO - Downloading/unpacking flake8 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:14:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:14:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:14:41 INFO - no previously-included directories found matching 'docs/_build' 01:14:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:14:41 INFO - Running setup.py install for pep8 01:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:14:41 INFO - no previously-included directories found matching 'docs/_build' 01:14:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:14:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:14:41 INFO - Cleaning up... 01:14:42 INFO - Return code: 0 01:14:42 INFO - Running post-action listener: _resource_record_post_action 01:14:42 INFO - Running post-action listener: _start_resource_monitoring 01:14:42 INFO - Starting resource monitoring. 01:14:42 INFO - ##### 01:14:42 INFO - ##### Finished create-virtualenv step (success) 01:14:42 INFO - ##### 01:14:42 INFO - ##### 01:14:42 INFO - ##### Running install step. 01:14:42 INFO - ##### 01:14:42 INFO - Running pre-action listener: _resource_record_pre_action 01:14:42 INFO - Running main action method: install 01:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:42 INFO - Reading from file tmpfile_stdout 01:14:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:14:42 INFO - Reading from file tmpfile_stdout 01:14:42 INFO - Output received: 01:14:42 INFO - Usage: mozinstall [options] installer 01:14:42 INFO - Options: 01:14:42 INFO - -h, --help show this help message and exit 01:14:42 INFO - -d DEST, --destination=DEST 01:14:42 INFO - Directory to install application into. [default: 01:14:42 INFO - "/builds/slave/test"] 01:14:42 INFO - --app=APP Application being installed. [default: firefox] 01:14:42 INFO - mkdir: /builds/slave/test/build/application 01:14:42 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'] 01:14:42 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 01:14:59 INFO - Reading from file tmpfile_stdout 01:14:59 INFO - Output received: 01:14:59 INFO - /builds/slave/test/build/application/firefox/firefox 01:14:59 INFO - Running post-action listener: _resource_record_post_action 01:14:59 INFO - ##### 01:14:59 INFO - ##### Finished install step (success) 01:14:59 INFO - ##### 01:14:59 INFO - ##### 01:14:59 INFO - ##### Running run-tests step. 01:14:59 INFO - ##### 01:14:59 INFO - Running pre-action listener: _resource_record_pre_action 01:14:59 INFO - Running main action method: run_tests 01:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:14:59 INFO - Python 2.7.3 01:14:59 INFO - Return code: 0 01:14:59 INFO - grabbing minidump binary from tooltool 01:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:59 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 0xe462e0>, '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 0xdb2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:14:59 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 01:14:59 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 01:14:59 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 01:14:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:14:59 INFO - Return code: 0 01:14:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:14:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:14:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:14:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:14:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:15:00 INFO - Return code: 0 01:15:00 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/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 01:15:00 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/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 01:15:00 INFO - Using env: {'DISPLAY': ':0', 01:15:00 INFO - 'HOME': '/home/cltbld', 01:15:00 INFO - 'LANG': 'en_US.UTF-8', 01:15:00 INFO - 'LANGUAGE': 'en_US:en', 01:15:00 INFO - 'LOGNAME': 'cltbld', 01:15:00 INFO - 'MAIL': '/var/mail/cltbld', 01:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:00 INFO - 'MOZ_NO_REMOTE': '1', 01:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:00 INFO - 'NO_EM_RESTART': '1', 01:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:00 INFO - 'PWD': '/builds/slave/test', 01:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:15:00 INFO - 'SHELL': '/bin/bash', 01:15:00 INFO - 'SHLVL': '1', 01:15:00 INFO - 'TERM': 'linux', 01:15:00 INFO - 'TMOUT': '86400', 01:15:00 INFO - 'USER': 'cltbld', 01:15:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961', 01:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:00 INFO - '_': '/tools/buildbot/bin/python'} 01:15:00 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/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 01:15:00 INFO - mozversion application_buildid: 20160615223049 01:15:00 INFO - mozversion application_changeset: b4867459589df246d85972669074233b8d2e23b8 01:15:00 INFO - mozversion application_display_name: Nightly 01:15:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:15:00 INFO - mozversion application_name: Firefox 01:15:00 INFO - mozversion application_remotingname: firefox 01:15:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:15:00 INFO - mozversion application_vendor: Mozilla 01:15:00 INFO - mozversion application_version: 50.0a1 01:15:00 INFO - mozversion platform_buildid: 20160615223049 01:15:00 INFO - mozversion platform_changeset: b4867459589df246d85972669074233b8d2e23b8 01:15:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:15:00 INFO - mozversion platform_version: 50.0a1 01:15:00 INFO - using testdate: 1466064900 01:15:00 INFO - actual date: 1466064900 01:15:00 INFO - starting webserver on 'localhost:57052' 01:15:00 INFO - SUITE-START | Running 2 tests 01:15:00 INFO - TEST-START | dromaeo_css 01:15:00 INFO - operating with platform_type : linux_ 01:15:00 INFO - Initialising browser for dromaeo_css test... 01:15:00 INFO - TEST-INFO | started process 19988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcZ6eh/profile http://localhost:57052/getInfo.html) 01:15:05 INFO - PROCESS | 19988 | __metrics Screen width/height:1600/1200 01:15:05 INFO - PROCESS | 19988 | colorDepth:24 01:15:05 INFO - PROCESS | 19988 | Browser inner width/height: 1024/697 01:15:05 INFO - PROCESS | 19988 | __metrics 01:15:06 INFO - PROCESS | 19988 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:15:06 INFO - PROCESS | 19988 | console.error: PushService: 01:15:06 INFO - PROCESS | 19988 | stateChangeProcessEnqueue: Error transitioning state 01:15:06 INFO - PROCESS | 19988 | UnknownError 01:15:07 INFO - TEST-INFO | 19988: exit 0 01:15:07 INFO - Browser initialized. 01:15:07 INFO - Running cycle 1/1 for dromaeo_css test... 01:15:07 INFO - TEST-INFO | started process 20070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcZ6eh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:19 INFO - PROCESS | 20070 | RSS: Main: 173850624 01:15:19 INFO - PROCESS | 20070 | 01:16:09 INFO - PROCESS | 20070 | 1466064969923 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] 01:18:18 INFO - PROCESS | 20070 | Cycle 1(1): loaded http://localhost:57052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57052/tests/dromaeo/cssquery-ext.html) 01:18:20 INFO - PROCESS | 20070 | RSS: Main: 313757696 01:18:20 INFO - PROCESS | 20070 | 01:21:22 INFO - PROCESS | 20070 | Cycle 1(1): loaded http://localhost:57052/tests/dromaeo/cssquery-ext.html (next: http://localhost:57052/tests/dromaeo/cssquery-jquery.html) 01:21:23 INFO - PROCESS | 20070 | RSS: Main: 271511552 01:21:23 INFO - PROCESS | 20070 | 01:24:25 INFO - PROCESS | 20070 | Cycle 1(1): loaded http://localhost:57052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57052/tests/dromaeo/cssquery-mootools.html) 01:24:26 INFO - PROCESS | 20070 | RSS: Main: 259813376 01:24:26 INFO - PROCESS | 20070 | 01:27:28 INFO - PROCESS | 20070 | Cycle 1(1): loaded http://localhost:57052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57052/tests/dromaeo/cssquery-prototype.html) 01:27:28 INFO - PROCESS | 20070 | RSS: Main: 259514368 01:27:28 INFO - PROCESS | 20070 | 01:30:31 INFO - PROCESS | 20070 | Cycle 1(1): loaded http://localhost:57052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57052/tests/dromaeo/cssquery-yui.html) 01:30:31 INFO - PROCESS | 20070 | RSS: Main: 243671040 01:30:31 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | Cycle 1(1): loaded http://localhost:57052/tests/dromaeo/cssquery-yui.html (next: http://localhost:57052/tests/dromaeo/cssquery-dojo.html) 01:33:34 INFO - PROCESS | 20070 | RSS: Main: 312954880 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | __start_tp_report 01:33:34 INFO - PROCESS | 20070 | _x_x_mozilla_page_load 01:33:34 INFO - PROCESS | 20070 | _x_x_mozilla_page_load_details 01:33:34 INFO - PROCESS | 20070 | |i|pagename|runs| 01:33:34 INFO - PROCESS | 20070 | |0;dojo.html;3094.24191073187;3126.077807046921;3130.264387868851;3161.525771134331;3182.2362632968093;5238.292830467885;5325.733713314328;5358.767483478798;5455.399906010341;5497.285352904127;5325.094733895237;5342;5379.596530260226;5391.406945236031;5396.379416367119;4787.042591481709;4877.097736918664;4881.267809828536;4886.51134886512;5064.898702025957;4974.97512512437;5001.849944501652;5013.498650134976;5022.121128802463;5071.492850714917;4747.335373047776;4777.856664300077;4807.326974223612;4831.347768051303;4868.488808675092;4842.12841688496;4853.587445067174;4856.39295088114;4919.827806026772;4938.678985865908;4877.853664390074;4898.853034408973;4919.557239848431;4934.901301973976;4936.728479933602;5238.240455134022;5310.62825602208;5390.649607775482;5440.727963601844;5458.263134476834;5783.624064435799;5803.7098145093;5852.414758524156;5859.970700146515;5865.296164460249;5861.765529378819;5868.647881127104;5931.762729490815;5931.91102133464;5937;5255.264263003182;5290.92063619046;5355.518003379714;5357.330333708286;5504.422035686235;5859.589828711949;5914.9112763308585;5922.437368449991;5923.407659234128;5926.051831706906;5673.290838645169;5687.345955215121;5690.430956904276;5692.0608099663095;5694.4590263924865;5609.467100625434;5707.771689132472;5773.134029895549;5780.421957804186;5820.185174075633;5790.71046447676;5808;5809.912851307234;5809.912851307234;5811.244538210006;5605.915911261334;5772.884542309214;5807.738651760681;5826.096954971986;5826.446487583673;4251.404803327537;4274.081072569413;4280.978595107004;4285.292926667127;4291.249031419489;3840.078381188495;3849.268638958589;3861.7296789225047;3884.941725874114;3886.7667939923695;5282.392524859613;5282.577393808486;5289.2859463972645;5336.17289320156;5338.492843179892;5741.62679425836;5782.913256301159;5809.6223745457255;5809.767609295665;5865.501432378295;5420.403755586883;5423.322084739408;5424.403315635277;5430.15832545956;5432.103702889058;4885.3649025627155;4936.605071594264;4972.154733695281;5003.399592048904;5070.391553013662;6045;6046.3651316612;6050.606710563799;6058.21243238385;6096.29892562361;5788.739506722123;5800.506956908541;5803.274590676166;5803.390643982321;5807.564432667651;5784.652920824764;5921.319048309328;5963.880722385615;5984.311804142405;6033.909491357721;5731.656100633975;5732.684702341411;5734.22587950638;5735.4551317624755;5739.799107031234;5779.826605201851;5790.044642633919;5821.854453638693;5836.153757705194;5844.532437404912;5435.23906653061;5470.507654311131;5509.47659972302;5524.033294173423;5562.7774889005605;5541.612087153861;5550.69471179089;5554.333479982428;5554.361248456479;5554.472325129106;5434.619576629598;5451.236826844166;5471.2887324647545;5472.863178420572;5526.668399896019;5448.645838020516;5524.66851988882;5592.580556458363;5656.971715141398;5657.066584013756;5430.755615997368;5439.537639300704;5482.616216864782;5487.2317875496665;5522.558195344443 01:33:34 INFO - PROCESS | 20070 | |1;ext.html;567.4495739133042;604.1360853978814;607.256111263702;621.4500167351895;625.1060982794605;30114.548281775762;42520.14959700808;42864.14271714564;43356.56643433573;43374.7831260844;40574.59425405745;45407.77296113523;45470;45667.314990275176;45808.54191458084;7940.960295198516;8830.999999999984;8988.910110898905;8990.190882820545;10727.517261723202;10385.11726503248;10498.580056797718;10758.677239682784;10779.245452818306;10797.946010269938;10821.188410869216;10886.183536234774;10888.67333979982;10899.182561307895;10900.672979810619;10741.087007604363;10802.027817496462;10823.567057317698;10828.079613232885;10828.512716927678;10765.30025548337;10851;10855.294405863593;10866.239363244576;10866.891331086666;43819;44359.33460998088;44423.777881110385;44445;44537.10925781466;3630.09247688078;3946.5586723046113;4035.9192816143805;4178.582141785828;4208.6633069354375;32748.67251327504;33142.45379621613;33428.16429589255;33580.83209583961;34320.48519272213;4241.978790106061;4298.656107511391;4301.698881078326;4338.3058710606465;4378.8029538670835;344410;346716;349809;349985;350926.24536877405;56862;57346.98571099983;57443;57732;57769.711151443975;66347;66597;66754.66622666856;67058;67215;14069.507567235098;14358.282085895664;14391.640208994859;14395.42418303256;14398.712025759636;10617.73455663599;10622.681319560426;10623.043926046694;10631.893681063091;10662.626808061681;18846.43460696181;20129.496762581053;20212.595748084957;20252.898735506227;20363.185472581226;7526.924730752732;7577.355924746348;7612.8477430451085;7629.8855517167285;7722.845543089107;923.4044041593135;1006.2754816532085;1030.6753372687579;1086.6957251969302;1102.5314241447352;31236.531452028237;31503.684963150074;31820.522692159637;32126.678733212837;32533.51199732006;1078.2775540387959;1078.6817888722846;1079.8812130665779;1155.624422062833;1172.5251273234182;16819;17101.57246068858;17193.226304816315;17285.481435556703;17498.825011749974;538948;540246;541671;543625;544243;58537.4146258532;58931.41068589345;58967;59068.704656476446;59154;1298.2794549025382;1348.2449828096298;1359.3067535556936;1370.047816767357;1370.3422357268566;30095.247618809706;31109.53335699921;31151.376972460876;31561.21096972594;31704.524432133996;50102;50350.49649503458;50461;50525.49474505208;50619.74690126526;408675;409792;409801;411955;413286;41934.58065419429;43203.567964319955;43949.56050439583;44087.55912440835;44250.55749442464;49254.26118608152;49599.50400495949;49779;50128.24807627961;51033.489665102876;40744.3888341681;41323;41611;41898.58101418947;42901.356479653456;40933.38599921063;41705.58294417017;41715.37426938659;41833;41959.790201048796;35725.64274357223;39574.80212598918;41026.58973410228;41324.1735165289;42264;31850.681493184773;36988.44517332188;37427.81286093552;37686.434703480016;37814;27507.587386189625;27823.44353112967;27949.183303085236;27974.720252798026;27998.58002129929 01:33:34 INFO - PROCESS | 20070 | |2;jquery.html;381.6774825272644;381.7687956340801;386.3104358719685;394.22337994151513;404.70860980094324;14859.925700371483;14968.401263949456;16518.83481165188;19474.221031158755;19493.610127797434;16348.591285217875;18479.2608295668;19016.239350425967;19047.333343332986;19487.70768438471;5599;5777.393373695764;5814.360420353779;5843.357230704619;5850.122481627769;4128.60778226068;5691.117876729093;6155.938440615581;6487;6488.967555162218;6255.87488250237;6522.184726909137;6528.934710652904;6553.148090748196;6562.081308616797;6357.904631430509;6361.8409539761415;6382.776602818925;6393.936060639404;6400.263969643481;5556;5598.636088654265;5602.24369710088;5611.691356975365;5687.345955215162;22465.887670561708;22586.661200082013;22681.77318226813;22779.430514237112;22890.31329060131;2920.2261400728826;3055.6587649550374;3104.1463597510638;3146.889858854929;3251.170951407376;13990.580282591538;14094.577162685136;14219.786703199461;14244.715105697827;15272.77090843627;1903.8667293289475;1991.760988681353;1992.0935974131735;2000.6598878190744;2073.02567793137;75850.62074689647;78866.21133788703;78884.21115788826;78977;79744;9997.419252377202;10398.480075996169;10598.841017384746;10623.309484883457;10700.571977120984;14252.714945701235;14386.784198237036;14402.855971440362;14408.711825763427;14487;7790;7826.882596761053;7837.647305871135;7931.167227441036;7942.960285198537;7416.7033318666645;7435.591042492715;7496.962515187389;7594.31651151399;7630.313271805564;6448.774292899726;6569.441597464269;6591.571547849375;6619.867602648016;6735.663216839139;1852.6652026352513;1869.5793446474433;1891.2813131010403;1902.2295970132118;1940.4857712706144;942.820864035831;949.4825320200507;964.1948972607811;1002.659095907395;1021.5300961557766;18928.810711892704;19432.319868804807;19641.705374419395;19686.917219552775;19691.310804121786;1004.5278719002057;1006.9496525173712;1039.3036665434176;1042.9322094063862;1047.8690163729534;10440.216983726252;10440.738981525523;10721.731956700989;11212.618409116847;11256.943715281372;397632;436755;455158;458477;458760;92185;93800.06199937913;94573;95882;96298;1000.5397517142051;1008.5965613754411;1026.1226651213256;1034.8913364096811;1035.1098055672117;17358.82641173572;17395.82604173942;17753.289868405634;17782.466526004242;17933.820661793216;41926.371104432845;42153.156936860476;43069.98510104263;44015.339769904116;44545.55454445414;61205.69397152986;62070.068948966706;62710.372896270455;63284.57008009579;64047;7302.96348518254;7609.162992070757;7836.216378362118;7954.761357159063;8043.3967452442475;11363.954488192205;13795.034347595572;13822.447102115802;13974.441022359399;14003.369848356644;11829.881701182878;11950.103742219542;12096.758064838477;12161.468584782868;12274.263544187377;12014.75970480568;12115;12218.572349967708;12267.447964841782;12338.321392323509;12277.754444910874;12339.75320493603;12404;12420.565280215149;12509.124361294986;7243.311885370881;7592.620368981639;7606.163322034461;7740.458167928191;7742.624349500653;8651.95674021626;11294.830577541179;12136.696582585506;12146.757064858477;12350.938245308716 01:33:34 INFO - PROCESS | 20070 | |3;mootools.html;1326.927019013954;1467.3910327214203;1522.1704171226681;1637.4678229575384;1752.6407086547267;8239.258466737992;8619.525926074071;8619.965604127505;8880.822383552326;8881.822363552725;8614.612342444589;8815.77960550985;8819.779505512366;8835.293176545876;8836.24891884189;1995.5609765851489;2301.2750983440246;2338.543983923136;2373.2761507740133;2373.9287821365388;2391.5097405032016;2395.077895010425;2395.73646898841;2398.832081754278;2400.411899084718;2331.5103828196097;2339.263132113379;2377.679013333204;2385.224801939368;2391.1391898916377;1991.531989982353;2259.8644081355005;2327.0924339507606;2334.3113781434517;2335.801456876168;2314.375118717937;2316.860988340705;2345.5308938212424;2354.705661792276;2354.905803767864;8967.372283940127;9109.225715814164;9109.954450227773;9111.81776364469;9112.407693499901;5198.2722418861385;5321.494458026481;5340.439253878365;5351.919721204185;5362.034833729927;3305.1241421023205;3458.360203362386;3498.8950331490096;3516.859325626972;3537.1864471171516;1130.1806190511895;1153.26191237608;1168.4858662188694;1174.8179032250016;1191.6901605582611;12470.563530276488;12474.688132796662;12528.74942501154;12529.93735031319;12588.937055314756;4456.844010459618;4531.410916580823;4628.83799067031;4642.257238841769;4642.698224615389;10514.684559463229;10529.894701052892;10532.947335263274;10546.894531054744;10582;5325.121354976463;5347.545458636059;5361.115415956401;5361.865953351119;5363.973180134074;4456.309272062836;4670.696404733681;4792.640551958547;4801.5438533339275;4872.610191184696;3906.2187562487047;4011.6389524942897;4027.859024934113;4064.7154699171365;4109.445224894601;1219.9329036903055;1233.993830030844;1240.49759847262;1246.7719296492946;1254.0970501239094;1006.4816619440994;1032.9896701032894;1039.599754094664;1041.9895801041891;1047.8323468245044;6261.060840873814;6279.215098112736;6289.654069026247;6298.496120310364;6392.4886009119155;426.6565414841083;436.9104333611602;439.8570464598954;442.0782668136906;449.4135153624486;4370.912581748411;4439.822407103679;4474.39595654589;4487.461504619467;4518.209313370147;10257.538410771533;10700.678979630624;10773.78452430947;10792.568297268179;10809.297395669257;10669.893301067044;10685.252032357661;10687.893121068846;10690.198235132397;10699.73250668724;7810.843783124419;8101.959490202511;8139.593020348959;8147.75556733299;8148.348132149533;6078;6395.926971878701;6401;6449;6580.374864387875;10251.487425628839;10316.17470602335;10506.422146781695;10530.526126324487;10537.315074520131;9665.661701840401;9868.50657467138;9974.251931105342;10734.892651073389;10750.13998880072;7937;7946.443748937519;7962.163972782774;7964.920350796418;8011.6795328188555;8685.305175586065;8704.825903482022;8747.781305467413;8749.212570868653;8781.25359344463;7515.924840751522;7650.081990161217;7658.2724641159;7837.725679601414;7981.561014144278;7642.656080476503;7651.1201211859125;7762.340201082745;7904;7922.4850384724805;6942.583444993316;6998.6500674967065;7014;7027.121609798775;7032.824179395556;5000.424951130666;5502.284702988586;5636.239107720406;5666.206731057738;5760.423957604206;5272.499112584298;5414.242006119225;5420.430854760351;5447.782088716565;5463.726813659222 01:33:34 INFO - PROCESS | 20070 | |4;prototype.html;312.17118550249097;321.56106914062303;324.38205219057704;325.4353696336856;326.8545497253722;5340.893182136355;5360.5443537299325;5365.826840129744;5417.133258678612;5474;5244.659097158682;5280.788768449267;5291.708956007418;5296.576273898088;5318.76065577049;3773.471713960048;3901.4342920276545;4007.178528401685;4024.879253622396;4051.372037334218;4072.1448495815766;4082.9183416331657;4107.726604752522;4107.79461026949;4137.338025915854;4083.2650122977852;4086.6730661547153;4094.7747873866924;4096.918061638766;4112.856050038249;3957.8917902986923;4130.401091841666;4137.213929353413;4158.708890377675;4170.249355116062;3584.193556449804;3622.3660859349507;3632.164602141496;3672.6143754905615;3687.4468829675493;5128.25640282157;5147.948520514784;5173.793048278064;5191.454897235812;5199.922001169985;4649.976750116261;4720.277098858892;4722.480527142012;4748.881277968044;4769.523047695237;5476.507114359727;5552.278203833516;5563.499285064323;5569.220309156722;5572.721363931787;4010.47863777707;4013.3979903014488;4016;4023.2355852388246;4028.9194216115807;5471.863203419906;5521.834344969658;5794.362620111784;5799.2750906136735;5835.620684655484;3602.819859007039;3988.980055099706;4017.799110044486;4051.47330846988;4063.715539912178;4099.61053699898;4109.876703698894;4111.650509706648;4117.835286588563;4122.031322639177;4697.684648298482;4718.622510199176;4728.38530990969;4743.57307842289;4754.549862291965;5359.249705041298;5534.225208470817;5538.141588053858;5604.243427137284;5619.157126430986;1414.1161773891317;1422.246209508962;1422.615893708693;1432.584550480349;1432.8065711129072;896.2202883491404;909.5225006871314;925.2366797392044;932.0306880843982;933.7712260496222;4743.691660042086;4775.95224047762;4777.307290442866;4778.187708089633;4791.233402655558;5042.647014708935;5045.41977672565;5068.847934561969;5080.5681517070725;5088.363954505687;4758.715146910315;4787.319101303281;4802.711837289774;4813.95186048135;4957.652964292465;3029.424409362214;3056.281773783159;3056.312329725794;3063.6629970703207;3068.4170007698913;5967.343592204854;5968.46283834457;5969.910451343233;5971.119097484278;5971.761129554856;5631.662100273997;5783.537317014629;5855.130985816919;5867.266591676041;5896.174535565025;5644.491995720487;5730.392671334449;5844.165579693845;5898.8820223595285;5919.9640062989665;5676;5680.318361796611;5680.460356266148;5709.7430615623225;5720.856978575569;5653.858653533694;5654.745536450787;5662.462066103713;5690.857728556819;5733.2260144881575;5783.190353350618;5875.353711091691;5876.853078673067;5899.852503687443;5902.763889444546;4002.2595819773437;4041.1513582148077;4044.3529035354204;4066.2477441673386;4077.327241005201;5497.835064948058;5736.5410767139365;5749.7125143741805;5781.537477001913;5784.971075144597;5513.8345849624575;5529.778808847762;5537.9169312459535;5550.333959924674;5556.88862227548;5481.917771233514;5511.940872815466;5523.585731070106;5558.722063896708;5584.832455026356;5240.502152295526;5434.565234781129;5457.126859702428;5463.787166197696;5469.128707428632;5609.158626206102;5616.241807355955;5619.409961953936;5625.971870140623;5641.351244606923;5513.173024046425;5517.475839795213;5529.281193444826;5567.638103523258;5578.693171875423 01:33:34 INFO - PROCESS | 20070 | |5;yui.html;638.5051585021607;641.4643772450004;727.9090113735783;782.6126067596541;819.2831272636444;15010.624734381647;15846.920765396171;16116.194190290467;16117.597060073504;16132.596685082894;14695.191764452951;14819.333130009149;14823.92588037061;14825.332860021297;15415;816.9754907352789;819.7622689420076;820.8440396324709;821.2198411509061;822.2188920525494;803.9879401808978;804.6178065418937;805.9677612895478;809.348474478045;809.6720828064643;862.1163307609687;862.874883141944;864.3474176996359;864.6800683747023;865.3380164174412;856.8500512410335;858.9699360522352;859.042167982698;859.5831021954347;859.6776208921655;619.9752009919598;621.1025068775621;624.4785604020648;625.3059104394118;625.8842114208886;15303.852211084102;15524.456644017406;15526.223688815515;15573.065616063073;15589.688206235925;14213.928930355281;14479.855201447956;14621.561353159423;14739.55781326562;14755.628309485857;11387.943060284728;11417.54329826806;11602.709932251677;11631.76736465266;11651.883481165249;3768.5854555998817;3799.905002374935;3822.636849499293;3916.5887581803786;3935.370340745467;73809;74224.99999999946;74512;75026;75115.62442187809;11219.326840389604;11287.379194144236;11317.320960742381;11360.147988900866;11864.644060678194;20284.898575507028;20423.693644595343;20461.386158415273;20471.59056818885;20506.282280120424;8030.678772849137;8085.393595480363;8185.508869467851;8215.465994710325;8331.37514686401;4756.904861902743;4789.592884604778;4803.711777293373;4846.8788280292565;4850.733209673502;3427.2288735034417;3531.911702207414;3549.7337699672626;3551.3430015447225;3552.786832790041;606.0787602843741;612.2775125352127;646.9611823290618;651.5504302031583;655.4952686431421;589.2104579863004;589.8348462430527;610.3012051201349;611.5169016476933;639.9728435860377;8896.8665470018;9034.23209027227;9043.32175086871;9214.79364159248;9243.491607961627;617.0897925559764;652.9314421985719;700.3031983176771;714.4748609771814;714.556974675694;4393.582609652078;4462.44219472566;4478.507364189936;4499.257622492252;4576.794044268016;103724;103860;105128;105958;106271;96799.51600241954;98737;99093.99999999856;99204.50397747965;99295.50352248193;75360.62319688367;76814.23185768182;83892.16107838966;84376.15623843805;84435;8693.652253909773;8710.869336960077;8724.171203735636;8811.213184952923;8840.557972101498;49720;49732;51097.48902510927;51566.74216628893;53261.7336913313;52160;61003;72367.27632723606;73002;75095;10537.209709271681;10746.677599672023;10887.618933337295;10888.128949684165;11238.606648767254;12314.81527777102;12497;12596.181248218836;12638.620841374774;12716.745665086832;11341.716457088638;11346.432678366215;11545.480453379787;11679.941600291944;12046.337451440255;11076.501557429774;11220.326780393203;11334.319940803578;11422.31466112036;11568.768624627628;11162;11273.098152147972;11277.71805704864;11524.795303568642;11643.650690479299;9413.858792117986;9564.95217523908;9825.950870245602;9854.310198286052;9928.255380846322;9326.114019168168;9529.94779401216;9575.712728618153;9619.374740641835;9837.360571562825 01:33:34 INFO - PROCESS | 20070 | __end_tp_report 01:33:34 INFO - PROCESS | 20070 | __start_cc_report 01:33:34 INFO - PROCESS | 20070 | _x_x_mozilla_cycle_collect,1253 01:33:34 INFO - PROCESS | 20070 | __end_cc_report 01:33:34 INFO - PROCESS | 20070 | __startTimestamp1466066014831__endTimestamp 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | ------- Summary: start ------- 01:33:34 INFO - PROCESS | 20070 | Number of tests: 6 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | [#0] dojo.html Cycles:165 Average:5343.46 Median:5482.62 stddev:623.72 (11.4%) stddev-sans-first:600.16 01:33:34 INFO - PROCESS | 20070 | Values: 3094.2 3126.1 3130.3 3161.5 3182.2 5238.3 5325.7 5358.8 5455.4 5497.3 5325.1 5342.0 5379.6 5391.4 5396.4 4787.0 4877.1 4881.3 4886.5 5064.9 4975.0 5001.8 5013.5 5022.1 5071.5 4747.3 4777.9 4807.3 4831.3 4868.5 4842.1 4853.6 4856.4 4919.8 4938.7 4877.9 4898.9 4919.6 4934.9 4936.7 5238.2 5310.6 5390.6 5440.7 5458.3 5783.6 5803.7 5852.4 5860.0 5865.3 5861.8 5868.6 5931.8 5931.9 5937.0 5255.3 5290.9 5355.5 5357.3 5504.4 5859.6 5914.9 5922.4 5923.4 5926.1 5673.3 5687.3 5690.4 5692.1 5694.5 5609.5 5707.8 5773.1 5780.4 5820.2 5790.7 5808.0 5809.9 5809.9 5811.2 5605.9 5772.9 5807.7 5826.1 5826.4 4251.4 4274.1 4281.0 4285.3 4291.2 3840.1 3849.3 3861.7 3884.9 3886.8 5282.4 5282.6 5289.3 5336.2 5338.5 5741.6 5782.9 5809.6 5809.8 5865.5 5420.4 5423.3 5424.4 5430.2 5432.1 4885.4 4936.6 4972.2 5003.4 5070.4 6045.0 6046.4 6050.6 6058.2 6096.3 5788.7 5800.5 5803.3 5803.4 5807.6 5784.7 5921.3 5963.9 5984.3 6033.9 5731.7 5732.7 5734.2 5735.5 5739.8 5779.8 5790.0 5821.9 5836.2 5844.5 5435.2 5470.5 5509.5 5524.0 5562.8 5541.6 5550.7 5554.3 5554.4 5554.5 5434.6 5451.2 5471.3 5472.9 5526.7 5448.6 5524.7 5592.6 5657.0 5657.1 5430.8 5439.5 5482.6 5487.2 5522.6 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | [#1] ext.html Cycles:180 Average:60430.17 Median:22305.26 stddev:116728.50 (523.3%) stddev-sans-first:116969.43 01:33:34 INFO - PROCESS | 20070 | Values: 567.4 604.1 607.3 621.5 625.1 30114.5 42520.1 42864.1 43356.6 43374.8 40574.6 45407.8 45470.0 45667.3 45808.5 7941.0 8831.0 8988.9 8990.2 10727.5 10385.1 10498.6 10758.7 10779.2 10797.9 10821.2 10886.2 10888.7 10899.2 10900.7 10741.1 10802.0 10823.6 10828.1 10828.5 10765.3 10851.0 10855.3 10866.2 10866.9 43819.0 44359.3 44423.8 44445.0 44537.1 3630.1 3946.6 4035.9 4178.6 4208.7 32748.7 33142.5 33428.2 33580.8 34320.5 4242.0 4298.7 4301.7 4338.3 4378.8 344410.0 346716.0 349809.0 349985.0 350926.2 56862.0 57347.0 57443.0 57732.0 57769.7 66347.0 66597.0 66754.7 67058.0 67215.0 14069.5 14358.3 14391.6 14395.4 14398.7 10617.7 10622.7 10623.0 10631.9 10662.6 18846.4 20129.5 20212.6 20252.9 20363.2 7526.9 7577.4 7612.8 7629.9 7722.8 923.4 1006.3 1030.7 1086.7 1102.5 31236.5 31503.7 31820.5 32126.7 32533.5 1078.3 1078.7 1079.9 1155.6 1172.5 16819.0 17101.6 17193.2 17285.5 17498.8 538948.0 540246.0 541671.0 543625.0 544243.0 58537.4 58931.4 58967.0 59068.7 59154.0 1298.3 1348.2 1359.3 1370.0 1370.3 30095.2 31109.5 31151.4 31561.2 31704.5 50102.0 50350.5 50461.0 50525.5 50619.7 408675.0 409792.0 409801.0 411955.0 413286.0 41934.6 43203.6 43949.6 44087.6 44250.6 49254.3 49599.5 49779.0 50128.2 51033.5 40744.4 41323.0 41611.0 41898.6 42901.4 40933.4 41705.6 41715.4 41833.0 41959.8 35725.6 39574.8 41026.6 41324.2 42264.0 31850.7 36988.4 37427.8 37686.4 37814.0 27507.6 27823.4 27949.2 27974.7 27998.6 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | [#2] jquery.html Cycles:180 Average:27906.70 Median:2987.94 stddev:73217.41 (2450.4%) stddev-sans-first:73393.64 01:33:34 INFO - PROCESS | 20070 | Values: 381.7 381.8 386.3 394.2 404.7 14859.9 14968.4 16518.8 19474.2 19493.6 16348.6 18479.3 19016.2 19047.3 19487.7 5599.0 5777.4 5814.4 5843.4 5850.1 4128.6 5691.1 6155.9 6487.0 6489.0 6255.9 6522.2 6528.9 6553.1 6562.1 6357.9 6361.8 6382.8 6393.9 6400.3 5556.0 5598.6 5602.2 5611.7 5687.3 22465.9 22586.7 22681.8 22779.4 22890.3 2920.2 3055.7 3104.1 3146.9 3251.2 13990.6 14094.6 14219.8 14244.7 15272.8 1903.9 1991.8 1992.1 2000.7 2073.0 75850.6 78866.2 78884.2 78977.0 79744.0 9997.4 10398.5 10598.8 10623.3 10700.6 14252.7 14386.8 14402.9 14408.7 14487.0 7790.0 7826.9 7837.6 7931.2 7943.0 7416.7 7435.6 7497.0 7594.3 7630.3 6448.8 6569.4 6591.6 6619.9 6735.7 1852.7 1869.6 1891.3 1902.2 1940.5 942.8 949.5 964.2 1002.7 1021.5 18928.8 19432.3 19641.7 19686.9 19691.3 1004.5 1006.9 1039.3 1042.9 1047.9 10440.2 10440.7 10721.7 11212.6 11256.9 397632.0 436755.0 455158.0 458477.0 458760.0 92185.0 93800.1 94573.0 95882.0 96298.0 1000.5 1008.6 1026.1 1034.9 1035.1 17358.8 17395.8 17753.3 17782.5 17933.8 41926.4 42153.2 43070.0 44015.3 44545.6 61205.7 62070.1 62710.4 63284.6 64047.0 7303.0 7609.2 7836.2 7954.8 8043.4 11364.0 13795.0 13822.4 13974.4 14003.4 11829.9 11950.1 12096.8 12161.5 12274.3 12014.8 12115.0 12218.6 12267.4 12338.3 12277.8 12339.8 12404.0 12420.6 12509.1 7243.3 7592.6 7606.2 7740.5 7742.6 8652.0 11294.8 12136.7 12146.8 12350.9 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | [#3] mootools.html Cycles:180 Average:5871.83 Median:4480.93 stddev:3335.55 (74.4%) stddev-sans-first:3327.42 01:33:34 INFO - PROCESS | 20070 | Values: 1326.9 1467.4 1522.2 1637.5 1752.6 8239.3 8619.5 8620.0 8880.8 8881.8 8614.6 8815.8 8819.8 8835.3 8836.2 1995.6 2301.3 2338.5 2373.3 2373.9 2391.5 2395.1 2395.7 2398.8 2400.4 2331.5 2339.3 2377.7 2385.2 2391.1 1991.5 2259.9 2327.1 2334.3 2335.8 2314.4 2316.9 2345.5 2354.7 2354.9 8967.4 9109.2 9110.0 9111.8 9112.4 5198.3 5321.5 5340.4 5351.9 5362.0 3305.1 3458.4 3498.9 3516.9 3537.2 1130.2 1153.3 1168.5 1174.8 1191.7 12470.6 12474.7 12528.7 12529.9 12588.9 4456.8 4531.4 4628.8 4642.3 4642.7 10514.7 10529.9 10532.9 10546.9 10582.0 5325.1 5347.5 5361.1 5361.9 5364.0 4456.3 4670.7 4792.6 4801.5 4872.6 3906.2 4011.6 4027.9 4064.7 4109.4 1219.9 1234.0 1240.5 1246.8 1254.1 1006.5 1033.0 1039.6 1042.0 1047.8 6261.1 6279.2 6289.7 6298.5 6392.5 426.7 436.9 439.9 442.1 449.4 4370.9 4439.8 4474.4 4487.5 4518.2 10257.5 10700.7 10773.8 10792.6 10809.3 10669.9 10685.3 10687.9 10690.2 10699.7 7810.8 8102.0 8139.6 8147.8 8148.3 6078.0 6395.9 6401.0 6449.0 6580.4 10251.5 10316.2 10506.4 10530.5 10537.3 9665.7 9868.5 9974.3 10734.9 10750.1 7937.0 7946.4 7962.2 7964.9 8011.7 8685.3 8704.8 8747.8 8749.2 8781.3 7515.9 7650.1 7658.3 7837.7 7981.6 7642.7 7651.1 7762.3 7904.0 7922.5 6942.6 6998.7 7014.0 7027.1 7032.8 5000.4 5502.3 5636.2 5666.2 5760.4 5272.5 5414.2 5420.4 5447.8 5463.7 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | [#4] prototype.html Cycles:180 Average:4629.02 Median:5242.58 stddev:1366.42 (26.1%) stddev-sans-first:1331.28 01:33:34 INFO - PROCESS | 20070 | Values: 312.2 321.6 324.4 325.4 326.9 5340.9 5360.5 5365.8 5417.1 5474.0 5244.7 5280.8 5291.7 5296.6 5318.8 3773.5 3901.4 4007.2 4024.9 4051.4 4072.1 4082.9 4107.7 4107.8 4137.3 4083.3 4086.7 4094.8 4096.9 4112.9 3957.9 4130.4 4137.2 4158.7 4170.2 3584.2 3622.4 3632.2 3672.6 3687.4 5128.3 5147.9 5173.8 5191.5 5199.9 4650.0 4720.3 4722.5 4748.9 4769.5 5476.5 5552.3 5563.5 5569.2 5572.7 4010.5 4013.4 4016.0 4023.2 4028.9 5471.9 5521.8 5794.4 5799.3 5835.6 3602.8 3989.0 4017.8 4051.5 4063.7 4099.6 4109.9 4111.7 4117.8 4122.0 4697.7 4718.6 4728.4 4743.6 4754.5 5359.2 5534.2 5538.1 5604.2 5619.2 1414.1 1422.2 1422.6 1432.6 1432.8 896.2 909.5 925.2 932.0 933.8 4743.7 4776.0 4777.3 4778.2 4791.2 5042.6 5045.4 5068.8 5080.6 5088.4 4758.7 4787.3 4802.7 4814.0 4957.7 3029.4 3056.3 3056.3 3063.7 3068.4 5967.3 5968.5 5969.9 5971.1 5971.8 5631.7 5783.5 5855.1 5867.3 5896.2 5644.5 5730.4 5844.2 5898.9 5920.0 5676.0 5680.3 5680.5 5709.7 5720.9 5653.9 5654.7 5662.5 5690.9 5733.2 5783.2 5875.4 5876.9 5899.9 5902.8 4002.3 4041.2 4044.4 4066.2 4077.3 5497.8 5736.5 5749.7 5781.5 5785.0 5513.8 5529.8 5537.9 5550.3 5556.9 5481.9 5511.9 5523.6 5558.7 5584.8 5240.5 5434.6 5457.1 5463.8 5469.1 5609.2 5616.2 5619.4 5626.0 5641.4 5513.2 5517.5 5529.3 5567.6 5578.7 01:33:34 INFO - PROCESS | 20070 | 01:33:34 INFO - PROCESS | 20070 | [#5] yui.html Cycles:180 Average:19650.70 Median:26925.47 stddev:28403.45 (105.5%) stddev-sans-first:28447.26 01:33:34 INFO - PROCESS | 20070 | Values: 638.5 641.5 727.9 782.6 819.3 15010.6 15846.9 16116.2 16117.6 16132.6 14695.2 14819.3 14823.9 14825.3 15415.0 817.0 819.8 820.8 821.2 822.2 804.0 804.6 806.0 809.3 809.7 862.1 862.9 864.3 864.7 865.3 856.9 859.0 859.0 859.6 859.7 620.0 621.1 624.5 625.3 625.9 15303.9 15524.5 15526.2 15573.1 15589.7 14213.9 14479.9 14621.6 14739.6 14755.6 11387.9 11417.5 11602.7 11631.8 11651.9 3768.6 3799.9 3822.6 3916.6 3935.4 73809.0 74225.0 74512.0 75026.0 75115.6 11219.3 11287.4 11317.3 11360.1 11864.6 20284.9 20423.7 20461.4 20471.6 20506.3 8030.7 8085.4 8185.5 8215.5 8331.4 4756.9 4789.6 4803.7 4846.9 4850.7 3427.2 3531.9 3549.7 3551.3 3552.8 606.1 612.3 647.0 651.6 655.5 589.2 589.8 610.3 611.5 640.0 8896.9 9034.2 9043.3 9214.8 9243.5 617.1 652.9 700.3 714.5 714.6 4393.6 4462.4 4478.5 4499.3 4576.8 103724.0 103860.0 105128.0 105958.0 106271.0 96799.5 98737.0 99094.0 99204.5 99295.5 75360.6 76814.2 83892.2 84376.2 84435.0 8693.7 8710.9 8724.2 8811.2 8840.6 49720.0 49732.0 51097.5 51566.7 53261.7 52160.0 61003.0 72367.3 73002.0 75095.0 10537.2 10746.7 10887.6 10888.1 11238.6 12314.8 12497.0 12596.2 12638.6 12716.7 11341.7 11346.4 11545.5 11679.9 12046.3 11076.5 11220.3 11334.3 11422.3 11568.8 11162.0 11273.1 11277.7 11524.8 11643.7 9413.9 9565.0 9826.0 9854.3 9928.3 9326.1 9529.9 9575.7 9619.4 9837.4 01:33:34 INFO - PROCESS | 20070 | -------- Summary: end -------- 01:33:34 INFO - PROCESS | 20070 | 01:33:35 INFO - TEST-INFO | 20070: exit 0 01:33:35 INFO - TEST-OK | dromaeo_css | took 1115238ms 01:33:35 INFO - TEST-START | kraken 01:33:35 INFO - operating with platform_type : linux_ 01:33:35 INFO - Initialising browser for kraken test... 01:33:35 INFO - TEST-INFO | started process 20259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Ic2Pp/profile http://localhost:57052/getInfo.html) 01:33:40 INFO - PROCESS | 20259 | __metrics Screen width/height:1600/1200 01:33:40 INFO - PROCESS | 20259 | colorDepth:24 01:33:40 INFO - PROCESS | 20259 | Browser inner width/height: 1024/697 01:33:40 INFO - PROCESS | 20259 | __metrics 01:33:41 INFO - PROCESS | 20259 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:33:42 INFO - PROCESS | 20259 | console.error: PushService: 01:33:42 INFO - PROCESS | 20259 | stateChangeProcessEnqueue: Error transitioning state 01:33:42 INFO - PROCESS | 20259 | UnknownError 01:33:42 INFO - TEST-INFO | 20259: exit 0 01:33:42 INFO - Browser initialized. 01:33:42 INFO - Running cycle 1/1 for kraken test... 01:33:42 INFO - TEST-INFO | started process 20341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Ic2Pp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:54 INFO - PROCESS | 20341 | RSS: Main: 174460928 01:33:54 INFO - PROCESS | 20341 | 01:33:57 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57052/tests/kraken/driver.html?testName=audio-beat-detection) 01:33:58 INFO - PROCESS | 20341 | RSS: Main: 233295872 01:33:58 INFO - PROCESS | 20341 | 01:34:00 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57052/tests/kraken/driver.html?testName=audio-dft) 01:34:01 INFO - PROCESS | 20341 | RSS: Main: 220192768 01:34:01 INFO - PROCESS | 20341 | 01:34:04 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57052/tests/kraken/driver.html?testName=audio-fft) 01:34:05 INFO - PROCESS | 20341 | RSS: Main: 287125504 01:34:05 INFO - PROCESS | 20341 | 01:34:07 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57052/tests/kraken/driver.html?testName=audio-oscillator) 01:34:07 INFO - PROCESS | 20341 | RSS: Main: 198168576 01:34:07 INFO - PROCESS | 20341 | 01:34:10 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:34:10 INFO - PROCESS | 20341 | RSS: Main: 202694656 01:34:10 INFO - PROCESS | 20341 | 01:34:13 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57052/tests/kraken/driver.html?testName=imaging-darkroom) 01:34:14 INFO - PROCESS | 20341 | RSS: Main: 238260224 01:34:14 INFO - PROCESS | 20341 | 01:34:17 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57052/tests/kraken/driver.html?testName=imaging-desaturate) 01:34:18 INFO - PROCESS | 20341 | RSS: Main: 234622976 01:34:18 INFO - PROCESS | 20341 | 01:34:21 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57052/tests/kraken/driver.html?testName=json-parse-financial) 01:34:22 INFO - PROCESS | 20341 | RSS: Main: 237264896 01:34:22 INFO - PROCESS | 20341 | 01:34:23 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:34:24 INFO - PROCESS | 20341 | RSS: Main: 226234368 01:34:24 INFO - PROCESS | 20341 | 01:34:26 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:34:26 INFO - PROCESS | 20341 | RSS: Main: 232198144 01:34:26 INFO - PROCESS | 20341 | 01:34:28 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:34:29 INFO - PROCESS | 20341 | RSS: Main: 237563904 01:34:29 INFO - PROCESS | 20341 | 01:34:31 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:34:32 INFO - PROCESS | 20341 | RSS: Main: 237023232 01:34:32 INFO - PROCESS | 20341 | 01:34:35 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:34:35 INFO - PROCESS | 20341 | RSS: Main: 236838912 01:34:35 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:57052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57052/tests/kraken/driver.html?testName=ai-astar) 01:34:37 INFO - PROCESS | 20341 | RSS: Main: 279949312 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | __start_tp_report 01:34:37 INFO - PROCESS | 20341 | _x_x_mozilla_page_load 01:34:37 INFO - PROCESS | 20341 | _x_x_mozilla_page_load_details 01:34:37 INFO - PROCESS | 20341 | |i|pagename|runs| 01:34:37 INFO - PROCESS | 20341 | |0;ai-astar;111;107;112;110;111;110;110;110;109;110 01:34:37 INFO - PROCESS | 20341 | |1;audio-beat-detection;151;126;126;184;134;127;158;126;159;126 01:34:37 INFO - PROCESS | 20341 | |2;audio-dft;160;161;161;159;159;160;161;162;160;160 01:34:37 INFO - PROCESS | 20341 | |3;audio-fft;75;75;77;120;76;77;74;75;100;75 01:34:37 INFO - PROCESS | 20341 | |4;audio-oscillator;85;86;119;85;86;86;116;85;85;125 01:34:37 INFO - PROCESS | 20341 | |5;imaging-gaussian-blur;117;117;118;116;116;117;117;117;116;116 01:34:37 INFO - PROCESS | 20341 | |6;imaging-darkroom;145;146;146;146;145;145;145;146;145;144 01:34:37 INFO - PROCESS | 20341 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;95;95 01:34:37 INFO - PROCESS | 20341 | |8;json-parse-financial;54;54;53;55;54;53;54;53;54;53 01:34:37 INFO - PROCESS | 20341 | |9;json-stringify-tinderbox;61;61;61;61;61;61;62;62;61;62 01:34:37 INFO - PROCESS | 20341 | |10;stanford-crypto-aes;86;79;84;84;79;80;90;81;115;80 01:34:37 INFO - PROCESS | 20341 | |11;stanford-crypto-ccm;122;132;122;126;136;119;125;120;130;121 01:34:37 INFO - PROCESS | 20341 | |12;stanford-crypto-pbkdf2;163;164;160;172;159;161;164;161;166;159 01:34:37 INFO - PROCESS | 20341 | |13;stanford-crypto-sha256-iterative;64;63;67;64;64;64;62;63;63;61 01:34:37 INFO - PROCESS | 20341 | __end_tp_report 01:34:37 INFO - PROCESS | 20341 | __start_cc_report 01:34:37 INFO - PROCESS | 20341 | _x_x_mozilla_cycle_collect,1618 01:34:37 INFO - PROCESS | 20341 | __end_cc_report 01:34:37 INFO - PROCESS | 20341 | __startTimestamp1466066077841__endTimestamp 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | ------- Summary: start ------- 01:34:37 INFO - PROCESS | 20341 | Number of tests: 14 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.33 (1.2%) stddev-sans-first:1.36 01:34:37 INFO - PROCESS | 20341 | Values: 111.0 107.0 112.0 110.0 111.0 110.0 110.0 110.0 109.0 110.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:142.50 stddev:20.28 (14.2%) stddev-sans-first:21.23 01:34:37 INFO - PROCESS | 20341 | Values: 151.0 126.0 126.0 184.0 134.0 127.0 158.0 126.0 159.0 126.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 01:34:37 INFO - PROCESS | 20341 | Values: 160.0 161.0 161.0 159.0 159.0 160.0 161.0 162.0 160.0 160.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.32 (20.4%) stddev-sans-first:16.01 01:34:37 INFO - PROCESS | 20341 | Values: 75.0 75.0 77.0 120.0 76.0 77.0 74.0 75.0 100.0 75.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:16.84 (19.8%) stddev-sans-first:17.41 01:34:37 INFO - PROCESS | 20341 | Values: 85.0 86.0 119.0 85.0 86.0 86.0 116.0 85.0 85.0 125.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 01:34:37 INFO - PROCESS | 20341 | Values: 117.0 117.0 118.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:34:37 INFO - PROCESS | 20341 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 144.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:34:37 INFO - PROCESS | 20341 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 01:34:37 INFO - PROCESS | 20341 | Values: 54.0 54.0 53.0 55.0 54.0 53.0 54.0 53.0 54.0 53.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:34:37 INFO - PROCESS | 20341 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:82.50 stddev:10.85 (13.2%) stddev-sans-first:11.51 01:34:37 INFO - PROCESS | 20341 | Values: 86.0 79.0 84.0 84.0 79.0 80.0 90.0 81.0 115.0 80.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:125.50 stddev:5.68 (4.5%) stddev-sans-first:5.89 01:34:37 INFO - PROCESS | 20341 | Values: 122.0 132.0 122.0 126.0 136.0 119.0 125.0 120.0 130.0 121.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:3.96 (2.4%) stddev-sans-first:4.20 01:34:37 INFO - PROCESS | 20341 | Values: 163.0 164.0 160.0 172.0 159.0 161.0 164.0 161.0 166.0 159.0 01:34:37 INFO - PROCESS | 20341 | 01:34:37 INFO - PROCESS | 20341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.58 (2.5%) stddev-sans-first:1.67 01:34:37 INFO - PROCESS | 20341 | Values: 64.0 63.0 67.0 64.0 64.0 64.0 62.0 63.0 63.0 61.0 01:34:37 INFO - PROCESS | 20341 | -------- Summary: end -------- 01:34:37 INFO - PROCESS | 20341 | 01:34:38 INFO - TEST-INFO | 20341: exit 0 01:34:38 INFO - TEST-OK | kraken | took 63225ms 01:34:38 INFO - SUITE-END | took 1178s 01:34:39 INFO - Completed test suite (00:19:38) 01:34:39 INFO - javascript benchmark 01:34:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.24191073187, 3126.077807046921, 3130.264387868851, 3161.525771134331, 3182.2362632968093, 5238.292830467885, 5325.733713314328, 5358.767483478798, 5455.399906010341, 5497.285352904127, 5325.094733895237, 5342.0, 5379.596530260226, 5391.406945236031, 5396.379416367119, 4787.042591481709, 4877.097736918664, 4881.267809828536, 4886.51134886512, 5064.898702025957, 4974.97512512437, 5001.849944501652, 5013.498650134976, 5022.121128802463, 5071.492850714917, 4747.335373047776, 4777.856664300077, 4807.326974223612, 4831.347768051303, 4868.488808675092, 4842.12841688496, 4853.587445067174, 4856.39295088114, 4919.827806026772, 4938.678985865908, 4877.853664390074, 4898.853034408973, 4919.557239848431, 4934.901301973976, 4936.728479933602, 5238.240455134022, 5310.62825602208, 5390.649607775482, 5440.727963601844, 5458.263134476834, 5783.624064435799, 5803.7098145093, 5852.414758524156, 5859.970700146515, 5865.296164460249, 5861.765529378819, 5868.647881127104, 5931.762729490815, 5931.91102133464, 5937.0, 5255.264263003182, 5290.92063619046, 5355.518003379714, 5357.330333708286, 5504.422035686235, 5859.589828711949, 5914.9112763308585, 5922.437368449991, 5923.407659234128, 5926.051831706906, 5673.290838645169, 5687.345955215121, 5690.430956904276, 5692.0608099663095, 5694.4590263924865, 5609.467100625434, 5707.771689132472, 5773.134029895549, 5780.421957804186, 5820.185174075633, 5790.71046447676, 5808.0, 5809.912851307234, 5809.912851307234, 5811.244538210006, 5605.915911261334, 5772.884542309214, 5807.738651760681, 5826.096954971986, 5826.446487583673, 4251.404803327537, 4274.081072569413, 4280.978595107004, 4285.292926667127, 4291.249031419489, 3840.078381188495, 3849.268638958589, 3861.7296789225047, 3884.941725874114, 3886.7667939923695, 5282.392524859613, 5282.577393808486, 5289.2859463972645, 5336.17289320156, 5338.492843179892, 5741.62679425836, 5782.913256301159, 5809.6223745457255, 5809.767609295665, 5865.501432378295, 5420.403755586883, 5423.322084739408, 5424.403315635277, 5430.15832545956, 5432.103702889058, 4885.3649025627155, 4936.605071594264, 4972.154733695281, 5003.399592048904, 5070.391553013662, 6045.0, 6046.3651316612, 6050.606710563799, 6058.21243238385, 6096.29892562361, 5788.739506722123, 5800.506956908541, 5803.274590676166, 5803.390643982321, 5807.564432667651, 5784.652920824764, 5921.319048309328, 5963.880722385615, 5984.311804142405, 6033.909491357721, 5731.656100633975, 5732.684702341411, 5734.22587950638, 5735.4551317624755, 5739.799107031234, 5779.826605201851, 5790.044642633919, 5821.854453638693, 5836.153757705194, 5844.532437404912, 5435.23906653061, 5470.507654311131, 5509.47659972302, 5524.033294173423, 5562.7774889005605, 5541.612087153861, 5550.69471179089, 5554.333479982428, 5554.361248456479, 5554.472325129106, 5434.619576629598, 5451.236826844166, 5471.2887324647545, 5472.863178420572, 5526.668399896019, 5448.645838020516, 5524.66851988882, 5592.580556458363, 5656.971715141398, 5657.066584013756, 5430.755615997368, 5439.537639300704, 5482.616216864782, 5487.2317875496665, 5522.558195344443], "value": 5300.545542598107, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4495739133042, 604.1360853978814, 607.256111263702, 621.4500167351895, 625.1060982794605, 30114.548281775762, 42520.14959700808, 42864.14271714564, 43356.56643433573, 43374.7831260844, 40574.59425405745, 45407.77296113523, 45470.0, 45667.314990275176, 45808.54191458084, 7940.960295198516, 8830.999999999984, 8988.910110898905, 8990.190882820545, 10727.517261723202, 10385.11726503248, 10498.580056797718, 10758.677239682784, 10779.245452818306, 10797.946010269938, 10821.188410869216, 10886.183536234774, 10888.67333979982, 10899.182561307895, 10900.672979810619, 10741.087007604363, 10802.027817496462, 10823.567057317698, 10828.079613232885, 10828.512716927678, 10765.30025548337, 10851.0, 10855.294405863593, 10866.239363244576, 10866.891331086666, 43819.0, 44359.33460998088, 44423.777881110385, 44445.0, 44537.10925781466, 3630.09247688078, 3946.5586723046113, 4035.9192816143805, 4178.582141785828, 4208.6633069354375, 32748.67251327504, 33142.45379621613, 33428.16429589255, 33580.83209583961, 34320.48519272213, 4241.978790106061, 4298.656107511391, 4301.698881078326, 4338.3058710606465, 4378.8029538670835, 344410.0, 346716.0, 349809.0, 349985.0, 350926.24536877405, 56862.0, 57346.98571099983, 57443.0, 57732.0, 57769.711151443975, 66347.0, 66597.0, 66754.66622666856, 67058.0, 67215.0, 14069.507567235098, 14358.282085895664, 14391.640208994859, 14395.42418303256, 14398.712025759636, 10617.73455663599, 10622.681319560426, 10623.043926046694, 10631.893681063091, 10662.626808061681, 18846.43460696181, 20129.496762581053, 20212.595748084957, 20252.898735506227, 20363.185472581226, 7526.924730752732, 7577.355924746348, 7612.8477430451085, 7629.8855517167285, 7722.845543089107, 923.4044041593135, 1006.2754816532085, 1030.6753372687579, 1086.6957251969302, 1102.5314241447352, 31236.531452028237, 31503.684963150074, 31820.522692159637, 32126.678733212837, 32533.51199732006, 1078.2775540387959, 1078.6817888722846, 1079.8812130665779, 1155.624422062833, 1172.5251273234182, 16819.0, 17101.57246068858, 17193.226304816315, 17285.481435556703, 17498.825011749974, 538948.0, 540246.0, 541671.0, 543625.0, 544243.0, 58537.4146258532, 58931.41068589345, 58967.0, 59068.704656476446, 59154.0, 1298.2794549025382, 1348.2449828096298, 1359.3067535556936, 1370.047816767357, 1370.3422357268566, 30095.247618809706, 31109.53335699921, 31151.376972460876, 31561.21096972594, 31704.524432133996, 50102.0, 50350.49649503458, 50461.0, 50525.49474505208, 50619.74690126526, 408675.0, 409792.0, 409801.0, 411955.0, 413286.0, 41934.58065419429, 43203.567964319955, 43949.56050439583, 44087.55912440835, 44250.55749442464, 49254.26118608152, 49599.50400495949, 49779.0, 50128.24807627961, 51033.489665102876, 40744.3888341681, 41323.0, 41611.0, 41898.58101418947, 42901.356479653456, 40933.38599921063, 41705.58294417017, 41715.37426938659, 41833.0, 41959.790201048796, 35725.64274357223, 39574.80212598918, 41026.58973410228, 41324.1735165289, 42264.0, 31850.681493184773, 36988.44517332188, 37427.81286093552, 37686.434703480016, 37814.0, 27507.587386189625, 27823.44353112967, 27949.183303085236, 27974.720252798026, 27998.58002129929], "value": 20804.09771273039, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.6774825272644, 381.7687956340801, 386.3104358719685, 394.22337994151513, 404.70860980094324, 14859.925700371483, 14968.401263949456, 16518.83481165188, 19474.221031158755, 19493.610127797434, 16348.591285217875, 18479.2608295668, 19016.239350425967, 19047.333343332986, 19487.70768438471, 5599.0, 5777.393373695764, 5814.360420353779, 5843.357230704619, 5850.122481627769, 4128.60778226068, 5691.117876729093, 6155.938440615581, 6487.0, 6488.967555162218, 6255.87488250237, 6522.184726909137, 6528.934710652904, 6553.148090748196, 6562.081308616797, 6357.904631430509, 6361.8409539761415, 6382.776602818925, 6393.936060639404, 6400.263969643481, 5556.0, 5598.636088654265, 5602.24369710088, 5611.691356975365, 5687.345955215162, 22465.887670561708, 22586.661200082013, 22681.77318226813, 22779.430514237112, 22890.31329060131, 2920.2261400728826, 3055.6587649550374, 3104.1463597510638, 3146.889858854929, 3251.170951407376, 13990.580282591538, 14094.577162685136, 14219.786703199461, 14244.715105697827, 15272.77090843627, 1903.8667293289475, 1991.760988681353, 1992.0935974131735, 2000.6598878190744, 2073.02567793137, 75850.62074689647, 78866.21133788703, 78884.21115788826, 78977.0, 79744.0, 9997.419252377202, 10398.480075996169, 10598.841017384746, 10623.309484883457, 10700.571977120984, 14252.714945701235, 14386.784198237036, 14402.855971440362, 14408.711825763427, 14487.0, 7790.0, 7826.882596761053, 7837.647305871135, 7931.167227441036, 7942.960285198537, 7416.7033318666645, 7435.591042492715, 7496.962515187389, 7594.31651151399, 7630.313271805564, 6448.774292899726, 6569.441597464269, 6591.571547849375, 6619.867602648016, 6735.663216839139, 1852.6652026352513, 1869.5793446474433, 1891.2813131010403, 1902.2295970132118, 1940.4857712706144, 942.820864035831, 949.4825320200507, 964.1948972607811, 1002.659095907395, 1021.5300961557766, 18928.810711892704, 19432.319868804807, 19641.705374419395, 19686.917219552775, 19691.310804121786, 1004.5278719002057, 1006.9496525173712, 1039.3036665434176, 1042.9322094063862, 1047.8690163729534, 10440.216983726252, 10440.738981525523, 10721.731956700989, 11212.618409116847, 11256.943715281372, 397632.0, 436755.0, 455158.0, 458477.0, 458760.0, 92185.0, 93800.06199937913, 94573.0, 95882.0, 96298.0, 1000.5397517142051, 1008.5965613754411, 1026.1226651213256, 1034.8913364096811, 1035.1098055672117, 17358.82641173572, 17395.82604173942, 17753.289868405634, 17782.466526004242, 17933.820661793216, 41926.371104432845, 42153.156936860476, 43069.98510104263, 44015.339769904116, 44545.55454445414, 61205.69397152986, 62070.068948966706, 62710.372896270455, 63284.57008009579, 64047.0, 7302.96348518254, 7609.162992070757, 7836.216378362118, 7954.761357159063, 8043.3967452442475, 11363.954488192205, 13795.034347595572, 13822.447102115802, 13974.441022359399, 14003.369848356644, 11829.881701182878, 11950.103742219542, 12096.758064838477, 12161.468584782868, 12274.263544187377, 12014.75970480568, 12115.0, 12218.572349967708, 12267.447964841782, 12338.321392323509, 12277.754444910874, 12339.75320493603, 12404.0, 12420.565280215149, 12509.124361294986, 7243.311885370881, 7592.620368981639, 7606.163322034461, 7740.458167928191, 7742.624349500653, 8651.95674021626, 11294.830577541179, 12136.696582585506, 12146.757064858477, 12350.938245308716], "value": 9421.514605764572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.927019013954, 1467.3910327214203, 1522.1704171226681, 1637.4678229575384, 1752.6407086547267, 8239.258466737992, 8619.525926074071, 8619.965604127505, 8880.822383552326, 8881.822363552725, 8614.612342444589, 8815.77960550985, 8819.779505512366, 8835.293176545876, 8836.24891884189, 1995.5609765851489, 2301.2750983440246, 2338.543983923136, 2373.2761507740133, 2373.9287821365388, 2391.5097405032016, 2395.077895010425, 2395.73646898841, 2398.832081754278, 2400.411899084718, 2331.5103828196097, 2339.263132113379, 2377.679013333204, 2385.224801939368, 2391.1391898916377, 1991.531989982353, 2259.8644081355005, 2327.0924339507606, 2334.3113781434517, 2335.801456876168, 2314.375118717937, 2316.860988340705, 2345.5308938212424, 2354.705661792276, 2354.905803767864, 8967.372283940127, 9109.225715814164, 9109.954450227773, 9111.81776364469, 9112.407693499901, 5198.2722418861385, 5321.494458026481, 5340.439253878365, 5351.919721204185, 5362.034833729927, 3305.1241421023205, 3458.360203362386, 3498.8950331490096, 3516.859325626972, 3537.1864471171516, 1130.1806190511895, 1153.26191237608, 1168.4858662188694, 1174.8179032250016, 1191.6901605582611, 12470.563530276488, 12474.688132796662, 12528.74942501154, 12529.93735031319, 12588.937055314756, 4456.844010459618, 4531.410916580823, 4628.83799067031, 4642.257238841769, 4642.698224615389, 10514.684559463229, 10529.894701052892, 10532.947335263274, 10546.894531054744, 10582.0, 5325.121354976463, 5347.545458636059, 5361.115415956401, 5361.865953351119, 5363.973180134074, 4456.309272062836, 4670.696404733681, 4792.640551958547, 4801.5438533339275, 4872.610191184696, 3906.2187562487047, 4011.6389524942897, 4027.859024934113, 4064.7154699171365, 4109.445224894601, 1219.9329036903055, 1233.993830030844, 1240.49759847262, 1246.7719296492946, 1254.0970501239094, 1006.4816619440994, 1032.9896701032894, 1039.599754094664, 1041.9895801041891, 1047.8323468245044, 6261.060840873814, 6279.215098112736, 6289.654069026247, 6298.496120310364, 6392.4886009119155, 426.6565414841083, 436.9104333611602, 439.8570464598954, 442.0782668136906, 449.4135153624486, 4370.912581748411, 4439.822407103679, 4474.39595654589, 4487.461504619467, 4518.209313370147, 10257.538410771533, 10700.678979630624, 10773.78452430947, 10792.568297268179, 10809.297395669257, 10669.893301067044, 10685.252032357661, 10687.893121068846, 10690.198235132397, 10699.73250668724, 7810.843783124419, 8101.959490202511, 8139.593020348959, 8147.75556733299, 8148.348132149533, 6078.0, 6395.926971878701, 6401.0, 6449.0, 6580.374864387875, 10251.487425628839, 10316.17470602335, 10506.422146781695, 10530.526126324487, 10537.315074520131, 9665.661701840401, 9868.50657467138, 9974.251931105342, 10734.892651073389, 10750.13998880072, 7937.0, 7946.443748937519, 7962.163972782774, 7964.920350796418, 8011.6795328188555, 8685.305175586065, 8704.825903482022, 8747.781305467413, 8749.212570868653, 8781.25359344463, 7515.924840751522, 7650.081990161217, 7658.2724641159, 7837.725679601414, 7981.561014144278, 7642.656080476503, 7651.1201211859125, 7762.340201082745, 7904.0, 7922.4850384724805, 6942.583444993316, 6998.6500674967065, 7014.0, 7027.121609798775, 7032.824179395556, 5000.424951130666, 5502.284702988586, 5636.239107720406, 5666.206731057738, 5760.423957604206, 5272.499112584298, 5414.242006119225, 5420.430854760351, 5447.782088716565, 5463.726813659222], "value": 4616.056759257737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.17118550249097, 321.56106914062303, 324.38205219057704, 325.4353696336856, 326.8545497253722, 5340.893182136355, 5360.5443537299325, 5365.826840129744, 5417.133258678612, 5474.0, 5244.659097158682, 5280.788768449267, 5291.708956007418, 5296.576273898088, 5318.76065577049, 3773.471713960048, 3901.4342920276545, 4007.178528401685, 4024.879253622396, 4051.372037334218, 4072.1448495815766, 4082.9183416331657, 4107.726604752522, 4107.79461026949, 4137.338025915854, 4083.2650122977852, 4086.6730661547153, 4094.7747873866924, 4096.918061638766, 4112.856050038249, 3957.8917902986923, 4130.401091841666, 4137.213929353413, 4158.708890377675, 4170.249355116062, 3584.193556449804, 3622.3660859349507, 3632.164602141496, 3672.6143754905615, 3687.4468829675493, 5128.25640282157, 5147.948520514784, 5173.793048278064, 5191.454897235812, 5199.922001169985, 4649.976750116261, 4720.277098858892, 4722.480527142012, 4748.881277968044, 4769.523047695237, 5476.507114359727, 5552.278203833516, 5563.499285064323, 5569.220309156722, 5572.721363931787, 4010.47863777707, 4013.3979903014488, 4016.0, 4023.2355852388246, 4028.9194216115807, 5471.863203419906, 5521.834344969658, 5794.362620111784, 5799.2750906136735, 5835.620684655484, 3602.819859007039, 3988.980055099706, 4017.799110044486, 4051.47330846988, 4063.715539912178, 4099.61053699898, 4109.876703698894, 4111.650509706648, 4117.835286588563, 4122.031322639177, 4697.684648298482, 4718.622510199176, 4728.38530990969, 4743.57307842289, 4754.549862291965, 5359.249705041298, 5534.225208470817, 5538.141588053858, 5604.243427137284, 5619.157126430986, 1414.1161773891317, 1422.246209508962, 1422.615893708693, 1432.584550480349, 1432.8065711129072, 896.2202883491404, 909.5225006871314, 925.2366797392044, 932.0306880843982, 933.7712260496222, 4743.691660042086, 4775.95224047762, 4777.307290442866, 4778.187708089633, 4791.233402655558, 5042.647014708935, 5045.41977672565, 5068.847934561969, 5080.5681517070725, 5088.363954505687, 4758.715146910315, 4787.319101303281, 4802.711837289774, 4813.95186048135, 4957.652964292465, 3029.424409362214, 3056.281773783159, 3056.312329725794, 3063.6629970703207, 3068.4170007698913, 5967.343592204854, 5968.46283834457, 5969.910451343233, 5971.119097484278, 5971.761129554856, 5631.662100273997, 5783.537317014629, 5855.130985816919, 5867.266591676041, 5896.174535565025, 5644.491995720487, 5730.392671334449, 5844.165579693845, 5898.8820223595285, 5919.9640062989665, 5676.0, 5680.318361796611, 5680.460356266148, 5709.7430615623225, 5720.856978575569, 5653.858653533694, 5654.745536450787, 5662.462066103713, 5690.857728556819, 5733.2260144881575, 5783.190353350618, 5875.353711091691, 5876.853078673067, 5899.852503687443, 5902.763889444546, 4002.2595819773437, 4041.1513582148077, 4044.3529035354204, 4066.2477441673386, 4077.327241005201, 5497.835064948058, 5736.5410767139365, 5749.7125143741805, 5781.537477001913, 5784.971075144597, 5513.8345849624575, 5529.778808847762, 5537.9169312459535, 5550.333959924674, 5556.88862227548, 5481.917771233514, 5511.940872815466, 5523.585731070106, 5558.722063896708, 5584.832455026356, 5240.502152295526, 5434.565234781129, 5457.126859702428, 5463.787166197696, 5469.128707428632, 5609.158626206102, 5616.241807355955, 5619.409961953936, 5625.971870140623, 5641.351244606923, 5513.173024046425, 5517.475839795213, 5529.281193444826, 5567.638103523258, 5578.693171875423], "value": 4191.985447882812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.5051585021607, 641.4643772450004, 727.9090113735783, 782.6126067596541, 819.2831272636444, 15010.624734381647, 15846.920765396171, 16116.194190290467, 16117.597060073504, 16132.596685082894, 14695.191764452951, 14819.333130009149, 14823.92588037061, 14825.332860021297, 15415.0, 816.9754907352789, 819.7622689420076, 820.8440396324709, 821.2198411509061, 822.2188920525494, 803.9879401808978, 804.6178065418937, 805.9677612895478, 809.348474478045, 809.6720828064643, 862.1163307609687, 862.874883141944, 864.3474176996359, 864.6800683747023, 865.3380164174412, 856.8500512410335, 858.9699360522352, 859.042167982698, 859.5831021954347, 859.6776208921655, 619.9752009919598, 621.1025068775621, 624.4785604020648, 625.3059104394118, 625.8842114208886, 15303.852211084102, 15524.456644017406, 15526.223688815515, 15573.065616063073, 15589.688206235925, 14213.928930355281, 14479.855201447956, 14621.561353159423, 14739.55781326562, 14755.628309485857, 11387.943060284728, 11417.54329826806, 11602.709932251677, 11631.76736465266, 11651.883481165249, 3768.5854555998817, 3799.905002374935, 3822.636849499293, 3916.5887581803786, 3935.370340745467, 73809.0, 74224.99999999946, 74512.0, 75026.0, 75115.62442187809, 11219.326840389604, 11287.379194144236, 11317.320960742381, 11360.147988900866, 11864.644060678194, 20284.898575507028, 20423.693644595343, 20461.386158415273, 20471.59056818885, 20506.282280120424, 8030.678772849137, 8085.393595480363, 8185.508869467851, 8215.465994710325, 8331.37514686401, 4756.904861902743, 4789.592884604778, 4803.711777293373, 4846.8788280292565, 4850.733209673502, 3427.2288735034417, 3531.911702207414, 3549.7337699672626, 3551.3430015447225, 3552.786832790041, 606.0787602843741, 612.2775125352127, 646.9611823290618, 651.5504302031583, 655.4952686431421, 589.2104579863004, 589.8348462430527, 610.3012051201349, 611.5169016476933, 639.9728435860377, 8896.8665470018, 9034.23209027227, 9043.32175086871, 9214.79364159248, 9243.491607961627, 617.0897925559764, 652.9314421985719, 700.3031983176771, 714.4748609771814, 714.556974675694, 4393.582609652078, 4462.44219472566, 4478.507364189936, 4499.257622492252, 4576.794044268016, 103724.0, 103860.0, 105128.0, 105958.0, 106271.0, 96799.51600241954, 98737.0, 99093.99999999856, 99204.50397747965, 99295.50352248193, 75360.62319688367, 76814.23185768182, 83892.16107838966, 84376.15623843805, 84435.0, 8693.652253909773, 8710.869336960077, 8724.171203735636, 8811.213184952923, 8840.557972101498, 49720.0, 49732.0, 51097.48902510927, 51566.74216628893, 53261.7336913313, 52160.0, 61003.0, 72367.27632723606, 73002.0, 75095.0, 10537.209709271681, 10746.677599672023, 10887.618933337295, 10888.128949684165, 11238.606648767254, 12314.81527777102, 12497.0, 12596.181248218836, 12638.620841374774, 12716.745665086832, 11341.716457088638, 11346.432678366215, 11545.480453379787, 11679.941600291944, 12046.337451440255, 11076.501557429774, 11220.326780393203, 11334.319940803578, 11422.31466112036, 11568.768624627628, 11162.0, 11273.098152147972, 11277.71805704864, 11524.795303568642, 11643.650690479299, 9413.858792117986, 9564.95217523908, 9825.950870245602, 9854.310198286052, 9928.255380846322, 9326.114019168168, 9529.94779401216, 9575.712728618153, 9619.374740641835, 9837.360571562825], "value": 7174.671267133329, "unit": "score"}], "name": "dromaeo_css", "value": 7241.942372643075, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 112.0, 110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 126.0, 184.0, 134.0, 127.0, 158.0, 126.0, 159.0, 126.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 159.0, 159.0, 160.0, 161.0, 162.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 120.0, 76.0, 77.0, 74.0, 75.0, 100.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 119.0, 85.0, 86.0, 86.0, 116.0, 85.0, 85.0, 125.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 55.0, 54.0, 53.0, 54.0, 53.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 84.0, 84.0, 79.0, 80.0, 90.0, 81.0, 115.0, 80.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 132.0, 122.0, 126.0, 136.0, 119.0, 125.0, 120.0, 130.0, 121.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 160.0, 172.0, 159.0, 161.0, 164.0, 161.0, 166.0, 159.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 67.0, 64.0, 64.0, 64.0, 62.0, 63.0, 63.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1499.5, "alertThreshold": 2.0}]} 01:34:39 INFO - Return code: 0 01:34:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:34:39 INFO - # TBPL SUCCESS # 01:34:39 INFO - Running post-action listener: _resource_record_post_action 01:34:39 INFO - ##### 01:34:39 INFO - ##### Finished run-tests step (success) 01:34:39 INFO - ##### 01:34:39 INFO - Running post-run listener: _resource_record_post_run 01:34:39 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561709056; Read time: 12; Write time: 977388 01:34:39 INFO - TinderboxPrint: CPU usage
13.3% 01:34:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:34:39 INFO - TinderboxPrint: I/O write bytes / time
561,709,056 / 977,388 01:34:39 INFO - TinderboxPrint: CPU idle
8,284.0 (86.7%) 01:34:39 INFO - TinderboxPrint: CPU user
1,211.3 (12.7%) 01:34:39 INFO - TinderboxPrint: Swap in / out
0 / 0 01:34:39 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 273498112; Read time: 0; Write time: 568616 01:34:39 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288210944; Read time: 12; Write time: 408772 01:34:39 INFO - Running post-run listener: _upload_blobber_files 01:34:39 INFO - Blob upload gear active. 01:34:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:34:39 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 01:34:39 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'] 01:34:39 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 01:34:40 INFO - (blobuploader) - INFO - Open directory for files ... 01:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:44 INFO - (blobuploader) - INFO - Done attempting. 01:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:44 INFO - (blobuploader) - INFO - Done attempting. 01:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:45 INFO - (blobuploader) - INFO - Done attempting. 01:34:45 INFO - (blobuploader) - INFO - Iteration through files over. 01:34:45 INFO - Return code: 0 01:34:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:34:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:34:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9772f6ac6ccc153c5fb8036b016ad99c27beec44562526424afc14c03bc2be3f7f9e1f3daa29fdf32d5a0696c6a1b5e5eb66b0ddad508393985d3e961ac57fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470dbf2eaf4013a16da3a15c919ad1620ba2e8dec0e711c98d5b519e0211a1676b8eca26d983605f92fcb169611389a06a42a8de5f21397f6861025063981987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e49f80d3de7ae0b37b3193f685181d9a9109802fae9334953b84aa181c715b797a4a172702ed868b9c96efbeaa2b6c48d1724be99ec9fdf6aa73da522c5c983"} 01:34:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:34:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:34:45 INFO - Contents: 01:34:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9772f6ac6ccc153c5fb8036b016ad99c27beec44562526424afc14c03bc2be3f7f9e1f3daa29fdf32d5a0696c6a1b5e5eb66b0ddad508393985d3e961ac57fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470dbf2eaf4013a16da3a15c919ad1620ba2e8dec0e711c98d5b519e0211a1676b8eca26d983605f92fcb169611389a06a42a8de5f21397f6861025063981987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e49f80d3de7ae0b37b3193f685181d9a9109802fae9334953b84aa181c715b797a4a172702ed868b9c96efbeaa2b6c48d1724be99ec9fdf6aa73da522c5c983"} 01:34:45 INFO - Running post-run listener: copy_logs_to_upload_dir 01:34:45 INFO - Copying logs to upload dir... 01:34:45 INFO - mkdir: /builds/slave/test/build/upload/logs 01:34:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.940335 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-16 01:34:45.590199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 01:34:45.593716) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961 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/9772f6ac6ccc153c5fb8036b016ad99c27beec44562526424afc14c03bc2be3f7f9e1f3daa29fdf32d5a0696c6a1b5e5eb66b0ddad508393985d3e961ac57fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470dbf2eaf4013a16da3a15c919ad1620ba2e8dec0e711c98d5b519e0211a1676b8eca26d983605f92fcb169611389a06a42a8de5f21397f6861025063981987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e49f80d3de7ae0b37b3193f685181d9a9109802fae9334953b84aa181c715b797a4a172702ed868b9c96efbeaa2b6c48d1724be99ec9fdf6aa73da522c5c983"} build_url:https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/CZwdI_woSm2jZED4B8dsxw/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/9772f6ac6ccc153c5fb8036b016ad99c27beec44562526424afc14c03bc2be3f7f9e1f3daa29fdf32d5a0696c6a1b5e5eb66b0ddad508393985d3e961ac57fbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470dbf2eaf4013a16da3a15c919ad1620ba2e8dec0e711c98d5b519e0211a1676b8eca26d983605f92fcb169611389a06a42a8de5f21397f6861025063981987", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0e49f80d3de7ae0b37b3193f685181d9a9109802fae9334953b84aa181c715b797a4a172702ed868b9c96efbeaa2b6c48d1724be99ec9fdf6aa73da522c5c983"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 01:34:45.623340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:34:45.624021) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1466041213.540420-422381961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:34:45.672954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 01:34:45.673464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 01:34:45.673909) ========= ========= Total master_lag: 0.15 =========