builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1466089836.8 results: success (0) buildid: 20160616053041 builduid: 43d31168b08a46708a72e20a08665eff revision: 61b7d2351dd2ed50789df8aed472ee0af1e06829 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.799842) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.801121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.801624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.839808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.840143) ========= 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=cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 08:10:37-- 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% 46.3M=0s 2016-06-16 08:10:37 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.933677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.934134) ========= 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=cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020553 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:36.988527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 08:10:36.989128) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61b7d2351dd2ed50789df8aed472ee0af1e06829 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 61b7d2351dd2ed50789df8aed472ee0af1e06829 --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=cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 08:10:37,369 truncating revision to first 12 chars 2016-06-16 08:10:37,369 Setting DEBUG logging. 2016-06-16 08:10:37,369 attempt 1/10 2016-06-16 08:10:37,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61b7d2351dd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 08:10:38,645 unpacking tar archive at: fx-team-61b7d2351dd2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.602555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 08:10:38.609281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:38.609782) ========= script_repo_revision: 61b7d2351dd2ed50789df8aed472ee0af1e06829 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:38.610361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:38.610752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 08:10:38.621995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-16 08:10:38.622569) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:10:39 INFO - MultiFileLogger online at 20160616 08:10:39 in /builds/slave/test 08:10:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:10:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:39 INFO - {'append_to_log': False, 08:10:39 INFO - 'base_work_dir': '/builds/slave/test', 08:10:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:39 INFO - 'branch': 'Fx-Team', 08:10:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:39 INFO - 'config_files': ('talos/linux_config.py',), 08:10:39 INFO - 'default_actions': ('clobber', 08:10:39 INFO - 'read-buildbot-config', 08:10:39 INFO - 'download-and-extract', 08:10:39 INFO - 'populate-webroot', 08:10:39 INFO - 'create-virtualenv', 08:10:39 INFO - 'install', 08:10:39 INFO - 'run-tests'), 08:10:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:39 INFO - 'download_minidump_stackwalk': True, 08:10:39 INFO - 'download_symbols': 'ondemand', 08:10:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:39 INFO - 'installer_path': 'installer.exe', 08:10:39 INFO - 'log_level': 'info', 08:10:39 INFO - 'log_name': 'talos', 08:10:39 INFO - 'log_to_console': True, 08:10:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:10:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:10:39 INFO - 'opt_config_files': (), 08:10:39 INFO - 'pip_index': False, 08:10:39 INFO - 'sps_profile': False, 08:10:39 INFO - 'sps_profile_interval': 0, 08:10:39 INFO - 'suite': 'dromaeojs', 08:10:39 INFO - 'system_bits': '32', 08:10:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:39 INFO - 'title': 'talos-linux64-ix-054', 08:10:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:39 INFO - 'use_talos_json': True, 08:10:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:39 INFO - 'work_dir': 'build'} 08:10:39 INFO - ##### 08:10:39 INFO - ##### Running clobber step. 08:10:39 INFO - ##### 08:10:39 INFO - Running pre-action listener: _resource_record_pre_action 08:10:39 INFO - Running main action method: clobber 08:10:39 INFO - rmtree: /builds/slave/test/build 08:10:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:39 INFO - Running post-action listener: _resource_record_post_action 08:10:39 INFO - ##### 08:10:39 INFO - ##### Finished clobber step (success) 08:10:39 INFO - ##### 08:10:39 INFO - ##### 08:10:39 INFO - ##### Running read-buildbot-config step. 08:10:39 INFO - ##### 08:10:39 INFO - Running pre-action listener: _resource_record_pre_action 08:10:39 INFO - Running main action method: read_buildbot_config 08:10:39 INFO - Using buildbot properties: 08:10:39 INFO - { 08:10:39 INFO - "project": "", 08:10:39 INFO - "product": "firefox", 08:10:39 INFO - "script_repo_revision": "production", 08:10:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:10:39 INFO - "repository": "", 08:10:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:10:39 INFO - "buildid": "20160616053041", 08:10:39 INFO - "pgo_build": "True", 08:10:39 INFO - "basedir": "/builds/slave/test", 08:10:39 INFO - "buildnumber": 808, 08:10:39 INFO - "slavename": "talos-linux64-ix-054", 08:10:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:10:39 INFO - "platform": "ubuntu64_hw", 08:10:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:10:39 INFO - "branch": "fx-team", 08:10:39 INFO - "repo_path": "integration/fx-team", 08:10:39 INFO - "revision": "61b7d2351dd2ed50789df8aed472ee0af1e06829", 08:10:39 INFO - "stage_platform": "linux64-pgo", 08:10:39 INFO - "builduid": "43d31168b08a46708a72e20a08665eff", 08:10:39 INFO - "slavebuilddir": "test" 08:10:39 INFO - } 08:10:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:10:39 INFO - Running post-action listener: _resource_record_post_action 08:10:39 INFO - ##### 08:10:39 INFO - ##### Finished read-buildbot-config step (success) 08:10:39 INFO - ##### 08:10:39 INFO - ##### 08:10:39 INFO - ##### Running download-and-extract step. 08:10:39 INFO - ##### 08:10:39 INFO - Running pre-action listener: _resource_record_pre_action 08:10:39 INFO - Running main action method: download_and_extract 08:10:39 INFO - mkdir: /builds/slave/test/build/tests 08:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:39 INFO - https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:10:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:40 INFO - Downloaded 1361 bytes. 08:10:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:40 INFO - Using the following test package requirements: 08:10:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:10:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:10:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'jsshell-linux-x86_64.zip'], 08:10:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:10:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:10:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:10:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:10:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:10:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:40 INFO - https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:42 INFO - Downloaded 24220743 bytes. 08:10:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:10:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:10:43 INFO - Return code: 0 08:10:43 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 08:10:43 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')]} 08:10:43 INFO - https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:44 INFO - Downloaded 24220743 bytes. 08:10:44 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'] 08:10:44 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 08:10:46 INFO - Return code: 0 08:10:46 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')]} 08:10:46 INFO - https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:10:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:47 INFO - Downloaded 14405384 bytes. 08:10:47 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'] 08:10:47 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 08:10:47 INFO - Return code: 0 08:10:47 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')]} 08:10:47 INFO - https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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 08:10:48 INFO - Downloaded 59391894 bytes. 08:10:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:48 INFO - mkdir: /builds/slave/test/properties 08:10:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:48 INFO - Contents: 08:10:48 INFO - build_url:https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:49 INFO - Running post-action listener: _resource_record_post_action 08:10:49 INFO - Running post-action listener: set_extra_try_arguments 08:10:49 INFO - ##### 08:10:49 INFO - ##### Finished download-and-extract step (success) 08:10:49 INFO - ##### 08:10:49 INFO - ##### 08:10:49 INFO - ##### Running populate-webroot step. 08:10:49 INFO - ##### 08:10:49 INFO - Running pre-action listener: _resource_record_pre_action 08:10:49 INFO - Running main action method: populate_webroot 08:10:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:49 INFO - '--tppagecycles', 08:10:49 INFO - '7'], 08:10:49 INFO - 'tests': ['tsvgm']}}, 08:10:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['damp', 'tps']}, 08:10:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'tests': ['damp', 'tps']}, 08:10:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['dromaeo_dom']}, 08:10:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['basic_compositor_video']}, 08:10:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tsvgx', 08:10:49 INFO - 'tsvgr_opacity', 08:10:49 INFO - 'tart', 08:10:49 INFO - 'tscrollx', 08:10:49 INFO - 'cart']}, 08:10:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:49 INFO - 'tsvgr_opacity', 08:10:49 INFO - 'tart', 08:10:49 INFO - 'tscrollx', 08:10:49 INFO - 'cart']}, 08:10:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tp5o']}, 08:10:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'tests': ['tp5o']}, 08:10:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s', 08:10:49 INFO - '--xperf_path', 08:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:49 INFO - 'tests': ['tp5n']}, 08:10:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--xperf_path', 08:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:49 INFO - 'tests': ['tp5n']}}, 08:10:49 INFO - 'talos.zip': {'path': '', 08:10:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:49 INFO - Running post-action listener: _resource_record_post_action 08:10:49 INFO - ##### 08:10:49 INFO - ##### Finished populate-webroot step (success) 08:10:49 INFO - ##### 08:10:49 INFO - ##### 08:10:49 INFO - ##### Running create-virtualenv step. 08:10:49 INFO - ##### 08:10:49 INFO - Running pre-action listener: _resource_record_pre_action 08:10:49 INFO - Running main action method: create_virtualenv 08:10:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:49 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 08:10:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:49 INFO - Using real prefix '/usr' 08:10:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:52 INFO - Installing pip.................done. 08:10:52 INFO - Return code: 0 08:10:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:52 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')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:10:52 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 08:10:52 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 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 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 08:10:52 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:52 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')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:10:52 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 08:10:52 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 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 INFO - Downloading/unpacking psutil>=3.1.1 08:10:52 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 08:10:52 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 08:10:52 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 08:10:52 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 08:10:52 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 08:10:52 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 08:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:54 INFO - Installing collected packages: psutil 08:10:54 INFO - Running setup.py install for psutil 08:10:54 INFO - building 'psutil._psutil_linux' extension 08:10:54 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 08:10:54 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 08:10:54 INFO - building 'psutil._psutil_posix' extension 08:10:54 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 08:10:55 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 08:10:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:55 INFO - Successfully installed psutil 08:10:55 INFO - Cleaning up... 08:10:55 INFO - Return code: 0 08:10:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:10:55 INFO - Using env: {'DISPLAY': ':0', 08:10:55 INFO - 'HOME': '/home/cltbld', 08:10:55 INFO - 'LANG': 'en_US.UTF-8', 08:10:55 INFO - 'LANGUAGE': 'en_US:en', 08:10:55 INFO - 'LOGNAME': 'cltbld', 08:10:55 INFO - 'MAIL': '/var/mail/cltbld', 08:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:55 INFO - 'MOZ_NO_REMOTE': '1', 08:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:55 INFO - 'NO_EM_RESTART': '1', 08:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:55 INFO - 'PWD': '/builds/slave/test', 08:10:55 INFO - 'SHELL': '/bin/bash', 08:10:55 INFO - 'SHLVL': '1', 08:10:55 INFO - 'TERM': 'linux', 08:10:55 INFO - 'TMOUT': '86400', 08:10:55 INFO - 'USER': 'cltbld', 08:10:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:55 INFO - '_': '/tools/buildbot/bin/python'} 08:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:57 INFO - Installing collected packages: mozsystemmonitor 08:10:57 INFO - Running setup.py install for mozsystemmonitor 08:10:57 INFO - Successfully installed mozsystemmonitor 08:10:57 INFO - Cleaning up... 08:10:57 INFO - Return code: 0 08:10:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:57 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')]} 08:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:57 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')]} 08:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:57 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:10:57 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 08:10:57 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 08:10:57 INFO - Using env: {'DISPLAY': ':0', 08:10:57 INFO - 'HOME': '/home/cltbld', 08:10:57 INFO - 'LANG': 'en_US.UTF-8', 08:10:57 INFO - 'LANGUAGE': 'en_US:en', 08:10:57 INFO - 'LOGNAME': 'cltbld', 08:10:57 INFO - 'MAIL': '/var/mail/cltbld', 08:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:57 INFO - 'MOZ_NO_REMOTE': '1', 08:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:57 INFO - 'NO_EM_RESTART': '1', 08:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:57 INFO - 'PWD': '/builds/slave/test', 08:10:57 INFO - 'SHELL': '/bin/bash', 08:10:57 INFO - 'SHLVL': '1', 08:10:57 INFO - 'TERM': 'linux', 08:10:57 INFO - 'TMOUT': '86400', 08:10:57 INFO - 'USER': 'cltbld', 08:10:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:57 INFO - '_': '/tools/buildbot/bin/python'} 08:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:59 INFO - warning: no files found matching '*.txt' 08:10:59 INFO - no previously-included directories found matching 'build' 08:10:59 INFO - no previously-included directories found matching 'dist' 08:10:59 INFO - no previously-included directories found matching '.git*' 08:10:59 INFO - Installing collected packages: jsonschema, functools32 08:10:59 INFO - Running setup.py install for functools32 08:11:00 INFO - warning: no files found matching '*.txt' 08:11:00 INFO - no previously-included directories found matching 'build' 08:11:00 INFO - no previously-included directories found matching 'dist' 08:11:00 INFO - no previously-included directories found matching '.git*' 08:11:00 INFO - Successfully installed jsonschema functools32 08:11:00 INFO - Cleaning up... 08:11:00 INFO - Return code: 0 08:11:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:00 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:11:00 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 08:11:00 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 08:11:00 INFO - Using env: {'DISPLAY': ':0', 08:11:00 INFO - 'HOME': '/home/cltbld', 08:11:00 INFO - 'LANG': 'en_US.UTF-8', 08:11:00 INFO - 'LANGUAGE': 'en_US:en', 08:11:00 INFO - 'LOGNAME': 'cltbld', 08:11:00 INFO - 'MAIL': '/var/mail/cltbld', 08:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:00 INFO - 'MOZ_NO_REMOTE': '1', 08:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:00 INFO - 'NO_EM_RESTART': '1', 08:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:00 INFO - 'PWD': '/builds/slave/test', 08:11:00 INFO - 'SHELL': '/bin/bash', 08:11:00 INFO - 'SHLVL': '1', 08:11:00 INFO - 'TERM': 'linux', 08:11:00 INFO - 'TMOUT': '86400', 08:11:00 INFO - 'USER': 'cltbld', 08:11:00 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:00 INFO - '_': '/tools/buildbot/bin/python'} 08:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:02 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:03 INFO - Downloading docopt-0.6.1.tar.gz 08:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:03 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:03 INFO - Running setup.py install for blobuploader 08:11:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:03 INFO - Running setup.py install for requests 08:11:03 INFO - Running setup.py install for docopt 08:11:03 INFO - Successfully installed blobuploader requests docopt 08:11:03 INFO - Cleaning up... 08:11:03 INFO - Return code: 0 08:11:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:03 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')]} 08:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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')]} 08:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:11:03 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 08:11:03 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 08:11:03 INFO - Using env: {'DISPLAY': ':0', 08:11:03 INFO - 'HOME': '/home/cltbld', 08:11:03 INFO - 'LANG': 'en_US.UTF-8', 08:11:03 INFO - 'LANGUAGE': 'en_US:en', 08:11:03 INFO - 'LOGNAME': 'cltbld', 08:11:03 INFO - 'MAIL': '/var/mail/cltbld', 08:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:03 INFO - 'MOZ_NO_REMOTE': '1', 08:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:03 INFO - 'NO_EM_RESTART': '1', 08:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:03 INFO - 'PWD': '/builds/slave/test', 08:11:03 INFO - 'SHELL': '/bin/bash', 08:11:03 INFO - 'SHLVL': '1', 08:11:03 INFO - 'TERM': 'linux', 08:11:03 INFO - 'TMOUT': '86400', 08:11:03 INFO - 'USER': 'cltbld', 08:11:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:03 INFO - '_': '/tools/buildbot/bin/python'} 08:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:03 INFO - Running setup.py (path:/tmp/pip-B3pM6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:04 INFO - Running setup.py (path:/tmp/pip-A3ekIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:04 INFO - Running setup.py (path:/tmp/pip-XwryXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:04 INFO - Running setup.py (path:/tmp/pip-Y220j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:04 INFO - Running setup.py (path:/tmp/pip-Ea8zyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:04 INFO - Running setup.py (path:/tmp/pip-uGkBQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:04 INFO - Running setup.py (path:/tmp/pip-x26poa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:04 INFO - Running setup.py (path:/tmp/pip-b47aML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:04 INFO - Running setup.py (path:/tmp/pip-yvfBBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:04 INFO - Running setup.py (path:/tmp/pip-clQ8NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:04 INFO - Running setup.py (path:/tmp/pip-VkJAx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:04 INFO - Running setup.py (path:/tmp/pip-zxoHVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:04 INFO - Running setup.py (path:/tmp/pip-6NBLDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:04 INFO - Running setup.py (path:/tmp/pip-nE1yGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:04 INFO - Running setup.py (path:/tmp/pip-z96l1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:05 INFO - Running setup.py (path:/tmp/pip-frCi9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:05 INFO - Running setup.py (path:/tmp/pip-8GZYdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:05 INFO - Running setup.py install for manifestparser 08:11:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Running setup.py install for mozcrash 08:11:05 INFO - Running setup.py install for mozdebug 08:11:05 INFO - Running setup.py install for mozdevice 08:11:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Running setup.py install for mozfile 08:11:05 INFO - Running setup.py install for mozhttpd 08:11:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Running setup.py install for mozinfo 08:11:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Running setup.py install for mozInstall 08:11:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Running setup.py install for mozleak 08:11:06 INFO - Running setup.py install for mozlog 08:11:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Running setup.py install for moznetwork 08:11:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Running setup.py install for mozprocess 08:11:06 INFO - Running setup.py install for mozprofile 08:11:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Running setup.py install for mozrunner 08:11:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Running setup.py install for mozscreenshot 08:11:06 INFO - Running setup.py install for moztest 08:11:06 INFO - Running setup.py install for mozversion 08:11:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:06 INFO - Cleaning up... 08:11:06 INFO - Return code: 0 08:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:06 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:11:06 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 08:11:06 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 08:11:06 INFO - Using env: {'DISPLAY': ':0', 08:11:06 INFO - 'HOME': '/home/cltbld', 08:11:06 INFO - 'LANG': 'en_US.UTF-8', 08:11:06 INFO - 'LANGUAGE': 'en_US:en', 08:11:06 INFO - 'LOGNAME': 'cltbld', 08:11:06 INFO - 'MAIL': '/var/mail/cltbld', 08:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:06 INFO - 'MOZ_NO_REMOTE': '1', 08:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:06 INFO - 'NO_EM_RESTART': '1', 08:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:06 INFO - 'PWD': '/builds/slave/test', 08:11:06 INFO - 'SHELL': '/bin/bash', 08:11:06 INFO - 'SHLVL': '1', 08:11:06 INFO - 'TERM': 'linux', 08:11:06 INFO - 'TMOUT': '86400', 08:11:06 INFO - 'USER': 'cltbld', 08:11:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:06 INFO - '_': '/tools/buildbot/bin/python'} 08:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:07 INFO - Running setup.py (path:/tmp/pip-sANSJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:07 INFO - Running setup.py (path:/tmp/pip-ocoiyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:07 INFO - Running setup.py (path:/tmp/pip-z3b5Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:07 INFO - Running setup.py (path:/tmp/pip-q9KnAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:07 INFO - Running setup.py (path:/tmp/pip-l7XK3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:07 INFO - Running setup.py (path:/tmp/pip-yDqwBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:07 INFO - Running setup.py (path:/tmp/pip-gHivYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:07 INFO - Running setup.py (path:/tmp/pip-Tp3koO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:07 INFO - Running setup.py (path:/tmp/pip-icAjV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:07 INFO - Running setup.py (path:/tmp/pip-zSWNcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:07 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)) 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:07 INFO - Running setup.py (path:/tmp/pip-npex7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:08 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)) 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:08 INFO - Running setup.py (path:/tmp/pip-F33iEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:08 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)) 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:08 INFO - Running setup.py (path:/tmp/pip-zHprZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:08 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)) 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:08 INFO - Running setup.py (path:/tmp/pip-vbbAYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:08 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)) 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:08 INFO - Running setup.py (path:/tmp/pip-l_Rfd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:08 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)) 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:08 INFO - Running setup.py (path:/tmp/pip-b3Gpna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:08 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)) 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:08 INFO - Running setup.py (path:/tmp/pip-KVJY_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:08 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)) 08:11:08 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)) 08:11:08 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)) 08:11:08 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)) 08:11:08 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)) 08:11:08 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)) 08:11:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:08 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 08:11:08 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 08:11:08 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 08:11:08 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 08:11:08 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 08:11:08 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 08:11:10 INFO - Downloading blessings-1.6.tar.gz 08:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:10 INFO - Installing collected packages: blessings 08:11:10 INFO - Running setup.py install for blessings 08:11:10 INFO - Successfully installed blessings 08:11:10 INFO - Cleaning up... 08:11:10 INFO - Return code: 0 08:11:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:10 INFO - Reading from file tmpfile_stdout 08:11:10 INFO - Current package versions: 08:11:10 INFO - argparse == 1.2.1 08:11:10 INFO - blessings == 1.6 08:11:10 INFO - blobuploader == 1.2.4 08:11:10 INFO - docopt == 0.6.1 08:11:10 INFO - functools32 == 3.2.3-2 08:11:10 INFO - jsonschema == 2.5.1 08:11:10 INFO - manifestparser == 1.1 08:11:10 INFO - mozInstall == 1.12 08:11:10 INFO - mozcrash == 0.17 08:11:10 INFO - mozdebug == 0.1 08:11:10 INFO - mozdevice == 0.48 08:11:10 INFO - mozfile == 1.2 08:11:10 INFO - mozhttpd == 0.7 08:11:10 INFO - mozinfo == 0.9 08:11:10 INFO - mozleak == 0.1 08:11:10 INFO - mozlog == 3.2 08:11:10 INFO - moznetwork == 0.27 08:11:10 INFO - mozprocess == 0.22 08:11:10 INFO - mozprofile == 0.28 08:11:10 INFO - mozrunner == 6.11 08:11:10 INFO - mozscreenshot == 0.1 08:11:10 INFO - mozsystemmonitor == 0.3 08:11:10 INFO - moztest == 0.7 08:11:10 INFO - mozversion == 1.4 08:11:10 INFO - psutil == 3.1.1 08:11:10 INFO - requests == 1.2.3 08:11:10 INFO - wsgiref == 0.1.2 08:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:10 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:11:10 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 08:11:10 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 08:11:10 INFO - Using env: {'DISPLAY': ':0', 08:11:10 INFO - 'HOME': '/home/cltbld', 08:11:10 INFO - 'LANG': 'en_US.UTF-8', 08:11:10 INFO - 'LANGUAGE': 'en_US:en', 08:11:10 INFO - 'LOGNAME': 'cltbld', 08:11:10 INFO - 'MAIL': '/var/mail/cltbld', 08:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:10 INFO - 'MOZ_NO_REMOTE': '1', 08:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:10 INFO - 'NO_EM_RESTART': '1', 08:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:10 INFO - 'PWD': '/builds/slave/test', 08:11:10 INFO - 'SHELL': '/bin/bash', 08:11:10 INFO - 'SHLVL': '1', 08:11:10 INFO - 'TERM': 'linux', 08:11:10 INFO - 'TMOUT': '86400', 08:11:10 INFO - 'USER': 'cltbld', 08:11:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:10 INFO - '_': '/tools/buildbot/bin/python'} 08:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 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)) 08:11:11 INFO - Cleaning up... 08:11:11 INFO - Return code: 0 08:11:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:11 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')]} 08:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:11 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')]} 08:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:11 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:11:11 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 08:11:11 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 08:11:11 INFO - Using env: {'DISPLAY': ':0', 08:11:11 INFO - 'HOME': '/home/cltbld', 08:11:11 INFO - 'LANG': 'en_US.UTF-8', 08:11:11 INFO - 'LANGUAGE': 'en_US:en', 08:11:11 INFO - 'LOGNAME': 'cltbld', 08:11:11 INFO - 'MAIL': '/var/mail/cltbld', 08:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:11 INFO - 'MOZ_NO_REMOTE': '1', 08:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:11 INFO - 'NO_EM_RESTART': '1', 08:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:11 INFO - 'PWD': '/builds/slave/test', 08:11:11 INFO - 'SHELL': '/bin/bash', 08:11:11 INFO - 'SHLVL': '1', 08:11:11 INFO - 'TERM': 'linux', 08:11:11 INFO - 'TMOUT': '86400', 08:11:11 INFO - 'USER': 'cltbld', 08:11:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:11 INFO - '_': '/tools/buildbot/bin/python'} 08:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:11 INFO - Cleaning up... 08:11:11 INFO - Return code: 0 08:11:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:11:11 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')]} 08:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:11 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')]} 08:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:11 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 0x7fae3208cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', '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 08:11:11 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 08:11:11 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 08:11:11 INFO - Using env: {'DISPLAY': ':0', 08:11:11 INFO - 'HOME': '/home/cltbld', 08:11:11 INFO - 'LANG': 'en_US.UTF-8', 08:11:11 INFO - 'LANGUAGE': 'en_US:en', 08:11:11 INFO - 'LOGNAME': 'cltbld', 08:11:11 INFO - 'MAIL': '/var/mail/cltbld', 08:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:11 INFO - 'MOZ_NO_REMOTE': '1', 08:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:11 INFO - 'NO_EM_RESTART': '1', 08:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:11 INFO - 'PWD': '/builds/slave/test', 08:11:11 INFO - 'SHELL': '/bin/bash', 08:11:11 INFO - 'SHLVL': '1', 08:11:11 INFO - 'TERM': 'linux', 08:11:11 INFO - 'TMOUT': '86400', 08:11:11 INFO - 'USER': 'cltbld', 08:11:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:11 INFO - '_': '/tools/buildbot/bin/python'} 08:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:11 INFO - Downloading/unpacking flake8 08:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:11:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:11:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 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 08:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:11:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:14 INFO - no previously-included directories found matching 'docs/_build' 08:11:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:11:14 INFO - Running setup.py install for pep8 08:11:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:14 INFO - no previously-included directories found matching 'docs/_build' 08:11:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:11:14 INFO - Cleaning up... 08:11:14 INFO - Return code: 0 08:11:14 INFO - Running post-action listener: _resource_record_post_action 08:11:14 INFO - Running post-action listener: _start_resource_monitoring 08:11:14 INFO - Starting resource monitoring. 08:11:14 INFO - ##### 08:11:14 INFO - ##### Finished create-virtualenv step (success) 08:11:14 INFO - ##### 08:11:14 INFO - ##### 08:11:14 INFO - ##### Running install step. 08:11:14 INFO - ##### 08:11:14 INFO - Running pre-action listener: _resource_record_pre_action 08:11:14 INFO - Running main action method: install 08:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:14 INFO - Reading from file tmpfile_stdout 08:11:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:14 INFO - Reading from file tmpfile_stdout 08:11:14 INFO - Output received: 08:11:14 INFO - Usage: mozinstall [options] installer 08:11:14 INFO - Options: 08:11:14 INFO - -h, --help show this help message and exit 08:11:14 INFO - -d DEST, --destination=DEST 08:11:14 INFO - Directory to install application into. [default: 08:11:14 INFO - "/builds/slave/test"] 08:11:14 INFO - --app=APP Application being installed. [default: firefox] 08:11:14 INFO - mkdir: /builds/slave/test/build/application 08:11:14 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'] 08:11:14 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 08:11:31 INFO - Reading from file tmpfile_stdout 08:11:31 INFO - Output received: 08:11:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:11:31 INFO - Running post-action listener: _resource_record_post_action 08:11:31 INFO - ##### 08:11:31 INFO - ##### Finished install step (success) 08:11:31 INFO - ##### 08:11:31 INFO - ##### 08:11:31 INFO - ##### Running run-tests step. 08:11:31 INFO - ##### 08:11:31 INFO - Running pre-action listener: _resource_record_pre_action 08:11:31 INFO - Running main action method: run_tests 08:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:31 INFO - Python 2.7.3 08:11:31 INFO - Return code: 0 08:11:31 INFO - grabbing minidump binary from tooltool 08:11: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')]} 08:11:31 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 0x289d1c0>, '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 0x289e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:31 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 08:11:31 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 08:11:31 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 08:11:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:31 INFO - Return code: 0 08:11:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:11:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:11:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:11:32 INFO - Return code: 0 08:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 08:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 08:11:32 INFO - Using env: {'DISPLAY': ':0', 08:11:32 INFO - 'HOME': '/home/cltbld', 08:11:32 INFO - 'LANG': 'en_US.UTF-8', 08:11:32 INFO - 'LANGUAGE': 'en_US:en', 08:11:32 INFO - 'LOGNAME': 'cltbld', 08:11:32 INFO - 'MAIL': '/var/mail/cltbld', 08:11:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:32 INFO - 'MOZ_NO_REMOTE': '1', 08:11:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:32 INFO - 'NO_EM_RESTART': '1', 08:11:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:32 INFO - 'PWD': '/builds/slave/test', 08:11:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:32 INFO - 'SHELL': '/bin/bash', 08:11:32 INFO - 'SHLVL': '1', 08:11:32 INFO - 'TERM': 'linux', 08:11:32 INFO - 'TMOUT': '86400', 08:11:32 INFO - 'USER': 'cltbld', 08:11:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756', 08:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:32 INFO - '_': '/tools/buildbot/bin/python'} 08:11:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 08:11:32 INFO - mozversion application_buildid: 20160616053041 08:11:32 INFO - mozversion application_changeset: 61b7d2351dd2ed50789df8aed472ee0af1e06829 08:11:32 INFO - mozversion application_display_name: Nightly 08:11:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:32 INFO - mozversion application_name: Firefox 08:11:32 INFO - mozversion application_remotingname: firefox 08:11:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:11:32 INFO - mozversion application_vendor: Mozilla 08:11:32 INFO - mozversion application_version: 50.0a1 08:11:32 INFO - mozversion platform_buildid: 20160616053041 08:11:32 INFO - mozversion platform_changeset: 61b7d2351dd2ed50789df8aed472ee0af1e06829 08:11:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:32 INFO - mozversion platform_version: 50.0a1 08:11:32 INFO - using testdate: 1466089892 08:11:32 INFO - actual date: 1466089892 08:11:32 INFO - starting webserver on 'localhost:57412' 08:11:32 INFO - SUITE-START | Running 2 tests 08:11:32 INFO - TEST-START | dromaeo_css 08:11:32 INFO - operating with platform_type : linux_ 08:11:32 INFO - Initialising browser for dromaeo_css test... 08:11:32 INFO - TEST-INFO | started process 21677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzycbS0/profile http://localhost:57412/getInfo.html) 08:11:36 INFO - PROCESS | 21677 | __metrics Screen width/height:1600/1200 08:11:36 INFO - PROCESS | 21677 | colorDepth:24 08:11:36 INFO - PROCESS | 21677 | Browser inner width/height: 1024/697 08:11:36 INFO - PROCESS | 21677 | __metrics 08:11:38 INFO - PROCESS | 21677 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:38 INFO - TEST-INFO | 21677: exit 0 08:11:38 INFO - Browser initialized. 08:11:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:38 INFO - TEST-INFO | started process 21759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzycbS0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:50 INFO - PROCESS | 21759 | RSS: Main: 173940736 08:11:50 INFO - PROCESS | 21759 | 08:12:42 INFO - PROCESS | 21759 | 1466089962532 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] 08:14:50 INFO - PROCESS | 21759 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57412/tests/dromaeo/cssquery-ext.html) 08:14:51 INFO - PROCESS | 21759 | RSS: Main: 286662656 08:14:51 INFO - PROCESS | 21759 | 08:17:54 INFO - PROCESS | 21759 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-ext.html (next: http://localhost:57412/tests/dromaeo/cssquery-jquery.html) 08:17:54 INFO - PROCESS | 21759 | RSS: Main: 270184448 08:17:54 INFO - PROCESS | 21759 | 08:20:56 INFO - PROCESS | 21759 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57412/tests/dromaeo/cssquery-mootools.html) 08:20:57 INFO - PROCESS | 21759 | RSS: Main: 264089600 08:20:57 INFO - PROCESS | 21759 | 08:23:59 INFO - PROCESS | 21759 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57412/tests/dromaeo/cssquery-prototype.html) 08:23:59 INFO - PROCESS | 21759 | RSS: Main: 265035776 08:23:59 INFO - PROCESS | 21759 | 08:27:02 INFO - PROCESS | 21759 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57412/tests/dromaeo/cssquery-yui.html) 08:27:03 INFO - PROCESS | 21759 | RSS: Main: 222044160 08:27:03 INFO - PROCESS | 21759 | 08:30:05 INFO - PROCESS | 21759 | Cycle 1(1): loaded http://localhost:57412/tests/dromaeo/cssquery-yui.html (next: http://localhost:57412/tests/dromaeo/cssquery-dojo.html) 08:30:06 INFO - PROCESS | 21759 | RSS: Main: 284872704 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | __start_tp_report 08:30:06 INFO - PROCESS | 21759 | _x_x_mozilla_page_load 08:30:06 INFO - PROCESS | 21759 | _x_x_mozilla_page_load_details 08:30:06 INFO - PROCESS | 21759 | |i|pagename|runs| 08:30:06 INFO - PROCESS | 21759 | |0;dojo.html;3084.706952839481;3098.3028818515836;3119.8284094374812;3133.7493000559957;3150.2911844834916;5075.568576670988;5198.194279886624;5228.189630607258;5308.071087559676;5334.573234141264;5215.765290561924;5281.841544753664;5302;5304.761285742141;5338.172583249593;4705.317728929312;4759.595434388064;4789.80840766369;4797.6401769867225;4951.282064100703;4849.078675051746;4860.586850117745;4894.926576101361;4914.189158788796;4933.333999910002;4709.505501922283;4740.976295118519;4758.214894542379;4772.42730872294;4776.188048031808;4751.358566593535;4769.880752981168;4772.069446457942;4827.662063655545;4866.78099485524;4784.330193772875;4805.327254184417;4807.9038419231765;4809.158397280462;4816.301636262722;4890.755462226874;5115.565176959963;5188.299579556749;5188.688678679254;5366.087765079946;5744.6840423776675;5762.654240745527;5788.392218817005;5792.913106303409;5793.7972170974235;5586.720663966786;5823.068309070571;5845.386234445407;5847.093700476433;5847.532197424196;5316.893662126736;5379.085555455582;5379.542738867201;5417.295751552273;5421.620486565942;5860.589758716849;5926.644401335933;5938.020226662552;5938.257717785277;5943.375945525658;5448.182772584065;5506.2841830562575;5642.379338272786;5650.576206784508;5658.094704847204;5597;5652.576056795757;5655.660660360391;5657.4908258256955;5658.122990936411;5613.158026296088;5622.100463925834;5632.690202038927;5633.943660563342;5635.549156067505;5588.273524441878;5596.188552659923;5635.6618602883955;5654.180143879114;5655.434456554394;4256.36154576816;4329.826806927751;4331.696781225284;4387.100644367897;4391.429114215195;3878.941815872764;3900.7854567999034;3977.3238549446664;3986.1031267965054;3986.202759448122;5315.468453154731;5318.627696061316;5325.573954083664;5325.920111198335;5372.167314066326;5683.119116536944;5687.175359572839;5722.885542289214;5739.569532285095;5798.217240672539;5206.3752349717515;5264.473552644705;5293.761780719877;5311.946880531145;5396.514313711707;4922.680025798311;4948.331975183304;4952.479989601112;4969.552740253394;4982.800687972513;5872.17789509469;5882.529397648178;5883.294004719375;5887.911681324784;5950.702464876826;5619.578531610064;5654.208410822406;5711.286089238845;5719.599628025998;5755.8561035974435;5932.347441781314;5955.434233747787;5955.642661440327;5955.940440595538;5957.046872500379;5442.591805614516;5633.436656334334;5644.407337229696;5645.830625081254;5649.604527683023;5654.85862853432;5735.36910939788;5754.136879468113;5783.219265399117;5791.594588378942;5613.101903695389;5644;5650.152477128299;5660.349059858005;5666.263385759825;5383.623146379716;5521.585881059017;5567.860803479945;5625.634333768456;5631.802886898939;5494.917576236279;5559.24950131727;5560;5576.302962129734;5610.4670056344585;5671;5682.801101961411;5739.942600573941;5743.224664670216;5747.3103227612955;5432.6468779529205;5456.536194423518;5505.862353441196;5544.112941929433;5559.499645031967 08:30:06 INFO - PROCESS | 21759 | |1;ext.html;600.5765935015811;628.5160426471617;645.383658606031;653.3466533466534;655.9930506672259;29638;30205.697943020565;32701.18247043819;32766.836165819168;41641.16717665645;39375.21249575014;43847.780761096226;44137.99999999992;44301.77849110758;44314.556854431525;8700.912990870089;8920.330975176856;8920.509371984539;8922.598483068277;8925.55372231389;8822.86765698515;8919.420237684562;8965.686200982967;8975.416597921147;8977.46135231885;8996.550172491381;9017.54912254388;9020.684276050339;9024.458532488039;9027.95486022569;8933.59798809052;8976.147266009719;8997.820043599157;9000.459972401644;9013.324000699973;8735.606897689619;8807.207351338411;8811.867821982676;8817.470951742916;8823;42540.78729606363;42713.145737085084;42716.359254611205;42969.57030429718;42998.78500607508;3490.2670439207795;3955.251313946202;4213.389058586487;4278.679099067583;4316.417283666696;32114.678853211637;33024;33033.50449743256;33074.83462582672;34313.31373372518;4365.563443655609;4381.277089280265;4387.868363949086;4392.450943632046;4408.184485870092;346089;346418;346468;347335;347691.2615436932;33654.15864603355;34674.133146671535;56451.71774141103;56580;56665.716671416376;36206.818965905004;36212.27575448476;36266.81866590703;36444.45333320002;36456.27087458236;14559.272036398137;14579.708405831823;14663.92668036653;14680;14682.412703491955;12055.819162712567;12126.454309556091;12140.575079872162;12146.117351810484;12179.147459677737;8303.294219991369;8309;8326.542040187727;8386.287165590871;8386.832263354821;3216.485362342014;3226.2902161524426;3244.383567122239;3266.216108134031;3270.6238782539835;993.7517114336271;1036.4233002212404;1101.6309536305266;1146.8050431426511;1148.7013376522164;32432.513512297333;32593.837030814695;32746.181345466553;32755;32944.83527582347;1101.7961677089763;1114.2367478277406;1127.1658972360394;1141.6346769033996;1202.0563857371922;16887.915560422363;17443.12784360802;17487.825121748872;17599.472015839547;17719.822801771817;539561;543802;543929;544399;545999;58395.70802145962;58425.123623145686;58497.41502584919;58592.7070364654;59066.40933590695;1110.7056629993058;1326.973460530784;1341.4768240386256;1352.1211212711619;1394.958151255464;32144.35711285808;33718.49422258717;33921;33946.8302658495;34603.65396346105;50702.74648626733;50791.49208508016;51549;51577.48422515727;51594.484055158966;448795;455271;455660;455933;456146;37992.43011354887;43582.782086090636;44233.11533769371;44271.11457770891;44781.32828007648;47473.762631186626;47619.76190119027;48791.26813097877;48856.51143488519;49452.50547494623;38288.04279893025;40801.38797918093;41966.370504441846;42012.7882693169;42563.36154957616;40600;40748;40981;41443.7927810359;41590.37614435725;41814;42270.618350531266;42346.7882660597;43807;44620;35862.64137358697;37658;37959.240815184094;38199;38457.807710962385;27944.720552794213;28397;28412.289692757848;28690.71309286964;28916.855415722788 08:30:06 INFO - PROCESS | 21759 | |2;jquery.html;389.41393203229137;389.70771921059196;390.30525664317526;395.693337663311;413.41088948248756;14383.64040898978;16823.495295141136;18061.819381806177;19604.90197549012;19676.11457484413;14550.854491455082;15185.77221341678;16870.57823554412;17662.823371766277;18214.27142914282;5715.3998830122755;5894.911576326359;5904.822855314326;5948.048312270038;5951.970240148793;4219.177260434217;5791.189233507313;5882.3529411764675;5883.852903677421;6170.506359491253;6528.510361722866;6567.376099270562;6614.834629134262;6622.304658010912;6622.966885165568;6250.124982502453;6550.508711846631;6567.047778072153;6575.704093315789;6578.046183303418;5668.518175955049;5745.368009518949;5777.682227477487;5782.3350314713925;5791.218185544982;22749.88625056881;22882.427939301484;23490.295291141294;23858.642120368208;24304.756952430427;2317.7682231776857;2365.0185173153122;2581.9096331628302;2642.9867850660817;2801.243664210652;13828.93085534576;13971.720565588734;14490.92754536231;14639.780403293958;14904.925475372555;1908.761404824397;1959.2456904091885;2032.5833204193104;2068.141721185706;2069.079259729421;77177.22822771757;79751.601241994;80000.59999700023;80831.59584202101;80875.5956220221;10421.947890260652;10563;10752.301100428447;10817.513211905483;11075.612353567587;14809;14882.627934301729;14901.776473352907;14913.179775112472;14932.32804523799;7739.264769846855;8142.226488483585;8165.591720413956;8186.099529051799;8199.262066414052;7706.306432421109;7736.961315193388;7757.549565123471;7842.451028427955;7860.0567931848545;5985.790497332572;6014.248218972629;6350.872982540323;6380.744770209232;6432.2602900667025;1768.3368736723728;1778.1553761963223;1800.5408620801875;1809.936652217166;1820.6722789897944;919.1865199298535;1064.3401091323274;1079.9362627811756;1103.1064837481665;1106.618216715232;19807.30674426417;20292;20302.39092827188;20391;20566.897165514376;960.9087136722001;974.1427543761445;977.6187286958092;1019.6686077024997;1061.532925512772;11266.549338026387;11545.307281562966;11580.189386743015;11679.124065695107;11703.531858725555;484587;486566;490502;499389;502930;78142.21857781349;79303.60348198222;79908.60045699851;82708.17291827124;83194;1023.7696518283476;1029.0841151375282;1038.8597539332093;1043.88517263101;1051.0750539525168;17514.211860466054;17694.469165925042;17801.842880213262;17814.198361073522;18113.003784791963;37671;37915.81042094772;39513.407298889964;39728.205435890544;40491.595084048786;53204.73397632987;55379;61520.38479615146;62022.68988655028;62245.688771555855;8593.785155370915;8623.784405389915;8662.82674346497;8687.478751274944;8873.334499912404;8755.60599772999;9843.803123937625;14230.573082807532;14247.28763561797;14356.425742970165;12212.938935305267;12232.87767122353;12300.077494187793;12409.93795031019;12475.688107797014;11299;11905.880941190824;12138;12148.635540933787;12253.509859605872;12202.633920982385;12310.507579696712;12379.93810030944;12596.118271721258;12894.935525322313;8519.74440766778;8533.53065581399;8562.100979397073;8855.468671879707;9013.954930225307;10983.286086404358;12298.323592202514;12316.50733970667;12349.814752778895;12474.625761227178 08:30:06 INFO - PROCESS | 21759 | |3;mootools.html;1324.7350529894024;1459.890508211884;1493.2011373914956;1621.7891674082368;1759.2611103336606;8264.83470330593;8673.739787806368;8686.174813392725;8688.087750786171;8706.956465217665;8359.4566353187;8614.913850861489;8615.31077513799;8617.224449799516;8625.611847466864;1953.6092781443767;2189.8576592521435;2252.256755270765;2295.9311220663367;2322.1059891941554;2270.160040784912;2277.077783497686;2277.214361045437;2279.544091181762;2279.726432828063;2219.844610877239;2234.910603575855;2238.955220895581;2242.843000989931;2244.8316376271764;1893.1953919584191;2151.290074275501;2176.880271585062;2217.2128894242474;2218.6228341181877;2232.8548644338066;2253.233900473847;2270.4437412833795;2271.761465046179;2272.0798076778933;8171.591420428955;8172.305354044914;8204.384671149688;8228.670853165866;8232.17678232178;4871.050145221683;4960.87597810054;5009.499050094998;5022.397312322545;5027.648064635477;2996.9360876888827;3111.735502482292;3142.858571364271;3169.857356418967;3189.7926634768664;1011.2769369900483;1024.2164743970868;1060.9416482093482;1063.3407287481734;1064.5901327988702;11634.476448559835;11680.707982300426;11687.298762074302;11727.88272117285;11737.647870563897;4429.357743127229;4467.798949047301;4518.6385089193445;4547.408836851188;4565.269556870885;9984.850227246598;9990.450525221182;9992.350497217658;9994.800103997879;10001.34991225568;5015.6489045767175;5048.066107770074;5049.141645920203;5051.747412629354;5052.418971818288;4009.0779120801794;4547.863564093016;4672.065586882637;4683.016566521069;4756.667033307635;3688.4098544232793;3764.5294338207723;3774.830132643983;3807.276617442677;3819.961800382016;1208.1603285716342;1224.7550489902055;1234.6913271682079;1248.4756402311052;1261.4449642157422;818.1777313799712;878.6309749905055;927.0636656976368;930.2604429478446;935.1770442010986;5590.664560126405;5679.290088738908;5766.163906233573;5780.855478613068;5785.537157027427;905.1310741687921;915.1671978499534;939.281449690987;940.1679513630486;982.7936133412063;3843.26977874203;3912.9021774455296;3938.212357528506;3946.940795888064;3976.5625781164626;10376.688699339033;10557.313774604627;10599.682009539727;10709.571617135383;10738.73153171177;10518.947405263078;10536.051755342056;10551.314164579278;10552.894471055344;10618.840717389245;7946.245106714853;7953.0853951795125;8140.552269625227;8164.061132969785;8167.469114507657;5648.71756412186;5705.714714264187;5711.171880077449;5788.189653448437;5807.274090738658;9467.952660236655;9952.552135154081;9952.900470995488;9959.452230127123;9967.800643987224;9576.521173941414;9930.702078937644;10163.7459063524;10189.43958082283;10195.388276703421;7222.09723784527;7875.803104922423;8111.310538604284;8119.147489513753;8123.228293312126;7891.565963872042;7905.288524032865;7949;8113.107558168479;8115.9855018122735;7098.5740855546765;7284.9635751823025;7482.401407887247;7574.697012119454;7687.231276872268;7277.090363704537;7385.852282954418;7485.812854678677;7489.775306740807;7554.508956917783;6538.738450461929;6575.605463672004;6617.172853393326;6621.3047629998155;6626.768063117768;4737.549932756383;4788.11419887322;4835.758212089311;5055.494450554915;5098.439171691185;4984.6261530384645;5084.237364395371;5099.974500127476;5141.5629671476845;5149.768260428365 08:30:06 INFO - PROCESS | 21759 | |4;prototype.html;282.46613899729505;298.6043492372607;305.24147493478716;308.2140541618872;316.3072870413794;5034;5097.700086477943;5220.4518525554795;5280.762365693543;5291.571275755548;5125.820596279131;5169;5218.582513398928;5232.816851410192;5258.237555554442;4112.568180341059;4121.278776214165;4136.607022332873;4145.523264824538;4167.39537788882;3908.609139086097;3920;4095.201435720036;4097.713160078795;4126.7523948563185;4061.73598716084;4079.2045551117544;4082.6935380678196;4087.652549533293;4094.6314831665145;4049.8785036448658;4067.450894129299;4080.245494437406;4093.6725061995267;4124.319487284594;3435.6220815710253;3658.158623516606;3680.411134218539;3684.2263124743836;3687.967369136646;5070;5083.262926875619;5084.771185296633;5103.642745007851;5109.591232701412;4665.976670116662;4671.766411679437;4688.976555117237;4700.811967521295;4710.199266124767;5331.840044798662;5339.91184529246;5436.238926550286;5444.591655625804;5480.506754392124;3967.1867267210155;3987.98006009971;3997.2804895118866;3999.960000399988;4005.619466150711;5713;5714.542836573064;5731.598788084836;5743.4543718346695;5748.7125643717645;4025.1748391579654;4109.91780164401;4125.154343359604;4158.376243563429;4163.708540402143;4137.007118291648;4164.6251837334785;4172.374143878443;4183.163367326547;4194.49666040071;4689.882752931204;4699.929501057487;4721.480637129913;4728.598069164091;4755.548222918817;5494.791145947885;5523.585731070186;5540.2243685884005;5543.556515478752;5560;1391.5547024951918;1449.5071675630124;1460.8466111058185;1463.1879306984513;1466.6846627975037;905.7690288976269;920.2959735802117;927.3184209605935;936.6066252174103;937.3017102258724;4739.312799644102;4760.120127322989;4766.261229509431;4781.904361912742;4869.902601947942;4965.553100220997;4987.177115775857;5006.874828129326;5011.57401620859;5015.974920125376;4683.976580117078;4794.736289504111;4810.835124194056;4811.206150985048;5019.774110165052;3016.8189908605113;3033.2568520712566;3040.300730831921;3059.4645936961388;3070.631524217108;5859.707014649251;5869.589128760946;5873.2658417697785;5906.852328691731;5945.10823376497;5540.088669409048;5780.364159942403;5830.766769329264;5842.620229685057;5852.741660542919;5754.856128596735;5758.510526605201;5782.45066718661;5807.883842323215;5812.79655212074;5338.3593968724;5658.49073583363;5688.203651488712;5697.230873832145;5710.314762228559;5573.414791446839;5613.915791263053;5614.157876318422;5622.775088996558;5644.278495059047;5822.184894114912;5844.707764611838;5858.150568167506;5902.612885971879;5915.2310199675485;3667.138222517653;3783.848646054127;3907.27715372657;3973.8013099345494;3986.800659967048;5596.188552659923;5602;5615.775368985195;5620.4098569649595;5622.678670512508;5476.178573213891;5498.725063746877;5503.367112782082;5506.834794956158;5519.503244707996;5222.921656175236;5412.025835349517;5430.5384042356845;5459.754311056092;5501.807436739695;5346.625736198429;5366.195070739421;5377.919331209957;5387.622866399314;5423.647462914898;5430.926804896328;5492.945070549244;5533.446655334435;5559.416261292506;5587.55299576041;5330.493603107699;5409;5453.182022696627;5457.645253058538;5463.262459567907 08:30:06 INFO - PROCESS | 21759 | |5;yui.html;707.2609123465977;720.5748608321089;762.4853224073748;814.1085511365055;844.430009743423;15601.765973510392;16106.51680449587;16486.175691215452;16537.255823487943;16567.585810354747;13686.52097176599;13687.384067716952;13698.726025479484;13756.58730238092;13894.930525347385;660.7324033766308;779.4777499075605;796.168004435365;796.3072127249301;803.9718609848657;783.306773505449;785.3363907498155;785.4972817396871;788.5268838696793;790.4229912164124;842.9494230346169;843.2073850580465;843.8607629741085;843.877637742527;846.6697987784769;697.4106879686682;803.8593246181924;834.7203686764941;841.7390608911257;844.4426678392293;604.4499505450063;606.1544145916466;608.8021393047277;610.206731249374;613.2824595223599;15121;15168.696626067416;15174.620634484116;15175.317110730044;15201.543953681406;15276.541703748906;15487.303071361815;15548.533543993699;15628.4530041448;15802.209889505479;12370;12466.875331246662;12483.126181167321;12510.37448127599;12609.684757881034;3841.5390153181515;3935.4293627423863;3949.763014219156;3996.020974861178;4084.6936479764136;77890;78430.60784696096;78583;79205.60397198035;79574.21490247814;12064.276143431422;12201.816972745415;12244.877551224552;12269.38653067361;12347.4737015039;21414.25050123238;22098.889505552368;23880.164194253117;23893.163739269043;23925.880370598035;8897.955510222408;8962.82074358509;9115.179633832855;9117.36178467501;9386.296027797942;4248.4052232687445;4377.058932329564;4573.862784116482;4851.442084160367;5002.224655178453;3667.449882517644;3706.6478684524927;3770.1328694399895;3781.8865434037025;3789.3368660484307;640.8333833203401;648.1994736500418;649.2533586375612;650.1418128070995;672.4183581202225;698.1691786773723;729.3253740290211;762.3024932186987;770.1912991359051;777.2577188784697;9271.351005429555;9941.950290248502;10024.899751002542;10061.4205940811;10192;650.9967450162814;749.1646813802571;754.4115589839934;756.428896183378;799.1169757418086;4632.953670463319;4837.806487740521;4879.926801097987;4924.212126059813;4985.925211121836;65619;111685;115798;117193;117963.41018295025;98620;99521.50239248903;99766;100713.49643251883;102355;86797.56601216954;90460.5476972624;90679.54660226656;90698;90991.63512547317;9323.580438880132;9324.627014919328;9382.67160649374;9602.66390676323;10016.801025012008;51652;52845.471545284054;53171.46828531665;53845;54251.21859767529;71525;73343.26656733578;74269.51460970858;75028;75528;13148.802767958297;13162.670933226746;13454.394552244976;13528.39122239482;14179.574612761633;14543.92728036353;15531.767023494882;15780.210989450712;15808.446704365291;16004.759928600848;14544.927275363978;14625.85374146245;15057.849421505645;15098.39606415731;15160.545183644508;14533;14777.852221477648;14784.260786960824;14964.133206735009;15643.608909777347;13680.794788077988;13704.314784260549;13841.79237311421;14058.39626248044;14235;11975.880241197476;12086.697832553904;12213.08183211102;12376.75246495083;12458.813117803058;11596.304221746723;12144.878551214375;12214.833861349798;12399.690007749878;12447.564335248222 08:30:06 INFO - PROCESS | 21759 | __end_tp_report 08:30:06 INFO - PROCESS | 21759 | __start_cc_report 08:30:06 INFO - PROCESS | 21759 | _x_x_mozilla_cycle_collect,908 08:30:06 INFO - PROCESS | 21759 | __end_cc_report 08:30:06 INFO - PROCESS | 21759 | __startTimestamp1466091006115__endTimestamp 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | ------- Summary: start ------- 08:30:06 INFO - PROCESS | 21759 | Number of tests: 6 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | [#0] dojo.html Cycles:165 Average:5291.73 Median:5506.28 stddev:607.90 (11.0%) stddev-sans-first:584.59 08:30:06 INFO - PROCESS | 21759 | Values: 3084.7 3098.3 3119.8 3133.7 3150.3 5075.6 5198.2 5228.2 5308.1 5334.6 5215.8 5281.8 5302.0 5304.8 5338.2 4705.3 4759.6 4789.8 4797.6 4951.3 4849.1 4860.6 4894.9 4914.2 4933.3 4709.5 4741.0 4758.2 4772.4 4776.2 4751.4 4769.9 4772.1 4827.7 4866.8 4784.3 4805.3 4807.9 4809.2 4816.3 4890.8 5115.6 5188.3 5188.7 5366.1 5744.7 5762.7 5788.4 5792.9 5793.8 5586.7 5823.1 5845.4 5847.1 5847.5 5316.9 5379.1 5379.5 5417.3 5421.6 5860.6 5926.6 5938.0 5938.3 5943.4 5448.2 5506.3 5642.4 5650.6 5658.1 5597.0 5652.6 5655.7 5657.5 5658.1 5613.2 5622.1 5632.7 5633.9 5635.5 5588.3 5596.2 5635.7 5654.2 5655.4 4256.4 4329.8 4331.7 4387.1 4391.4 3878.9 3900.8 3977.3 3986.1 3986.2 5315.5 5318.6 5325.6 5325.9 5372.2 5683.1 5687.2 5722.9 5739.6 5798.2 5206.4 5264.5 5293.8 5311.9 5396.5 4922.7 4948.3 4952.5 4969.6 4982.8 5872.2 5882.5 5883.3 5887.9 5950.7 5619.6 5654.2 5711.3 5719.6 5755.9 5932.3 5955.4 5955.6 5955.9 5957.0 5442.6 5633.4 5644.4 5645.8 5649.6 5654.9 5735.4 5754.1 5783.2 5791.6 5613.1 5644.0 5650.2 5660.3 5666.3 5383.6 5521.6 5567.9 5625.6 5631.8 5494.9 5559.2 5560.0 5576.3 5610.5 5671.0 5682.8 5739.9 5743.2 5747.3 5432.6 5456.5 5505.9 5544.1 5559.5 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | [#1] ext.html Cycles:180 Average:59804.99 Median:23242.00 stddev:120999.13 (520.6%) stddev-sans-first:121256.92 08:30:06 INFO - PROCESS | 21759 | Values: 600.6 628.5 645.4 653.3 656.0 29638.0 30205.7 32701.2 32766.8 41641.2 39375.2 43847.8 44138.0 44301.8 44314.6 8700.9 8920.3 8920.5 8922.6 8925.6 8822.9 8919.4 8965.7 8975.4 8977.5 8996.6 9017.5 9020.7 9024.5 9028.0 8933.6 8976.1 8997.8 9000.5 9013.3 8735.6 8807.2 8811.9 8817.5 8823.0 42540.8 42713.1 42716.4 42969.6 42998.8 3490.3 3955.3 4213.4 4278.7 4316.4 32114.7 33024.0 33033.5 33074.8 34313.3 4365.6 4381.3 4387.9 4392.5 4408.2 346089.0 346418.0 346468.0 347335.0 347691.3 33654.2 34674.1 56451.7 56580.0 56665.7 36206.8 36212.3 36266.8 36444.5 36456.3 14559.3 14579.7 14663.9 14680.0 14682.4 12055.8 12126.5 12140.6 12146.1 12179.1 8303.3 8309.0 8326.5 8386.3 8386.8 3216.5 3226.3 3244.4 3266.2 3270.6 993.8 1036.4 1101.6 1146.8 1148.7 32432.5 32593.8 32746.2 32755.0 32944.8 1101.8 1114.2 1127.2 1141.6 1202.1 16887.9 17443.1 17487.8 17599.5 17719.8 539561.0 543802.0 543929.0 544399.0 545999.0 58395.7 58425.1 58497.4 58592.7 59066.4 1110.7 1327.0 1341.5 1352.1 1395.0 32144.4 33718.5 33921.0 33946.8 34603.7 50702.7 50791.5 51549.0 51577.5 51594.5 448795.0 455271.0 455660.0 455933.0 456146.0 37992.4 43582.8 44233.1 44271.1 44781.3 47473.8 47619.8 48791.3 48856.5 49452.5 38288.0 40801.4 41966.4 42012.8 42563.4 40600.0 40748.0 40981.0 41443.8 41590.4 41814.0 42270.6 42346.8 43807.0 44620.0 35862.6 37658.0 37959.2 38199.0 38457.8 27944.7 28397.0 28412.3 28690.7 28916.9 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | [#2] jquery.html Cycles:180 Average:28864.79 Median:13443.33 stddev:80950.61 (602.2%) stddev-sans-first:81149.46 08:30:06 INFO - PROCESS | 21759 | Values: 389.4 389.7 390.3 395.7 413.4 14383.6 16823.5 18061.8 19604.9 19676.1 14550.9 15185.8 16870.6 17662.8 18214.3 5715.4 5894.9 5904.8 5948.0 5952.0 4219.2 5791.2 5882.4 5883.9 6170.5 6528.5 6567.4 6614.8 6622.3 6623.0 6250.1 6550.5 6567.0 6575.7 6578.0 5668.5 5745.4 5777.7 5782.3 5791.2 22749.9 22882.4 23490.3 23858.6 24304.8 2317.8 2365.0 2581.9 2643.0 2801.2 13828.9 13971.7 14490.9 14639.8 14904.9 1908.8 1959.2 2032.6 2068.1 2069.1 77177.2 79751.6 80000.6 80831.6 80875.6 10421.9 10563.0 10752.3 10817.5 11075.6 14809.0 14882.6 14901.8 14913.2 14932.3 7739.3 8142.2 8165.6 8186.1 8199.3 7706.3 7737.0 7757.5 7842.5 7860.1 5985.8 6014.2 6350.9 6380.7 6432.3 1768.3 1778.2 1800.5 1809.9 1820.7 919.2 1064.3 1079.9 1103.1 1106.6 19807.3 20292.0 20302.4 20391.0 20566.9 960.9 974.1 977.6 1019.7 1061.5 11266.5 11545.3 11580.2 11679.1 11703.5 484587.0 486566.0 490502.0 499389.0 502930.0 78142.2 79303.6 79908.6 82708.2 83194.0 1023.8 1029.1 1038.9 1043.9 1051.1 17514.2 17694.5 17801.8 17814.2 18113.0 37671.0 37915.8 39513.4 39728.2 40491.6 53204.7 55379.0 61520.4 62022.7 62245.7 8593.8 8623.8 8662.8 8687.5 8873.3 8755.6 9843.8 14230.6 14247.3 14356.4 12212.9 12232.9 12300.1 12409.9 12475.7 11299.0 11905.9 12138.0 12148.6 12253.5 12202.6 12310.5 12379.9 12596.1 12894.9 8519.7 8533.5 8562.1 8855.5 9014.0 10983.3 12298.3 12316.5 12349.8 12474.6 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | [#3] mootools.html Cycles:180 Average:5599.48 Median:5012.57 stddev:3201.27 (63.9%) stddev-sans-first:3194.14 08:30:06 INFO - PROCESS | 21759 | Values: 1324.7 1459.9 1493.2 1621.8 1759.3 8264.8 8673.7 8686.2 8688.1 8707.0 8359.5 8614.9 8615.3 8617.2 8625.6 1953.6 2189.9 2252.3 2295.9 2322.1 2270.2 2277.1 2277.2 2279.5 2279.7 2219.8 2234.9 2239.0 2242.8 2244.8 1893.2 2151.3 2176.9 2217.2 2218.6 2232.9 2253.2 2270.4 2271.8 2272.1 8171.6 8172.3 8204.4 8228.7 8232.2 4871.1 4960.9 5009.5 5022.4 5027.6 2996.9 3111.7 3142.9 3169.9 3189.8 1011.3 1024.2 1060.9 1063.3 1064.6 11634.5 11680.7 11687.3 11727.9 11737.6 4429.4 4467.8 4518.6 4547.4 4565.3 9984.9 9990.5 9992.4 9994.8 10001.3 5015.6 5048.1 5049.1 5051.7 5052.4 4009.1 4547.9 4672.1 4683.0 4756.7 3688.4 3764.5 3774.8 3807.3 3820.0 1208.2 1224.8 1234.7 1248.5 1261.4 818.2 878.6 927.1 930.3 935.2 5590.7 5679.3 5766.2 5780.9 5785.5 905.1 915.2 939.3 940.2 982.8 3843.3 3912.9 3938.2 3946.9 3976.6 10376.7 10557.3 10599.7 10709.6 10738.7 10518.9 10536.1 10551.3 10552.9 10618.8 7946.2 7953.1 8140.6 8164.1 8167.5 5648.7 5705.7 5711.2 5788.2 5807.3 9468.0 9952.6 9952.9 9959.5 9967.8 9576.5 9930.7 10163.7 10189.4 10195.4 7222.1 7875.8 8111.3 8119.1 8123.2 7891.6 7905.3 7949.0 8113.1 8116.0 7098.6 7285.0 7482.4 7574.7 7687.2 7277.1 7385.9 7485.8 7489.8 7554.5 6538.7 6575.6 6617.2 6621.3 6626.8 4737.5 4788.1 4835.8 5055.5 5098.4 4984.6 5084.2 5100.0 5141.6 5149.8 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | [#4] prototype.html Cycles:180 Average:4593.42 Median:5106.62 stddev:1342.70 (26.3%) stddev-sans-first:1306.90 08:30:06 INFO - PROCESS | 21759 | Values: 282.5 298.6 305.2 308.2 316.3 5034.0 5097.7 5220.5 5280.8 5291.6 5125.8 5169.0 5218.6 5232.8 5258.2 4112.6 4121.3 4136.6 4145.5 4167.4 3908.6 3920.0 4095.2 4097.7 4126.8 4061.7 4079.2 4082.7 4087.7 4094.6 4049.9 4067.5 4080.2 4093.7 4124.3 3435.6 3658.2 3680.4 3684.2 3688.0 5070.0 5083.3 5084.8 5103.6 5109.6 4666.0 4671.8 4689.0 4700.8 4710.2 5331.8 5339.9 5436.2 5444.6 5480.5 3967.2 3988.0 3997.3 4000.0 4005.6 5713.0 5714.5 5731.6 5743.5 5748.7 4025.2 4109.9 4125.2 4158.4 4163.7 4137.0 4164.6 4172.4 4183.2 4194.5 4689.9 4699.9 4721.5 4728.6 4755.5 5494.8 5523.6 5540.2 5543.6 5560.0 1391.6 1449.5 1460.8 1463.2 1466.7 905.8 920.3 927.3 936.6 937.3 4739.3 4760.1 4766.3 4781.9 4869.9 4965.6 4987.2 5006.9 5011.6 5016.0 4684.0 4794.7 4810.8 4811.2 5019.8 3016.8 3033.3 3040.3 3059.5 3070.6 5859.7 5869.6 5873.3 5906.9 5945.1 5540.1 5780.4 5830.8 5842.6 5852.7 5754.9 5758.5 5782.5 5807.9 5812.8 5338.4 5658.5 5688.2 5697.2 5710.3 5573.4 5613.9 5614.2 5622.8 5644.3 5822.2 5844.7 5858.2 5902.6 5915.2 3667.1 3783.8 3907.3 3973.8 3986.8 5596.2 5602.0 5615.8 5620.4 5622.7 5476.2 5498.7 5503.4 5506.8 5519.5 5222.9 5412.0 5430.5 5459.8 5501.8 5346.6 5366.2 5377.9 5387.6 5423.6 5430.9 5492.9 5533.4 5559.4 5587.6 5330.5 5409.0 5453.2 5457.6 5463.3 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - PROCESS | 21759 | [#5] yui.html Cycles:180 Average:21101.28 Median:4312.73 stddev:29727.29 (689.3%) stddev-sans-first:29771.24 08:30:06 INFO - PROCESS | 21759 | Values: 707.3 720.6 762.5 814.1 844.4 15601.8 16106.5 16486.2 16537.3 16567.6 13686.5 13687.4 13698.7 13756.6 13894.9 660.7 779.5 796.2 796.3 804.0 783.3 785.3 785.5 788.5 790.4 842.9 843.2 843.9 843.9 846.7 697.4 803.9 834.7 841.7 844.4 604.4 606.2 608.8 610.2 613.3 15121.0 15168.7 15174.6 15175.3 15201.5 15276.5 15487.3 15548.5 15628.5 15802.2 12370.0 12466.9 12483.1 12510.4 12609.7 3841.5 3935.4 3949.8 3996.0 4084.7 77890.0 78430.6 78583.0 79205.6 79574.2 12064.3 12201.8 12244.9 12269.4 12347.5 21414.3 22098.9 23880.2 23893.2 23925.9 8898.0 8962.8 9115.2 9117.4 9386.3 4248.4 4377.1 4573.9 4851.4 5002.2 3667.4 3706.6 3770.1 3781.9 3789.3 640.8 648.2 649.3 650.1 672.4 698.2 729.3 762.3 770.2 777.3 9271.4 9942.0 10024.9 10061.4 10192.0 651.0 749.2 754.4 756.4 799.1 4633.0 4837.8 4879.9 4924.2 4985.9 65619.0 111685.0 115798.0 117193.0 117963.4 98620.0 99521.5 99766.0 100713.5 102355.0 86797.6 90460.5 90679.5 90698.0 90991.6 9323.6 9324.6 9382.7 9602.7 10016.8 51652.0 52845.5 53171.5 53845.0 54251.2 71525.0 73343.3 74269.5 75028.0 75528.0 13148.8 13162.7 13454.4 13528.4 14179.6 14543.9 15531.8 15780.2 15808.4 16004.8 14544.9 14625.9 15057.8 15098.4 15160.5 14533.0 14777.9 14784.3 14964.1 15643.6 13680.8 13704.3 13841.8 14058.4 14235.0 11975.9 12086.7 12213.1 12376.8 12458.8 11596.3 12144.9 12214.8 12399.7 12447.6 08:30:06 INFO - PROCESS | 21759 | -------- Summary: end -------- 08:30:06 INFO - PROCESS | 21759 | 08:30:06 INFO - TEST-INFO | 21759: exit 0 08:30:06 INFO - TEST-OK | dromaeo_css | took 1114158ms 08:30:06 INFO - TEST-START | kraken 08:30:06 INFO - operating with platform_type : linux_ 08:30:06 INFO - Initialising browser for kraken test... 08:30:06 INFO - TEST-INFO | started process 21947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKi3zb/profile http://localhost:57412/getInfo.html) 08:30:11 INFO - PROCESS | 21947 | __metrics Screen width/height:1600/1200 08:30:11 INFO - PROCESS | 21947 | colorDepth:24 08:30:11 INFO - PROCESS | 21947 | Browser inner width/height: 1024/697 08:30:11 INFO - PROCESS | 21947 | __metrics 08:30:12 INFO - PROCESS | 21947 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:13 INFO - TEST-INFO | 21947: exit 0 08:30:13 INFO - Browser initialized. 08:30:13 INFO - Running cycle 1/1 for kraken test... 08:30:13 INFO - TEST-INFO | started process 22028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKi3zb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:25 INFO - PROCESS | 22028 | RSS: Main: 173207552 08:30:25 INFO - PROCESS | 22028 | 08:30:27 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:28 INFO - PROCESS | 22028 | RSS: Main: 233050112 08:30:28 INFO - PROCESS | 22028 | 08:30:31 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-dft) 08:30:31 INFO - PROCESS | 22028 | RSS: Main: 220606464 08:30:31 INFO - PROCESS | 22028 | 08:30:34 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-fft) 08:30:35 INFO - PROCESS | 22028 | RSS: Main: 286908416 08:30:35 INFO - PROCESS | 22028 | 08:30:37 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57412/tests/kraken/driver.html?testName=audio-oscillator) 08:30:38 INFO - PROCESS | 22028 | RSS: Main: 197451776 08:30:38 INFO - PROCESS | 22028 | 08:30:40 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:40 INFO - PROCESS | 22028 | RSS: Main: 201977856 08:30:40 INFO - PROCESS | 22028 | 08:30:43 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57412/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:44 INFO - PROCESS | 22028 | RSS: Main: 237883392 08:30:44 INFO - PROCESS | 22028 | 08:30:47 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57412/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:48 INFO - PROCESS | 22028 | RSS: Main: 238796800 08:30:48 INFO - PROCESS | 22028 | 08:30:51 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57412/tests/kraken/driver.html?testName=json-parse-financial) 08:30:51 INFO - PROCESS | 22028 | RSS: Main: 238170112 08:30:51 INFO - PROCESS | 22028 | 08:30:53 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:54 INFO - PROCESS | 22028 | RSS: Main: 226992128 08:30:54 INFO - PROCESS | 22028 | 08:30:55 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:56 INFO - PROCESS | 22028 | RSS: Main: 229089280 08:30:56 INFO - PROCESS | 22028 | 08:30:58 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:59 INFO - PROCESS | 22028 | RSS: Main: 237236224 08:30:59 INFO - PROCESS | 22028 | 08:31:01 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:02 INFO - PROCESS | 22028 | RSS: Main: 239968256 08:31:02 INFO - PROCESS | 22028 | 08:31:05 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:05 INFO - PROCESS | 22028 | RSS: Main: 240009216 08:31:05 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | Cycle 1(1): loaded http://localhost:57412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57412/tests/kraken/driver.html?testName=ai-astar) 08:31:07 INFO - PROCESS | 22028 | RSS: Main: 283439104 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | __start_tp_report 08:31:07 INFO - PROCESS | 22028 | _x_x_mozilla_page_load 08:31:07 INFO - PROCESS | 22028 | _x_x_mozilla_page_load_details 08:31:07 INFO - PROCESS | 22028 | |i|pagename|runs| 08:31:07 INFO - PROCESS | 22028 | |0;ai-astar;111;108;111;110;112;111;110;110;113;110 08:31:07 INFO - PROCESS | 22028 | |1;audio-beat-detection;158;126;126;182;131;126;149;125;172;126 08:31:07 INFO - PROCESS | 22028 | |2;audio-dft;162;160;161;161;160;164;160;161;163;161 08:31:07 INFO - PROCESS | 22028 | |3;audio-fft;74;74;73;125;76;75;74;75;99;74 08:31:07 INFO - PROCESS | 22028 | |4;audio-oscillator;86;85;113;86;86;86;124;84;85;130 08:31:07 INFO - PROCESS | 22028 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 08:31:07 INFO - PROCESS | 22028 | |6;imaging-darkroom;146;146;146;146;146;145;145;146;145;145 08:31:07 INFO - PROCESS | 22028 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;95 08:31:07 INFO - PROCESS | 22028 | |8;json-parse-financial;53;53;52;53;53;53;53;53;52;53 08:31:07 INFO - PROCESS | 22028 | |9;json-stringify-tinderbox;62;62;63;62;63;63;63;63;62;63 08:31:07 INFO - PROCESS | 22028 | |10;stanford-crypto-aes;79;79;83;82;84;82;79;82;111;81 08:31:07 INFO - PROCESS | 22028 | |11;stanford-crypto-ccm;122;132;129;119;129;124;121;129;133;127 08:31:07 INFO - PROCESS | 22028 | |12;stanford-crypto-pbkdf2;161;161;161;160;162;162;161;163;162;163 08:31:07 INFO - PROCESS | 22028 | |13;stanford-crypto-sha256-iterative;63;64;65;62;67;65;63;63;62;60 08:31:07 INFO - PROCESS | 22028 | __end_tp_report 08:31:07 INFO - PROCESS | 22028 | __start_cc_report 08:31:07 INFO - PROCESS | 22028 | _x_x_mozilla_cycle_collect,1661 08:31:07 INFO - PROCESS | 22028 | __end_cc_report 08:31:07 INFO - PROCESS | 22028 | __startTimestamp1466091067637__endTimestamp 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | ------- Summary: start ------- 08:31:07 INFO - PROCESS | 22028 | Number of tests: 14 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 08:31:07 INFO - PROCESS | 22028 | Values: 111.0 108.0 111.0 110.0 112.0 111.0 110.0 110.0 113.0 110.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:140.00 stddev:21.70 (15.5%) stddev-sans-first:22.24 08:31:07 INFO - PROCESS | 22028 | Values: 158.0 126.0 126.0 182.0 131.0 126.0 149.0 125.0 172.0 126.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 08:31:07 INFO - PROCESS | 22028 | Values: 162.0 160.0 161.0 161.0 160.0 164.0 160.0 161.0 163.0 161.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.50 stddev:17.03 (22.9%) stddev-sans-first:17.82 08:31:07 INFO - PROCESS | 22028 | Values: 74.0 74.0 73.0 125.0 76.0 75.0 74.0 75.0 99.0 74.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.50 stddev:18.30 (21.4%) stddev-sans-first:19.01 08:31:07 INFO - PROCESS | 22028 | Values: 86.0 85.0 113.0 86.0 86.0 86.0 124.0 84.0 85.0 130.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:31:07 INFO - PROCESS | 22028 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:31:07 INFO - PROCESS | 22028 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:31:07 INFO - PROCESS | 22028 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 08:31:07 INFO - PROCESS | 22028 | Values: 53.0 53.0 52.0 53.0 53.0 53.0 53.0 53.0 52.0 53.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 08:31:07 INFO - PROCESS | 22028 | Values: 62.0 62.0 63.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.00 stddev:9.58 (11.7%) stddev-sans-first:9.97 08:31:07 INFO - PROCESS | 22028 | Values: 79.0 79.0 83.0 82.0 84.0 82.0 79.0 82.0 111.0 81.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:129.00 stddev:4.77 (3.7%) stddev-sans-first:4.77 08:31:07 INFO - PROCESS | 22028 | Values: 122.0 132.0 129.0 119.0 129.0 124.0 121.0 129.0 133.0 127.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 08:31:07 INFO - PROCESS | 22028 | Values: 161.0 161.0 161.0 160.0 162.0 162.0 161.0 163.0 162.0 163.0 08:31:07 INFO - PROCESS | 22028 | 08:31:07 INFO - PROCESS | 22028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.96 (3.1%) stddev-sans-first:2.07 08:31:07 INFO - PROCESS | 22028 | Values: 63.0 64.0 65.0 62.0 67.0 65.0 63.0 63.0 62.0 60.0 08:31:07 INFO - PROCESS | 22028 | -------- Summary: end -------- 08:31:07 INFO - PROCESS | 22028 | 08:31:08 INFO - TEST-INFO | 22028: exit 0 08:31:08 INFO - TEST-OK | kraken | took 61749ms 08:31:08 INFO - SUITE-END | took 1175s 08:31:08 INFO - Completed test suite (00:19:36) 08:31:08 INFO - javascript benchmark 08:31:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.706952839481, 3098.3028818515836, 3119.8284094374812, 3133.7493000559957, 3150.2911844834916, 5075.568576670988, 5198.194279886624, 5228.189630607258, 5308.071087559676, 5334.573234141264, 5215.765290561924, 5281.841544753664, 5302.0, 5304.761285742141, 5338.172583249593, 4705.317728929312, 4759.595434388064, 4789.80840766369, 4797.6401769867225, 4951.282064100703, 4849.078675051746, 4860.586850117745, 4894.926576101361, 4914.189158788796, 4933.333999910002, 4709.505501922283, 4740.976295118519, 4758.214894542379, 4772.42730872294, 4776.188048031808, 4751.358566593535, 4769.880752981168, 4772.069446457942, 4827.662063655545, 4866.78099485524, 4784.330193772875, 4805.327254184417, 4807.9038419231765, 4809.158397280462, 4816.301636262722, 4890.755462226874, 5115.565176959963, 5188.299579556749, 5188.688678679254, 5366.087765079946, 5744.6840423776675, 5762.654240745527, 5788.392218817005, 5792.913106303409, 5793.7972170974235, 5586.720663966786, 5823.068309070571, 5845.386234445407, 5847.093700476433, 5847.532197424196, 5316.893662126736, 5379.085555455582, 5379.542738867201, 5417.295751552273, 5421.620486565942, 5860.589758716849, 5926.644401335933, 5938.020226662552, 5938.257717785277, 5943.375945525658, 5448.182772584065, 5506.2841830562575, 5642.379338272786, 5650.576206784508, 5658.094704847204, 5597.0, 5652.576056795757, 5655.660660360391, 5657.4908258256955, 5658.122990936411, 5613.158026296088, 5622.100463925834, 5632.690202038927, 5633.943660563342, 5635.549156067505, 5588.273524441878, 5596.188552659923, 5635.6618602883955, 5654.180143879114, 5655.434456554394, 4256.36154576816, 4329.826806927751, 4331.696781225284, 4387.100644367897, 4391.429114215195, 3878.941815872764, 3900.7854567999034, 3977.3238549446664, 3986.1031267965054, 3986.202759448122, 5315.468453154731, 5318.627696061316, 5325.573954083664, 5325.920111198335, 5372.167314066326, 5683.119116536944, 5687.175359572839, 5722.885542289214, 5739.569532285095, 5798.217240672539, 5206.3752349717515, 5264.473552644705, 5293.761780719877, 5311.946880531145, 5396.514313711707, 4922.680025798311, 4948.331975183304, 4952.479989601112, 4969.552740253394, 4982.800687972513, 5872.17789509469, 5882.529397648178, 5883.294004719375, 5887.911681324784, 5950.702464876826, 5619.578531610064, 5654.208410822406, 5711.286089238845, 5719.599628025998, 5755.8561035974435, 5932.347441781314, 5955.434233747787, 5955.642661440327, 5955.940440595538, 5957.046872500379, 5442.591805614516, 5633.436656334334, 5644.407337229696, 5645.830625081254, 5649.604527683023, 5654.85862853432, 5735.36910939788, 5754.136879468113, 5783.219265399117, 5791.594588378942, 5613.101903695389, 5644.0, 5650.152477128299, 5660.349059858005, 5666.263385759825, 5383.623146379716, 5521.585881059017, 5567.860803479945, 5625.634333768456, 5631.802886898939, 5494.917576236279, 5559.24950131727, 5560.0, 5576.302962129734, 5610.4670056344585, 5671.0, 5682.801101961411, 5739.942600573941, 5743.224664670216, 5747.3103227612955, 5432.6468779529205, 5456.536194423518, 5505.862353441196, 5544.112941929433, 5559.499645031967], "value": 5250.895025095622, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5765935015811, 628.5160426471617, 645.383658606031, 653.3466533466534, 655.9930506672259, 29638.0, 30205.697943020565, 32701.18247043819, 32766.836165819168, 41641.16717665645, 39375.21249575014, 43847.780761096226, 44137.99999999992, 44301.77849110758, 44314.556854431525, 8700.912990870089, 8920.330975176856, 8920.509371984539, 8922.598483068277, 8925.55372231389, 8822.86765698515, 8919.420237684562, 8965.686200982967, 8975.416597921147, 8977.46135231885, 8996.550172491381, 9017.54912254388, 9020.684276050339, 9024.458532488039, 9027.95486022569, 8933.59798809052, 8976.147266009719, 8997.820043599157, 9000.459972401644, 9013.324000699973, 8735.606897689619, 8807.207351338411, 8811.867821982676, 8817.470951742916, 8823.0, 42540.78729606363, 42713.145737085084, 42716.359254611205, 42969.57030429718, 42998.78500607508, 3490.2670439207795, 3955.251313946202, 4213.389058586487, 4278.679099067583, 4316.417283666696, 32114.678853211637, 33024.0, 33033.50449743256, 33074.83462582672, 34313.31373372518, 4365.563443655609, 4381.277089280265, 4387.868363949086, 4392.450943632046, 4408.184485870092, 346089.0, 346418.0, 346468.0, 347335.0, 347691.2615436932, 33654.15864603355, 34674.133146671535, 56451.71774141103, 56580.0, 56665.716671416376, 36206.818965905004, 36212.27575448476, 36266.81866590703, 36444.45333320002, 36456.27087458236, 14559.272036398137, 14579.708405831823, 14663.92668036653, 14680.0, 14682.412703491955, 12055.819162712567, 12126.454309556091, 12140.575079872162, 12146.117351810484, 12179.147459677737, 8303.294219991369, 8309.0, 8326.542040187727, 8386.287165590871, 8386.832263354821, 3216.485362342014, 3226.2902161524426, 3244.383567122239, 3266.216108134031, 3270.6238782539835, 993.7517114336271, 1036.4233002212404, 1101.6309536305266, 1146.8050431426511, 1148.7013376522164, 32432.513512297333, 32593.837030814695, 32746.181345466553, 32755.0, 32944.83527582347, 1101.7961677089763, 1114.2367478277406, 1127.1658972360394, 1141.6346769033996, 1202.0563857371922, 16887.915560422363, 17443.12784360802, 17487.825121748872, 17599.472015839547, 17719.822801771817, 539561.0, 543802.0, 543929.0, 544399.0, 545999.0, 58395.70802145962, 58425.123623145686, 58497.41502584919, 58592.7070364654, 59066.40933590695, 1110.7056629993058, 1326.973460530784, 1341.4768240386256, 1352.1211212711619, 1394.958151255464, 32144.35711285808, 33718.49422258717, 33921.0, 33946.8302658495, 34603.65396346105, 50702.74648626733, 50791.49208508016, 51549.0, 51577.48422515727, 51594.484055158966, 448795.0, 455271.0, 455660.0, 455933.0, 456146.0, 37992.43011354887, 43582.782086090636, 44233.11533769371, 44271.11457770891, 44781.32828007648, 47473.762631186626, 47619.76190119027, 48791.26813097877, 48856.51143488519, 49452.50547494623, 38288.04279893025, 40801.38797918093, 41966.370504441846, 42012.7882693169, 42563.36154957616, 40600.0, 40748.0, 40981.0, 41443.7927810359, 41590.37614435725, 41814.0, 42270.618350531266, 42346.7882660597, 43807.0, 44620.0, 35862.64137358697, 37658.0, 37959.240815184094, 38199.0, 38457.807710962385, 27944.720552794213, 28397.0, 28412.289692757848, 28690.71309286964, 28916.855415722788], "value": 19136.62803836144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.41393203229137, 389.70771921059196, 390.30525664317526, 395.693337663311, 413.41088948248756, 14383.64040898978, 16823.495295141136, 18061.819381806177, 19604.90197549012, 19676.11457484413, 14550.854491455082, 15185.77221341678, 16870.57823554412, 17662.823371766277, 18214.27142914282, 5715.3998830122755, 5894.911576326359, 5904.822855314326, 5948.048312270038, 5951.970240148793, 4219.177260434217, 5791.189233507313, 5882.3529411764675, 5883.852903677421, 6170.506359491253, 6528.510361722866, 6567.376099270562, 6614.834629134262, 6622.304658010912, 6622.966885165568, 6250.124982502453, 6550.508711846631, 6567.047778072153, 6575.704093315789, 6578.046183303418, 5668.518175955049, 5745.368009518949, 5777.682227477487, 5782.3350314713925, 5791.218185544982, 22749.88625056881, 22882.427939301484, 23490.295291141294, 23858.642120368208, 24304.756952430427, 2317.7682231776857, 2365.0185173153122, 2581.9096331628302, 2642.9867850660817, 2801.243664210652, 13828.93085534576, 13971.720565588734, 14490.92754536231, 14639.780403293958, 14904.925475372555, 1908.761404824397, 1959.2456904091885, 2032.5833204193104, 2068.141721185706, 2069.079259729421, 77177.22822771757, 79751.601241994, 80000.59999700023, 80831.59584202101, 80875.5956220221, 10421.947890260652, 10563.0, 10752.301100428447, 10817.513211905483, 11075.612353567587, 14809.0, 14882.627934301729, 14901.776473352907, 14913.179775112472, 14932.32804523799, 7739.264769846855, 8142.226488483585, 8165.591720413956, 8186.099529051799, 8199.262066414052, 7706.306432421109, 7736.961315193388, 7757.549565123471, 7842.451028427955, 7860.0567931848545, 5985.790497332572, 6014.248218972629, 6350.872982540323, 6380.744770209232, 6432.2602900667025, 1768.3368736723728, 1778.1553761963223, 1800.5408620801875, 1809.936652217166, 1820.6722789897944, 919.1865199298535, 1064.3401091323274, 1079.9362627811756, 1103.1064837481665, 1106.618216715232, 19807.30674426417, 20292.0, 20302.39092827188, 20391.0, 20566.897165514376, 960.9087136722001, 974.1427543761445, 977.6187286958092, 1019.6686077024997, 1061.532925512772, 11266.549338026387, 11545.307281562966, 11580.189386743015, 11679.124065695107, 11703.531858725555, 484587.0, 486566.0, 490502.0, 499389.0, 502930.0, 78142.21857781349, 79303.60348198222, 79908.60045699851, 82708.17291827124, 83194.0, 1023.7696518283476, 1029.0841151375282, 1038.8597539332093, 1043.88517263101, 1051.0750539525168, 17514.211860466054, 17694.469165925042, 17801.842880213262, 17814.198361073522, 18113.003784791963, 37671.0, 37915.81042094772, 39513.407298889964, 39728.205435890544, 40491.595084048786, 53204.73397632987, 55379.0, 61520.38479615146, 62022.68988655028, 62245.688771555855, 8593.785155370915, 8623.784405389915, 8662.82674346497, 8687.478751274944, 8873.334499912404, 8755.60599772999, 9843.803123937625, 14230.573082807532, 14247.28763561797, 14356.425742970165, 12212.938935305267, 12232.87767122353, 12300.077494187793, 12409.93795031019, 12475.688107797014, 11299.0, 11905.880941190824, 12138.0, 12148.635540933787, 12253.509859605872, 12202.633920982385, 12310.507579696712, 12379.93810030944, 12596.118271721258, 12894.935525322313, 8519.74440766778, 8533.53065581399, 8562.100979397073, 8855.468671879707, 9013.954930225307, 10983.286086404358, 12298.323592202514, 12316.50733970667, 12349.814752778895, 12474.625761227178], "value": 9438.14758407202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.7350529894024, 1459.890508211884, 1493.2011373914956, 1621.7891674082368, 1759.2611103336606, 8264.83470330593, 8673.739787806368, 8686.174813392725, 8688.087750786171, 8706.956465217665, 8359.4566353187, 8614.913850861489, 8615.31077513799, 8617.224449799516, 8625.611847466864, 1953.6092781443767, 2189.8576592521435, 2252.256755270765, 2295.9311220663367, 2322.1059891941554, 2270.160040784912, 2277.077783497686, 2277.214361045437, 2279.544091181762, 2279.726432828063, 2219.844610877239, 2234.910603575855, 2238.955220895581, 2242.843000989931, 2244.8316376271764, 1893.1953919584191, 2151.290074275501, 2176.880271585062, 2217.2128894242474, 2218.6228341181877, 2232.8548644338066, 2253.233900473847, 2270.4437412833795, 2271.761465046179, 2272.0798076778933, 8171.591420428955, 8172.305354044914, 8204.384671149688, 8228.670853165866, 8232.17678232178, 4871.050145221683, 4960.87597810054, 5009.499050094998, 5022.397312322545, 5027.648064635477, 2996.9360876888827, 3111.735502482292, 3142.858571364271, 3169.857356418967, 3189.7926634768664, 1011.2769369900483, 1024.2164743970868, 1060.9416482093482, 1063.3407287481734, 1064.5901327988702, 11634.476448559835, 11680.707982300426, 11687.298762074302, 11727.88272117285, 11737.647870563897, 4429.357743127229, 4467.798949047301, 4518.6385089193445, 4547.408836851188, 4565.269556870885, 9984.850227246598, 9990.450525221182, 9992.350497217658, 9994.800103997879, 10001.34991225568, 5015.6489045767175, 5048.066107770074, 5049.141645920203, 5051.747412629354, 5052.418971818288, 4009.0779120801794, 4547.863564093016, 4672.065586882637, 4683.016566521069, 4756.667033307635, 3688.4098544232793, 3764.5294338207723, 3774.830132643983, 3807.276617442677, 3819.961800382016, 1208.1603285716342, 1224.7550489902055, 1234.6913271682079, 1248.4756402311052, 1261.4449642157422, 818.1777313799712, 878.6309749905055, 927.0636656976368, 930.2604429478446, 935.1770442010986, 5590.664560126405, 5679.290088738908, 5766.163906233573, 5780.855478613068, 5785.537157027427, 905.1310741687921, 915.1671978499534, 939.281449690987, 940.1679513630486, 982.7936133412063, 3843.26977874203, 3912.9021774455296, 3938.212357528506, 3946.940795888064, 3976.5625781164626, 10376.688699339033, 10557.313774604627, 10599.682009539727, 10709.571617135383, 10738.73153171177, 10518.947405263078, 10536.051755342056, 10551.314164579278, 10552.894471055344, 10618.840717389245, 7946.245106714853, 7953.0853951795125, 8140.552269625227, 8164.061132969785, 8167.469114507657, 5648.71756412186, 5705.714714264187, 5711.171880077449, 5788.189653448437, 5807.274090738658, 9467.952660236655, 9952.552135154081, 9952.900470995488, 9959.452230127123, 9967.800643987224, 9576.521173941414, 9930.702078937644, 10163.7459063524, 10189.43958082283, 10195.388276703421, 7222.09723784527, 7875.803104922423, 8111.310538604284, 8119.147489513753, 8123.228293312126, 7891.565963872042, 7905.288524032865, 7949.0, 8113.107558168479, 8115.9855018122735, 7098.5740855546765, 7284.9635751823025, 7482.401407887247, 7574.697012119454, 7687.231276872268, 7277.090363704537, 7385.852282954418, 7485.812854678677, 7489.775306740807, 7554.508956917783, 6538.738450461929, 6575.605463672004, 6617.172853393326, 6621.3047629998155, 6626.768063117768, 4737.549932756383, 4788.11419887322, 4835.758212089311, 5055.494450554915, 5098.439171691185, 4984.6261530384645, 5084.237364395371, 5099.974500127476, 5141.5629671476845, 5149.768260428365], "value": 4467.6986343085955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.46613899729505, 298.6043492372607, 305.24147493478716, 308.2140541618872, 316.3072870413794, 5034.0, 5097.700086477943, 5220.4518525554795, 5280.762365693543, 5291.571275755548, 5125.820596279131, 5169.0, 5218.582513398928, 5232.816851410192, 5258.237555554442, 4112.568180341059, 4121.278776214165, 4136.607022332873, 4145.523264824538, 4167.39537788882, 3908.609139086097, 3920.0, 4095.201435720036, 4097.713160078795, 4126.7523948563185, 4061.73598716084, 4079.2045551117544, 4082.6935380678196, 4087.652549533293, 4094.6314831665145, 4049.8785036448658, 4067.450894129299, 4080.245494437406, 4093.6725061995267, 4124.319487284594, 3435.6220815710253, 3658.158623516606, 3680.411134218539, 3684.2263124743836, 3687.967369136646, 5070.0, 5083.262926875619, 5084.771185296633, 5103.642745007851, 5109.591232701412, 4665.976670116662, 4671.766411679437, 4688.976555117237, 4700.811967521295, 4710.199266124767, 5331.840044798662, 5339.91184529246, 5436.238926550286, 5444.591655625804, 5480.506754392124, 3967.1867267210155, 3987.98006009971, 3997.2804895118866, 3999.960000399988, 4005.619466150711, 5713.0, 5714.542836573064, 5731.598788084836, 5743.4543718346695, 5748.7125643717645, 4025.1748391579654, 4109.91780164401, 4125.154343359604, 4158.376243563429, 4163.708540402143, 4137.007118291648, 4164.6251837334785, 4172.374143878443, 4183.163367326547, 4194.49666040071, 4689.882752931204, 4699.929501057487, 4721.480637129913, 4728.598069164091, 4755.548222918817, 5494.791145947885, 5523.585731070186, 5540.2243685884005, 5543.556515478752, 5560.0, 1391.5547024951918, 1449.5071675630124, 1460.8466111058185, 1463.1879306984513, 1466.6846627975037, 905.7690288976269, 920.2959735802117, 927.3184209605935, 936.6066252174103, 937.3017102258724, 4739.312799644102, 4760.120127322989, 4766.261229509431, 4781.904361912742, 4869.902601947942, 4965.553100220997, 4987.177115775857, 5006.874828129326, 5011.57401620859, 5015.974920125376, 4683.976580117078, 4794.736289504111, 4810.835124194056, 4811.206150985048, 5019.774110165052, 3016.8189908605113, 3033.2568520712566, 3040.300730831921, 3059.4645936961388, 3070.631524217108, 5859.707014649251, 5869.589128760946, 5873.2658417697785, 5906.852328691731, 5945.10823376497, 5540.088669409048, 5780.364159942403, 5830.766769329264, 5842.620229685057, 5852.741660542919, 5754.856128596735, 5758.510526605201, 5782.45066718661, 5807.883842323215, 5812.79655212074, 5338.3593968724, 5658.49073583363, 5688.203651488712, 5697.230873832145, 5710.314762228559, 5573.414791446839, 5613.915791263053, 5614.157876318422, 5622.775088996558, 5644.278495059047, 5822.184894114912, 5844.707764611838, 5858.150568167506, 5902.612885971879, 5915.2310199675485, 3667.138222517653, 3783.848646054127, 3907.27715372657, 3973.8013099345494, 3986.800659967048, 5596.188552659923, 5602.0, 5615.775368985195, 5620.4098569649595, 5622.678670512508, 5476.178573213891, 5498.725063746877, 5503.367112782082, 5506.834794956158, 5519.503244707996, 5222.921656175236, 5412.025835349517, 5430.5384042356845, 5459.754311056092, 5501.807436739695, 5346.625736198429, 5366.195070739421, 5377.919331209957, 5387.622866399314, 5423.647462914898, 5430.926804896328, 5492.945070549244, 5533.446655334435, 5559.416261292506, 5587.55299576041, 5330.493603107699, 5409.0, 5453.182022696627, 5457.645253058538, 5463.262459567907], "value": 4159.821432793815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2609123465977, 720.5748608321089, 762.4853224073748, 814.1085511365055, 844.430009743423, 15601.765973510392, 16106.51680449587, 16486.175691215452, 16537.255823487943, 16567.585810354747, 13686.52097176599, 13687.384067716952, 13698.726025479484, 13756.58730238092, 13894.930525347385, 660.7324033766308, 779.4777499075605, 796.168004435365, 796.3072127249301, 803.9718609848657, 783.306773505449, 785.3363907498155, 785.4972817396871, 788.5268838696793, 790.4229912164124, 842.9494230346169, 843.2073850580465, 843.8607629741085, 843.877637742527, 846.6697987784769, 697.4106879686682, 803.8593246181924, 834.7203686764941, 841.7390608911257, 844.4426678392293, 604.4499505450063, 606.1544145916466, 608.8021393047277, 610.206731249374, 613.2824595223599, 15121.0, 15168.696626067416, 15174.620634484116, 15175.317110730044, 15201.543953681406, 15276.541703748906, 15487.303071361815, 15548.533543993699, 15628.4530041448, 15802.209889505479, 12370.0, 12466.875331246662, 12483.126181167321, 12510.37448127599, 12609.684757881034, 3841.5390153181515, 3935.4293627423863, 3949.763014219156, 3996.020974861178, 4084.6936479764136, 77890.0, 78430.60784696096, 78583.0, 79205.60397198035, 79574.21490247814, 12064.276143431422, 12201.816972745415, 12244.877551224552, 12269.38653067361, 12347.4737015039, 21414.25050123238, 22098.889505552368, 23880.164194253117, 23893.163739269043, 23925.880370598035, 8897.955510222408, 8962.82074358509, 9115.179633832855, 9117.36178467501, 9386.296027797942, 4248.4052232687445, 4377.058932329564, 4573.862784116482, 4851.442084160367, 5002.224655178453, 3667.449882517644, 3706.6478684524927, 3770.1328694399895, 3781.8865434037025, 3789.3368660484307, 640.8333833203401, 648.1994736500418, 649.2533586375612, 650.1418128070995, 672.4183581202225, 698.1691786773723, 729.3253740290211, 762.3024932186987, 770.1912991359051, 777.2577188784697, 9271.351005429555, 9941.950290248502, 10024.899751002542, 10061.4205940811, 10192.0, 650.9967450162814, 749.1646813802571, 754.4115589839934, 756.428896183378, 799.1169757418086, 4632.953670463319, 4837.806487740521, 4879.926801097987, 4924.212126059813, 4985.925211121836, 65619.0, 111685.0, 115798.0, 117193.0, 117963.41018295025, 98620.0, 99521.50239248903, 99766.0, 100713.49643251883, 102355.0, 86797.56601216954, 90460.5476972624, 90679.54660226656, 90698.0, 90991.63512547317, 9323.580438880132, 9324.627014919328, 9382.67160649374, 9602.66390676323, 10016.801025012008, 51652.0, 52845.471545284054, 53171.46828531665, 53845.0, 54251.21859767529, 71525.0, 73343.26656733578, 74269.51460970858, 75028.0, 75528.0, 13148.802767958297, 13162.670933226746, 13454.394552244976, 13528.39122239482, 14179.574612761633, 14543.92728036353, 15531.767023494882, 15780.210989450712, 15808.446704365291, 16004.759928600848, 14544.927275363978, 14625.85374146245, 15057.849421505645, 15098.39606415731, 15160.545183644508, 14533.0, 14777.852221477648, 14784.260786960824, 14964.133206735009, 15643.608909777347, 13680.794788077988, 13704.314784260549, 13841.79237311421, 14058.39626248044, 14235.0, 11975.880241197476, 12086.697832553904, 12213.08183211102, 12376.75246495083, 12458.813117803058, 11596.304221746723, 12144.878551214375, 12214.833861349798, 12399.690007749878, 12447.564335248222], "value": 7753.421255712228, "unit": "score"}], "name": "dromaeo_css", "value": 7177.070888291718, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 111.0, 110.0, 112.0, 111.0, 110.0, 110.0, 113.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 126.0, 182.0, 131.0, 126.0, 149.0, 125.0, 172.0, 126.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 160.0, 164.0, 160.0, 161.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 125.0, 76.0, 75.0, 74.0, 75.0, 99.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 113.0, 86.0, 86.0, 86.0, 124.0, 84.0, 85.0, 130.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.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": [53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 83.0, 82.0, 84.0, 82.0, 79.0, 82.0, 111.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 132.0, 129.0, 119.0, 129.0, 124.0, 121.0, 129.0, 133.0, 127.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 161.0, 163.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 62.0, 67.0, 65.0, 63.0, 63.0, 62.0, 60.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1500.8, "alertThreshold": 2.0}]} 08:31:08 INFO - Return code: 0 08:31:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:08 INFO - # TBPL SUCCESS # 08:31:08 INFO - Running post-action listener: _resource_record_post_action 08:31:08 INFO - ##### 08:31:08 INFO - ##### Finished run-tests step (success) 08:31:08 INFO - ##### 08:31:08 INFO - Running post-run listener: _resource_record_post_run 08:31:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557613056; Read time: 12; Write time: 617264 08:31:09 INFO - TinderboxPrint: CPU usage
13.2% 08:31:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:31:09 INFO - TinderboxPrint: I/O write bytes / time
557,613,056 / 617,264 08:31:09 INFO - TinderboxPrint: CPU idle
8,269.3 (86.8%) 08:31:09 INFO - TinderboxPrint: CPU user
1,209.5 (12.7%) 08:31:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:09 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 264761344; Read time: 0; Write time: 403428 08:31:09 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292851712; Read time: 12; Write time: 213836 08:31:09 INFO - Running post-run listener: _upload_blobber_files 08:31:09 INFO - Blob upload gear active. 08:31:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:09 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 08:31:09 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:31:09 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:31:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:31:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:10 INFO - (blobuploader) - INFO - Done attempting. 08:31:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:15 INFO - (blobuploader) - INFO - Done attempting. 08:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:15 INFO - (blobuploader) - INFO - Done attempting. 08:31:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:15 INFO - Return code: 0 08:31:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e71a48923636c17ff5aebae7826582864b71352f28f35c699a7aa942075054317f5f5ad26741ff842c876f9370eece8a0a653780a65e4fe9fb938c8bbd8cd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bdd6e04ced4ce47b18c07ef67079212f2a737191bd2f3b256c52fec2779a8b90ae0e7fa99ca4df35340dcf755c04d607cfa30f8410cff4194c8a04d9f6241c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6635081d9cf3760d0798b7cb50e16174be26681ae25c7d6176e8f81dfe4494b6c35cb72ae831877d7f0fd5c35ea48e7c4794c70c2c367e016baff00f0747f128"} 08:31:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:15 INFO - Contents: 08:31:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e71a48923636c17ff5aebae7826582864b71352f28f35c699a7aa942075054317f5f5ad26741ff842c876f9370eece8a0a653780a65e4fe9fb938c8bbd8cd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bdd6e04ced4ce47b18c07ef67079212f2a737191bd2f3b256c52fec2779a8b90ae0e7fa99ca4df35340dcf755c04d607cfa30f8410cff4194c8a04d9f6241c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6635081d9cf3760d0798b7cb50e16174be26681ae25c7d6176e8f81dfe4494b6c35cb72ae831877d7f0fd5c35ea48e7c4794c70c2c367e016baff00f0747f128"} 08:31:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:15 INFO - Copying logs to upload dir... 08:31:15 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.784272 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-16 08:31:15.421800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 08:31:15.425784) ========= 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=cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21e71a48923636c17ff5aebae7826582864b71352f28f35c699a7aa942075054317f5f5ad26741ff842c876f9370eece8a0a653780a65e4fe9fb938c8bbd8cd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bdd6e04ced4ce47b18c07ef67079212f2a737191bd2f3b256c52fec2779a8b90ae0e7fa99ca4df35340dcf755c04d607cfa30f8410cff4194c8a04d9f6241c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6635081d9cf3760d0798b7cb50e16174be26681ae25c7d6176e8f81dfe4494b6c35cb72ae831877d7f0fd5c35ea48e7c4794c70c2c367e016baff00f0747f128"} build_url:https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/T3zVxg9HQPSHZF9JOxbIZg/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/Fx-Team/sha512/21e71a48923636c17ff5aebae7826582864b71352f28f35c699a7aa942075054317f5f5ad26741ff842c876f9370eece8a0a653780a65e4fe9fb938c8bbd8cd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bdd6e04ced4ce47b18c07ef67079212f2a737191bd2f3b256c52fec2779a8b90ae0e7fa99ca4df35340dcf755c04d607cfa30f8410cff4194c8a04d9f6241c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6635081d9cf3760d0798b7cb50e16174be26681ae25c7d6176e8f81dfe4494b6c35cb72ae831877d7f0fd5c35ea48e7c4794c70c2c367e016baff00f0747f128"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 08:31:15.452524) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 08:31:15.453022) ========= 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=cbe409c6de289db6ac707de3000001d4-1466088083.413894-1226583756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 08:31:15.536842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 08:31:15.537277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 08:31:15.537637) ========= ========= Total master_lag: 0.18 =========