builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1465906220.57 results: success (0) buildid: 20160614043925 builduid: e7cc7e20383f4bf78e138685a792ee67 revision: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.567228) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.567763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.568042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.588089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.588581) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 05:10:20-- 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% 40.1M=0s 2016-06-14 05:10:20 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101110 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.969121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:20.969431) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016050 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:21.007845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 05:10:21.008188) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4eb7afe97b2b470c9276a8af9c23910cdbd02563 --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 4eb7afe97b2b470c9276a8af9c23910cdbd02563 --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=9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 05:10:21,268 truncating revision to first 12 chars 2016-06-14 05:10:21,268 Setting DEBUG logging. 2016-06-14 05:10:21,268 attempt 1/10 2016-06-14 05:10:21,268 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4eb7afe97b2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 05:10:22,616 unpacking tar archive at: fx-team-4eb7afe97b2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.680546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 05:10:22.702389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:22.702804) ========= script_repo_revision: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:22.703329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:22.703619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:10:22.714108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-14 05:10:22.714529) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:23 INFO - MultiFileLogger online at 20160614 05:10:23 in /builds/slave/test 05:10:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:10:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:23 INFO - {'append_to_log': False, 05:10:23 INFO - 'base_work_dir': '/builds/slave/test', 05:10:23 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:10:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:23 INFO - 'branch': 'Fx-Team-Non-PGO', 05:10:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:23 INFO - 'config_files': ('talos/linux_config.py',), 05:10:23 INFO - 'default_actions': ('clobber', 05:10:23 INFO - 'read-buildbot-config', 05:10:23 INFO - 'download-and-extract', 05:10:23 INFO - 'populate-webroot', 05:10:23 INFO - 'create-virtualenv', 05:10:23 INFO - 'install', 05:10:23 INFO - 'run-tests'), 05:10:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:23 INFO - 'download_minidump_stackwalk': True, 05:10:23 INFO - 'download_symbols': 'ondemand', 05:10:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:23 INFO - 'installer_path': 'installer.exe', 05:10:23 INFO - 'log_level': 'info', 05:10:23 INFO - 'log_name': 'talos', 05:10:23 INFO - 'log_to_console': True, 05:10:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:23 INFO - 'opt_config_files': (), 05:10:23 INFO - 'pip_index': False, 05:10:23 INFO - 'sps_profile': False, 05:10:23 INFO - 'sps_profile_interval': 0, 05:10:23 INFO - 'suite': 'dromaeojs', 05:10:23 INFO - 'system_bits': '32', 05:10:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:23 INFO - 'title': 'talos-linux64-ix-040', 05:10:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:23 INFO - 'use_talos_json': True, 05:10:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:23 INFO - 'work_dir': 'build'} 05:10:23 INFO - ##### 05:10:23 INFO - ##### Running clobber step. 05:10:23 INFO - ##### 05:10:23 INFO - Running pre-action listener: _resource_record_pre_action 05:10:23 INFO - Running main action method: clobber 05:10:23 INFO - rmtree: /builds/slave/test/build 05:10:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:23 INFO - Running post-action listener: _resource_record_post_action 05:10:23 INFO - ##### 05:10:23 INFO - ##### Finished clobber step (success) 05:10:23 INFO - ##### 05:10:23 INFO - ##### 05:10:23 INFO - ##### Running read-buildbot-config step. 05:10:23 INFO - ##### 05:10:23 INFO - Running pre-action listener: _resource_record_pre_action 05:10:23 INFO - Running main action method: read_buildbot_config 05:10:23 INFO - Using buildbot properties: 05:10:23 INFO - { 05:10:23 INFO - "project": "", 05:10:23 INFO - "product": "firefox", 05:10:23 INFO - "script_repo_revision": "production", 05:10:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:10:23 INFO - "repository": "", 05:10:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:10:23 INFO - "buildid": "20160614043925", 05:10:23 INFO - "pgo_build": "False", 05:10:23 INFO - "basedir": "/builds/slave/test", 05:10:23 INFO - "buildnumber": 1857, 05:10:23 INFO - "slavename": "talos-linux64-ix-040", 05:10:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:10:23 INFO - "platform": "ubuntu64_hw", 05:10:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:10:23 INFO - "branch": "fx-team", 05:10:23 INFO - "repo_path": "integration/fx-team", 05:10:23 INFO - "revision": "4eb7afe97b2b470c9276a8af9c23910cdbd02563", 05:10:23 INFO - "stage_platform": "linux64", 05:10:23 INFO - "builduid": "e7cc7e20383f4bf78e138685a792ee67", 05:10:23 INFO - "slavebuilddir": "test" 05:10:23 INFO - } 05:10:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:10:23 INFO - Running post-action listener: _resource_record_post_action 05:10:23 INFO - ##### 05:10:23 INFO - ##### Finished read-buildbot-config step (success) 05:10:23 INFO - ##### 05:10:23 INFO - ##### 05:10:23 INFO - ##### Running download-and-extract step. 05:10:23 INFO - ##### 05:10:23 INFO - Running pre-action listener: _resource_record_pre_action 05:10:23 INFO - Running main action method: download_and_extract 05:10:23 INFO - mkdir: /builds/slave/test/build/tests 05:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:23 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:24 INFO - Downloaded 1361 bytes. 05:10:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:24 INFO - Using the following test package requirements: 05:10:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'jsshell-linux-x86_64.zip'], 05:10:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:24 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')]} 05:10:24 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:26 INFO - Downloaded 22653673 bytes. 05:10:26 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'] 05:10:26 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 05:10:27 INFO - Return code: 0 05:10:27 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 05:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:27 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:28 INFO - Downloaded 22653673 bytes. 05:10:28 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'] 05:10:28 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 05:10:30 INFO - Return code: 0 05:10:30 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')]} 05:10:30 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:31 INFO - Downloaded 14405384 bytes. 05:10:31 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'] 05:10:31 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 05:10:31 INFO - Return code: 0 05:10: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')]} 05:10:31 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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 05:10:33 INFO - Downloaded 55399292 bytes. 05:10:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:33 INFO - mkdir: /builds/slave/test/properties 05:10:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:33 INFO - Contents: 05:10:33 INFO - build_url:https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:33 INFO - Running post-action listener: _resource_record_post_action 05:10:33 INFO - Running post-action listener: set_extra_try_arguments 05:10:33 INFO - ##### 05:10:33 INFO - ##### Finished download-and-extract step (success) 05:10:33 INFO - ##### 05:10:33 INFO - ##### 05:10:33 INFO - ##### Running populate-webroot step. 05:10:33 INFO - ##### 05:10:33 INFO - Running pre-action listener: _resource_record_pre_action 05:10:33 INFO - Running main action method: populate_webroot 05:10:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:34 INFO - '--tppagecycles', 05:10:34 INFO - '7'], 05:10:34 INFO - 'tests': ['tsvgm']}}, 05:10:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['damp', 'tps']}, 05:10:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'tests': ['damp', 'tps']}, 05:10:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['dromaeo_dom']}, 05:10:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['basic_compositor_video']}, 05:10:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:10:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['a11yr', 05:10:34 INFO - 'ts_paint', 05:10:34 INFO - 'tpaint', 05:10:34 INFO - 'sessionrestore', 05:10:34 INFO - 'sessionrestore_no_auto_restore', 05:10:34 INFO - 'tabpaint']}, 05:10:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:34 INFO - 'ts_paint', 05:10:34 INFO - 'tpaint', 05:10:34 INFO - 'sessionrestore', 05:10:34 INFO - 'sessionrestore_no_auto_restore', 05:10:34 INFO - 'tabpaint']}, 05:10:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:34 INFO - 'ts_paint', 05:10:34 INFO - 'tpaint', 05:10:34 INFO - 'sessionrestore', 05:10:34 INFO - 'sessionrestore_no_auto_restore', 05:10:34 INFO - 'tabpaint']}, 05:10:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:34 INFO - 'ts_paint', 05:10:34 INFO - 'tpaint', 05:10:34 INFO - 'sessionrestore', 05:10:34 INFO - 'sessionrestore_no_auto_restore', 05:10:34 INFO - 'tabpaint']}, 05:10:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['a11yr', 05:10:34 INFO - 'ts_paint', 05:10:34 INFO - 'tpaint', 05:10:34 INFO - 'sessionrestore', 05:10:34 INFO - 'sessionrestore_no_auto_restore', 05:10:34 INFO - 'tabpaint']}, 05:10:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['a11yr', 05:10:34 INFO - 'ts_paint', 05:10:34 INFO - 'tpaint', 05:10:34 INFO - 'sessionrestore', 05:10:34 INFO - 'sessionrestore_no_auto_restore', 05:10:34 INFO - 'tabpaint']}, 05:10:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['tsvgx', 05:10:34 INFO - 'tsvgr_opacity', 05:10:34 INFO - 'tart', 05:10:34 INFO - 'tscrollx', 05:10:34 INFO - 'cart']}, 05:10:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:34 INFO - 'tsvgr_opacity', 05:10:34 INFO - 'tart', 05:10:34 INFO - 'tscrollx', 05:10:34 INFO - 'cart']}, 05:10:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'talos_options': ['--disable-e10s'], 05:10:34 INFO - 'tests': ['tp5o']}, 05:10:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'tests': ['tp5o']}, 05:10:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'talos_options': ['--disable-e10s', 05:10:34 INFO - '--xperf_path', 05:10:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:34 INFO - 'tests': ['tp5n']}, 05:10:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:34 INFO - 'talos_options': ['--xperf_path', 05:10:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:34 INFO - 'tests': ['tp5n']}}, 05:10:34 INFO - 'talos.zip': {'path': '', 05:10:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:34 INFO - Running post-action listener: _resource_record_post_action 05:10:34 INFO - ##### 05:10:34 INFO - ##### Finished populate-webroot step (success) 05:10:34 INFO - ##### 05:10:34 INFO - ##### 05:10:34 INFO - ##### Running create-virtualenv step. 05:10:34 INFO - ##### 05:10:34 INFO - Running pre-action listener: _resource_record_pre_action 05:10:34 INFO - Running main action method: create_virtualenv 05:10:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:34 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 05:10:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:34 INFO - Using real prefix '/usr' 05:10:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:36 INFO - Installing pip.................done. 05:10:36 INFO - Return code: 0 05:10:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:36 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:36 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 05:10:36 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 05:10:36 INFO - Using env: {'DISPLAY': ':0', 05:10:36 INFO - 'HOME': '/home/cltbld', 05:10:36 INFO - 'LANG': 'en_US.UTF-8', 05:10:36 INFO - 'LANGUAGE': 'en_US:en', 05:10:36 INFO - 'LOGNAME': 'cltbld', 05:10:36 INFO - 'MAIL': '/var/mail/cltbld', 05:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:36 INFO - 'MOZ_NO_REMOTE': '1', 05:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:36 INFO - 'NO_EM_RESTART': '1', 05:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:36 INFO - 'PWD': '/builds/slave/test', 05:10:36 INFO - 'SHELL': '/bin/bash', 05:10:36 INFO - 'SHLVL': '1', 05:10:36 INFO - 'TERM': 'linux', 05:10:36 INFO - 'TMOUT': '86400', 05:10:36 INFO - 'USER': 'cltbld', 05:10:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:36 INFO - '_': '/tools/buildbot/bin/python'} 05:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:36 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 05:10:36 INFO - Cleaning up... 05:10:36 INFO - Return code: 0 05:10:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:36 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:36 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 05:10:36 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 05:10:36 INFO - Using env: {'DISPLAY': ':0', 05:10:36 INFO - 'HOME': '/home/cltbld', 05:10:36 INFO - 'LANG': 'en_US.UTF-8', 05:10:36 INFO - 'LANGUAGE': 'en_US:en', 05:10:36 INFO - 'LOGNAME': 'cltbld', 05:10:36 INFO - 'MAIL': '/var/mail/cltbld', 05:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:36 INFO - 'MOZ_NO_REMOTE': '1', 05:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:36 INFO - 'NO_EM_RESTART': '1', 05:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:36 INFO - 'PWD': '/builds/slave/test', 05:10:36 INFO - 'SHELL': '/bin/bash', 05:10:36 INFO - 'SHLVL': '1', 05:10:36 INFO - 'TERM': 'linux', 05:10:36 INFO - 'TMOUT': '86400', 05:10:36 INFO - 'USER': 'cltbld', 05:10:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:36 INFO - '_': '/tools/buildbot/bin/python'} 05:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:37 INFO - Downloading/unpacking psutil>=3.1.1 05:10:37 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 05:10:37 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 05:10:37 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 05:10:37 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 05:10:37 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 05:10:37 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 05:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:39 INFO - Installing collected packages: psutil 05:10:39 INFO - Running setup.py install for psutil 05:10:39 INFO - building 'psutil._psutil_linux' extension 05:10:39 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 05:10:39 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 05:10:39 INFO - building 'psutil._psutil_posix' extension 05:10:39 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 05:10:39 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 05:10:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:39 INFO - Successfully installed psutil 05:10:39 INFO - Cleaning up... 05:10:39 INFO - Return code: 0 05:10:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:10:39 INFO - Using env: {'DISPLAY': ':0', 05:10:39 INFO - 'HOME': '/home/cltbld', 05:10:39 INFO - 'LANG': 'en_US.UTF-8', 05:10:39 INFO - 'LANGUAGE': 'en_US:en', 05:10:39 INFO - 'LOGNAME': 'cltbld', 05:10:39 INFO - 'MAIL': '/var/mail/cltbld', 05:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:39 INFO - 'MOZ_NO_REMOTE': '1', 05:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:39 INFO - 'NO_EM_RESTART': '1', 05:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:39 INFO - 'PWD': '/builds/slave/test', 05:10:39 INFO - 'SHELL': '/bin/bash', 05:10:39 INFO - 'SHLVL': '1', 05:10:39 INFO - 'TERM': 'linux', 05:10:39 INFO - 'TMOUT': '86400', 05:10:39 INFO - 'USER': 'cltbld', 05:10:39 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:39 INFO - '_': '/tools/buildbot/bin/python'} 05:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:41 INFO - Installing collected packages: mozsystemmonitor 05:10:41 INFO - Running setup.py install for mozsystemmonitor 05:10:41 INFO - Successfully installed mozsystemmonitor 05:10:41 INFO - Cleaning up... 05:10:41 INFO - Return code: 0 05:10:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:41 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:41 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 05:10:41 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 05:10:41 INFO - Using env: {'DISPLAY': ':0', 05:10:41 INFO - 'HOME': '/home/cltbld', 05:10:41 INFO - 'LANG': 'en_US.UTF-8', 05:10:41 INFO - 'LANGUAGE': 'en_US:en', 05:10:41 INFO - 'LOGNAME': 'cltbld', 05:10:41 INFO - 'MAIL': '/var/mail/cltbld', 05:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:41 INFO - 'MOZ_NO_REMOTE': '1', 05:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:41 INFO - 'NO_EM_RESTART': '1', 05:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:41 INFO - 'PWD': '/builds/slave/test', 05:10:41 INFO - 'SHELL': '/bin/bash', 05:10:41 INFO - 'SHLVL': '1', 05:10:41 INFO - 'TERM': 'linux', 05:10:41 INFO - 'TMOUT': '86400', 05:10:41 INFO - 'USER': 'cltbld', 05:10:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:41 INFO - '_': '/tools/buildbot/bin/python'} 05:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:42 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:43 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 05:10:43 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 05:10:43 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 05:10:43 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 05:10:43 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 05:10:43 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 05:10:44 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:44 INFO - warning: no files found matching '*.txt' 05:10:44 INFO - no previously-included directories found matching 'build' 05:10:44 INFO - no previously-included directories found matching 'dist' 05:10:44 INFO - no previously-included directories found matching '.git*' 05:10:44 INFO - Installing collected packages: jsonschema, functools32 05:10:44 INFO - Running setup.py install for functools32 05:10:44 INFO - warning: no files found matching '*.txt' 05:10:44 INFO - no previously-included directories found matching 'build' 05:10:44 INFO - no previously-included directories found matching 'dist' 05:10:44 INFO - no previously-included directories found matching '.git*' 05:10:44 INFO - Successfully installed jsonschema functools32 05:10:44 INFO - Cleaning up... 05:10:44 INFO - Return code: 0 05:10:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:44 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 05:10:44 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 05:10:44 INFO - Using env: {'DISPLAY': ':0', 05:10:44 INFO - 'HOME': '/home/cltbld', 05:10:44 INFO - 'LANG': 'en_US.UTF-8', 05:10:44 INFO - 'LANGUAGE': 'en_US:en', 05:10:44 INFO - 'LOGNAME': 'cltbld', 05:10:44 INFO - 'MAIL': '/var/mail/cltbld', 05:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:44 INFO - 'MOZ_NO_REMOTE': '1', 05:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:44 INFO - 'NO_EM_RESTART': '1', 05:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:44 INFO - 'PWD': '/builds/slave/test', 05:10:44 INFO - 'SHELL': '/bin/bash', 05:10:44 INFO - 'SHLVL': '1', 05:10:44 INFO - 'TERM': 'linux', 05:10:44 INFO - 'TMOUT': '86400', 05:10:44 INFO - 'USER': 'cltbld', 05:10:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:44 INFO - '_': '/tools/buildbot/bin/python'} 05:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:44 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 05:10:44 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 05:10:44 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 05:10:44 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 05:10:44 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 05:10:44 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 05:10:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:46 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 05:10:47 INFO - Downloading docopt-0.6.1.tar.gz 05:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:47 INFO - Running setup.py install for blobuploader 05:10:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:47 INFO - Running setup.py install for requests 05:10:47 INFO - Running setup.py install for docopt 05:10:47 INFO - Successfully installed blobuploader requests docopt 05:10:47 INFO - Cleaning up... 05:10:47 INFO - Return code: 0 05:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05: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')]} 05:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:47 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:47 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 05:10:47 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 05:10:47 INFO - Using env: {'DISPLAY': ':0', 05:10:47 INFO - 'HOME': '/home/cltbld', 05:10:47 INFO - 'LANG': 'en_US.UTF-8', 05:10:47 INFO - 'LANGUAGE': 'en_US:en', 05:10:47 INFO - 'LOGNAME': 'cltbld', 05:10:47 INFO - 'MAIL': '/var/mail/cltbld', 05:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:47 INFO - 'MOZ_NO_REMOTE': '1', 05:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:47 INFO - 'NO_EM_RESTART': '1', 05:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:47 INFO - 'PWD': '/builds/slave/test', 05:10:47 INFO - 'SHELL': '/bin/bash', 05:10:47 INFO - 'SHLVL': '1', 05:10:47 INFO - 'TERM': 'linux', 05:10:47 INFO - 'TMOUT': '86400', 05:10:47 INFO - 'USER': 'cltbld', 05:10:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:47 INFO - '_': '/tools/buildbot/bin/python'} 05:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:48 INFO - Running setup.py (path:/tmp/pip-HsaWsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:48 INFO - Running setup.py (path:/tmp/pip-vvsPzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:48 INFO - Running setup.py (path:/tmp/pip-4_Q7KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:48 INFO - Running setup.py (path:/tmp/pip-wO39rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:48 INFO - Running setup.py (path:/tmp/pip-I1rCRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:48 INFO - Running setup.py (path:/tmp/pip-_NdHN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:48 INFO - Running setup.py (path:/tmp/pip-LJGg9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:48 INFO - Running setup.py (path:/tmp/pip-Gl2mM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:48 INFO - Running setup.py (path:/tmp/pip-8aX2uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:48 INFO - Running setup.py (path:/tmp/pip-aG1CcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:48 INFO - Running setup.py (path:/tmp/pip-XOVpps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:48 INFO - Running setup.py (path:/tmp/pip-xRvK7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:48 INFO - Running setup.py (path:/tmp/pip-sqJYPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:48 INFO - Running setup.py (path:/tmp/pip-E6henf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:49 INFO - Running setup.py (path:/tmp/pip-mSSdgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:49 INFO - Running setup.py (path:/tmp/pip-ybFZIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:49 INFO - Running setup.py (path:/tmp/pip-FntbEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:49 INFO - Running setup.py install for manifestparser 05:10:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozcrash 05:10:49 INFO - Running setup.py install for mozdebug 05:10:49 INFO - Running setup.py install for mozdevice 05:10:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozfile 05:10:49 INFO - Running setup.py install for mozhttpd 05:10:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozinfo 05:10:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:49 INFO - Running setup.py install for mozInstall 05:10:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozleak 05:10:50 INFO - Running setup.py install for mozlog 05:10:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for moznetwork 05:10:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozprocess 05:10:50 INFO - Running setup.py install for mozprofile 05:10:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozrunner 05:10:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:50 INFO - Running setup.py install for mozscreenshot 05:10:50 INFO - Running setup.py install for moztest 05:10:50 INFO - Running setup.py install for mozversion 05:10:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:51 INFO - Cleaning up... 05:10:51 INFO - Return code: 0 05:10:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:51 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')]} 05:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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')]} 05:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:51 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:51 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 05:10:51 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 05:10:51 INFO - Using env: {'DISPLAY': ':0', 05:10:51 INFO - 'HOME': '/home/cltbld', 05:10:51 INFO - 'LANG': 'en_US.UTF-8', 05:10:51 INFO - 'LANGUAGE': 'en_US:en', 05:10:51 INFO - 'LOGNAME': 'cltbld', 05:10:51 INFO - 'MAIL': '/var/mail/cltbld', 05:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:51 INFO - 'MOZ_NO_REMOTE': '1', 05:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:51 INFO - 'NO_EM_RESTART': '1', 05:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:51 INFO - 'PWD': '/builds/slave/test', 05:10:51 INFO - 'SHELL': '/bin/bash', 05:10:51 INFO - 'SHLVL': '1', 05:10:51 INFO - 'TERM': 'linux', 05:10:51 INFO - 'TMOUT': '86400', 05:10:51 INFO - 'USER': 'cltbld', 05:10:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:51 INFO - '_': '/tools/buildbot/bin/python'} 05:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:51 INFO - Running setup.py (path:/tmp/pip-Nn9bBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:51 INFO - Running setup.py (path:/tmp/pip-hdvuju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:51 INFO - Running setup.py (path:/tmp/pip-357Mj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:51 INFO - Running setup.py (path:/tmp/pip-8e7YeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:51 INFO - Running setup.py (path:/tmp/pip-MnYVgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:51 INFO - Running setup.py (path:/tmp/pip-cbFQfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:51 INFO - Running setup.py (path:/tmp/pip-KFmYHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:51 INFO - Running setup.py (path:/tmp/pip-Lmwgos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:51 INFO - Running setup.py (path:/tmp/pip-9OPzik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:51 INFO - Running setup.py (path:/tmp/pip-a3q4Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:51 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)) 05:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:51 INFO - Running setup.py (path:/tmp/pip-pjn6oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:52 INFO - Running setup.py (path:/tmp/pip-6T0uyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:52 INFO - Running setup.py (path:/tmp/pip-brzYMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:52 INFO - Running setup.py (path:/tmp/pip-eD6kFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:52 INFO - Running setup.py (path:/tmp/pip-bwFLXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:52 INFO - Running setup.py (path:/tmp/pip-bPcGjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:52 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)) 05:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:52 INFO - Running setup.py (path:/tmp/pip-isLa9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 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)) 05:10:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05: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 05: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 05: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 05: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 05: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 05: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 05:10:54 INFO - Downloading blessings-1.6.tar.gz 05:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:54 INFO - Installing collected packages: blessings 05:10:54 INFO - Running setup.py install for blessings 05:10:54 INFO - Successfully installed blessings 05:10:54 INFO - Cleaning up... 05:10:54 INFO - Return code: 0 05:10:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:54 INFO - Reading from file tmpfile_stdout 05:10:54 INFO - Current package versions: 05:10:54 INFO - argparse == 1.2.1 05:10:54 INFO - blessings == 1.6 05:10:54 INFO - blobuploader == 1.2.4 05:10:54 INFO - docopt == 0.6.1 05:10:54 INFO - functools32 == 3.2.3-2 05:10:54 INFO - jsonschema == 2.5.1 05:10:54 INFO - manifestparser == 1.1 05:10:54 INFO - mozInstall == 1.12 05:10:54 INFO - mozcrash == 0.17 05:10:54 INFO - mozdebug == 0.1 05:10:54 INFO - mozdevice == 0.48 05:10:54 INFO - mozfile == 1.2 05:10:54 INFO - mozhttpd == 0.7 05:10:54 INFO - mozinfo == 0.9 05:10:54 INFO - mozleak == 0.1 05:10:54 INFO - mozlog == 3.2 05:10:54 INFO - moznetwork == 0.27 05:10:54 INFO - mozprocess == 0.22 05:10:54 INFO - mozprofile == 0.28 05:10:54 INFO - mozrunner == 6.11 05:10:54 INFO - mozscreenshot == 0.1 05:10:54 INFO - mozsystemmonitor == 0.3 05:10:54 INFO - moztest == 0.7 05:10:54 INFO - mozversion == 1.4 05:10:54 INFO - psutil == 3.1.1 05:10:54 INFO - requests == 1.2.3 05:10:54 INFO - wsgiref == 0.1.2 05:10:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:54 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')]} 05:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 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')]} 05:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:54 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 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05:10:54 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 05:10:54 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 05:10:54 INFO - Using env: {'DISPLAY': ':0', 05:10:54 INFO - 'HOME': '/home/cltbld', 05:10:54 INFO - 'LANG': 'en_US.UTF-8', 05:10:54 INFO - 'LANGUAGE': 'en_US:en', 05:10:54 INFO - 'LOGNAME': 'cltbld', 05:10:54 INFO - 'MAIL': '/var/mail/cltbld', 05:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:54 INFO - 'MOZ_NO_REMOTE': '1', 05:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:54 INFO - 'NO_EM_RESTART': '1', 05:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:54 INFO - 'PWD': '/builds/slave/test', 05:10:54 INFO - 'SHELL': '/bin/bash', 05:10:54 INFO - 'SHLVL': '1', 05:10:54 INFO - 'TERM': 'linux', 05:10:54 INFO - 'TMOUT': '86400', 05:10:54 INFO - 'USER': 'cltbld', 05:10:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:54 INFO - '_': '/tools/buildbot/bin/python'} 05:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 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)) 05:10:55 INFO - Cleaning up... 05:10:55 INFO - Return code: 0 05:10:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05: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')]} 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05: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', 'jsonschema'] in /builds/slave/test/build 05: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 jsonschema 05:10:55 INFO - Using env: {'DISPLAY': ':0', 05:10:55 INFO - 'HOME': '/home/cltbld', 05:10:55 INFO - 'LANG': 'en_US.UTF-8', 05:10:55 INFO - 'LANGUAGE': 'en_US:en', 05:10:55 INFO - 'LOGNAME': 'cltbld', 05:10:55 INFO - 'MAIL': '/var/mail/cltbld', 05:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:55 INFO - 'MOZ_NO_REMOTE': '1', 05:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:55 INFO - 'NO_EM_RESTART': '1', 05:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:55 INFO - 'PWD': '/builds/slave/test', 05:10:55 INFO - 'SHELL': '/bin/bash', 05:10:55 INFO - 'SHLVL': '1', 05:10:55 INFO - 'TERM': 'linux', 05:10:55 INFO - 'TMOUT': '86400', 05:10:55 INFO - 'USER': 'cltbld', 05:10:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:55 INFO - '_': '/tools/buildbot/bin/python'} 05:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:55 INFO - Cleaning up... 05:10:55 INFO - Return code: 0 05:10:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05: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')]} 05:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91d79b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', '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 05: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', 'flake8'] in /builds/slave/test/build 05: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 flake8 05:10:55 INFO - Using env: {'DISPLAY': ':0', 05:10:55 INFO - 'HOME': '/home/cltbld', 05:10:55 INFO - 'LANG': 'en_US.UTF-8', 05:10:55 INFO - 'LANGUAGE': 'en_US:en', 05:10:55 INFO - 'LOGNAME': 'cltbld', 05:10:55 INFO - 'MAIL': '/var/mail/cltbld', 05:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:55 INFO - 'MOZ_NO_REMOTE': '1', 05:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:55 INFO - 'NO_EM_RESTART': '1', 05:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:55 INFO - 'PWD': '/builds/slave/test', 05:10:55 INFO - 'SHELL': '/bin/bash', 05:10:55 INFO - 'SHLVL': '1', 05:10:55 INFO - 'TERM': 'linux', 05:10:55 INFO - 'TMOUT': '86400', 05:10:55 INFO - 'USER': 'cltbld', 05:10:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:55 INFO - '_': '/tools/buildbot/bin/python'} 05:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:55 INFO - Downloading/unpacking flake8 05: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 05: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 05: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 05: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 05: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 05: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 05:10:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:10:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05: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 05: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 05: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 05: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 05: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 05: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 05:10:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:10:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05: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 05: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 05: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 05: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 05: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 05: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 05:10:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05: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 05: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 05: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 05: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 05: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 05: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 05:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:58 INFO - no previously-included directories found matching 'docs/_build' 05:10:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:58 INFO - Running setup.py install for pep8 05:10:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:58 INFO - no previously-included directories found matching 'docs/_build' 05:10:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:10:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:10:58 INFO - Cleaning up... 05:10:58 INFO - Return code: 0 05:10:58 INFO - Running post-action listener: _resource_record_post_action 05:10:58 INFO - Running post-action listener: _start_resource_monitoring 05:10:58 INFO - Starting resource monitoring. 05:10:58 INFO - ##### 05:10:58 INFO - ##### Finished create-virtualenv step (success) 05:10:58 INFO - ##### 05:10:58 INFO - ##### 05:10:58 INFO - ##### Running install step. 05:10:58 INFO - ##### 05:10:58 INFO - Running pre-action listener: _resource_record_pre_action 05:10:58 INFO - Running main action method: install 05:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:58 INFO - Reading from file tmpfile_stdout 05:10:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:58 INFO - Reading from file tmpfile_stdout 05:10:58 INFO - Output received: 05:10:58 INFO - Usage: mozinstall [options] installer 05:10:58 INFO - Options: 05:10:58 INFO - -h, --help show this help message and exit 05:10:58 INFO - -d DEST, --destination=DEST 05:10:58 INFO - Directory to install application into. [default: 05:10:58 INFO - "/builds/slave/test"] 05:10:58 INFO - --app=APP Application being installed. [default: firefox] 05:10:58 INFO - mkdir: /builds/slave/test/build/application 05:10:58 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'] 05:10:58 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 05:11:14 INFO - Reading from file tmpfile_stdout 05:11:14 INFO - Output received: 05:11:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:14 INFO - Running post-action listener: _resource_record_post_action 05:11:14 INFO - ##### 05:11:14 INFO - ##### Finished install step (success) 05:11:14 INFO - ##### 05:11:14 INFO - ##### 05:11:14 INFO - ##### Running run-tests step. 05:11:14 INFO - ##### 05:11:14 INFO - Running pre-action listener: _resource_record_pre_action 05:11:14 INFO - Running main action method: run_tests 05:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:14 INFO - Python 2.7.3 05:11:14 INFO - Return code: 0 05:11:14 INFO - grabbing minidump binary from tooltool 05:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:14 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 0x1b161c0>, '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 0x1b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b17550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:14 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 05:11:14 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 05:11:14 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 05:11:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:14 INFO - Return code: 0 05:11:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:15 INFO - Return code: 0 05:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 05:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 05:11:15 INFO - Using env: {'DISPLAY': ':0', 05:11:15 INFO - 'HOME': '/home/cltbld', 05:11:15 INFO - 'LANG': 'en_US.UTF-8', 05:11:15 INFO - 'LANGUAGE': 'en_US:en', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MAIL': '/var/mail/cltbld', 05:11:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SHLVL': '1', 05:11:15 INFO - 'TERM': 'linux', 05:11:15 INFO - 'TMOUT': '86400', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - '_': '/tools/buildbot/bin/python'} 05:11:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 05:11:15 INFO - mozversion application_buildid: 20160614043925 05:11:15 INFO - mozversion application_changeset: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 05:11:15 INFO - mozversion application_display_name: Nightly 05:11:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:15 INFO - mozversion application_name: Firefox 05:11:15 INFO - mozversion application_remotingname: firefox 05:11:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:15 INFO - mozversion application_vendor: Mozilla 05:11:15 INFO - mozversion application_version: 50.0a1 05:11:15 INFO - mozversion platform_buildid: 20160614043925 05:11:15 INFO - mozversion platform_changeset: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 05:11:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:15 INFO - mozversion platform_version: 50.0a1 05:11:15 INFO - using testdate: 1465906275 05:11:15 INFO - actual date: 1465906275 05:11:15 INFO - starting webserver on 'localhost:50126' 05:11:15 INFO - SUITE-START | Running 2 tests 05:11:15 INFO - TEST-START | dromaeo_css 05:11:15 INFO - operating with platform_type : linux_ 05:11:15 INFO - Initialising browser for dromaeo_css test... 05:11:15 INFO - TEST-INFO | started process 29262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRunM0i/profile http://localhost:50126/getInfo.html) 05:11:20 INFO - PROCESS | 29262 | __metrics Screen width/height:1600/1200 05:11:20 INFO - PROCESS | 29262 | colorDepth:24 05:11:20 INFO - PROCESS | 29262 | Browser inner width/height: 1024/697 05:11:20 INFO - PROCESS | 29262 | __metrics 05:11:21 INFO - PROCESS | 29262 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:21 INFO - PROCESS | 29262 | console.error: PushService: 05:11:21 INFO - PROCESS | 29262 | stateChangeProcessEnqueue: Error transitioning state 05:11:21 INFO - PROCESS | 29262 | UnknownError 05:11:22 INFO - TEST-INFO | 29262: exit 0 05:11:22 INFO - Browser initialized. 05:11:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:22 INFO - TEST-INFO | started process 29343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRunM0i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:34 INFO - PROCESS | 29343 | RSS: Main: 175886336 05:11:34 INFO - PROCESS | 29343 | 05:12:25 INFO - PROCESS | 29343 | 1465906345469 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] 05:14:37 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:50126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50126/tests/dromaeo/cssquery-ext.html) 05:14:39 INFO - PROCESS | 29343 | RSS: Main: 255832064 05:14:39 INFO - PROCESS | 29343 | 05:17:41 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:50126/tests/dromaeo/cssquery-ext.html (next: http://localhost:50126/tests/dromaeo/cssquery-jquery.html) 05:17:42 INFO - PROCESS | 29343 | RSS: Main: 258502656 05:17:42 INFO - PROCESS | 29343 | 05:20:44 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:50126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50126/tests/dromaeo/cssquery-mootools.html) 05:20:45 INFO - PROCESS | 29343 | RSS: Main: 256552960 05:20:45 INFO - PROCESS | 29343 | 05:23:47 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:50126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50126/tests/dromaeo/cssquery-prototype.html) 05:23:48 INFO - PROCESS | 29343 | RSS: Main: 252321792 05:23:48 INFO - PROCESS | 29343 | 05:26:50 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:50126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50126/tests/dromaeo/cssquery-yui.html) 05:26:51 INFO - PROCESS | 29343 | RSS: Main: 235515904 05:26:51 INFO - PROCESS | 29343 | 05:29:54 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:50126/tests/dromaeo/cssquery-yui.html (next: http://localhost:50126/tests/dromaeo/cssquery-dojo.html) 05:29:55 INFO - PROCESS | 29343 | RSS: Main: 292646912 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | __start_tp_report 05:29:55 INFO - PROCESS | 29343 | _x_x_mozilla_page_load 05:29:55 INFO - PROCESS | 29343 | _x_x_mozilla_page_load_details 05:29:55 INFO - PROCESS | 29343 | |i|pagename|runs| 05:29:55 INFO - PROCESS | 29343 | |0;dojo.html;2659.9335016624586;2664.293962100043;2683.8792254348564;2692.030868887201;2697.5818748094052;4620;4697.4832768395445;4783.784729687164;4838.685485443448;4907.2148456247005;4736.573708366246;4800.927986080212;4805.687630304028;4806.687565308262;4813.975930120353;4343.435353404053;4408.757518336491;4450.317702407981;4512.5261847506035;4566.1780879441685;4474.0380818124095;4514.097180563884;4533.478649955248;4544.363789069533;4559.749213793257;4309.504406993173;4348.043430445297;4353.84761533348;4386.254336762758;4419.867403977886;4402.3836662867225;4411.713238639478;4422.867313980586;4471.150481408555;4485.416895803557;4429.092036132585;4450.866474005785;4453.087117141011;4472.686911916135;4496.168208881368;4685.0395668887795;4687;4737.95262047382;4753.643476739258;4755.072760811643;5116.079105760961;5118.974405127988;5141.511556402136;5156.716380599103;5162.328897243372;5138.74306284688;5172.431032586413;5180.119379705459;5181.119209734355;5200.843974680765;4659.976700116512;4783.904321913542;4834.395700537433;4845.0067736114015;4859.2954021666665;5291.550218231417;5374.785008599612;5377.381601115843;5378.13949768043;5379.031774280667;4892.266160075946;5098.796048158032;5143.228515722672;5155.226715992631;5155.304033955443;5086.72023038729;5126.615503837153;5134.306868572695;5155.5617772489;5167.173252279692;5108.821191258288;5116.258142569381;5121.359830021247;5122.538971492583;5176.8964620707375;4892.877678058077;5034.194528875436;5070.163423035158;5076.74616269185;5091.541761241432;4340.47914250292;4349.782510874444;4358.65130789536;4395.164918665443;4402.163588918095;3798.1074447504816;3819.2170605025904;3824.2160357126722;3860.845566177378;3866.7679939203736;4266.146770645883;4308.763018033976;4452.376667266585;4455.064436468378;4505.954940450619;5140;5179.507946745053;5192.8961420771375;5201.843944681666;5208.088584497697;4464.084862603158;4468.419105516262;4469.553044695569;4477;4510.729356238636;4484.775761211927;4574.611158051603;4671.43942726875;4673.3690951721765;4710.8351207707565;4852.344933433941;4876.878078048077;4888.706677599355;4889.951100489092;4936.3829521309835;5185.27406163145;5194.091034068947;5198.090334191577;5209.973950130225;5247.527722504993;4652.116097941381;4792.257200133846;4834.323194752667;4843.418789745112;4897.559219670246;5090.592752579859;5099.515546023122;5105.566026887756;5115.820946266863;5157.020166168416;5152.22482435596;5162.8967420652125;5163.715995620277;5169.121249387688;5215.4002289735645;4881.633877459134;4917.926231106465;4957.182064959386;4998.100341938486;5032.446430892672;4998.325226094431;5009.223570346602;5018;5024.196128619549;5070.366204224472;4879.39007624047;4886.975565122151;4891.144049791201;4924.72913989734;4937.061958227925;4852.126617208936;4960.925586116284;5003.44962054181;5020.548150666457;5035.16919708244;4881.438634557071;4909.1899836528;4911.557959783637;4916.459189489082;4960.156773348612 05:29:55 INFO - PROCESS | 29343 | |1;ext.html;537.4046961194823;572.6907469966216;578.6354596604139;585.3765739487449;600.0309500157246;26950;39477.80261098694;40504.189916201656;40556.797216013954;40591.59408405915;41643.37534936978;41972.58027419725;41990.37014444786;42112;42142.7892860536;7898.684052637887;8038.517688938653;8052.396070294722;8052.798680033016;8056.315213206884;7858.960705196495;7937.126916039231;7951.204879512032;7958.562279074648;7960.084590272106;7961;8013.398995075364;8014.67941282348;8015.278624923756;8017.679292828309;7947.324477419426;7986.920130798676;7988.840223195532;7990.081140668839;7995.360371170293;7889.447738658297;7940.1265860755275;7951.085625153066;7961.840763184704;7962.840743185162;38454.615453845385;38927.610723892685;38929.22141557181;38942.415863762064;38944.80527597344;3191.48936170214;3296.538484612156;3347;3438.6905178534053;3638.399664055428;29575;29621.555676664866;29732.256693582618;29849.25376865596;30771.69228307733;3490.7905525668543;3535.9116022099397;3536.5932917714536;3560.0743806610208;3669.0460480275055;237485;238061;238441.80779096167;239107;239354;31166;32057.67942320547;32075.198120047186;51519.74240128775;51814;33492.49761253583;33725.494117588256;33754.831225843714;33757.83121084379;33760.32479350399;12359.196652217757;12420.254784712766;12488.438020289108;12549.74900502003;12589.43347549344;10169.644062457779;10191.082802547806;10233.283670143019;10301.639442619622;10302.02130797573;7859.331956783737;7908.3277921376175;7934.75490612531;7967.880481792778;8006;3114.377124575094;3125.1718294651937;3135.1848519384666;3142.905712828619;3156.842157892096;824.2293455619016;850.8348941936111;871.1854416120947;934.6635211323918;961.4615815143542;26750;26993.0552430664;27247.591286130722;27330.770115344858;28165.15504534867;807.4186585658316;963.3545524498603;966.2221911361421;967.9062659195065;971.9951400243095;14358.210298433687;14964.700705985819;14979.70040599182;14989.775153372708;15200.163990980602;379412;381097;382888;383420;383689;49389.50610493849;49717.25424118641;49719;49801.50198498041;49859.50140498549;1053.3627155570923;1159.3275899977994;1210.7820592293297;1211.1642966353188;1212.442276552778;27704.307392315353;28869.855650721613;29390.265243369086;29424;29923.251918702208;41463.58536414597;41559.7922010388;41868.58131418647;41979;42033.57966420297;275616;283535;283576;283693;283764;20578.27976020832;20951.790482094984;21034;21954.231601894495;24139;39013.414798778605;41913.37129943114;42332;42592.36111458269;42765.14469710651;35990.4601430984;36153.819230903675;36406.45390319201;36693.449598255516;36984.815075924445;32090.35819283648;33128.337433250716;33371.16572085717;34668.47997280093;35659.643403565635;34379;34718;34930.65069349274;34934.47598285977;36558.26883462369;26823.329416764736;28164.85917570399;30116.247093821952;30142.397152056397;30190.245243869078;23903.402414939766;24823.50352992966;24868;25064.624030639192;25247 05:29:55 INFO - PROCESS | 29343 | |2;jquery.html;366.99266014679705;376.4560210495834;377.52243412083703;379.2225936829499;381.1348239496343;15960.441384551543;16970.91514542427;17043.659126817456;17328.480145595622;17405.91297043516;15900.840991590081;16573.337066517353;17014.149292535385;17124.914375428107;17140.314387424518;5035.521625445586;5170.1727723564045;5175.456577059411;5212.609054320922;5240.711760853171;3789.2042671039117;3891.182851601167;3980.9402858957137;5063.8480845574695;5664.575156863251;5952.345242023374;6027.095935609672;6052.485538729214;6058.091286307045;6061.484773794233;5810.721641238921;5997.280326360843;6006.429389208019;6010.068439391857;6013.278406591216;3377.1725927148004;3544.4506101554302;3546.5034895114704;5251.658642188246;5279.472052794728;18061.7290740639;19840.40478785624;20066;21279.680804787942;21324.253651122137;2008.648486514854;2143.721316228896;2156.805887470135;2464;2522.382016405992;12809.935950320189;12948.935255323757;13441.932790335986;13476.708959476815;14005.369758360897;1760.8656591267563;1858.438911314489;1863.4782260966952;1866.2721538599958;1871.9064046797741;42791.14417711659;43094.353584696255;43232;58087;67385.3261467379;9314.394564353295;9410;9588.808223835484;9671.226301895973;9678.806423871623;12960.67598310031;13059.804102938464;13082.738345233041;13082.934585327013;13086.411111500005;7016.2632923543315;7019.5788252705;7073.186583542855;7412.4070074394995;7438.070241219848;7195.748148814766;7257.45569082321;7395.85208295831;7400.074990626172;7429.814254643569;5898.675572843449;6060.121282414026;6111.113888486145;6147.754089836446;6149.938500614937;1568.709788689096;1627.1050921992858;1674.6901823162755;1689.2651696512057;1720.1485264793757;682.8019874236516;798.4610387988084;848.2026894718945;863.0894406401181;925.1997022575424;17132.486025419257;17135.143242837807;17143;17580.12099395025;18036.36872709449;879.784452809053;880.2737741363401;894.9418287811271;911.9817603648023;912.0879120879121;9576.569054392568;10040.748981275527;10217.540210690388;10217.846732299022;10263.58945642166;394442;395399;413181;414083;414593;43928.78035609802;51942.74028629833;56802.14796778052;70132.64933675299;71510;900.5902314446911;925.6390007896925;926.0369216015404;939.154760715348;946.3091942881734;15670.294836732603;15753.13357765334;15845.366185352457;15863.920680396524;16209.837901620833;34643.653563464046;35729;37475.315585551805;39076.609233908435;39821;46273.3059004122;48079.75960120317;48229.75885120552;54806.72596637151;55797;7021.543599666005;7221.241769614115;7388.704451821867;7490.588017659081;7491.925080749123;8584.313254939714;10314.638987635397;10553.472326383804;10638.468076596295;10722.839157412802;9193.86209206849;9304.553961322521;9389.877317434328;9422.057794220524;9536.380135291183;9436.575354109218;9530.142287194185;9557.569909353957;9622.759431014281;9686.467244301632;5600.4959553640365;6358.459530939922;9585.952070239884;9714.611415543299;9778.9022109778;7376.225496322809;7387.039684840936;7392.149902761252;7437.8140546486775;7608.771736847903;5438.619296649196;9515.096065873731;9660.32377733552;9835.803283934425;10207.336523125972 05:29:55 INFO - PROCESS | 29343 | |3;mootools.html;1254.2349167008128;1387.4519564771913;1416.5396246219977;1511.712774572831;1708.2142214581293;6826.761063362784;7377.778666639996;7642.96178519108;7868.213178682143;7883.566403847801;8007.479513831611;8024.157463466339;8060.5566693831815;8093.554854483001;8097.433179677425;1930.94207173785;2179.585878683049;2206.1837120265523;2207.139215705876;2208.205046183373;2175.8368122390807;2266.5240299537118;2270.4550907782095;2280.281711260956;2280.7719228077226;2241.1371621925514;2246.921357752479;2256.5035692147785;2256.582532231534;2289.3360925331635;1941.2817257614772;2159.946001349963;2255.0979608156704;2265.0600000999566;2265.546890621882;2257.559775843711;2298.5058212484228;2300.5398920215857;2302;2304.723433188028;8007.519548827089;8057;8063.516189028677;8069.757907262791;8072.717454889051;4593.5406459354135;4721.079389519045;4722.362481065046;4722.858314250578;4734.502877197879;2960.955585666217;3107.0989413070183;3112.081935828936;3144.638366587849;3149.2126968257935;961.6489981156898;998.1316254858248;998.9450580218086;1000.164862339947;1040.8022475729663;10681.092107170978;10728.409937453436;10736.838947415796;10847.620333288376;10922.453877306103;4203.222403855297;4399.450068741407;4400.3399490076745;4471.821127154943;4472.08322293929;9240.8613870792;9292.767680808034;9294.25645948336;9297.628094876265;9315.673951411804;4749.311349854321;4749.952500474951;4760.7619619018915;4763.04739052191;4765.237561990065;3761.4545890845675;4100.528439229467;4192.832286708558;4246.63903568194;4277.743335399824;3658.1951970566433;3724.478572999782;3745.9063523411587;3760.341940160461;3770.7737535747942;1197.2636828350676;1217.6347095871204;1228.5392977633387;1231.445849367788;1246.4702501436852;838.1911455445525;840.1934143222575;841.1882533355341;873.7902903303288;888.4669198480989;5171.81898633546;5469.398366179717;5508.3114610673665;5540.612157148961;5621;429.9333603291495;437.52309982119004;441.34680672604725;903.2277402820625;935.1350001248818;3615.837287322077;3632.582253040934;3872.5352957645264;3875.4380614810693;3886.0479182600443;9628.951855240819;9645.035496450439;9894.752631184134;10039.899601004043;10048.748781280381;9865.75335616601;9944.950275248577;9961.252906032076;9982.650607228712;9996.250281228937;7348.301911318416;7659;7661.578613176329;7661.77014689549;7664.156942736406;5375.462453754593;5412.134058550613;5485.232067510472;5560.694161821139;5703.5722320826935;8760.4305720128;8967.910320896968;9190.724278271662;9194.448333100036;9199.35604507678;8876.11238876133;9184.816303674022;9196.954015229881;9200.401973871676;9457.43255404678;5929.229200203946;6077.179580756541;6239.344868788712;6825.726970921306;6990.580565166107;7667.539947603162;7675.692972281046;7710.306072453506;7758.7672369829;7766.5728384939375;6553.770618028346;6628.635425051669;6680.365365290289;6772.018057381751;6776.186857577122;6526.282108968105;6608.140941677551;6672.83317917056;6703.195616526048;6755.763548275787;6574.309697481887;6579.342065793382;6689.331066893272;6690.565113267622;6693.230278518033;4645.117427688729;4665.463471700662;4741.952580474289;4806.735629540409;4806.951930480651;4685.882852928704;4832.081904438145;4852.078105160008;4885.609151267819;4886.315915771724 05:29:55 INFO - PROCESS | 29343 | |4;prototype.html;297.27613261707745;301.502520840613;308.1679465443302;311.9578856854324;312.99687003129964;4795.96886669366;4830.2754586812;4853.272009198622;4865.951340486598;4893.632977526682;4540.274695615662;4775.164346239411;4780.8565743027675;4802.23164293713;4828.179209534379;3795.5635101963353;3805.752626079303;3807.3146833570086;3813.2373525294915;3813.6949044076546;3796.8481260749536;3803.4484999675033;3810.428435734634;3812.0850995760957;3819.828107735145;3651.1054791576103;3718.2005868738215;3737.906552336186;3763.5886542546546;3778.414345776409;3727.329080765461;3738.345789486856;3740.3080430120513;3745.4381842723537;3745.9812700936595;3278.557394751702;3280.7047365736958;3287.964291248249;3288.6875746804253;3314.3371325734947;4658.510856360067;4667.486576476619;4672.20572502672;4707.764611769432;4711.222648263032;4033.193361327746;4207.412441348579;4224.725392849455;4245.830166793325;4268.381084742695;4925.556699897026;4968;4968.807486203321;5008.373953255843;5046.26829109777;3538.5399898013093;3543.8228088595465;3551.3074950384685;3553.7867727936405;3559.555055618048;5089.389273287192;5247.658902171384;5254.842354729364;5283.841484755463;5323.494268044529;3666.1201311685004;3686.870959516404;3689.9077523062138;3693.5567731872347;3699.630036996333;3721.218544105714;3725.925481490355;3739.85040598373;3740.8129593520216;3767.679747221462;4282.357646353072;4292.806823692941;4316.2446571849805;4318.287482565342;4323.200207961474;4955.40535135786;5053.393592768891;5067.1639179535705;5077.593792496666;5111.693298402108;1281.9551315703904;1284.0818814547642;1287.1311864491431;1296.8652429124515;1301.8958483321312;796.8047828282108;807.5679511461458;816.77946954322;831.4969443486724;841.7373939091362;4016.658584020391;4031.959680403217;4049.1778699585307;4050.696197785119;4057.5739547347694;4539.818407263739;4580.24425969718;4600.907981840344;4621.329907163443;4633.351330813689;4037.425404092406;4044.3326851069246;4049.311617025113;4063.0700417301546;4077.6330130288416;2467.605183170684;2519.7480251974657;2738.8082834201414;2764.14311563416;2788.8884444622395;4866.416030076413;4884.5603895649565;4893.241547560134;4899.706017638953;4903.901921961541;5081.923771143436;5256.6057545684225;5278.947210527922;5341.305630268041;5350.946490535122;4581.65637577183;4690.788914498856;4889.584385327287;4901.215805471107;4910.8281210157475;5107.719075450886;5162.793488260428;5180.274761533464;5185.22221666753;5187.19598462239;4917.9016419672125;5091.821786237464;5101.362329708786;5104.310918026019;5121.641485096007;4632.305154226893;4777.95222047775;4778.737169455713;4833.927491087707;4838.250071238964;3657.762245454037;3676.5771936227675;3678.6873115785456;3689.686376658014;3692.5599016383094;5017.899642007066;5131.640785145004;5149.330587023663;5177.928828468643;5203.661761985459;4939.5554400104165;4967.726775027409;4976.2286845539;4978.7510624467905;4979.128652485728;4970.850874473772;4982.636720213914;5010.148274793367;5018.42288136869;5026.296318515484;4731.29030645406;4886.65793394459;4901.754912254301;4916.287138364845;4928.310036594808;5044.974775126101;5053.519915608012;5059.468755780737;5063.544281014726;5070.163423035158;4871.756412179448;4928;4981.62637802159;5010.874728131826;5014.323066385991 05:29:55 INFO - PROCESS | 29343 | |5;yui.html;642.7846671365093;644.3846126948764;679.0968012543315;705.2630001648278;736.1497470421663;12451.696436159305;12664.936675316621;12748.745025099492;12828.166169198996;12847.357632118403;12949.41727622257;13094;13652.249126298075;13658.931705341483;14159.575212743608;613.6747523812387;799.496317320089;801.4149670740363;804.1435870797582;805.6938363421891;767.17528656694;798.1101072304368;804.6499772598909;807.563915485637;807.6850028488894;842.0653075086649;843.1273631791097;845.1126317366771;846.3863698818338;846.7586737779734;641.7753786174848;790.4032455496122;832.9666813327459;833.4832403909554;833.9791505212388;610.3774150366601;613.3039000734154;613.3712944232153;613.5613036678751;614.1064750787593;13362.599122026355;13402.865971340358;13411.664708382368;13442;13450.798238026437;12290.139690221687;12646.49414023438;12852.548737615867;12902.290374029424;13049.86950130496;11828.645140645795;11976.461059252355;12003.63989080329;12075.516979320817;12473.376331183405;4128.298189307825;4172.916541669149;4277.529471758104;4373.562643735601;4374.12517496502;69336.95994560035;69722;69792;69871;70009;9729.173020293212;9957.950210248902;10000.79998400028;10021.79956400868;10041;18734.718979215322;18759.968201749034;18765.155567999474;18777;18820.81179188218;6631.86736265272;6899.724011039602;7040.119985001875;7040.612766297801;7049.154101507852;3428.9314213715584;3480.912977175591;3545.503629491873;3574.91062723434;3837.5586807516934;2844.4737723521216;3329.417351963397;3522.2427178156818;3534.4874993125854;3552.5914519830035;570.8858228354263;571.6255852416674;573.5211098732605;577.5783677915061;578.531389574446;466.2702870008426;543.7943324104383;559.574723210363;564.1396869773546;572.3360901354409;7178.066851309296;7183.102112235971;7328.450366222554;7896.565688887166;8193.09875913649;509.9133147364957;531.2933798048587;562.9324481062299;571.9799807006734;572.5934586443589;3738.5887552369218;3775.3770627846648;3857.3828187489867;3868.516435445569;3873.4577159197734;95466.5226673876;95702.52148739212;96377.5181124104;96552.51723741337;96938.51530742302;88039;89479;90057;90278;90422.54788726146;63378.999999999076;69743;75049;78689.67206803567;79815.20184798077;7923.7226697065325;8020;8071.954569703412;8184.468009579358;8237.176282371714;41175.794121029205;41862.79068604638;42141.157176856905;43228.56771432245;43652.56347436485;57824.71087644535;61174;62794.37205628068;63184;64094;11232.494537745657;11262.436878156223;11433.256838305484;11480.885191147981;11501.309921404743;12406.875931240933;12579.93710031444;12849.743005140032;13224.867751322363;13717.519886803913;11759.588414405454;12130.211536250115;12224.755504889674;12227.510899563918;12489.750204995667;11272.718182045186;11532.423378831192;11572.6528204154;11682.357470339213;11735.178537502294;11083.72290692739;11390.202685811913;11662.183647144619;11762.58830940913;11795.053816120244;9315.6273749052;9942.105210530797;10048.84926726085;10050.597976080875;10207.948960255151;8580.957095214484;8782.165694259034;9172.621789062563;9180.806495155586;9676.56455459492 05:29:55 INFO - PROCESS | 29343 | __end_tp_report 05:29:55 INFO - PROCESS | 29343 | __start_cc_report 05:29:55 INFO - PROCESS | 29343 | _x_x_mozilla_cycle_collect,1089 05:29:55 INFO - PROCESS | 29343 | __end_cc_report 05:29:55 INFO - PROCESS | 29343 | __startTimestamp1465907395146__endTimestamp 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | ------- Summary: start ------- 05:29:55 INFO - PROCESS | 29343 | Number of tests: 6 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | [#0] dojo.html Cycles:165 Average:4754.94 Median:4881.44 stddev:499.37 (10.2%) stddev-sans-first:473.09 05:29:55 INFO - PROCESS | 29343 | Values: 2659.9 2664.3 2683.9 2692.0 2697.6 4620.0 4697.5 4783.8 4838.7 4907.2 4736.6 4800.9 4805.7 4806.7 4814.0 4343.4 4408.8 4450.3 4512.5 4566.2 4474.0 4514.1 4533.5 4544.4 4559.7 4309.5 4348.0 4353.8 4386.3 4419.9 4402.4 4411.7 4422.9 4471.2 4485.4 4429.1 4450.9 4453.1 4472.7 4496.2 4685.0 4687.0 4738.0 4753.6 4755.1 5116.1 5119.0 5141.5 5156.7 5162.3 5138.7 5172.4 5180.1 5181.1 5200.8 4660.0 4783.9 4834.4 4845.0 4859.3 5291.6 5374.8 5377.4 5378.1 5379.0 4892.3 5098.8 5143.2 5155.2 5155.3 5086.7 5126.6 5134.3 5155.6 5167.2 5108.8 5116.3 5121.4 5122.5 5176.9 4892.9 5034.2 5070.2 5076.7 5091.5 4340.5 4349.8 4358.7 4395.2 4402.2 3798.1 3819.2 3824.2 3860.8 3866.8 4266.1 4308.8 4452.4 4455.1 4506.0 5140.0 5179.5 5192.9 5201.8 5208.1 4464.1 4468.4 4469.6 4477.0 4510.7 4484.8 4574.6 4671.4 4673.4 4710.8 4852.3 4876.9 4888.7 4890.0 4936.4 5185.3 5194.1 5198.1 5210.0 5247.5 4652.1 4792.3 4834.3 4843.4 4897.6 5090.6 5099.5 5105.6 5115.8 5157.0 5152.2 5162.9 5163.7 5169.1 5215.4 4881.6 4917.9 4957.2 4998.1 5032.4 4998.3 5009.2 5018.0 5024.2 5070.4 4879.4 4887.0 4891.1 4924.7 4937.1 4852.1 4960.9 5003.4 5020.5 5035.2 4881.4 4909.2 4911.6 4916.5 4960.2 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | [#1] ext.html Cycles:180 Average:44276.78 Median:35825.05 stddev:80911.21 (225.9%) stddev-sans-first:81071.55 05:29:55 INFO - PROCESS | 29343 | Values: 537.4 572.7 578.6 585.4 600.0 26950.0 39477.8 40504.2 40556.8 40591.6 41643.4 41972.6 41990.4 42112.0 42142.8 7898.7 8038.5 8052.4 8052.8 8056.3 7859.0 7937.1 7951.2 7958.6 7960.1 7961.0 8013.4 8014.7 8015.3 8017.7 7947.3 7986.9 7988.8 7990.1 7995.4 7889.4 7940.1 7951.1 7961.8 7962.8 38454.6 38927.6 38929.2 38942.4 38944.8 3191.5 3296.5 3347.0 3438.7 3638.4 29575.0 29621.6 29732.3 29849.3 30771.7 3490.8 3535.9 3536.6 3560.1 3669.0 237485.0 238061.0 238441.8 239107.0 239354.0 31166.0 32057.7 32075.2 51519.7 51814.0 33492.5 33725.5 33754.8 33757.8 33760.3 12359.2 12420.3 12488.4 12549.7 12589.4 10169.6 10191.1 10233.3 10301.6 10302.0 7859.3 7908.3 7934.8 7967.9 8006.0 3114.4 3125.2 3135.2 3142.9 3156.8 824.2 850.8 871.2 934.7 961.5 26750.0 26993.1 27247.6 27330.8 28165.2 807.4 963.4 966.2 967.9 972.0 14358.2 14964.7 14979.7 14989.8 15200.2 379412.0 381097.0 382888.0 383420.0 383689.0 49389.5 49717.3 49719.0 49801.5 49859.5 1053.4 1159.3 1210.8 1211.2 1212.4 27704.3 28869.9 29390.3 29424.0 29923.3 41463.6 41559.8 41868.6 41979.0 42033.6 275616.0 283535.0 283576.0 283693.0 283764.0 20578.3 20951.8 21034.0 21954.2 24139.0 39013.4 41913.4 42332.0 42592.4 42765.1 35990.5 36153.8 36406.5 36693.4 36984.8 32090.4 33128.3 33371.2 34668.5 35659.6 34379.0 34718.0 34930.7 34934.5 36558.3 26823.3 28164.9 30116.2 30142.4 30190.2 23903.4 24823.5 24868.0 25064.6 25247.0 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | [#2] jquery.html Cycles:180 Average:23705.63 Median:28559.10 stddev:66460.38 (232.7%) stddev-sans-first:66623.71 05:29:55 INFO - PROCESS | 29343 | Values: 367.0 376.5 377.5 379.2 381.1 15960.4 16970.9 17043.7 17328.5 17405.9 15900.8 16573.3 17014.1 17124.9 17140.3 5035.5 5170.2 5175.5 5212.6 5240.7 3789.2 3891.2 3980.9 5063.8 5664.6 5952.3 6027.1 6052.5 6058.1 6061.5 5810.7 5997.3 6006.4 6010.1 6013.3 3377.2 3544.5 3546.5 5251.7 5279.5 18061.7 19840.4 20066.0 21279.7 21324.3 2008.6 2143.7 2156.8 2464.0 2522.4 12809.9 12948.9 13441.9 13476.7 14005.4 1760.9 1858.4 1863.5 1866.3 1871.9 42791.1 43094.4 43232.0 58087.0 67385.3 9314.4 9410.0 9588.8 9671.2 9678.8 12960.7 13059.8 13082.7 13082.9 13086.4 7016.3 7019.6 7073.2 7412.4 7438.1 7195.7 7257.5 7395.9 7400.1 7429.8 5898.7 6060.1 6111.1 6147.8 6149.9 1568.7 1627.1 1674.7 1689.3 1720.1 682.8 798.5 848.2 863.1 925.2 17132.5 17135.1 17143.0 17580.1 18036.4 879.8 880.3 894.9 912.0 912.1 9576.6 10040.7 10217.5 10217.8 10263.6 394442.0 395399.0 413181.0 414083.0 414593.0 43928.8 51942.7 56802.1 70132.6 71510.0 900.6 925.6 926.0 939.2 946.3 15670.3 15753.1 15845.4 15863.9 16209.8 34643.7 35729.0 37475.3 39076.6 39821.0 46273.3 48079.8 48229.8 54806.7 55797.0 7021.5 7221.2 7388.7 7490.6 7491.9 8584.3 10314.6 10553.5 10638.5 10722.8 9193.9 9304.6 9389.9 9422.1 9536.4 9436.6 9530.1 9557.6 9622.8 9686.5 5600.5 6358.5 9586.0 9714.6 9778.9 7376.2 7387.0 7392.1 7437.8 7608.8 5438.6 9515.1 9660.3 9835.8 10207.3 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | [#3] mootools.html Cycles:180 Average:5245.80 Median:4885.96 stddev:2933.23 (60.0%) stddev-sans-first:2926.11 05:29:55 INFO - PROCESS | 29343 | Values: 1254.2 1387.5 1416.5 1511.7 1708.2 6826.8 7377.8 7643.0 7868.2 7883.6 8007.5 8024.2 8060.6 8093.6 8097.4 1930.9 2179.6 2206.2 2207.1 2208.2 2175.8 2266.5 2270.5 2280.3 2280.8 2241.1 2246.9 2256.5 2256.6 2289.3 1941.3 2159.9 2255.1 2265.1 2265.5 2257.6 2298.5 2300.5 2302.0 2304.7 8007.5 8057.0 8063.5 8069.8 8072.7 4593.5 4721.1 4722.4 4722.9 4734.5 2961.0 3107.1 3112.1 3144.6 3149.2 961.6 998.1 998.9 1000.2 1040.8 10681.1 10728.4 10736.8 10847.6 10922.5 4203.2 4399.5 4400.3 4471.8 4472.1 9240.9 9292.8 9294.3 9297.6 9315.7 4749.3 4750.0 4760.8 4763.0 4765.2 3761.5 4100.5 4192.8 4246.6 4277.7 3658.2 3724.5 3745.9 3760.3 3770.8 1197.3 1217.6 1228.5 1231.4 1246.5 838.2 840.2 841.2 873.8 888.5 5171.8 5469.4 5508.3 5540.6 5621.0 429.9 437.5 441.3 903.2 935.1 3615.8 3632.6 3872.5 3875.4 3886.0 9629.0 9645.0 9894.8 10039.9 10048.7 9865.8 9945.0 9961.3 9982.7 9996.3 7348.3 7659.0 7661.6 7661.8 7664.2 5375.5 5412.1 5485.2 5560.7 5703.6 8760.4 8967.9 9190.7 9194.4 9199.4 8876.1 9184.8 9197.0 9200.4 9457.4 5929.2 6077.2 6239.3 6825.7 6990.6 7667.5 7675.7 7710.3 7758.8 7766.6 6553.8 6628.6 6680.4 6772.0 6776.2 6526.3 6608.1 6672.8 6703.2 6755.8 6574.3 6579.3 6689.3 6690.6 6693.2 4645.1 4665.5 4742.0 4806.7 4807.0 4685.9 4832.1 4852.1 4885.6 4886.3 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | [#4] prototype.html Cycles:180 Average:4133.24 Median:4681.50 stddev:1200.09 (25.6%) stddev-sans-first:1168.41 05:29:55 INFO - PROCESS | 29343 | Values: 297.3 301.5 308.2 312.0 313.0 4796.0 4830.3 4853.3 4866.0 4893.6 4540.3 4775.2 4780.9 4802.2 4828.2 3795.6 3805.8 3807.3 3813.2 3813.7 3796.8 3803.4 3810.4 3812.1 3819.8 3651.1 3718.2 3737.9 3763.6 3778.4 3727.3 3738.3 3740.3 3745.4 3746.0 3278.6 3280.7 3288.0 3288.7 3314.3 4658.5 4667.5 4672.2 4707.8 4711.2 4033.2 4207.4 4224.7 4245.8 4268.4 4925.6 4968.0 4968.8 5008.4 5046.3 3538.5 3543.8 3551.3 3553.8 3559.6 5089.4 5247.7 5254.8 5283.8 5323.5 3666.1 3686.9 3689.9 3693.6 3699.6 3721.2 3725.9 3739.9 3740.8 3767.7 4282.4 4292.8 4316.2 4318.3 4323.2 4955.4 5053.4 5067.2 5077.6 5111.7 1282.0 1284.1 1287.1 1296.9 1301.9 796.8 807.6 816.8 831.5 841.7 4016.7 4032.0 4049.2 4050.7 4057.6 4539.8 4580.2 4600.9 4621.3 4633.4 4037.4 4044.3 4049.3 4063.1 4077.6 2467.6 2519.7 2738.8 2764.1 2788.9 4866.4 4884.6 4893.2 4899.7 4903.9 5081.9 5256.6 5278.9 5341.3 5350.9 4581.7 4690.8 4889.6 4901.2 4910.8 5107.7 5162.8 5180.3 5185.2 5187.2 4917.9 5091.8 5101.4 5104.3 5121.6 4632.3 4778.0 4778.7 4833.9 4838.3 3657.8 3676.6 3678.7 3689.7 3692.6 5017.9 5131.6 5149.3 5177.9 5203.7 4939.6 4967.7 4976.2 4978.8 4979.1 4970.9 4982.6 5010.1 5018.4 5026.3 4731.3 4886.7 4901.8 4916.3 4928.3 5045.0 5053.5 5059.5 5063.5 5070.2 4871.8 4928.0 4981.6 5010.9 5014.3 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - PROCESS | 29343 | [#5] yui.html Cycles:180 Average:18018.81 Median:561.25 stddev:25849.30 (4605.6%) stddev-sans-first:25888.89 05:29:55 INFO - PROCESS | 29343 | Values: 642.8 644.4 679.1 705.3 736.1 12451.7 12664.9 12748.7 12828.2 12847.4 12949.4 13094.0 13652.2 13658.9 14159.6 613.7 799.5 801.4 804.1 805.7 767.2 798.1 804.6 807.6 807.7 842.1 843.1 845.1 846.4 846.8 641.8 790.4 833.0 833.5 834.0 610.4 613.3 613.4 613.6 614.1 13362.6 13402.9 13411.7 13442.0 13450.8 12290.1 12646.5 12852.5 12902.3 13049.9 11828.6 11976.5 12003.6 12075.5 12473.4 4128.3 4172.9 4277.5 4373.6 4374.1 69337.0 69722.0 69792.0 69871.0 70009.0 9729.2 9958.0 10000.8 10021.8 10041.0 18734.7 18760.0 18765.2 18777.0 18820.8 6631.9 6899.7 7040.1 7040.6 7049.2 3428.9 3480.9 3545.5 3574.9 3837.6 2844.5 3329.4 3522.2 3534.5 3552.6 570.9 571.6 573.5 577.6 578.5 466.3 543.8 559.6 564.1 572.3 7178.1 7183.1 7328.5 7896.6 8193.1 509.9 531.3 562.9 572.0 572.6 3738.6 3775.4 3857.4 3868.5 3873.5 95466.5 95702.5 96377.5 96552.5 96938.5 88039.0 89479.0 90057.0 90278.0 90422.5 63379.0 69743.0 75049.0 78689.7 79815.2 7923.7 8020.0 8072.0 8184.5 8237.2 41175.8 41862.8 42141.2 43228.6 43652.6 57824.7 61174.0 62794.4 63184.0 64094.0 11232.5 11262.4 11433.3 11480.9 11501.3 12406.9 12579.9 12849.7 13224.9 13717.5 11759.6 12130.2 12224.8 12227.5 12489.8 11272.7 11532.4 11572.7 11682.4 11735.2 11083.7 11390.2 11662.2 11762.6 11795.1 9315.6 9942.1 10048.8 10050.6 10207.9 8581.0 8782.2 9172.6 9180.8 9676.6 05:29:55 INFO - PROCESS | 29343 | -------- Summary: end -------- 05:29:55 INFO - PROCESS | 29343 | 05:29:55 INFO - TEST-INFO | 29343: exit 0 05:29:55 INFO - TEST-OK | dromaeo_css | took 1120039ms 05:29:55 INFO - TEST-START | kraken 05:29:55 INFO - operating with platform_type : linux_ 05:29:55 INFO - Initialising browser for kraken test... 05:29:55 INFO - TEST-INFO | started process 29524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4HmDL/profile http://localhost:50126/getInfo.html) 05:30:00 INFO - PROCESS | 29524 | __metrics Screen width/height:1600/1200 05:30:00 INFO - PROCESS | 29524 | colorDepth:24 05:30:00 INFO - PROCESS | 29524 | Browser inner width/height: 1024/697 05:30:00 INFO - PROCESS | 29524 | __metrics 05:30:01 INFO - PROCESS | 29524 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:01 INFO - PROCESS | 29524 | console.error: PushService: 05:30:01 INFO - PROCESS | 29524 | stateChangeProcessEnqueue: Error transitioning state 05:30:01 INFO - PROCESS | 29524 | UnknownError 05:30:02 INFO - TEST-INFO | 29524: exit 0 05:30:02 INFO - Browser initialized. 05:30:02 INFO - Running cycle 1/1 for kraken test... 05:30:02 INFO - TEST-INFO | started process 29603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4HmDL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:14 INFO - PROCESS | 29603 | RSS: Main: 175677440 05:30:14 INFO - PROCESS | 29603 | 05:30:17 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50126/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:18 INFO - PROCESS | 29603 | RSS: Main: 233779200 05:30:18 INFO - PROCESS | 29603 | 05:30:21 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50126/tests/kraken/driver.html?testName=audio-dft) 05:30:21 INFO - PROCESS | 29603 | RSS: Main: 221560832 05:30:21 INFO - PROCESS | 29603 | 05:30:24 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50126/tests/kraken/driver.html?testName=audio-fft) 05:30:25 INFO - PROCESS | 29603 | RSS: Main: 289153024 05:30:25 INFO - PROCESS | 29603 | 05:30:27 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50126/tests/kraken/driver.html?testName=audio-oscillator) 05:30:28 INFO - PROCESS | 29603 | RSS: Main: 199188480 05:30:28 INFO - PROCESS | 29603 | 05:30:30 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:31 INFO - PROCESS | 29603 | RSS: Main: 203022336 05:30:31 INFO - PROCESS | 29603 | 05:30:34 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50126/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:34 INFO - PROCESS | 29603 | RSS: Main: 238837760 05:30:34 INFO - PROCESS | 29603 | 05:30:38 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50126/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:39 INFO - PROCESS | 29603 | RSS: Main: 233897984 05:30:39 INFO - PROCESS | 29603 | 05:30:42 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50126/tests/kraken/driver.html?testName=json-parse-financial) 05:30:42 INFO - PROCESS | 29603 | RSS: Main: 237441024 05:30:42 INFO - PROCESS | 29603 | 05:30:44 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:44 INFO - PROCESS | 29603 | RSS: Main: 226082816 05:30:44 INFO - PROCESS | 29603 | 05:30:46 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:47 INFO - PROCESS | 29603 | RSS: Main: 230838272 05:30:47 INFO - PROCESS | 29603 | 05:30:49 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:50 INFO - PROCESS | 29603 | RSS: Main: 238555136 05:30:50 INFO - PROCESS | 29603 | 05:30:53 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:53 INFO - PROCESS | 29603 | RSS: Main: 240877568 05:30:53 INFO - PROCESS | 29603 | 05:30:56 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:57 INFO - PROCESS | 29603 | RSS: Main: 239591424 05:30:57 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | Cycle 1(1): loaded http://localhost:50126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50126/tests/kraken/driver.html?testName=ai-astar) 05:30:59 INFO - PROCESS | 29603 | RSS: Main: 283508736 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | __start_tp_report 05:30:59 INFO - PROCESS | 29603 | _x_x_mozilla_page_load 05:30:59 INFO - PROCESS | 29603 | _x_x_mozilla_page_load_details 05:30:59 INFO - PROCESS | 29603 | |i|pagename|runs| 05:30:59 INFO - PROCESS | 29603 | |0;ai-astar;112;108;112;115;112;113;114;112;114;112 05:30:59 INFO - PROCESS | 29603 | |1;audio-beat-detection;163;139;132;185;131;163;156;141;209;132 05:30:59 INFO - PROCESS | 29603 | |2;audio-dft;162;162;162;162;162;164;161;162;164;162 05:30:59 INFO - PROCESS | 29603 | |3;audio-fft;75;77;77;110;76;78;77;76;105;75 05:30:59 INFO - PROCESS | 29603 | |4;audio-oscillator;87;88;117;85;86;85;117;86;86;125 05:30:59 INFO - PROCESS | 29603 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;117;117;117 05:30:59 INFO - PROCESS | 29603 | |6;imaging-darkroom;146;146;145;147;146;146;146;145;146;146 05:30:59 INFO - PROCESS | 29603 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;94;95 05:30:59 INFO - PROCESS | 29603 | |8;json-parse-financial;64;64;64;64;65;64;64;63;64;64 05:30:59 INFO - PROCESS | 29603 | |9;json-stringify-tinderbox;65;65;65;65;67;65;65;65;66;66 05:30:59 INFO - PROCESS | 29603 | |10;stanford-crypto-aes;85;84;84;84;85;91;84;89;116;84 05:30:59 INFO - PROCESS | 29603 | |11;stanford-crypto-ccm;134;148;131;142;128;129;130;142;139;134 05:30:59 INFO - PROCESS | 29603 | |12;stanford-crypto-pbkdf2;171;169;167;180;172;171;169;167;170;169 05:30:59 INFO - PROCESS | 29603 | |13;stanford-crypto-sha256-iterative;71;67;68;67;67;72;71;70;74;67 05:30:59 INFO - PROCESS | 29603 | __end_tp_report 05:30:59 INFO - PROCESS | 29603 | __start_cc_report 05:30:59 INFO - PROCESS | 29603 | _x_x_mozilla_cycle_collect,1897 05:30:59 INFO - PROCESS | 29603 | __end_cc_report 05:30:59 INFO - PROCESS | 29603 | __startTimestamp1465907459306__endTimestamp 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | ------- Summary: start ------- 05:30:59 INFO - PROCESS | 29603 | Number of tests: 14 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.90 (1.7%) stddev-sans-first:2.01 05:30:59 INFO - PROCESS | 29603 | Values: 112.0 108.0 112.0 115.0 112.0 113.0 114.0 112.0 114.0 112.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:159.50 stddev:25.89 (16.2%) stddev-sans-first:27.30 05:30:59 INFO - PROCESS | 29603 | Values: 163.0 139.0 132.0 185.0 131.0 163.0 156.0 141.0 209.0 132.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:30:59 INFO - PROCESS | 29603 | Values: 162.0 162.0 162.0 162.0 162.0 164.0 161.0 162.0 164.0 162.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:13.21 (17.3%) stddev-sans-first:13.72 05:30:59 INFO - PROCESS | 29603 | Values: 75.0 77.0 77.0 110.0 76.0 78.0 77.0 76.0 105.0 75.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:86.00 stddev:16.36 (19.0%) stddev-sans-first:17.01 05:30:59 INFO - PROCESS | 29603 | Values: 87.0 88.0 117.0 85.0 86.0 85.0 117.0 86.0 86.0 125.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:30:59 INFO - PROCESS | 29603 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 05:30:59 INFO - PROCESS | 29603 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 146.0 145.0 146.0 146.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:30:59 INFO - PROCESS | 29603 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 05:30:59 INFO - PROCESS | 29603 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 63.0 64.0 64.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 05:30:59 INFO - PROCESS | 29603 | Values: 65.0 65.0 65.0 65.0 67.0 65.0 65.0 65.0 66.0 66.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:84.50 stddev:9.94 (11.8%) stddev-sans-first:10.45 05:30:59 INFO - PROCESS | 29603 | Values: 85.0 84.0 84.0 84.0 85.0 91.0 84.0 89.0 116.0 84.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:136.50 stddev:6.72 (4.9%) stddev-sans-first:7.10 05:30:59 INFO - PROCESS | 29603 | Values: 134.0 148.0 131.0 142.0 128.0 129.0 130.0 142.0 139.0 134.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.50 stddev:3.72 (2.2%) stddev-sans-first:3.94 05:30:59 INFO - PROCESS | 29603 | Values: 171.0 169.0 167.0 180.0 172.0 171.0 169.0 167.0 170.0 169.0 05:30:59 INFO - PROCESS | 29603 | 05:30:59 INFO - PROCESS | 29603 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.50 stddev:2.55 (3.6%) stddev-sans-first:2.64 05:30:59 INFO - PROCESS | 29603 | Values: 71.0 67.0 68.0 67.0 67.0 72.0 71.0 70.0 74.0 67.0 05:30:59 INFO - PROCESS | 29603 | -------- Summary: end -------- 05:30:59 INFO - PROCESS | 29603 | 05:31:00 INFO - TEST-INFO | 29603: exit 0 05:31:00 INFO - TEST-OK | kraken | took 64455ms 05:31:00 INFO - SUITE-END | took 1184s 05:31:00 INFO - Completed test suite (00:19:44) 05:31:00 INFO - javascript benchmark 05:31:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.9335016624586, 2664.293962100043, 2683.8792254348564, 2692.030868887201, 2697.5818748094052, 4620.0, 4697.4832768395445, 4783.784729687164, 4838.685485443448, 4907.2148456247005, 4736.573708366246, 4800.927986080212, 4805.687630304028, 4806.687565308262, 4813.975930120353, 4343.435353404053, 4408.757518336491, 4450.317702407981, 4512.5261847506035, 4566.1780879441685, 4474.0380818124095, 4514.097180563884, 4533.478649955248, 4544.363789069533, 4559.749213793257, 4309.504406993173, 4348.043430445297, 4353.84761533348, 4386.254336762758, 4419.867403977886, 4402.3836662867225, 4411.713238639478, 4422.867313980586, 4471.150481408555, 4485.416895803557, 4429.092036132585, 4450.866474005785, 4453.087117141011, 4472.686911916135, 4496.168208881368, 4685.0395668887795, 4687.0, 4737.95262047382, 4753.643476739258, 4755.072760811643, 5116.079105760961, 5118.974405127988, 5141.511556402136, 5156.716380599103, 5162.328897243372, 5138.74306284688, 5172.431032586413, 5180.119379705459, 5181.119209734355, 5200.843974680765, 4659.976700116512, 4783.904321913542, 4834.395700537433, 4845.0067736114015, 4859.2954021666665, 5291.550218231417, 5374.785008599612, 5377.381601115843, 5378.13949768043, 5379.031774280667, 4892.266160075946, 5098.796048158032, 5143.228515722672, 5155.226715992631, 5155.304033955443, 5086.72023038729, 5126.615503837153, 5134.306868572695, 5155.5617772489, 5167.173252279692, 5108.821191258288, 5116.258142569381, 5121.359830021247, 5122.538971492583, 5176.8964620707375, 4892.877678058077, 5034.194528875436, 5070.163423035158, 5076.74616269185, 5091.541761241432, 4340.47914250292, 4349.782510874444, 4358.65130789536, 4395.164918665443, 4402.163588918095, 3798.1074447504816, 3819.2170605025904, 3824.2160357126722, 3860.845566177378, 3866.7679939203736, 4266.146770645883, 4308.763018033976, 4452.376667266585, 4455.064436468378, 4505.954940450619, 5140.0, 5179.507946745053, 5192.8961420771375, 5201.843944681666, 5208.088584497697, 4464.084862603158, 4468.419105516262, 4469.553044695569, 4477.0, 4510.729356238636, 4484.775761211927, 4574.611158051603, 4671.43942726875, 4673.3690951721765, 4710.8351207707565, 4852.344933433941, 4876.878078048077, 4888.706677599355, 4889.951100489092, 4936.3829521309835, 5185.27406163145, 5194.091034068947, 5198.090334191577, 5209.973950130225, 5247.527722504993, 4652.116097941381, 4792.257200133846, 4834.323194752667, 4843.418789745112, 4897.559219670246, 5090.592752579859, 5099.515546023122, 5105.566026887756, 5115.820946266863, 5157.020166168416, 5152.22482435596, 5162.8967420652125, 5163.715995620277, 5169.121249387688, 5215.4002289735645, 4881.633877459134, 4917.926231106465, 4957.182064959386, 4998.100341938486, 5032.446430892672, 4998.325226094431, 5009.223570346602, 5018.0, 5024.196128619549, 5070.366204224472, 4879.39007624047, 4886.975565122151, 4891.144049791201, 4924.72913989734, 4937.061958227925, 4852.126617208936, 4960.925586116284, 5003.44962054181, 5020.548150666457, 5035.16919708244, 4881.438634557071, 4909.1899836528, 4911.557959783637, 4916.459189489082, 4960.156773348612], "value": 4723.047778201124, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.4046961194823, 572.6907469966216, 578.6354596604139, 585.3765739487449, 600.0309500157246, 26950.0, 39477.80261098694, 40504.189916201656, 40556.797216013954, 40591.59408405915, 41643.37534936978, 41972.58027419725, 41990.37014444786, 42112.0, 42142.7892860536, 7898.684052637887, 8038.517688938653, 8052.396070294722, 8052.798680033016, 8056.315213206884, 7858.960705196495, 7937.126916039231, 7951.204879512032, 7958.562279074648, 7960.084590272106, 7961.0, 8013.398995075364, 8014.67941282348, 8015.278624923756, 8017.679292828309, 7947.324477419426, 7986.920130798676, 7988.840223195532, 7990.081140668839, 7995.360371170293, 7889.447738658297, 7940.1265860755275, 7951.085625153066, 7961.840763184704, 7962.840743185162, 38454.615453845385, 38927.610723892685, 38929.22141557181, 38942.415863762064, 38944.80527597344, 3191.48936170214, 3296.538484612156, 3347.0, 3438.6905178534053, 3638.399664055428, 29575.0, 29621.555676664866, 29732.256693582618, 29849.25376865596, 30771.69228307733, 3490.7905525668543, 3535.9116022099397, 3536.5932917714536, 3560.0743806610208, 3669.0460480275055, 237485.0, 238061.0, 238441.80779096167, 239107.0, 239354.0, 31166.0, 32057.67942320547, 32075.198120047186, 51519.74240128775, 51814.0, 33492.49761253583, 33725.494117588256, 33754.831225843714, 33757.83121084379, 33760.32479350399, 12359.196652217757, 12420.254784712766, 12488.438020289108, 12549.74900502003, 12589.43347549344, 10169.644062457779, 10191.082802547806, 10233.283670143019, 10301.639442619622, 10302.02130797573, 7859.331956783737, 7908.3277921376175, 7934.75490612531, 7967.880481792778, 8006.0, 3114.377124575094, 3125.1718294651937, 3135.1848519384666, 3142.905712828619, 3156.842157892096, 824.2293455619016, 850.8348941936111, 871.1854416120947, 934.6635211323918, 961.4615815143542, 26750.0, 26993.0552430664, 27247.591286130722, 27330.770115344858, 28165.15504534867, 807.4186585658316, 963.3545524498603, 966.2221911361421, 967.9062659195065, 971.9951400243095, 14358.210298433687, 14964.700705985819, 14979.70040599182, 14989.775153372708, 15200.163990980602, 379412.0, 381097.0, 382888.0, 383420.0, 383689.0, 49389.50610493849, 49717.25424118641, 49719.0, 49801.50198498041, 49859.50140498549, 1053.3627155570923, 1159.3275899977994, 1210.7820592293297, 1211.1642966353188, 1212.442276552778, 27704.307392315353, 28869.855650721613, 29390.265243369086, 29424.0, 29923.251918702208, 41463.58536414597, 41559.7922010388, 41868.58131418647, 41979.0, 42033.57966420297, 275616.0, 283535.0, 283576.0, 283693.0, 283764.0, 20578.27976020832, 20951.790482094984, 21034.0, 21954.231601894495, 24139.0, 39013.414798778605, 41913.37129943114, 42332.0, 42592.36111458269, 42765.14469710651, 35990.4601430984, 36153.819230903675, 36406.45390319201, 36693.449598255516, 36984.815075924445, 32090.35819283648, 33128.337433250716, 33371.16572085717, 34668.47997280093, 35659.643403565635, 34379.0, 34718.0, 34930.65069349274, 34934.47598285977, 36558.26883462369, 26823.329416764736, 28164.85917570399, 30116.247093821952, 30142.397152056397, 30190.245243869078, 23903.402414939766, 24823.50352992966, 24868.0, 25064.624030639192, 25247.0], "value": 16137.402908564081, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.99266014679705, 376.4560210495834, 377.52243412083703, 379.2225936829499, 381.1348239496343, 15960.441384551543, 16970.91514542427, 17043.659126817456, 17328.480145595622, 17405.91297043516, 15900.840991590081, 16573.337066517353, 17014.149292535385, 17124.914375428107, 17140.314387424518, 5035.521625445586, 5170.1727723564045, 5175.456577059411, 5212.609054320922, 5240.711760853171, 3789.2042671039117, 3891.182851601167, 3980.9402858957137, 5063.8480845574695, 5664.575156863251, 5952.345242023374, 6027.095935609672, 6052.485538729214, 6058.091286307045, 6061.484773794233, 5810.721641238921, 5997.280326360843, 6006.429389208019, 6010.068439391857, 6013.278406591216, 3377.1725927148004, 3544.4506101554302, 3546.5034895114704, 5251.658642188246, 5279.472052794728, 18061.7290740639, 19840.40478785624, 20066.0, 21279.680804787942, 21324.253651122137, 2008.648486514854, 2143.721316228896, 2156.805887470135, 2464.0, 2522.382016405992, 12809.935950320189, 12948.935255323757, 13441.932790335986, 13476.708959476815, 14005.369758360897, 1760.8656591267563, 1858.438911314489, 1863.4782260966952, 1866.2721538599958, 1871.9064046797741, 42791.14417711659, 43094.353584696255, 43232.0, 58087.0, 67385.3261467379, 9314.394564353295, 9410.0, 9588.808223835484, 9671.226301895973, 9678.806423871623, 12960.67598310031, 13059.804102938464, 13082.738345233041, 13082.934585327013, 13086.411111500005, 7016.2632923543315, 7019.5788252705, 7073.186583542855, 7412.4070074394995, 7438.070241219848, 7195.748148814766, 7257.45569082321, 7395.85208295831, 7400.074990626172, 7429.814254643569, 5898.675572843449, 6060.121282414026, 6111.113888486145, 6147.754089836446, 6149.938500614937, 1568.709788689096, 1627.1050921992858, 1674.6901823162755, 1689.2651696512057, 1720.1485264793757, 682.8019874236516, 798.4610387988084, 848.2026894718945, 863.0894406401181, 925.1997022575424, 17132.486025419257, 17135.143242837807, 17143.0, 17580.12099395025, 18036.36872709449, 879.784452809053, 880.2737741363401, 894.9418287811271, 911.9817603648023, 912.0879120879121, 9576.569054392568, 10040.748981275527, 10217.540210690388, 10217.846732299022, 10263.58945642166, 394442.0, 395399.0, 413181.0, 414083.0, 414593.0, 43928.78035609802, 51942.74028629833, 56802.14796778052, 70132.64933675299, 71510.0, 900.5902314446911, 925.6390007896925, 926.0369216015404, 939.154760715348, 946.3091942881734, 15670.294836732603, 15753.13357765334, 15845.366185352457, 15863.920680396524, 16209.837901620833, 34643.653563464046, 35729.0, 37475.315585551805, 39076.609233908435, 39821.0, 46273.3059004122, 48079.75960120317, 48229.75885120552, 54806.72596637151, 55797.0, 7021.543599666005, 7221.241769614115, 7388.704451821867, 7490.588017659081, 7491.925080749123, 8584.313254939714, 10314.638987635397, 10553.472326383804, 10638.468076596295, 10722.839157412802, 9193.86209206849, 9304.553961322521, 9389.877317434328, 9422.057794220524, 9536.380135291183, 9436.575354109218, 9530.142287194185, 9557.569909353957, 9622.759431014281, 9686.467244301632, 5600.4959553640365, 6358.459530939922, 9585.952070239884, 9714.611415543299, 9778.9022109778, 7376.225496322809, 7387.039684840936, 7392.149902761252, 7437.8140546486775, 7608.771736847903, 5438.619296649196, 9515.096065873731, 9660.32377733552, 9835.803283934425, 10207.336523125972], "value": 8068.921193713827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.2349167008128, 1387.4519564771913, 1416.5396246219977, 1511.712774572831, 1708.2142214581293, 6826.761063362784, 7377.778666639996, 7642.96178519108, 7868.213178682143, 7883.566403847801, 8007.479513831611, 8024.157463466339, 8060.5566693831815, 8093.554854483001, 8097.433179677425, 1930.94207173785, 2179.585878683049, 2206.1837120265523, 2207.139215705876, 2208.205046183373, 2175.8368122390807, 2266.5240299537118, 2270.4550907782095, 2280.281711260956, 2280.7719228077226, 2241.1371621925514, 2246.921357752479, 2256.5035692147785, 2256.582532231534, 2289.3360925331635, 1941.2817257614772, 2159.946001349963, 2255.0979608156704, 2265.0600000999566, 2265.546890621882, 2257.559775843711, 2298.5058212484228, 2300.5398920215857, 2302.0, 2304.723433188028, 8007.519548827089, 8057.0, 8063.516189028677, 8069.757907262791, 8072.717454889051, 4593.5406459354135, 4721.079389519045, 4722.362481065046, 4722.858314250578, 4734.502877197879, 2960.955585666217, 3107.0989413070183, 3112.081935828936, 3144.638366587849, 3149.2126968257935, 961.6489981156898, 998.1316254858248, 998.9450580218086, 1000.164862339947, 1040.8022475729663, 10681.092107170978, 10728.409937453436, 10736.838947415796, 10847.620333288376, 10922.453877306103, 4203.222403855297, 4399.450068741407, 4400.3399490076745, 4471.821127154943, 4472.08322293929, 9240.8613870792, 9292.767680808034, 9294.25645948336, 9297.628094876265, 9315.673951411804, 4749.311349854321, 4749.952500474951, 4760.7619619018915, 4763.04739052191, 4765.237561990065, 3761.4545890845675, 4100.528439229467, 4192.832286708558, 4246.63903568194, 4277.743335399824, 3658.1951970566433, 3724.478572999782, 3745.9063523411587, 3760.341940160461, 3770.7737535747942, 1197.2636828350676, 1217.6347095871204, 1228.5392977633387, 1231.445849367788, 1246.4702501436852, 838.1911455445525, 840.1934143222575, 841.1882533355341, 873.7902903303288, 888.4669198480989, 5171.81898633546, 5469.398366179717, 5508.3114610673665, 5540.612157148961, 5621.0, 429.9333603291495, 437.52309982119004, 441.34680672604725, 903.2277402820625, 935.1350001248818, 3615.837287322077, 3632.582253040934, 3872.5352957645264, 3875.4380614810693, 3886.0479182600443, 9628.951855240819, 9645.035496450439, 9894.752631184134, 10039.899601004043, 10048.748781280381, 9865.75335616601, 9944.950275248577, 9961.252906032076, 9982.650607228712, 9996.250281228937, 7348.301911318416, 7659.0, 7661.578613176329, 7661.77014689549, 7664.156942736406, 5375.462453754593, 5412.134058550613, 5485.232067510472, 5560.694161821139, 5703.5722320826935, 8760.4305720128, 8967.910320896968, 9190.724278271662, 9194.448333100036, 9199.35604507678, 8876.11238876133, 9184.816303674022, 9196.954015229881, 9200.401973871676, 9457.43255404678, 5929.229200203946, 6077.179580756541, 6239.344868788712, 6825.726970921306, 6990.580565166107, 7667.539947603162, 7675.692972281046, 7710.306072453506, 7758.7672369829, 7766.5728384939375, 6553.770618028346, 6628.635425051669, 6680.365365290289, 6772.018057381751, 6776.186857577122, 6526.282108968105, 6608.140941677551, 6672.83317917056, 6703.195616526048, 6755.763548275787, 6574.309697481887, 6579.342065793382, 6689.331066893272, 6690.565113267622, 6693.230278518033, 4645.117427688729, 4665.463471700662, 4741.952580474289, 4806.735629540409, 4806.951930480651, 4685.882852928704, 4832.081904438145, 4852.078105160008, 4885.609151267819, 4886.315915771724], "value": 4203.566991664593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.27613261707745, 301.502520840613, 308.1679465443302, 311.9578856854324, 312.99687003129964, 4795.96886669366, 4830.2754586812, 4853.272009198622, 4865.951340486598, 4893.632977526682, 4540.274695615662, 4775.164346239411, 4780.8565743027675, 4802.23164293713, 4828.179209534379, 3795.5635101963353, 3805.752626079303, 3807.3146833570086, 3813.2373525294915, 3813.6949044076546, 3796.8481260749536, 3803.4484999675033, 3810.428435734634, 3812.0850995760957, 3819.828107735145, 3651.1054791576103, 3718.2005868738215, 3737.906552336186, 3763.5886542546546, 3778.414345776409, 3727.329080765461, 3738.345789486856, 3740.3080430120513, 3745.4381842723537, 3745.9812700936595, 3278.557394751702, 3280.7047365736958, 3287.964291248249, 3288.6875746804253, 3314.3371325734947, 4658.510856360067, 4667.486576476619, 4672.20572502672, 4707.764611769432, 4711.222648263032, 4033.193361327746, 4207.412441348579, 4224.725392849455, 4245.830166793325, 4268.381084742695, 4925.556699897026, 4968.0, 4968.807486203321, 5008.373953255843, 5046.26829109777, 3538.5399898013093, 3543.8228088595465, 3551.3074950384685, 3553.7867727936405, 3559.555055618048, 5089.389273287192, 5247.658902171384, 5254.842354729364, 5283.841484755463, 5323.494268044529, 3666.1201311685004, 3686.870959516404, 3689.9077523062138, 3693.5567731872347, 3699.630036996333, 3721.218544105714, 3725.925481490355, 3739.85040598373, 3740.8129593520216, 3767.679747221462, 4282.357646353072, 4292.806823692941, 4316.2446571849805, 4318.287482565342, 4323.200207961474, 4955.40535135786, 5053.393592768891, 5067.1639179535705, 5077.593792496666, 5111.693298402108, 1281.9551315703904, 1284.0818814547642, 1287.1311864491431, 1296.8652429124515, 1301.8958483321312, 796.8047828282108, 807.5679511461458, 816.77946954322, 831.4969443486724, 841.7373939091362, 4016.658584020391, 4031.959680403217, 4049.1778699585307, 4050.696197785119, 4057.5739547347694, 4539.818407263739, 4580.24425969718, 4600.907981840344, 4621.329907163443, 4633.351330813689, 4037.425404092406, 4044.3326851069246, 4049.311617025113, 4063.0700417301546, 4077.6330130288416, 2467.605183170684, 2519.7480251974657, 2738.8082834201414, 2764.14311563416, 2788.8884444622395, 4866.416030076413, 4884.5603895649565, 4893.241547560134, 4899.706017638953, 4903.901921961541, 5081.923771143436, 5256.6057545684225, 5278.947210527922, 5341.305630268041, 5350.946490535122, 4581.65637577183, 4690.788914498856, 4889.584385327287, 4901.215805471107, 4910.8281210157475, 5107.719075450886, 5162.793488260428, 5180.274761533464, 5185.22221666753, 5187.19598462239, 4917.9016419672125, 5091.821786237464, 5101.362329708786, 5104.310918026019, 5121.641485096007, 4632.305154226893, 4777.95222047775, 4778.737169455713, 4833.927491087707, 4838.250071238964, 3657.762245454037, 3676.5771936227675, 3678.6873115785456, 3689.686376658014, 3692.5599016383094, 5017.899642007066, 5131.640785145004, 5149.330587023663, 5177.928828468643, 5203.661761985459, 4939.5554400104165, 4967.726775027409, 4976.2286845539, 4978.7510624467905, 4979.128652485728, 4970.850874473772, 4982.636720213914, 5010.148274793367, 5018.42288136869, 5026.296318515484, 4731.29030645406, 4886.65793394459, 4901.754912254301, 4916.287138364845, 4928.310036594808, 5044.974775126101, 5053.519915608012, 5059.468755780737, 5063.544281014726, 5070.163423035158, 4871.756412179448, 4928.0, 4981.62637802159, 5010.874728131826, 5014.323066385991], "value": 3754.0002752815003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.7846671365093, 644.3846126948764, 679.0968012543315, 705.2630001648278, 736.1497470421663, 12451.696436159305, 12664.936675316621, 12748.745025099492, 12828.166169198996, 12847.357632118403, 12949.41727622257, 13094.0, 13652.249126298075, 13658.931705341483, 14159.575212743608, 613.6747523812387, 799.496317320089, 801.4149670740363, 804.1435870797582, 805.6938363421891, 767.17528656694, 798.1101072304368, 804.6499772598909, 807.563915485637, 807.6850028488894, 842.0653075086649, 843.1273631791097, 845.1126317366771, 846.3863698818338, 846.7586737779734, 641.7753786174848, 790.4032455496122, 832.9666813327459, 833.4832403909554, 833.9791505212388, 610.3774150366601, 613.3039000734154, 613.3712944232153, 613.5613036678751, 614.1064750787593, 13362.599122026355, 13402.865971340358, 13411.664708382368, 13442.0, 13450.798238026437, 12290.139690221687, 12646.49414023438, 12852.548737615867, 12902.290374029424, 13049.86950130496, 11828.645140645795, 11976.461059252355, 12003.63989080329, 12075.516979320817, 12473.376331183405, 4128.298189307825, 4172.916541669149, 4277.529471758104, 4373.562643735601, 4374.12517496502, 69336.95994560035, 69722.0, 69792.0, 69871.0, 70009.0, 9729.173020293212, 9957.950210248902, 10000.79998400028, 10021.79956400868, 10041.0, 18734.718979215322, 18759.968201749034, 18765.155567999474, 18777.0, 18820.81179188218, 6631.86736265272, 6899.724011039602, 7040.119985001875, 7040.612766297801, 7049.154101507852, 3428.9314213715584, 3480.912977175591, 3545.503629491873, 3574.91062723434, 3837.5586807516934, 2844.4737723521216, 3329.417351963397, 3522.2427178156818, 3534.4874993125854, 3552.5914519830035, 570.8858228354263, 571.6255852416674, 573.5211098732605, 577.5783677915061, 578.531389574446, 466.2702870008426, 543.7943324104383, 559.574723210363, 564.1396869773546, 572.3360901354409, 7178.066851309296, 7183.102112235971, 7328.450366222554, 7896.565688887166, 8193.09875913649, 509.9133147364957, 531.2933798048587, 562.9324481062299, 571.9799807006734, 572.5934586443589, 3738.5887552369218, 3775.3770627846648, 3857.3828187489867, 3868.516435445569, 3873.4577159197734, 95466.5226673876, 95702.52148739212, 96377.5181124104, 96552.51723741337, 96938.51530742302, 88039.0, 89479.0, 90057.0, 90278.0, 90422.54788726146, 63378.999999999076, 69743.0, 75049.0, 78689.67206803567, 79815.20184798077, 7923.7226697065325, 8020.0, 8071.954569703412, 8184.468009579358, 8237.176282371714, 41175.794121029205, 41862.79068604638, 42141.157176856905, 43228.56771432245, 43652.56347436485, 57824.71087644535, 61174.0, 62794.37205628068, 63184.0, 64094.0, 11232.494537745657, 11262.436878156223, 11433.256838305484, 11480.885191147981, 11501.309921404743, 12406.875931240933, 12579.93710031444, 12849.743005140032, 13224.867751322363, 13717.519886803913, 11759.588414405454, 12130.211536250115, 12224.755504889674, 12227.510899563918, 12489.750204995667, 11272.718182045186, 11532.423378831192, 11572.6528204154, 11682.357470339213, 11735.178537502294, 11083.72290692739, 11390.202685811913, 11662.183647144619, 11762.58830940913, 11795.053816120244, 9315.6273749052, 9942.105210530797, 10048.84926726085, 10050.597976080875, 10207.948960255151, 8580.957095214484, 8782.165694259034, 9172.621789062563, 9180.806495155586, 9676.56455459492], "value": 6641.303296445568, "unit": "score"}], "name": "dromaeo_css", "value": 6332.09029530776, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 115.0, 112.0, 113.0, 114.0, 112.0, 114.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 139.0, 132.0, 185.0, 131.0, 163.0, 156.0, 141.0, 209.0, 132.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 164.0, 161.0, 162.0, 164.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 110.0, 76.0, 78.0, 77.0, 76.0, 105.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 117.0, 85.0, 86.0, 85.0, 117.0, 86.0, 86.0, 125.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 91.0, 84.0, 89.0, 116.0, 84.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 148.0, 131.0, 142.0, 128.0, 129.0, 130.0, 142.0, 139.0, 134.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 167.0, 180.0, 172.0, 171.0, 169.0, 167.0, 170.0, 169.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 68.0, 67.0, 67.0, 72.0, 71.0, 70.0, 74.0, 67.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1559.5000000000002, "alertThreshold": 2.0}]} 05:31:00 INFO - Return code: 0 05:31:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:00 INFO - # TBPL SUCCESS # 05:31:00 INFO - Running post-action listener: _resource_record_post_action 05:31:00 INFO - ##### 05:31:00 INFO - ##### Finished run-tests step (success) 05:31:00 INFO - ##### 05:31:00 INFO - Running post-run listener: _resource_record_post_run 05:31:00 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 550391808; Read time: 180; Write time: 419952 05:31:00 INFO - TinderboxPrint: CPU usage
13.2% 05:31:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 05:31:00 INFO - TinderboxPrint: I/O write bytes / time
550,391,808 / 419,952 05:31:00 INFO - TinderboxPrint: CPU idle
8,328.9 (86.8%) 05:31:00 INFO - TinderboxPrint: CPU user
1,216.4 (12.7%) 05:31:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254177280; Read time: 0; Write time: 239084 05:31:00 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296214528; Read time: 180; Write time: 180868 05:31:01 INFO - Running post-run listener: _upload_blobber_files 05:31:01 INFO - Blob upload gear active. 05:31:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:01 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 05:31:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:05 INFO - (blobuploader) - INFO - Done attempting. 05:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:06 INFO - (blobuploader) - INFO - Done attempting. 05:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:08 INFO - (blobuploader) - INFO - Done attempting. 05:31:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:08 INFO - Return code: 0 05:31:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5df4d08fe4b16385758f4c22ccf688657410cd11bf46615bad6d316b9b8bd491ce99634989f9f466a13e294d3b75d46bd9323f87c61c089c524ce79975e07b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b858659b5502434fc5a2b9d222a4fa83d07b195f8a67c2e2f0027ca6db7db9e0d7d18828ef5a940622db3810cd3e39c18eb2e5af78115f1fe86dfd2a5b0b559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02d3a1951e7419dc624e726173f24a69ee981e461d13e3a71c3f7d073a243850816e0e06ac8027093aaaeb4f1f8d1db68e9fe4f713341843539dbb431b5b1d07"} 05:31:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:08 INFO - Contents: 05:31:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5df4d08fe4b16385758f4c22ccf688657410cd11bf46615bad6d316b9b8bd491ce99634989f9f466a13e294d3b75d46bd9323f87c61c089c524ce79975e07b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b858659b5502434fc5a2b9d222a4fa83d07b195f8a67c2e2f0027ca6db7db9e0d7d18828ef5a940622db3810cd3e39c18eb2e5af78115f1fe86dfd2a5b0b559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02d3a1951e7419dc624e726173f24a69ee981e461d13e3a71c3f7d073a243850816e0e06ac8027093aaaeb4f1f8d1db68e9fe4f713341843539dbb431b5b1d07"} 05:31:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:08 INFO - Copying logs to upload dir... 05:31:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.692360 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-14 05:31:08.439594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 05:31:08.444012) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841 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-Non-PGO/sha512/5df4d08fe4b16385758f4c22ccf688657410cd11bf46615bad6d316b9b8bd491ce99634989f9f466a13e294d3b75d46bd9323f87c61c089c524ce79975e07b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b858659b5502434fc5a2b9d222a4fa83d07b195f8a67c2e2f0027ca6db7db9e0d7d18828ef5a940622db3810cd3e39c18eb2e5af78115f1fe86dfd2a5b0b559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02d3a1951e7419dc624e726173f24a69ee981e461d13e3a71c3f7d073a243850816e0e06ac8027093aaaeb4f1f8d1db68e9fe4f713341843539dbb431b5b1d07"} build_url:https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/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-Non-PGO/sha512/5df4d08fe4b16385758f4c22ccf688657410cd11bf46615bad6d316b9b8bd491ce99634989f9f466a13e294d3b75d46bd9323f87c61c089c524ce79975e07b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b858659b5502434fc5a2b9d222a4fa83d07b195f8a67c2e2f0027ca6db7db9e0d7d18828ef5a940622db3810cd3e39c18eb2e5af78115f1fe86dfd2a5b0b559", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02d3a1951e7419dc624e726173f24a69ee981e461d13e3a71c3f7d073a243850816e0e06ac8027093aaaeb4f1f8d1db68e9fe4f713341843539dbb431b5b1d07"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 05:31:08.472531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:31:08.472891) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465906109.969709-1492593841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:31:08.552226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 05:31:08.555021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 05:31:08.555368) ========= ========= Total master_lag: 0.44 =========