builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1469827180.4 results: success (0) buildid: 20160729113002 builduid: e2158d3311074fa3a62f759012f90158 revision: fc777f42356960dad649f977452d22d05e0154d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.399015) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.399536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.399846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.417358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.417772) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 14:19:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.2M=0s 2016-07-29 14:19:40 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.528963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.529353) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.579417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:40.579820) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc777f42356960dad649f977452d22d05e0154d9 --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 fc777f42356960dad649f977452d22d05e0154d9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 14:19:40,621 truncating revision to first 12 chars 2016-07-29 14:19:40,621 Setting DEBUG logging. 2016-07-29 14:19:40,621 attempt 1/10 2016-07-29 14:19:40,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc777f423569?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 14:19:40,950 unpacking tar archive at: fx-team-fc777f423569/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645305 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:41.239248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:41.239596) ========= script_repo_revision: fc777f42356960dad649f977452d22d05e0154d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:41.240058) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:41.240359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 14:19:41.251370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-29 14:19:41.251782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:19:41 INFO - MultiFileLogger online at 20160729 14:19:41 in /builds/slave/test 14:19:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:19:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:19:41 INFO - {'append_to_log': False, 14:19:41 INFO - 'base_work_dir': '/builds/slave/test', 14:19:41 INFO - 'blob_upload_branch': 'Fx-Team', 14:19:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:19:41 INFO - 'branch': 'Fx-Team', 14:19:41 INFO - 'buildbot_json_path': 'buildprops.json', 14:19:41 INFO - 'config_files': ('talos/linux_config.py',), 14:19:41 INFO - 'default_actions': ('clobber', 14:19:41 INFO - 'read-buildbot-config', 14:19:41 INFO - 'download-and-extract', 14:19:41 INFO - 'populate-webroot', 14:19:41 INFO - 'create-virtualenv', 14:19:41 INFO - 'install', 14:19:41 INFO - 'run-tests'), 14:19:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:19:41 INFO - 'download_minidump_stackwalk': True, 14:19:41 INFO - 'download_symbols': 'ondemand', 14:19:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:19:41 INFO - 'tooltool.py': '/tools/tooltool.py', 14:19:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:19:41 INFO - '/tools/misc-python/virtualenv.py')}, 14:19:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:19:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:19:41 INFO - 'installer_path': 'installer.exe', 14:19:41 INFO - 'log_level': 'info', 14:19:41 INFO - 'log_name': 'talos', 14:19:41 INFO - 'log_to_console': True, 14:19:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:19:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:19:41 INFO - 'opt_config_files': (), 14:19:41 INFO - 'pip_index': False, 14:19:41 INFO - 'sps_profile': False, 14:19:41 INFO - 'sps_profile_interval': 0, 14:19:41 INFO - 'suite': 'dromaeojs-e10s', 14:19:41 INFO - 'system_bits': '32', 14:19:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:19:41 INFO - 'title': 'talos-linux64-ix-010', 14:19:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:19:41 INFO - 'use_talos_json': True, 14:19:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:19:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:19:41 INFO - 'work_dir': 'build'} 14:19:41 INFO - [mozharness: 2016-07-29 21:19:41.389954Z] Running clobber step. 14:19:41 INFO - Running pre-action listener: _resource_record_pre_action 14:19:41 INFO - Running main action method: clobber 14:19:41 INFO - rmtree: /builds/slave/test/build 14:19:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:19:41 INFO - Running post-action listener: _resource_record_post_action 14:19:41 INFO - [mozharness: 2016-07-29 21:19:41.865020Z] Finished clobber step (success) 14:19:41 INFO - [mozharness: 2016-07-29 21:19:41.865125Z] Running read-buildbot-config step. 14:19:41 INFO - Running pre-action listener: _resource_record_pre_action 14:19:41 INFO - Running main action method: read_buildbot_config 14:19:41 INFO - Using buildbot properties: 14:19:41 INFO - { 14:19:41 INFO - "project": "", 14:19:41 INFO - "product": "firefox", 14:19:41 INFO - "script_repo_revision": "production", 14:19:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:19:41 INFO - "repository": "", 14:19:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:19:41 INFO - "buildid": "20160729113002", 14:19:41 INFO - "pgo_build": "True", 14:19:41 INFO - "basedir": "/builds/slave/test", 14:19:41 INFO - "buildnumber": 654, 14:19:41 INFO - "slavename": "talos-linux64-ix-010", 14:19:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:19:41 INFO - "platform": "ubuntu64_hw", 14:19:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:19:41 INFO - "branch": "fx-team", 14:19:41 INFO - "repo_path": "integration/fx-team", 14:19:41 INFO - "revision": "fc777f42356960dad649f977452d22d05e0154d9", 14:19:41 INFO - "stage_platform": "linux64-pgo", 14:19:41 INFO - "builduid": "e2158d3311074fa3a62f759012f90158", 14:19:41 INFO - "slavebuilddir": "test" 14:19:41 INFO - } 14:19:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:19:41 INFO - Running post-action listener: _resource_record_post_action 14:19:41 INFO - [mozharness: 2016-07-29 21:19:41.867648Z] Finished read-buildbot-config step (success) 14:19:41 INFO - [mozharness: 2016-07-29 21:19:41.867737Z] Running download-and-extract step. 14:19:41 INFO - Running pre-action listener: _resource_record_pre_action 14:19:41 INFO - Running main action method: download_and_extract 14:19:41 INFO - mkdir: /builds/slave/test/build/tests 14:19: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')]} 14:19:41 INFO - https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:19:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:19:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:19:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:42 INFO - Downloaded 1361 bytes. 14:19:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:19:42 INFO - Using the following test package requirements: 14:19:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:19:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:19:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:19:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'jsshell-linux-x86_64.zip'], 14:19:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:19:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:19:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:19:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:19:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:19:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:19:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:19:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:19:42 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')]} 14:19:42 INFO - https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:19:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:19:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:19:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:43 INFO - Downloaded 24329921 bytes. 14:19:43 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'] 14:19:43 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 14:19:45 INFO - Return code: 0 14:19:45 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 14:19:45 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')]} 14:19:45 INFO - https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:19:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:19:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:19:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:46 INFO - Downloaded 24329921 bytes. 14:19:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:19:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:19:47 INFO - Return code: 0 14:19: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')]} 14:19:47 INFO - https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:19:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:19:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:19:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:48 INFO - Downloaded 14413725 bytes. 14:19:48 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'] 14:19:48 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 14:19:48 INFO - Return code: 0 14:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:48 INFO - https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GvL79jfSSnOj2lAeIqCqOg/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 14:19:50 INFO - Downloaded 61011394 bytes. 14:19:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:19:50 INFO - mkdir: /builds/slave/test/properties 14:19:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:19:50 INFO - Writing to file /builds/slave/test/properties/build_url 14:19:50 INFO - Contents: 14:19:50 INFO - build_url:https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:19:51 INFO - Running post-action listener: _resource_record_post_action 14:19:51 INFO - Running post-action listener: set_extra_try_arguments 14:19:51 INFO - [mozharness: 2016-07-29 21:19:51.669851Z] Finished download-and-extract step (success) 14:19:51 INFO - [mozharness: 2016-07-29 21:19:51.670086Z] Running populate-webroot step. 14:19:51 INFO - Running pre-action listener: _resource_record_pre_action 14:19:51 INFO - Running main action method: populate_webroot 14:19:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:19:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:19:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:19:51 INFO - '--tppagecycles', 14:19:51 INFO - '7'], 14:19:51 INFO - 'tests': ['tsvgm']}}, 14:19:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:19:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:19:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:19:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:19:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:19:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['damp', 'tps']}, 14:19:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'tests': ['damp', 'tps']}, 14:19:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['dromaeo_dom']}, 14:19:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:19:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['basic_compositor_video']}, 14:19:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:19:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['a11yr', 14:19:51 INFO - 'ts_paint', 14:19:51 INFO - 'tpaint', 14:19:51 INFO - 'sessionrestore', 14:19:51 INFO - 'sessionrestore_no_auto_restore', 14:19:51 INFO - 'tabpaint']}, 14:19:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:19:51 INFO - 'ts_paint', 14:19:51 INFO - 'tpaint', 14:19:51 INFO - 'sessionrestore', 14:19:51 INFO - 'sessionrestore_no_auto_restore', 14:19:51 INFO - 'tabpaint']}, 14:19:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:19:51 INFO - 'ts_paint', 14:19:51 INFO - 'tpaint', 14:19:51 INFO - 'sessionrestore', 14:19:51 INFO - 'sessionrestore_no_auto_restore', 14:19:51 INFO - 'tabpaint']}, 14:19:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:19:51 INFO - 'ts_paint', 14:19:51 INFO - 'tpaint', 14:19:51 INFO - 'sessionrestore', 14:19:51 INFO - 'sessionrestore_no_auto_restore', 14:19:51 INFO - 'tabpaint']}, 14:19:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['a11yr', 14:19:51 INFO - 'ts_paint', 14:19:51 INFO - 'tpaint', 14:19:51 INFO - 'sessionrestore', 14:19:51 INFO - 'sessionrestore_no_auto_restore', 14:19:51 INFO - 'tabpaint']}, 14:19:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['a11yr', 14:19:51 INFO - 'ts_paint', 14:19:51 INFO - 'tpaint', 14:19:51 INFO - 'sessionrestore', 14:19:51 INFO - 'sessionrestore_no_auto_restore', 14:19:51 INFO - 'tabpaint']}, 14:19:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['tsvgx', 14:19:51 INFO - 'tsvgr_opacity', 14:19:51 INFO - 'tart', 14:19:51 INFO - 'tscrollx', 14:19:51 INFO - 'cart']}, 14:19:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:19:51 INFO - 'tsvgr_opacity', 14:19:51 INFO - 'tart', 14:19:51 INFO - 'tscrollx', 14:19:51 INFO - 'cart']}, 14:19:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'talos_options': ['--disable-e10s'], 14:19:51 INFO - 'tests': ['tp5o']}, 14:19:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'tests': ['tp5o']}, 14:19:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'talos_options': ['--disable-e10s', 14:19:51 INFO - '--xperf_path', 14:19:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:51 INFO - 'tests': ['tp5n']}, 14:19:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:19:51 INFO - 'talos_options': ['--xperf_path', 14:19:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:19:51 INFO - 'tests': ['tp5n']}}, 14:19:51 INFO - 'talos.zip': {'path': '', 14:19:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:19:51 INFO - Running post-action listener: _resource_record_post_action 14:19:51 INFO - [mozharness: 2016-07-29 21:19:51.685451Z] Finished populate-webroot step (success) 14:19:51 INFO - [mozharness: 2016-07-29 21:19:51.685541Z] Running create-virtualenv step. 14:19:51 INFO - Running pre-action listener: _resource_record_pre_action 14:19:51 INFO - Running main action method: create_virtualenv 14:19:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:19:51 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 14:19:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:19:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:19:51 INFO - Using real prefix '/usr' 14:19:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:19:52 INFO - Installing distribute.............................................................................................................................................................................................done. 14:19:54 INFO - Installing pip.................done. 14:19:54 INFO - Return code: 0 14:19:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:54 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:19:54 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 14:19:54 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 14:19:54 INFO - Using env: {'DISPLAY': ':0', 14:19:54 INFO - 'HOME': '/home/cltbld', 14:19:54 INFO - 'LANG': 'en_US.UTF-8', 14:19:54 INFO - 'LANGUAGE': 'en_US:en', 14:19:54 INFO - 'LOGNAME': 'cltbld', 14:19:54 INFO - 'MAIL': '/var/mail/cltbld', 14:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:54 INFO - 'MOZ_NO_REMOTE': '1', 14:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:54 INFO - 'NO_EM_RESTART': '1', 14:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:54 INFO - 'PWD': '/builds/slave/test', 14:19:54 INFO - 'SHELL': '/bin/bash', 14:19:54 INFO - 'SHLVL': '1', 14:19:54 INFO - 'TERM': 'linux', 14:19:54 INFO - 'TMOUT': '86400', 14:19:54 INFO - 'USER': 'cltbld', 14:19:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:54 INFO - '_': '/tools/buildbot/bin/python'} 14:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:54 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 14:19:54 INFO - Cleaning up... 14:19:54 INFO - Return code: 0 14:19:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:54 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:19:54 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 14:19:54 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 14:19:54 INFO - Using env: {'DISPLAY': ':0', 14:19:54 INFO - 'HOME': '/home/cltbld', 14:19:54 INFO - 'LANG': 'en_US.UTF-8', 14:19:54 INFO - 'LANGUAGE': 'en_US:en', 14:19:54 INFO - 'LOGNAME': 'cltbld', 14:19:54 INFO - 'MAIL': '/var/mail/cltbld', 14:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:54 INFO - 'MOZ_NO_REMOTE': '1', 14:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:54 INFO - 'NO_EM_RESTART': '1', 14:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:54 INFO - 'PWD': '/builds/slave/test', 14:19:54 INFO - 'SHELL': '/bin/bash', 14:19:54 INFO - 'SHLVL': '1', 14:19:54 INFO - 'TERM': 'linux', 14:19:54 INFO - 'TMOUT': '86400', 14:19:54 INFO - 'USER': 'cltbld', 14:19:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:54 INFO - '_': '/tools/buildbot/bin/python'} 14:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:54 INFO - Downloading/unpacking psutil>=3.1.1 14:19:54 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 14:19:54 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 14:19:54 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 14:19:54 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 14:19:54 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 14:19:54 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 14:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:19:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:56 INFO - Installing collected packages: psutil 14:19:56 INFO - Running setup.py install for psutil 14:19:56 INFO - building 'psutil._psutil_linux' extension 14:19:56 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 14:19:56 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 14:19:56 INFO - building 'psutil._psutil_posix' extension 14:19:56 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 14:19:57 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 14:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:19:57 INFO - Successfully installed psutil 14:19:57 INFO - Cleaning up... 14:19:57 INFO - Return code: 0 14:19:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:19:57 INFO - Using env: {'DISPLAY': ':0', 14:19:57 INFO - 'HOME': '/home/cltbld', 14:19:57 INFO - 'LANG': 'en_US.UTF-8', 14:19:57 INFO - 'LANGUAGE': 'en_US:en', 14:19:57 INFO - 'LOGNAME': 'cltbld', 14:19:57 INFO - 'MAIL': '/var/mail/cltbld', 14:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:57 INFO - 'MOZ_NO_REMOTE': '1', 14:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:57 INFO - 'NO_EM_RESTART': '1', 14:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:57 INFO - 'PWD': '/builds/slave/test', 14:19:57 INFO - 'SHELL': '/bin/bash', 14:19:57 INFO - 'SHLVL': '1', 14:19:57 INFO - 'TERM': 'linux', 14:19:57 INFO - 'TMOUT': '86400', 14:19:57 INFO - 'USER': 'cltbld', 14:19:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:57 INFO - '_': '/tools/buildbot/bin/python'} 14:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:19:59 INFO - Installing collected packages: mozsystemmonitor 14:19:59 INFO - Running setup.py install for mozsystemmonitor 14:19:59 INFO - Successfully installed mozsystemmonitor 14:19:59 INFO - Cleaning up... 14:19:59 INFO - Return code: 0 14:19:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:19:59 INFO - Using env: {'DISPLAY': ':0', 14:19:59 INFO - 'HOME': '/home/cltbld', 14:19:59 INFO - 'LANG': 'en_US.UTF-8', 14:19:59 INFO - 'LANGUAGE': 'en_US:en', 14:19:59 INFO - 'LOGNAME': 'cltbld', 14:19:59 INFO - 'MAIL': '/var/mail/cltbld', 14:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:59 INFO - 'MOZ_NO_REMOTE': '1', 14:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:59 INFO - 'NO_EM_RESTART': '1', 14:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:59 INFO - 'PWD': '/builds/slave/test', 14:19:59 INFO - 'SHELL': '/bin/bash', 14:19:59 INFO - 'SHLVL': '1', 14:19:59 INFO - 'TERM': 'linux', 14:19:59 INFO - 'TMOUT': '86400', 14:19:59 INFO - 'USER': 'cltbld', 14:19:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:59 INFO - '_': '/tools/buildbot/bin/python'} 14:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:59 INFO - Downloading/unpacking jsonschema==2.5.1 14:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:20:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:20:01 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 14:20:01 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 14:20:01 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 14:20:01 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 14:20:01 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 14:20:01 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 14:20:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:20:01 INFO - warning: no files found matching '*.txt' 14:20:01 INFO - no previously-included directories found matching 'build' 14:20:01 INFO - no previously-included directories found matching 'dist' 14:20:01 INFO - no previously-included directories found matching '.git*' 14:20:01 INFO - Installing collected packages: jsonschema, functools32 14:20:01 INFO - Running setup.py install for functools32 14:20:02 INFO - warning: no files found matching '*.txt' 14:20:02 INFO - no previously-included directories found matching 'build' 14:20:02 INFO - no previously-included directories found matching 'dist' 14:20:02 INFO - no previously-included directories found matching '.git*' 14:20:02 INFO - Successfully installed jsonschema functools32 14:20:02 INFO - Cleaning up... 14:20:02 INFO - Return code: 0 14:20:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:20:02 INFO - Using env: {'DISPLAY': ':0', 14:20:02 INFO - 'HOME': '/home/cltbld', 14:20:02 INFO - 'LANG': 'en_US.UTF-8', 14:20:02 INFO - 'LANGUAGE': 'en_US:en', 14:20:02 INFO - 'LOGNAME': 'cltbld', 14:20:02 INFO - 'MAIL': '/var/mail/cltbld', 14:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:02 INFO - 'MOZ_NO_REMOTE': '1', 14:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:02 INFO - 'NO_EM_RESTART': '1', 14:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:02 INFO - 'PWD': '/builds/slave/test', 14:20:02 INFO - 'SHELL': '/bin/bash', 14:20:02 INFO - 'SHLVL': '1', 14:20:02 INFO - 'TERM': 'linux', 14:20:02 INFO - 'TMOUT': '86400', 14:20:02 INFO - 'USER': 'cltbld', 14:20:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:02 INFO - '_': '/tools/buildbot/bin/python'} 14:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:20:02 INFO - Cleaning up... 14:20:02 INFO - Return code: 0 14:20:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:20:02 INFO - Using env: {'DISPLAY': ':0', 14:20:02 INFO - 'HOME': '/home/cltbld', 14:20:02 INFO - 'LANG': 'en_US.UTF-8', 14:20:02 INFO - 'LANGUAGE': 'en_US:en', 14:20:02 INFO - 'LOGNAME': 'cltbld', 14:20:02 INFO - 'MAIL': '/var/mail/cltbld', 14:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:02 INFO - 'MOZ_NO_REMOTE': '1', 14:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:02 INFO - 'NO_EM_RESTART': '1', 14:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:02 INFO - 'PWD': '/builds/slave/test', 14:20:02 INFO - 'SHELL': '/bin/bash', 14:20:02 INFO - 'SHLVL': '1', 14:20:02 INFO - 'TERM': 'linux', 14:20:02 INFO - 'TMOUT': '86400', 14:20:02 INFO - 'USER': 'cltbld', 14:20:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:02 INFO - '_': '/tools/buildbot/bin/python'} 14:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:20:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:20:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:20:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 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 14:20:04 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 14:20:05 INFO - Downloading docopt-0.6.1.tar.gz 14:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:20:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:20:05 INFO - Running setup.py install for blobuploader 14:20:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:20:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:20:05 INFO - Running setup.py install for requests 14:20:05 INFO - Running setup.py install for docopt 14:20:05 INFO - Successfully installed blobuploader requests docopt 14:20:05 INFO - Cleaning up... 14:20:05 INFO - Return code: 0 14:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:05 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')]} 14:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:05 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')]} 14:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:05 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:20:05 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 14:20:05 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 14:20:05 INFO - Using env: {'DISPLAY': ':0', 14:20:05 INFO - 'HOME': '/home/cltbld', 14:20:05 INFO - 'LANG': 'en_US.UTF-8', 14:20:05 INFO - 'LANGUAGE': 'en_US:en', 14:20:05 INFO - 'LOGNAME': 'cltbld', 14:20:05 INFO - 'MAIL': '/var/mail/cltbld', 14:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:05 INFO - 'MOZ_NO_REMOTE': '1', 14:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:05 INFO - 'NO_EM_RESTART': '1', 14:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:05 INFO - 'PWD': '/builds/slave/test', 14:20:05 INFO - 'SHELL': '/bin/bash', 14:20:05 INFO - 'SHLVL': '1', 14:20:05 INFO - 'TERM': 'linux', 14:20:05 INFO - 'TMOUT': '86400', 14:20:05 INFO - 'USER': 'cltbld', 14:20:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:05 INFO - '_': '/tools/buildbot/bin/python'} 14:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:05 INFO - Running setup.py (path:/tmp/pip-66RmSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:06 INFO - Running setup.py (path:/tmp/pip-s4ug0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:06 INFO - Running setup.py (path:/tmp/pip-rF14g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:06 INFO - Running setup.py (path:/tmp/pip-WfkzKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:06 INFO - Running setup.py (path:/tmp/pip-MS1Gk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:06 INFO - Running setup.py (path:/tmp/pip-8YK8Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:06 INFO - Running setup.py (path:/tmp/pip-ldzXRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:06 INFO - Running setup.py (path:/tmp/pip-vsSDyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:06 INFO - Running setup.py (path:/tmp/pip-mve_AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:06 INFO - Running setup.py (path:/tmp/pip-EPbS7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:06 INFO - Running setup.py (path:/tmp/pip-fqbhzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:06 INFO - Running setup.py (path:/tmp/pip-Ddq8P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:06 INFO - Running setup.py (path:/tmp/pip-yPfWOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:06 INFO - Running setup.py (path:/tmp/pip-VcftJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:06 INFO - Running setup.py (path:/tmp/pip-JBKSA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:07 INFO - Running setup.py (path:/tmp/pip-zcsFEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:07 INFO - Running setup.py (path:/tmp/pip-jWKrCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:20:07 INFO - Running setup.py install for manifestparser 14:20:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Running setup.py install for mozcrash 14:20:07 INFO - Running setup.py install for mozdebug 14:20:07 INFO - Running setup.py install for mozdevice 14:20:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Running setup.py install for mozfile 14:20:07 INFO - Running setup.py install for mozhttpd 14:20:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Running setup.py install for mozinfo 14:20:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Running setup.py install for mozInstall 14:20:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:20:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Running setup.py install for mozleak 14:20:08 INFO - Running setup.py install for mozlog 14:20:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Running setup.py install for moznetwork 14:20:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Running setup.py install for mozprocess 14:20:08 INFO - Running setup.py install for mozprofile 14:20:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Running setup.py install for mozrunner 14:20:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Running setup.py install for mozscreenshot 14:20:08 INFO - Running setup.py install for moztest 14:20:08 INFO - Running setup.py install for mozversion 14:20:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:20:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:20:08 INFO - Cleaning up... 14:20:09 INFO - Return code: 0 14:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:09 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:20:09 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 14:20:09 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 14:20:09 INFO - Using env: {'DISPLAY': ':0', 14:20:09 INFO - 'HOME': '/home/cltbld', 14:20:09 INFO - 'LANG': 'en_US.UTF-8', 14:20:09 INFO - 'LANGUAGE': 'en_US:en', 14:20:09 INFO - 'LOGNAME': 'cltbld', 14:20:09 INFO - 'MAIL': '/var/mail/cltbld', 14:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:09 INFO - 'MOZ_NO_REMOTE': '1', 14:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:09 INFO - 'NO_EM_RESTART': '1', 14:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:09 INFO - 'PWD': '/builds/slave/test', 14:20:09 INFO - 'SHELL': '/bin/bash', 14:20:09 INFO - 'SHLVL': '1', 14:20:09 INFO - 'TERM': 'linux', 14:20:09 INFO - 'TMOUT': '86400', 14:20:09 INFO - 'USER': 'cltbld', 14:20:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:09 INFO - '_': '/tools/buildbot/bin/python'} 14:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:20:09 INFO - Running setup.py (path:/tmp/pip-ciMK_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:20:09 INFO - Running setup.py (path:/tmp/pip-gsaOaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:20:09 INFO - Running setup.py (path:/tmp/pip-nZ0END-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:20:09 INFO - Running setup.py (path:/tmp/pip-MS7hNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:20:09 INFO - Running setup.py (path:/tmp/pip-EOBftw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:20:09 INFO - Running setup.py (path:/tmp/pip-kqIS28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:20:09 INFO - Running setup.py (path:/tmp/pip-00AOq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:20:09 INFO - Running setup.py (path:/tmp/pip-5Erhjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:20:09 INFO - Running setup.py (path:/tmp/pip-q_FL0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:20:09 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:20:09 INFO - Running setup.py (path:/tmp/pip-6RRPTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:20:09 INFO - Running setup.py (path:/tmp/pip-4koW5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:20:10 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)) 14:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:20:10 INFO - Running setup.py (path:/tmp/pip-OnMjcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:20:10 INFO - Running setup.py (path:/tmp/pip-w5YYTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:20:10 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)) 14:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:20:10 INFO - Running setup.py (path:/tmp/pip-e9gNk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:10 INFO - Running setup.py (path:/tmp/pip-7K5D6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:20:10 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)) 14:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:20:10 INFO - Running setup.py (path:/tmp/pip-lvS2vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:20:10 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)) 14:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:20:10 INFO - Running setup.py (path:/tmp/pip-pWa9oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:20:10 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)) 14:20:10 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)) 14:20:10 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)) 14:20:10 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)) 14:20:10 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)) 14:20:10 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)) 14:20:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:20:10 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 14:20:10 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 14:20:10 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 14:20:10 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 14:20:10 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 14:20:10 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 14:20:12 INFO - Downloading blessings-1.6.tar.gz 14:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:20:12 INFO - Installing collected packages: blessings 14:20:12 INFO - Running setup.py install for blessings 14:20:12 INFO - Successfully installed blessings 14:20:12 INFO - Cleaning up... 14:20:12 INFO - Return code: 0 14:20:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:12 INFO - Reading from file tmpfile_stdout 14:20:12 INFO - Current package versions: 14:20:12 INFO - argparse == 1.2.1 14:20:12 INFO - blessings == 1.6 14:20:12 INFO - blobuploader == 1.2.4 14:20:12 INFO - docopt == 0.6.1 14:20:12 INFO - functools32 == 3.2.3-2 14:20:12 INFO - jsonschema == 2.5.1 14:20:12 INFO - manifestparser == 1.1 14:20:12 INFO - mozInstall == 1.12 14:20:12 INFO - mozcrash == 0.17 14:20:12 INFO - mozdebug == 0.1 14:20:12 INFO - mozdevice == 0.48 14:20:12 INFO - mozfile == 1.2 14:20:12 INFO - mozhttpd == 0.7 14:20:12 INFO - mozinfo == 0.9 14:20:12 INFO - mozleak == 0.1 14:20:12 INFO - mozlog == 3.3 14:20:12 INFO - moznetwork == 0.27 14:20:12 INFO - mozprocess == 0.23 14:20:12 INFO - mozprofile == 0.28 14:20:12 INFO - mozrunner == 6.12 14:20:12 INFO - mozscreenshot == 0.1 14:20:12 INFO - mozsystemmonitor == 0.3 14:20:12 INFO - moztest == 0.7 14:20:12 INFO - mozversion == 1.4 14:20:12 INFO - psutil == 3.1.1 14:20:12 INFO - requests == 1.2.3 14:20:12 INFO - wsgiref == 0.1.2 14:20:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:12 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:20:12 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 14:20:12 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 14:20:12 INFO - Using env: {'DISPLAY': ':0', 14:20:12 INFO - 'HOME': '/home/cltbld', 14:20:12 INFO - 'LANG': 'en_US.UTF-8', 14:20:12 INFO - 'LANGUAGE': 'en_US:en', 14:20:12 INFO - 'LOGNAME': 'cltbld', 14:20:12 INFO - 'MAIL': '/var/mail/cltbld', 14:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:12 INFO - 'MOZ_NO_REMOTE': '1', 14:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:12 INFO - 'NO_EM_RESTART': '1', 14:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:12 INFO - 'PWD': '/builds/slave/test', 14:20:12 INFO - 'SHELL': '/bin/bash', 14:20:12 INFO - 'SHLVL': '1', 14:20:12 INFO - 'TERM': 'linux', 14:20:12 INFO - 'TMOUT': '86400', 14:20:12 INFO - 'USER': 'cltbld', 14:20:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:12 INFO - '_': '/tools/buildbot/bin/python'} 14:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 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)) 14:20:13 INFO - Cleaning up... 14:20:13 INFO - Return code: 0 14:20:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:20:13 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')]} 14:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:13 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')]} 14:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:20:13 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 0x12f4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', '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 14:20:13 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 14:20:13 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 14:20:13 INFO - Using env: {'DISPLAY': ':0', 14:20:13 INFO - 'HOME': '/home/cltbld', 14:20:13 INFO - 'LANG': 'en_US.UTF-8', 14:20:13 INFO - 'LANGUAGE': 'en_US:en', 14:20:13 INFO - 'LOGNAME': 'cltbld', 14:20:13 INFO - 'MAIL': '/var/mail/cltbld', 14:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:13 INFO - 'MOZ_NO_REMOTE': '1', 14:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:13 INFO - 'NO_EM_RESTART': '1', 14:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:13 INFO - 'PWD': '/builds/slave/test', 14:20:13 INFO - 'SHELL': '/bin/bash', 14:20:13 INFO - 'SHLVL': '1', 14:20:13 INFO - 'TERM': 'linux', 14:20:13 INFO - 'TMOUT': '86400', 14:20:13 INFO - 'USER': 'cltbld', 14:20:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:13 INFO - '_': '/tools/buildbot/bin/python'} 14:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:20:13 INFO - Cleaning up... 14:20:13 INFO - Return code: 0 14:20:13 INFO - Running post-action listener: _resource_record_post_action 14:20:13 INFO - Running post-action listener: _start_resource_monitoring 14:20:13 INFO - Starting resource monitoring. 14:20:13 INFO - [mozharness: 2016-07-29 21:20:13.277814Z] Finished create-virtualenv step (success) 14:20:13 INFO - [mozharness: 2016-07-29 21:20:13.278292Z] Running install step. 14:20:13 INFO - Running pre-action listener: _resource_record_pre_action 14:20:13 INFO - Running main action method: install 14:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:20:13 INFO - Reading from file tmpfile_stdout 14:20:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:20:13 INFO - Reading from file tmpfile_stdout 14:20:13 INFO - Output received: 14:20:13 INFO - Usage: mozinstall [options] installer 14:20:13 INFO - Options: 14:20:13 INFO - -h, --help show this help message and exit 14:20:13 INFO - -d DEST, --destination=DEST 14:20:13 INFO - Directory to install application into. [default: 14:20:13 INFO - "/builds/slave/test"] 14:20:13 INFO - --app=APP Application being installed. [default: firefox] 14:20:13 INFO - mkdir: /builds/slave/test/build/application 14:20:13 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'] 14:20:13 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 14:20:30 INFO - Reading from file tmpfile_stdout 14:20:30 INFO - Output received: 14:20:30 INFO - /builds/slave/test/build/application/firefox/firefox 14:20:30 INFO - Running post-action listener: _resource_record_post_action 14:20:30 INFO - [mozharness: 2016-07-29 21:20:30.881166Z] Finished install step (success) 14:20:30 INFO - [mozharness: 2016-07-29 21:20:30.881444Z] Running run-tests step. 14:20:30 INFO - Running pre-action listener: _resource_record_pre_action 14:20:30 INFO - Running main action method: run_tests 14:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:20:30 INFO - Python 2.7.3 14:20:30 INFO - Return code: 0 14:20:30 INFO - grabbing minidump binary from tooltool 14:20: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')]} 14:20:30 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 0x15b33b0>, '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 0x15b42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:20:30 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 14:20:30 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 14:20:30 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 14:20:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:20:30 INFO - Return code: 0 14:20:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:20:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:20:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:20:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:20:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:20:30 INFO - Using env: {'DISPLAY': ':0', 14:20:30 INFO - 'HOME': '/home/cltbld', 14:20:30 INFO - 'LANG': 'en_US.UTF-8', 14:20:30 INFO - 'LANGUAGE': 'en_US:en', 14:20:30 INFO - 'LOGNAME': 'cltbld', 14:20:30 INFO - 'MAIL': '/var/mail/cltbld', 14:20:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:20:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:20:30 INFO - 'MOZ_NO_REMOTE': '1', 14:20:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:20:30 INFO - 'NO_EM_RESTART': '1', 14:20:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:20:30 INFO - 'PWD': '/builds/slave/test', 14:20:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:20:30 INFO - 'SHELL': '/bin/bash', 14:20:30 INFO - 'SHLVL': '1', 14:20:30 INFO - 'TERM': 'linux', 14:20:30 INFO - 'TMOUT': '86400', 14:20:30 INFO - 'USER': 'cltbld', 14:20:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185', 14:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:20:30 INFO - '_': '/tools/buildbot/bin/python'} 14:20:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:20:31 INFO - mozversion application_buildid: 20160729113002 14:20:31 INFO - mozversion application_changeset: fc777f42356960dad649f977452d22d05e0154d9 14:20:31 INFO - mozversion application_display_name: Nightly 14:20:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:20:31 INFO - mozversion application_name: Firefox 14:20:31 INFO - mozversion application_remotingname: firefox 14:20:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:20:31 INFO - mozversion application_vendor: Mozilla 14:20:31 INFO - mozversion application_version: 50.0a1 14:20:31 INFO - mozversion platform_buildid: 20160729113002 14:20:31 INFO - mozversion platform_changeset: fc777f42356960dad649f977452d22d05e0154d9 14:20:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:20:31 INFO - mozversion platform_version: 50.0a1 14:20:31 INFO - using testdate: 1469827231 14:20:31 INFO - actual date: 1469827231 14:20:31 INFO - starting webserver on 'localhost:60167' 14:20:31 INFO - SUITE-START | Running 2 tests 14:20:31 INFO - TEST-START | dromaeo_css 14:20:31 INFO - operating with platform_type : linux_ 14:20:31 INFO - Initialising browser for dromaeo_css test... 14:20:31 INFO - TEST-INFO | started process 15131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo4NO4j/profile http://localhost:60167/getInfo.html) 14:20:34 INFO - PROCESS | 15131 | JavaScript error: , line 0: uncaught exception: undefined 14:20:36 INFO - PROCESS | 15131 | __metrics Screen width/height:1600/1200 14:20:36 INFO - PROCESS | 15131 | colorDepth:24 14:20:36 INFO - PROCESS | 15131 | Browser inner width/height: 1024/697 14:20:36 INFO - PROCESS | 15131 | __metrics 14:20:36 ERROR - PROCESS | 15131 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:20:37 INFO - TEST-INFO | 15131: exit 0 14:20:37 INFO - Browser initialized. 14:20:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:20:37 INFO - TEST-INFO | started process 15249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo4NO4j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:49 INFO - PROCESS | 15249 | RSS: Main: 164835328 14:20:49 INFO - PROCESS | 15249 | 14:21:39 INFO - PROCESS | 15249 | 1469827299203 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] 14:23:47 INFO - PROCESS | 15249 | Cycle 1(1): loaded http://localhost:60167/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60167/tests/dromaeo/cssquery-ext.html) 14:23:48 INFO - PROCESS | 15249 | RSS: Main: 170422272 14:23:48 INFO - PROCESS | 15249 | 14:26:51 INFO - PROCESS | 15249 | Cycle 1(1): loaded http://localhost:60167/tests/dromaeo/cssquery-ext.html (next: http://localhost:60167/tests/dromaeo/cssquery-jquery.html) 14:26:51 INFO - PROCESS | 15249 | RSS: Main: 167784448 14:26:51 INFO - PROCESS | 15249 | 14:29:53 INFO - PROCESS | 15249 | Cycle 1(1): loaded http://localhost:60167/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60167/tests/dromaeo/cssquery-mootools.html) 14:29:54 INFO - PROCESS | 15249 | RSS: Main: 170823680 14:29:54 INFO - PROCESS | 15249 | 14:32:55 INFO - PROCESS | 15249 | Cycle 1(1): loaded http://localhost:60167/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60167/tests/dromaeo/cssquery-prototype.html) 14:32:56 INFO - PROCESS | 15249 | RSS: Main: 165625856 14:32:56 INFO - PROCESS | 15249 | 14:35:59 INFO - PROCESS | 15249 | Cycle 1(1): loaded http://localhost:60167/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60167/tests/dromaeo/cssquery-yui.html) 14:35:59 INFO - PROCESS | 15249 | RSS: Main: 167813120 14:35:59 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | Cycle 1(1): loaded http://localhost:60167/tests/dromaeo/cssquery-yui.html (next: http://localhost:60167/tests/dromaeo/cssquery-dojo.html) 14:39:02 INFO - PROCESS | 15249 | RSS: Main: 171102208 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | __start_tp_report 14:39:02 INFO - PROCESS | 15249 | _x_x_mozilla_page_load 14:39:02 INFO - PROCESS | 15249 | _x_x_mozilla_page_load_details 14:39:02 INFO - PROCESS | 15249 | |i|pagename|runs| 14:39:02 INFO - PROCESS | 15249 | |0;dojo.html;3088.5984821973143;3096.334288128052;3115.049909777518;3116.9064928052153;3125.8280794556304;5203.4536373680785;5241.2924255225535;5284.260203571498;5286.814961476354;5351.7056561889085;5267.209918512225;5272.892692534563;5278.049951008817;5294.364676238857;5310.4424035476295;4802.903941921169;4885.902281954359;4907.386576677915;4928.5564299213065;4968.056069346812;4987.950120498803;5005.924911126336;5042.401332968601;5056.469070747574;5069.340985671857;4840.709557426566;4892.559669629715;4928.457869634337;4935.605151587864;4952.281919121725;4945.455999840051;4958;4958.454569997298;4970.850874473772;4999.625028122905;4864.489228630978;4893.168161412568;4908.509149085063;4916.70499770015;4938.308636790852;5091.490850914879;5138.58891288696;5264.657797243167;5268.998890210886;5368.114261146906;5622.32532096151;5625.240592519998;5636.15457681347;5675.063614503602;5715.342735585377;5692.316921969349;5692.658440493584;5701.230333904911;5702.486776190121;5705.515031222351;5187.325647665817;5324.1215199492035;5325.360956685184;5356.1430171172815;5400.702961337086;5902.291724992942;5912.320083190488;5921.881562368814;5922.644641321534;5954.940450595525;5636.802711905064;5639.125935479925;5653.095504719226;5653.434656534396;5663.830085097454;5494.560435165257;5656.717164141859;5741.282339707536;5741.311042674905;5756.683382413924;5474.315710536183;5523.944760552343;5567.24842146305;5601.859953501195;5605;5612.326520817446;5618.550515958714;5642.210090587321;5658.519025882763;5669.54643628517;4376.102898905717;4385.978070109692;4388.297872340474;4389.934150987738;4438.533953934855;3822.7132965027736;3873.3802591585213;3908.257431088084;3920.6079392061138;3989.2221016901426;5499.50504454601;5526.309211348582;5527.088030474926;5543.307086614173;5547.972260138674;5740.971295143581;5751.511121554715;5751.884962300731;5759.280089988752;5795.9420405796245;5324.733763311819;5346.572274218053;5369.731513424314;5383.542398896059;5404.162354835007;4840.733759643183;4845.781939812717;4846.491118432514;4851.757412129379;4879.243717223836;5812.38969908162;5850.4149585042005;5855.238818953509;5857.589968702235;5857.677827719431;5572.944270557405;5663.603547751618;5727.656340619576;5758.683272420057;5859.648421094748;6044.0933859919605;6048.334683184934;6048.334683184934;6055.424734650202;6067.908981365372;5644.096944488862;5700.401457847032;5707.857303567444;5709.600327977002;5719.8570035749435;5575.9163612545035;5703.030484817508;5732.140178973187;5762.855928601818;5857.853553661193;5641.153826925994;5659.009673307237;5661.801836935852;5664.801731939528;5667.971660141673;5620.662760234399;5624.465675760796;5650.406707295675;5654.180143879033;5657.632253903483;5257.710825904612;5463.836084917459;5526.723663816873;5548.445155484419;5567.471090246582;5569.888602227852;5572.4148964358155;5612.821307525465;5623.297087864017;5643.746031428514;5311.49540793624;5480.287562616834;5488.615796894179;5513.8345849624575;5567.05360088794 14:39:02 INFO - PROCESS | 15249 | |1;ext.html;556.2334204403433;584.3630442817329;594.7620951619352;609.0042780054611;628.2084573437468;39907.60092399075;43750;43852.12295754083;43999.78000109999;44005;44142.11715765683;44657;44771.328430073576;44793.104137917304;44851.77574112125;8810.515421651806;8924.776880578005;8931.464112153259;9027.774305642346;9041.819163616723;8808.427452215617;8931.55342232889;8938.329625278098;8944.150305720947;8953.686620968267;9049.095090490964;9061.773455663628;9066.320025998044;9068.138526839939;9091.590878410487;8972.59623316949;8994.370394072417;9002.279817614575;9007.099290070973;9022.45865248084;8774.122587741238;8879.600417981206;8890.955545222298;8891.822163556693;8899.37704360695;41135.7943210282;41265.38101928474;41502.79248603768;41537.792311038254;41548.79225603853;3798.240351929625;3823.9426408603895;3962.385830196324;4210.32634778437;4296.119295544406;32792.50811237833;33247.83376083104;33451.83274083614;33465.83267083673;33534.832325838215;4351;4493.573110554525;4541.386912766768;4544.863654090383;4618.722876627413;353045;354616;354719;354778;354837;57658.7117064412;58459.415405846245;58646.70676646675;58804.41195588075;58859.41140588625;61389;61568.69215653893;61812;61892.381076189566;62028.37971620316;14826.925865370604;14961;15013.324400401789;15038.699226015418;15060.924695376672;11847.703807404883;11860.76278474443;11888.048956083492;11888.405579720978;11948.522059117711;15804.36782528686;16809.243584038504;17118.572035699206;17261.223244954006;17262.309507619804;6322.968385158045;6369.363063693593;6487.643179625166;6508.707108180143;6534.693061387741;918.7657147427497;988.9406635601887;1027.4143240092174;1085.2077983072402;1090.6782499162766;29422.264443389085;30597.541036884464;31107.68892311048;31175.53236701451;31466.213344666565;1144.5434786943551;1145.3414286785132;1171.9062475001979;1199.7120691034088;1201.243216773427;15276.541703748906;16282.918585406996;16370.427035053715;16416.343346266254;16586.17069146562;505834;507157;509597;509824;513851;58318.41681583215;58543;58600.41399586035;58722.41277587169;58818;1317.6442360562594;1360.9591712248648;1379.048456564967;1385.7297826923855;1388.4446221511475;30688.364702883966;33085.503717443775;33145.83427082946;33198.668013319555;33550.66449335475;50305.24542131798;50542.49457505378;50707.492925071754;50727.74636126796;50770.2384464226;378568;378933;379489;380663;381330;27760.36276553724;28095.157145285673;28276.575851361835;28291.009814657213;28309.575356370082;47327.76336118297;47425.28862067003;48608;48611.5138848607;49669.75165124151;41114.588854111076;41817.37273940954;42275;42824;44185.11629767322;42223.366649500895;42362.15275694407;43598.782006089765;44115.55884441114;44302;40651.18697625972;41076.79461602673;41609;41871.37192942047;41907.7904610475;33864.83067584646;37468;37832.62167378291;37848.43227351647;38648;28843.134705958855;28867.711322887342;29082.41835163327;29136.7086329134;29240.853795730884 14:39:02 INFO - PROCESS | 15249 | |2;jquery.html;378.65731512980744;386.9090763670537;387.4711019458438;397.79513550521506;409.1510116508246;17683;19677.311294104707;19810.801891981093;19854.602907941833;20218.39344819654;17938.19278132484;18405.90797046016;19028;19114.426567203005;19140;5638.520725738307;5736.196932429463;5755.942440575583;5783.826485205451;5821.27234095738;5638.689872057035;5697;5741.827745167651;5751.4536119068625;5792.7972520961775;5675;5705.087186050233;5747.59766816323;5750.942490575104;5774.335951365584;5558.888822223553;5740.483356497914;5752.539796816244;5768.3366412862215;5789.507891829199;4675.368825208588;4941.802327906916;4949.430815456232;5044.949550504484;5052.9242061369105;13418;13555.932220338935;13556.11885227457;18918.148683309286;22400.439989000242;2158.53591477833;2219.844610877239;2245.595792757303;2745.7803375729895;2957.659869115058;9389.859152112724;9597.760055998586;10028;10127.64553240633;11914.821277680841;1824.4526642007477;1862.9068546572616;1896.535348839543;1908.2257984156329;1961.7155512450615;79707.6014619929;80080;80645.59677201635;80950.59524702397;81154.9999999994;10629.787404251872;10763.83854242187;11071.225014249087;11076.446177691245;11133.443327833576;14441.711165776625;14497.202653853928;14912.179830109231;14919.776203356958;14957.925210373878;6405.839854003687;6467.417932386108;7356.37470814976;7807.453478256468;8094.51432914027;7411.407087432993;7467.439942004263;7523.674779273666;7635.121960974559;7662.272084151997;4580.083983203373;4582.518835522289;4626.953730462652;4653.464851542049;4711.575958163782;1884.3593178319438;1927.9563662517776;1976.8319692825983;1988.7812340642517;2006.2476571285767;935.317218430536;944.3106532231373;948.5913418573413;950.496236994394;1037.956853362366;18441.354552590863;19787.40637780869;19811.306604268782;19842.206311747657;20045.49886252826;986.28001558861;1004;1012.5291739341242;1013.9797204056025;1038.2213339995003;9250.86123708145;10981.3960232188;11000.944995274973;11120.888791112147;11197.776044479227;524027;529085;531319;538978;540141;78040.60979695065;94732.52633736788;95200.04799951911;96548;96943.51528242313;947.1002547579827;973.5181085362791;975.7219192530094;982.7101005203482;1008.6822650864954;15588.376464941275;17498.300067997137;17664.470065898044;17677.646447071245;17906.91046544759;41163.7941810301;41774.58225417828;42407.03150779539;43493.78253108841;43589.346159808265;53892.730536347066;55698.443015569326;56480.15279770889;60782.69608651928;61923.07115393183;11896.643100706993;12357.567485137977;12464.937675311565;13256.867431325949;13261.204327740366;13905.791413129013;13960.170810551552;14291.714165716836;14554.345054472362;14693.265336732908;11735.882641173479;12118.939405302917;12147.210431321935;12186.2078964867;12684;7857.096433909945;7872.330851877655;12238.388080596113;12478.18891772032;12644.873551264369;7727.961360193163;8071.636776344961;8295.709650162215;8309.459885107448;8565;12694.365281736062;12902.935485322514;13128;13222.338883055616;13286.468541258242;11506.367149806842;12695.174813637084;12744.936275318563;12840.935795320964;13249.205047697169 14:39:02 INFO - PROCESS | 15249 | |3;mootools.html;1502.8947973641843;1515.651400177959;1654.6277087655278;1771.309189416127;1784.3754685859942;7694.115176754675;8602.311815054789;8654;9164.221041211496;9172.587233574488;8746.650133994632;9068;9074.818503629924;9079.863802042975;9097.681581144645;2412.3245491262433;2452.104981681682;2460.2619214235747;2460.520198561281;2470.6047032474808;2381.30942026812;2394.784469397754;2430.5503481855826;2434.4400787818813;2438.609822428403;2358.858468491896;2392.6052201386838;2395.4370722880108;2409.759024097585;2430.890609922558;2327.615943369342;2348.8590684558812;2351.4826738117586;2356.7643235676464;2369.419492224416;2301.42464383904;2347.7769611886843;2348.3542025943;2360.421696684306;2361.480474295652;9112.271018318519;9165.404248723811;9180.357374983754;9181.632734690604;9244.95377523108;5225.1117310057;5375.543078838304;5453.618246722731;5566.944330556683;5567.2762540869835;3535.0985498697924;3580.838862251205;3632.5822530409077;3633.273345330918;3642.344378011957;1214.5141943222693;1228.281455348622;1240.0823390690914;1246.4453318273372;1249.331607589935;12339.62981110568;12398.876011239863;12400.441980110916;12402.13185077045;12416.441260143405;4623.42207224097;4727.078219747116;4854.417469903634;4877.6829506081995;4974.850754477371;10787.406692631981;10790.94604526988;10799.67600971972;10804.67585972422;10827.83758243627;5545.417731138253;5560.054790685593;5574.888502230014;5576.804811831566;5581.079121944834;4327.242732521796;4746.667733258639;4849.878753031202;4884.902301953941;5132.486751324837;3979.403089536535;4047.817848196838;4068.9186216275507;4205.705600607928;4212.599803018708;1318.3276528970293;1321.4648067532664;1324.9801252981213;1361.271719630013;1376.6145479265822;854.2610641794803;977.9217662586976;994.3437331361267;1040.245821779219;1074.5648012554927;6206.224221972254;6319.368063193736;6326.398992095744;6359.554831161867;6479.416852483299;446.9955300446954;458.3972076719104;460.8962983328791;465.664721400591;465.7717718318;4231.78841057952;4423.756693381895;4491.371208030879;4504.887377815581;4523.208438523246;11068.28056176346;11272;11326.490307936163;11329.603463878724;11345.149113816497;11061.391623460788;11062.170337224741;11215.831762523569;11225.438728063564;11237.775244495064;8180.631871565674;8368.916310836814;8416.410851240355;8458.281046111026;8498.447600905922;6216.694494156278;6256.124142620128;6309.968450157903;6373.171487706569;6385.45723613498;10044.54799534008;10066.647667331608;10133.493325333851;10177.898221017695;10219.131373833308;10386.376817390981;10439.895601043892;10502.212334075128;10527.473626318806;10528;7048.823779405556;7616.3906887447765;7922.366210703245;7992.280694737501;8071.636776345196;8805.603747831492;8864.556772161237;8881.467111973303;8888.066752990842;8947.821043578962;7759;7990.560519171501;8007.799805004922;8074.354051675734;8088;7895.289423951872;7911.485753426009;7912.0901096374655;7932;7995.720149794729;7147.2852714728115;7230.74692385764;7252;7305.853882922418;7308.59802710856;5543.1962365455975;5575.414581468887;5629.493345598916;5662.348829884451;5720.599558031065;5503.614746967673;5607.719614019365;5652.85867853307;5675.886482270249;5696 14:39:02 INFO - PROCESS | 15249 | |4;prototype.html;321.1169284467714;325.39801367470176;330.6313460491551;335.3025706530417;337.2142907026628;5373.355197376311;5440.945590544094;5508.228847961289;5565.137403702428;5588.133839254917;5374.543163831079;5448.37343705474;5468.48049435304;5473.17902314653;5490.533304669098;4338.956610433886;4344.784160078367;4355.869323920288;4361.34579813029;4363.258246098171;4151.12826306476;4200.180964711883;4224.9226447255905;4343.131373725252;4351.71713838601;4164.250434921712;4168.7081904266715;4169.833206671729;4187.806475154582;4191.853285135021;4178.874633760992;4187.497500299984;4194.559571245021;4210.578942105765;4232.153569286155;3654.8121860395477;3668.468072129553;3670.853165873362;3690.2988432197794;3690.5755838078694;5079.923801142986;5302.3297661236975;5308.442613525563;5353.437889021675;5358.223057656657;4832.251001094836;4845.079434907357;4849.393825771778;4860.489648586883;4877.561019508261;5427.782888684487;5726.77092916287;5736.1682556029145;5736.598438109334;5786.42135786418;4045.4740883685226;4055.7566546007038;4055.898602534931;4066.247744167309;4098.52866920305;6042.9395706042815;6045.486133678643;6054.909176362358;6061.090836374535;6092.380276481112;3861.2277544490653;4127.669786417079;4162.146759914211;4165.396017577435;4171.728837625545;4088.366303223005;4090.284200264942;4103.076807718239;4114.526829414595;4118.979405103015;4809.495003024702;4809.78355973982;4817.7350245736825;4823.975880120647;4828.975855120702;5617.522510586564;5773.249477567973;5775.3540241031105;5850.268716410449;5869.61847479921;1397.6436008817686;1421.8649228323293;1425.49394964786;1426.1728197645548;1427.635952832021;881.4799268431656;907.1880666803174;911.6735150356216;931.1154403316876;935.9064093590587;4967.279744437036;4974.403071631427;4977.950220497749;5002.299678045077;5011.621804003928;5253.553447956967;5265.473452654704;5266.052110620125;5293.253226435267;5309.734513274321;4635.351050852883;4991.625628077836;5084.779652883355;5093.0577843099145;5129.7691603877165;2779.8185771047224;2789.567617019365;2792.5531914893927;2798.622186004904;2821.5908693239367;5496.367917689437;5504.889902202013;5541.141123125922;5580.330360356783;5580.414056524088;5170.948290517122;5230.503102205284;5291.841244762663;5314.415414304423;5323.866903327448;5420.075873065084;5456.863578410572;5463.644863083887;5502.2296878437055;5517.9443109315425;5260.736963151904;5290.756672181958;5371.979323928441;5376.467706703727;5390.865228369322;4856.805727770991;5107.395228433451;5142.948570514247;5149.562287205629;5151.531813433154;5443.8094666686475;5485.286912701324;5485.807996720096;5492.940147444709;5504.2753836849415;3681.723870709654;3933.8426462942307;4050.3721923101966;4137.751734895915;4155.750654960712;5855.243426971806;5902.730912853757;5915.526757859447;5928.644281343133;5929.695466997254;5662.207290979184;5817.243758311392;5818.4763371296785;5822.5633077518505;5825.330087040044;5706.80026199081;5711.400302968294;5730.848033581597;5734.455226753452;5744.42555744439;5660.349059858169;5666.575006874418;5669.881565139074;5703.885922281448;5709.65742055478;5525.309336332958;5710.800121995876;5728.942710572841;5768.2501274834;5796.652200867961;5607.158926161109;5645.463680950304;5660.830175094589;5684.7157642118555;5695.971520142372 14:39:02 INFO - PROCESS | 15249 | |5;yui.html;746.8095635612918;748;769.3153093746563;770.4221833624781;830.3606223208134;14501.927490362546;14953.47662831801;15257.160856152906;15270.465533706323;15298.770518442232;14192.574222773308;14256.928715356435;14267.78598321026;14273.286335683226;14282.785758213635;659.1595715462776;778.17513435758;784.9372050235982;794.7417089445925;799.1369321133192;805.5368163306093;810.2019510781876;812.4597142899964;814.2468216899374;814.8573999550084;857.3698331726176;862.2369203255133;866.9739907802776;867.8654808504692;868.0754995929346;853.8676505141713;861.8190180062131;863.7754183912165;864.4078806017835;865.0570877743259;628.3559351664535;630.8643641617074;631.564220687724;632.2349956552576;635.3773302163905;15525.223738813014;15588.454404095803;15590.454334098253;15590.454334098253;15639.218039098;13934.512292069729;14079.296035198302;14116.223607701573;14135.081219720789;14201.147931124166;11978.281303121754;12053.57812476559;12090.879091209063;12280.692982675415;12352.752944941141;3924.5806595475774;3957.7625342479255;3971.6624086952643;4014.3376342903384;4086.9795651021554;78756.60621696913;81310;81967;82368.9999999994;82394;10639.787204256027;10750.677479675622;10847.132229421628;10956.835647465294;10986.285891417032;22437.43906402353;22641.320760376886;22901.770982289963;22939.426514337276;23168.76831231666;8592.312614990786;8638.740837774876;8677.739667809976;8749.606267717969;8817.470951742916;4804.95195048052;4959.479254678279;4992.750362481861;5013.924791128136;5014.774335154853;3365.781224220467;3456.5679290088738;3476.3568739783223;3482.7213822894614;3487.3722729908354;588.8351261646745;606.1483615520201;606.5602438232335;616.5622408090217;635.4852569418786;686.9965650171818;708.1643660480579;709.6558169287891;731.0861423220974;751.3538357012965;10132.949335253277;10247.59009639621;10365.533550990072;10388.584456621651;10464.162866970624;613.2579578709722;627.5669787846372;682.1439093937078;690.9689063992132;736.1644533454568;4855.902881942412;5027.1705168647495;5128.128233194931;5168.095583272912;5203.60972927032;114480.42759786148;114753;116438.41780791042;116543.41728291304;116745;98627;100431;100557.49721251347;101235;104247.47876260571;87725.1227487717;87883;88145.55927220451;88768.5561572188;89642.55178724065;9647.276454265817;9673.322867399214;9744.75638109053;9753.853692194765;9995.550200240861;46351.53648463472;48186.5181348182;48429.51570484391;49000.754996224794;50620;71398;71627;78927.21072789429;81239;81557.18442815733;12213.75572488563;12453.501859925502;12630.179038362478;13018.479260829461;13085.869141308845;14451.78322325187;14519;14568.27158642085;14685;14781;13422.194668319931;13827.446902124204;14079.577612671636;14256.358463869357;14289.28553572338;12542.310172940211;12692;12993.09048366643;13421.127626704232;13492.797608036084;12711.491540338653;12983;13199.406026729012;13552.728945421233;13580.45678172862;10075;10119.544620492243;10209.132223761064;10255.128314093086;10292.948535257276;9771.804563908825;9879.50602469888;10101.747456313651;11403.771924561628;11423.885761142283 14:39:02 INFO - PROCESS | 15249 | __end_tp_report 14:39:02 INFO - PROCESS | 15249 | __start_cc_report 14:39:02 INFO - PROCESS | 15249 | _x_x_mozilla_cycle_collect,328 14:39:02 INFO - PROCESS | 15249 | __end_cc_report 14:39:02 INFO - PROCESS | 15249 | __startTimestamp1469828342613__endTimestamp 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | ------- Summary: start ------- 14:39:02 INFO - PROCESS | 15249 | Number of tests: 6 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | [#0] dojo.html Cycles:165 Average:5315.65 Median:5527.09 stddev:596.47 (10.8%) stddev-sans-first:572.14 14:39:02 INFO - PROCESS | 15249 | Values: 3088.6 3096.3 3115.0 3116.9 3125.8 5203.5 5241.3 5284.3 5286.8 5351.7 5267.2 5272.9 5278.0 5294.4 5310.4 4802.9 4885.9 4907.4 4928.6 4968.1 4988.0 5005.9 5042.4 5056.5 5069.3 4840.7 4892.6 4928.5 4935.6 4952.3 4945.5 4958.0 4958.5 4970.9 4999.6 4864.5 4893.2 4908.5 4916.7 4938.3 5091.5 5138.6 5264.7 5269.0 5368.1 5622.3 5625.2 5636.2 5675.1 5715.3 5692.3 5692.7 5701.2 5702.5 5705.5 5187.3 5324.1 5325.4 5356.1 5400.7 5902.3 5912.3 5921.9 5922.6 5954.9 5636.8 5639.1 5653.1 5653.4 5663.8 5494.6 5656.7 5741.3 5741.3 5756.7 5474.3 5523.9 5567.2 5601.9 5605.0 5612.3 5618.6 5642.2 5658.5 5669.5 4376.1 4386.0 4388.3 4389.9 4438.5 3822.7 3873.4 3908.3 3920.6 3989.2 5499.5 5526.3 5527.1 5543.3 5548.0 5741.0 5751.5 5751.9 5759.3 5795.9 5324.7 5346.6 5369.7 5383.5 5404.2 4840.7 4845.8 4846.5 4851.8 4879.2 5812.4 5850.4 5855.2 5857.6 5857.7 5572.9 5663.6 5727.7 5758.7 5859.6 6044.1 6048.3 6048.3 6055.4 6067.9 5644.1 5700.4 5707.9 5709.6 5719.9 5575.9 5703.0 5732.1 5762.9 5857.9 5641.2 5659.0 5661.8 5664.8 5668.0 5620.7 5624.5 5650.4 5654.2 5657.6 5257.7 5463.8 5526.7 5548.4 5567.5 5569.9 5572.4 5612.8 5623.3 5643.7 5311.5 5480.3 5488.6 5513.8 5567.1 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | [#1] ext.html Cycles:180 Average:58124.21 Median:42249.18 stddev:111068.55 (262.9%) stddev-sans-first:111296.03 14:39:02 INFO - PROCESS | 15249 | Values: 556.2 584.4 594.8 609.0 628.2 39907.6 43750.0 43852.1 43999.8 44005.0 44142.1 44657.0 44771.3 44793.1 44851.8 8810.5 8924.8 8931.5 9027.8 9041.8 8808.4 8931.6 8938.3 8944.2 8953.7 9049.1 9061.8 9066.3 9068.1 9091.6 8972.6 8994.4 9002.3 9007.1 9022.5 8774.1 8879.6 8891.0 8891.8 8899.4 41135.8 41265.4 41502.8 41537.8 41548.8 3798.2 3823.9 3962.4 4210.3 4296.1 32792.5 33247.8 33451.8 33465.8 33534.8 4351.0 4493.6 4541.4 4544.9 4618.7 353045.0 354616.0 354719.0 354778.0 354837.0 57658.7 58459.4 58646.7 58804.4 58859.4 61389.0 61568.7 61812.0 61892.4 62028.4 14826.9 14961.0 15013.3 15038.7 15060.9 11847.7 11860.8 11888.0 11888.4 11948.5 15804.4 16809.2 17118.6 17261.2 17262.3 6323.0 6369.4 6487.6 6508.7 6534.7 918.8 988.9 1027.4 1085.2 1090.7 29422.3 30597.5 31107.7 31175.5 31466.2 1144.5 1145.3 1171.9 1199.7 1201.2 15276.5 16282.9 16370.4 16416.3 16586.2 505834.0 507157.0 509597.0 509824.0 513851.0 58318.4 58543.0 58600.4 58722.4 58818.0 1317.6 1361.0 1379.0 1385.7 1388.4 30688.4 33085.5 33145.8 33198.7 33550.7 50305.2 50542.5 50707.5 50727.7 50770.2 378568.0 378933.0 379489.0 380663.0 381330.0 27760.4 28095.2 28276.6 28291.0 28309.6 47327.8 47425.3 48608.0 48611.5 49669.8 41114.6 41817.4 42275.0 42824.0 44185.1 42223.4 42362.2 43598.8 44115.6 44302.0 40651.2 41076.8 41609.0 41871.4 41907.8 33864.8 37468.0 37832.6 37848.4 38648.0 28843.1 28867.7 29082.4 29136.7 29240.9 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | [#2] jquery.html Cycles:180 Average:30117.54 Median:1668.16 stddev:87636.10 (5253.5%) stddev-sans-first:87853.49 14:39:02 INFO - PROCESS | 15249 | Values: 378.7 386.9 387.5 397.8 409.2 17683.0 19677.3 19810.8 19854.6 20218.4 17938.2 18405.9 19028.0 19114.4 19140.0 5638.5 5736.2 5755.9 5783.8 5821.3 5638.7 5697.0 5741.8 5751.5 5792.8 5675.0 5705.1 5747.6 5750.9 5774.3 5558.9 5740.5 5752.5 5768.3 5789.5 4675.4 4941.8 4949.4 5044.9 5052.9 13418.0 13555.9 13556.1 18918.1 22400.4 2158.5 2219.8 2245.6 2745.8 2957.7 9389.9 9597.8 10028.0 10127.6 11914.8 1824.5 1862.9 1896.5 1908.2 1961.7 79707.6 80080.0 80645.6 80950.6 81155.0 10629.8 10763.8 11071.2 11076.4 11133.4 14441.7 14497.2 14912.2 14919.8 14957.9 6405.8 6467.4 7356.4 7807.5 8094.5 7411.4 7467.4 7523.7 7635.1 7662.3 4580.1 4582.5 4627.0 4653.5 4711.6 1884.4 1928.0 1976.8 1988.8 2006.2 935.3 944.3 948.6 950.5 1038.0 18441.4 19787.4 19811.3 19842.2 20045.5 986.3 1004.0 1012.5 1014.0 1038.2 9250.9 10981.4 11000.9 11120.9 11197.8 524027.0 529085.0 531319.0 538978.0 540141.0 78040.6 94732.5 95200.0 96548.0 96943.5 947.1 973.5 975.7 982.7 1008.7 15588.4 17498.3 17664.5 17677.6 17906.9 41163.8 41774.6 42407.0 43493.8 43589.3 53892.7 55698.4 56480.2 60782.7 61923.1 11896.6 12357.6 12464.9 13256.9 13261.2 13905.8 13960.2 14291.7 14554.3 14693.3 11735.9 12118.9 12147.2 12186.2 12684.0 7857.1 7872.3 12238.4 12478.2 12644.9 7728.0 8071.6 8295.7 8309.5 8565.0 12694.4 12902.9 13128.0 13222.3 13286.5 11506.4 12695.2 12744.9 12840.9 13249.2 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | [#3] mootools.html Cycles:180 Average:5986.30 Median:2542.16 stddev:3377.57 (132.9%) stddev-sans-first:3370.24 14:39:02 INFO - PROCESS | 15249 | Values: 1502.9 1515.7 1654.6 1771.3 1784.4 7694.1 8602.3 8654.0 9164.2 9172.6 8746.7 9068.0 9074.8 9079.9 9097.7 2412.3 2452.1 2460.3 2460.5 2470.6 2381.3 2394.8 2430.6 2434.4 2438.6 2358.9 2392.6 2395.4 2409.8 2430.9 2327.6 2348.9 2351.5 2356.8 2369.4 2301.4 2347.8 2348.4 2360.4 2361.5 9112.3 9165.4 9180.4 9181.6 9245.0 5225.1 5375.5 5453.6 5566.9 5567.3 3535.1 3580.8 3632.6 3633.3 3642.3 1214.5 1228.3 1240.1 1246.4 1249.3 12339.6 12398.9 12400.4 12402.1 12416.4 4623.4 4727.1 4854.4 4877.7 4974.9 10787.4 10790.9 10799.7 10804.7 10827.8 5545.4 5560.1 5574.9 5576.8 5581.1 4327.2 4746.7 4849.9 4884.9 5132.5 3979.4 4047.8 4068.9 4205.7 4212.6 1318.3 1321.5 1325.0 1361.3 1376.6 854.3 977.9 994.3 1040.2 1074.6 6206.2 6319.4 6326.4 6359.6 6479.4 447.0 458.4 460.9 465.7 465.8 4231.8 4423.8 4491.4 4504.9 4523.2 11068.3 11272.0 11326.5 11329.6 11345.1 11061.4 11062.2 11215.8 11225.4 11237.8 8180.6 8368.9 8416.4 8458.3 8498.4 6216.7 6256.1 6310.0 6373.2 6385.5 10044.5 10066.6 10133.5 10177.9 10219.1 10386.4 10439.9 10502.2 10527.5 10528.0 7048.8 7616.4 7922.4 7992.3 8071.6 8805.6 8864.6 8881.5 8888.1 8947.8 7759.0 7990.6 8007.8 8074.4 8088.0 7895.3 7911.5 7912.1 7932.0 7995.7 7147.3 7230.7 7252.0 7305.9 7308.6 5543.2 5575.4 5629.5 5662.3 5720.6 5503.6 5607.7 5652.9 5675.9 5696.0 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | [#4] prototype.html Cycles:180 Average:4658.15 Median:5265.76 stddev:1366.62 (26.0%) stddev-sans-first:1331.12 14:39:02 INFO - PROCESS | 15249 | Values: 321.1 325.4 330.6 335.3 337.2 5373.4 5440.9 5508.2 5565.1 5588.1 5374.5 5448.4 5468.5 5473.2 5490.5 4339.0 4344.8 4355.9 4361.3 4363.3 4151.1 4200.2 4224.9 4343.1 4351.7 4164.3 4168.7 4169.8 4187.8 4191.9 4178.9 4187.5 4194.6 4210.6 4232.2 3654.8 3668.5 3670.9 3690.3 3690.6 5079.9 5302.3 5308.4 5353.4 5358.2 4832.3 4845.1 4849.4 4860.5 4877.6 5427.8 5726.8 5736.2 5736.6 5786.4 4045.5 4055.8 4055.9 4066.2 4098.5 6042.9 6045.5 6054.9 6061.1 6092.4 3861.2 4127.7 4162.1 4165.4 4171.7 4088.4 4090.3 4103.1 4114.5 4119.0 4809.5 4809.8 4817.7 4824.0 4829.0 5617.5 5773.2 5775.4 5850.3 5869.6 1397.6 1421.9 1425.5 1426.2 1427.6 881.5 907.2 911.7 931.1 935.9 4967.3 4974.4 4978.0 5002.3 5011.6 5253.6 5265.5 5266.1 5293.3 5309.7 4635.4 4991.6 5084.8 5093.1 5129.8 2779.8 2789.6 2792.6 2798.6 2821.6 5496.4 5504.9 5541.1 5580.3 5580.4 5170.9 5230.5 5291.8 5314.4 5323.9 5420.1 5456.9 5463.6 5502.2 5517.9 5260.7 5290.8 5372.0 5376.5 5390.9 4856.8 5107.4 5142.9 5149.6 5151.5 5443.8 5485.3 5485.8 5492.9 5504.3 3681.7 3933.8 4050.4 4137.8 4155.8 5855.2 5902.7 5915.5 5928.6 5929.7 5662.2 5817.2 5818.5 5822.6 5825.3 5706.8 5711.4 5730.8 5734.5 5744.4 5660.3 5666.6 5669.9 5703.9 5709.7 5525.3 5710.8 5728.9 5768.3 5796.7 5607.2 5645.5 5660.8 5684.7 5696.0 14:39:02 INFO - PROCESS | 15249 | 14:39:02 INFO - PROCESS | 15249 | [#5] yui.html Cycles:180 Average:21056.23 Median:4050.66 stddev:30609.56 (755.7%) stddev-sans-first:30657.44 14:39:02 INFO - PROCESS | 15249 | Values: 746.8 748.0 769.3 770.4 830.4 14501.9 14953.5 15257.2 15270.5 15298.8 14192.6 14256.9 14267.8 14273.3 14282.8 659.2 778.2 784.9 794.7 799.1 805.5 810.2 812.5 814.2 814.9 857.4 862.2 867.0 867.9 868.1 853.9 861.8 863.8 864.4 865.1 628.4 630.9 631.6 632.2 635.4 15525.2 15588.5 15590.5 15590.5 15639.2 13934.5 14079.3 14116.2 14135.1 14201.1 11978.3 12053.6 12090.9 12280.7 12352.8 3924.6 3957.8 3971.7 4014.3 4087.0 78756.6 81310.0 81967.0 82369.0 82394.0 10639.8 10750.7 10847.1 10956.8 10986.3 22437.4 22641.3 22901.8 22939.4 23168.8 8592.3 8638.7 8677.7 8749.6 8817.5 4805.0 4959.5 4992.8 5013.9 5014.8 3365.8 3456.6 3476.4 3482.7 3487.4 588.8 606.1 606.6 616.6 635.5 687.0 708.2 709.7 731.1 751.4 10132.9 10247.6 10365.5 10388.6 10464.2 613.3 627.6 682.1 691.0 736.2 4855.9 5027.2 5128.1 5168.1 5203.6 114480.4 114753.0 116438.4 116543.4 116745.0 98627.0 100431.0 100557.5 101235.0 104247.5 87725.1 87883.0 88145.6 88768.6 89642.6 9647.3 9673.3 9744.8 9753.9 9995.6 46351.5 48186.5 48429.5 49000.8 50620.0 71398.0 71627.0 78927.2 81239.0 81557.2 12213.8 12453.5 12630.2 13018.5 13085.9 14451.8 14519.0 14568.3 14685.0 14781.0 13422.2 13827.4 14079.6 14256.4 14289.3 12542.3 12692.0 12993.1 13421.1 13492.8 12711.5 12983.0 13199.4 13552.7 13580.5 10075.0 10119.5 10209.1 10255.1 10292.9 9771.8 9879.5 10101.7 11403.8 11423.9 14:39:02 INFO - PROCESS | 15249 | -------- Summary: end -------- 14:39:02 INFO - PROCESS | 15249 | 14:39:03 INFO - TEST-INFO | 15249: exit 0 14:39:03 INFO - TEST-OK | dromaeo_css | took 1112255ms 14:39:03 INFO - TEST-START | kraken 14:39:03 INFO - operating with platform_type : linux_ 14:39:03 INFO - Initialising browser for kraken test... 14:39:03 INFO - TEST-INFO | started process 15494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRjkluD/profile http://localhost:60167/getInfo.html) 14:39:06 INFO - PROCESS | 15494 | JavaScript error: , line 0: uncaught exception: undefined 14:39:08 INFO - PROCESS | 15494 | __metrics Screen width/height:1600/1200 14:39:08 INFO - PROCESS | 15494 | colorDepth:24 14:39:08 INFO - PROCESS | 15494 | Browser inner width/height: 1024/697 14:39:08 INFO - PROCESS | 15494 | __metrics 14:39:09 ERROR - PROCESS | 15494 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:39:09 INFO - TEST-INFO | 15494: exit 0 14:39:09 INFO - Browser initialized. 14:39:09 INFO - Running cycle 1/1 for kraken test... 14:39:09 INFO - TEST-INFO | started process 15611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRjkluD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:21 INFO - PROCESS | 15611 | RSS: Main: 164904960 14:39:21 INFO - PROCESS | 15611 | 14:39:24 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60167/tests/kraken/driver.html?testName=audio-beat-detection) 14:39:25 INFO - PROCESS | 15611 | RSS: Main: 169918464 14:39:25 INFO - PROCESS | 15611 | 14:39:27 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60167/tests/kraken/driver.html?testName=audio-dft) 14:39:28 INFO - PROCESS | 15611 | RSS: Main: 169234432 14:39:28 INFO - PROCESS | 15611 | 14:39:31 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60167/tests/kraken/driver.html?testName=audio-fft) 14:39:32 INFO - PROCESS | 15611 | RSS: Main: 165490688 14:39:32 INFO - PROCESS | 15611 | 14:39:34 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60167/tests/kraken/driver.html?testName=audio-oscillator) 14:39:34 INFO - PROCESS | 15611 | RSS: Main: 166952960 14:39:34 INFO - PROCESS | 15611 | 14:39:36 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60167/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:39:37 INFO - PROCESS | 15611 | RSS: Main: 167030784 14:39:37 INFO - PROCESS | 15611 | 14:39:40 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60167/tests/kraken/driver.html?testName=imaging-darkroom) 14:39:41 INFO - PROCESS | 15611 | RSS: Main: 167522304 14:39:41 INFO - PROCESS | 15611 | 14:39:44 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60167/tests/kraken/driver.html?testName=imaging-desaturate) 14:39:45 INFO - PROCESS | 15611 | RSS: Main: 164196352 14:39:45 INFO - PROCESS | 15611 | 14:39:48 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60167/tests/kraken/driver.html?testName=json-parse-financial) 14:39:48 INFO - PROCESS | 15611 | RSS: Main: 165867520 14:39:48 INFO - PROCESS | 15611 | 14:39:50 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60167/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:39:51 INFO - PROCESS | 15611 | RSS: Main: 166580224 14:39:51 INFO - PROCESS | 15611 | 14:39:52 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:39:53 INFO - PROCESS | 15611 | RSS: Main: 167063552 14:39:53 INFO - PROCESS | 15611 | 14:39:55 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:39:56 INFO - PROCESS | 15611 | RSS: Main: 167190528 14:39:56 INFO - PROCESS | 15611 | 14:39:58 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:39:59 INFO - PROCESS | 15611 | RSS: Main: 167374848 14:39:59 INFO - PROCESS | 15611 | 14:40:02 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:40:02 INFO - PROCESS | 15611 | RSS: Main: 167268352 14:40:02 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | Cycle 1(1): loaded http://localhost:60167/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60167/tests/kraken/driver.html?testName=ai-astar) 14:40:04 INFO - PROCESS | 15611 | RSS: Main: 168116224 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | __start_tp_report 14:40:04 INFO - PROCESS | 15611 | _x_x_mozilla_page_load 14:40:04 INFO - PROCESS | 15611 | _x_x_mozilla_page_load_details 14:40:04 INFO - PROCESS | 15611 | |i|pagename|runs| 14:40:04 INFO - PROCESS | 15611 | |0;ai-astar;103;115;108;116;113;112;113;110;113;113 14:40:04 INFO - PROCESS | 15611 | |1;audio-beat-detection;151;118;148;179;121;150;150;121;180;118 14:40:04 INFO - PROCESS | 15611 | |2;audio-dft;161;162;162;160;163;168;168;165;162;163 14:40:04 INFO - PROCESS | 15611 | |3;audio-fft;75;74;75;179;78;76;75;75;176;77 14:40:04 INFO - PROCESS | 15611 | |4;audio-oscillator;83;84;152;84;84;84;146;84;91;145 14:40:04 INFO - PROCESS | 15611 | |5;imaging-gaussian-blur;118;119;119;118;117;118;118;118;119;117 14:40:04 INFO - PROCESS | 15611 | |6;imaging-darkroom;147;147;147;147;147;148;147;147;147;148 14:40:04 INFO - PROCESS | 15611 | |7;imaging-desaturate;95;98;96;96;97;96;96;96;96;96 14:40:04 INFO - PROCESS | 15611 | |8;json-parse-financial;53;53;56;52;53;57;54;53;53;53 14:40:04 INFO - PROCESS | 15611 | |9;json-stringify-tinderbox;62;63;62;62;63;62;63;63;65;63 14:40:04 INFO - PROCESS | 15611 | |10;stanford-crypto-aes;88;77;82;76;82;79;75;76;76;78 14:40:04 INFO - PROCESS | 15611 | |11;stanford-crypto-ccm;124;121;122;136;135;128;122;127;168;136 14:40:04 INFO - PROCESS | 15611 | |12;stanford-crypto-pbkdf2;163;161;165;165;161;157;161;161;161;161 14:40:04 INFO - PROCESS | 15611 | |13;stanford-crypto-sha256-iterative;65;65;64;65;63;63;64;64;64;62 14:40:04 INFO - PROCESS | 15611 | __end_tp_report 14:40:04 INFO - PROCESS | 15611 | __start_cc_report 14:40:04 INFO - PROCESS | 15611 | _x_x_mozilla_cycle_collect,862 14:40:04 INFO - PROCESS | 15611 | __end_cc_report 14:40:04 INFO - PROCESS | 15611 | __startTimestamp1469828404800__endTimestamp 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | ------- Summary: start ------- 14:40:04 INFO - PROCESS | 15611 | Number of tests: 14 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:2.40 14:40:04 INFO - PROCESS | 15611 | Values: 103.0 115.0 108.0 116.0 113.0 112.0 113.0 110.0 113.0 113.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.00 stddev:23.73 (15.8%) stddev-sans-first:25.01 14:40:04 INFO - PROCESS | 15611 | Values: 151.0 118.0 148.0 179.0 121.0 150.0 150.0 121.0 180.0 118.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.76 (1.7%) stddev-sans-first:2.78 14:40:04 INFO - PROCESS | 15611 | Values: 161.0 162.0 162.0 160.0 163.0 168.0 168.0 165.0 162.0 163.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.00 stddev:42.98 (57.3%) stddev-sans-first:44.91 14:40:04 INFO - PROCESS | 15611 | Values: 75.0 74.0 75.0 179.0 78.0 76.0 75.0 75.0 176.0 77.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:84.00 stddev:30.47 (36.3%) stddev-sans-first:31.39 14:40:04 INFO - PROCESS | 15611 | Values: 83.0 84.0 152.0 84.0 84.0 84.0 146.0 84.0 91.0 145.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:40:04 INFO - PROCESS | 15611 | Values: 118.0 119.0 119.0 118.0 117.0 118.0 118.0 118.0 119.0 117.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:40:04 INFO - PROCESS | 15611 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 148.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 14:40:04 INFO - PROCESS | 15611 | Values: 95.0 98.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:1.57 (3.0%) stddev-sans-first:1.64 14:40:04 INFO - PROCESS | 15611 | Values: 53.0 53.0 56.0 52.0 53.0 57.0 54.0 53.0 53.0 53.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 14:40:04 INFO - PROCESS | 15611 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 63.0 63.0 65.0 63.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.50 stddev:4.04 (5.1%) stddev-sans-first:2.62 14:40:04 INFO - PROCESS | 15611 | Values: 88.0 77.0 82.0 76.0 82.0 79.0 75.0 76.0 76.0 78.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.50 stddev:14.00 (10.6%) stddev-sans-first:14.55 14:40:04 INFO - PROCESS | 15611 | Values: 124.0 121.0 122.0 136.0 135.0 128.0 122.0 127.0 168.0 136.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.00 stddev:2.32 (1.4%) stddev-sans-first:2.40 14:40:04 INFO - PROCESS | 15611 | Values: 163.0 161.0 165.0 165.0 161.0 157.0 161.0 161.0 161.0 161.0 14:40:04 INFO - PROCESS | 15611 | 14:40:04 INFO - PROCESS | 15611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:0.97 14:40:04 INFO - PROCESS | 15611 | Values: 65.0 65.0 64.0 65.0 63.0 63.0 64.0 64.0 64.0 62.0 14:40:04 INFO - PROCESS | 15611 | -------- Summary: end -------- 14:40:04 INFO - PROCESS | 15611 | 14:40:05 INFO - TEST-INFO | 15611: exit 0 14:40:05 INFO - TEST-OK | kraken | took 62431ms 14:40:05 INFO - SUITE-END | took 1174s 14:40:05 INFO - Completed test suite (00:19:34) 14:40:05 INFO - javascript benchmark 14:40:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7260.589044284622, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.5984821973143, 3096.334288128052, 3115.049909777518, 3116.9064928052153, 3125.8280794556304, 5203.4536373680785, 5241.2924255225535, 5284.260203571498, 5286.814961476354, 5351.7056561889085, 5267.209918512225, 5272.892692534563, 5278.049951008817, 5294.364676238857, 5310.4424035476295, 4802.903941921169, 4885.902281954359, 4907.386576677915, 4928.5564299213065, 4968.056069346812, 4987.950120498803, 5005.924911126336, 5042.401332968601, 5056.469070747574, 5069.340985671857, 4840.709557426566, 4892.559669629715, 4928.457869634337, 4935.605151587864, 4952.281919121725, 4945.455999840051, 4958.0, 4958.454569997298, 4970.850874473772, 4999.625028122905, 4864.489228630978, 4893.168161412568, 4908.509149085063, 4916.70499770015, 4938.308636790852, 5091.490850914879, 5138.58891288696, 5264.657797243167, 5268.998890210886, 5368.114261146906, 5622.32532096151, 5625.240592519998, 5636.15457681347, 5675.063614503602, 5715.342735585377, 5692.316921969349, 5692.658440493584, 5701.230333904911, 5702.486776190121, 5705.515031222351, 5187.325647665817, 5324.1215199492035, 5325.360956685184, 5356.1430171172815, 5400.702961337086, 5902.291724992942, 5912.320083190488, 5921.881562368814, 5922.644641321534, 5954.940450595525, 5636.802711905064, 5639.125935479925, 5653.095504719226, 5653.434656534396, 5663.830085097454, 5494.560435165257, 5656.717164141859, 5741.282339707536, 5741.311042674905, 5756.683382413924, 5474.315710536183, 5523.944760552343, 5567.24842146305, 5601.859953501195, 5605.0, 5612.326520817446, 5618.550515958714, 5642.210090587321, 5658.519025882763, 5669.54643628517, 4376.102898905717, 4385.978070109692, 4388.297872340474, 4389.934150987738, 4438.533953934855, 3822.7132965027736, 3873.3802591585213, 3908.257431088084, 3920.6079392061138, 3989.2221016901426, 5499.50504454601, 5526.309211348582, 5527.088030474926, 5543.307086614173, 5547.972260138674, 5740.971295143581, 5751.511121554715, 5751.884962300731, 5759.280089988752, 5795.9420405796245, 5324.733763311819, 5346.572274218053, 5369.731513424314, 5383.542398896059, 5404.162354835007, 4840.733759643183, 4845.781939812717, 4846.491118432514, 4851.757412129379, 4879.243717223836, 5812.38969908162, 5850.4149585042005, 5855.238818953509, 5857.589968702235, 5857.677827719431, 5572.944270557405, 5663.603547751618, 5727.656340619576, 5758.683272420057, 5859.648421094748, 6044.0933859919605, 6048.334683184934, 6048.334683184934, 6055.424734650202, 6067.908981365372, 5644.096944488862, 5700.401457847032, 5707.857303567444, 5709.600327977002, 5719.8570035749435, 5575.9163612545035, 5703.030484817508, 5732.140178973187, 5762.855928601818, 5857.853553661193, 5641.153826925994, 5659.009673307237, 5661.801836935852, 5664.801731939528, 5667.971660141673, 5620.662760234399, 5624.465675760796, 5650.406707295675, 5654.180143879033, 5657.632253903483, 5257.710825904612, 5463.836084917459, 5526.723663816873, 5548.445155484419, 5567.471090246582, 5569.888602227852, 5572.4148964358155, 5612.821307525465, 5623.297087864017, 5643.746031428514, 5311.49540793624, 5480.287562616834, 5488.615796894179, 5513.8345849624575, 5567.05360088794], "value": 5275.871699079122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2334204403433, 584.3630442817329, 594.7620951619352, 609.0042780054611, 628.2084573437468, 39907.60092399075, 43750.0, 43852.12295754083, 43999.78000109999, 44005.0, 44142.11715765683, 44657.0, 44771.328430073576, 44793.104137917304, 44851.77574112125, 8810.515421651806, 8924.776880578005, 8931.464112153259, 9027.774305642346, 9041.819163616723, 8808.427452215617, 8931.55342232889, 8938.329625278098, 8944.150305720947, 8953.686620968267, 9049.095090490964, 9061.773455663628, 9066.320025998044, 9068.138526839939, 9091.590878410487, 8972.59623316949, 8994.370394072417, 9002.279817614575, 9007.099290070973, 9022.45865248084, 8774.122587741238, 8879.600417981206, 8890.955545222298, 8891.822163556693, 8899.37704360695, 41135.7943210282, 41265.38101928474, 41502.79248603768, 41537.792311038254, 41548.79225603853, 3798.240351929625, 3823.9426408603895, 3962.385830196324, 4210.32634778437, 4296.119295544406, 32792.50811237833, 33247.83376083104, 33451.83274083614, 33465.83267083673, 33534.832325838215, 4351.0, 4493.573110554525, 4541.386912766768, 4544.863654090383, 4618.722876627413, 353045.0, 354616.0, 354719.0, 354778.0, 354837.0, 57658.7117064412, 58459.415405846245, 58646.70676646675, 58804.41195588075, 58859.41140588625, 61389.0, 61568.69215653893, 61812.0, 61892.381076189566, 62028.37971620316, 14826.925865370604, 14961.0, 15013.324400401789, 15038.699226015418, 15060.924695376672, 11847.703807404883, 11860.76278474443, 11888.048956083492, 11888.405579720978, 11948.522059117711, 15804.36782528686, 16809.243584038504, 17118.572035699206, 17261.223244954006, 17262.309507619804, 6322.968385158045, 6369.363063693593, 6487.643179625166, 6508.707108180143, 6534.693061387741, 918.7657147427497, 988.9406635601887, 1027.4143240092174, 1085.2077983072402, 1090.6782499162766, 29422.264443389085, 30597.541036884464, 31107.68892311048, 31175.53236701451, 31466.213344666565, 1144.5434786943551, 1145.3414286785132, 1171.9062475001979, 1199.7120691034088, 1201.243216773427, 15276.541703748906, 16282.918585406996, 16370.427035053715, 16416.343346266254, 16586.17069146562, 505834.0, 507157.0, 509597.0, 509824.0, 513851.0, 58318.41681583215, 58543.0, 58600.41399586035, 58722.41277587169, 58818.0, 1317.6442360562594, 1360.9591712248648, 1379.048456564967, 1385.7297826923855, 1388.4446221511475, 30688.364702883966, 33085.503717443775, 33145.83427082946, 33198.668013319555, 33550.66449335475, 50305.24542131798, 50542.49457505378, 50707.492925071754, 50727.74636126796, 50770.2384464226, 378568.0, 378933.0, 379489.0, 380663.0, 381330.0, 27760.36276553724, 28095.157145285673, 28276.575851361835, 28291.009814657213, 28309.575356370082, 47327.76336118297, 47425.28862067003, 48608.0, 48611.5138848607, 49669.75165124151, 41114.588854111076, 41817.37273940954, 42275.0, 42824.0, 44185.11629767322, 42223.366649500895, 42362.15275694407, 43598.782006089765, 44115.55884441114, 44302.0, 40651.18697625972, 41076.79461602673, 41609.0, 41871.37192942047, 41907.7904610475, 33864.83067584646, 37468.0, 37832.62167378291, 37848.43227351647, 38648.0, 28843.134705958855, 28867.711322887342, 29082.41835163327, 29136.7086329134, 29240.853795730884], "value": 20011.001438566254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.65731512980744, 386.9090763670537, 387.4711019458438, 397.79513550521506, 409.1510116508246, 17683.0, 19677.311294104707, 19810.801891981093, 19854.602907941833, 20218.39344819654, 17938.19278132484, 18405.90797046016, 19028.0, 19114.426567203005, 19140.0, 5638.520725738307, 5736.196932429463, 5755.942440575583, 5783.826485205451, 5821.27234095738, 5638.689872057035, 5697.0, 5741.827745167651, 5751.4536119068625, 5792.7972520961775, 5675.0, 5705.087186050233, 5747.59766816323, 5750.942490575104, 5774.335951365584, 5558.888822223553, 5740.483356497914, 5752.539796816244, 5768.3366412862215, 5789.507891829199, 4675.368825208588, 4941.802327906916, 4949.430815456232, 5044.949550504484, 5052.9242061369105, 13418.0, 13555.932220338935, 13556.11885227457, 18918.148683309286, 22400.439989000242, 2158.53591477833, 2219.844610877239, 2245.595792757303, 2745.7803375729895, 2957.659869115058, 9389.859152112724, 9597.760055998586, 10028.0, 10127.64553240633, 11914.821277680841, 1824.4526642007477, 1862.9068546572616, 1896.535348839543, 1908.2257984156329, 1961.7155512450615, 79707.6014619929, 80080.0, 80645.59677201635, 80950.59524702397, 81154.9999999994, 10629.787404251872, 10763.83854242187, 11071.225014249087, 11076.446177691245, 11133.443327833576, 14441.711165776625, 14497.202653853928, 14912.179830109231, 14919.776203356958, 14957.925210373878, 6405.839854003687, 6467.417932386108, 7356.37470814976, 7807.453478256468, 8094.51432914027, 7411.407087432993, 7467.439942004263, 7523.674779273666, 7635.121960974559, 7662.272084151997, 4580.083983203373, 4582.518835522289, 4626.953730462652, 4653.464851542049, 4711.575958163782, 1884.3593178319438, 1927.9563662517776, 1976.8319692825983, 1988.7812340642517, 2006.2476571285767, 935.317218430536, 944.3106532231373, 948.5913418573413, 950.496236994394, 1037.956853362366, 18441.354552590863, 19787.40637780869, 19811.306604268782, 19842.206311747657, 20045.49886252826, 986.28001558861, 1004.0, 1012.5291739341242, 1013.9797204056025, 1038.2213339995003, 9250.86123708145, 10981.3960232188, 11000.944995274973, 11120.888791112147, 11197.776044479227, 524027.0, 529085.0, 531319.0, 538978.0, 540141.0, 78040.60979695065, 94732.52633736788, 95200.04799951911, 96548.0, 96943.51528242313, 947.1002547579827, 973.5181085362791, 975.7219192530094, 982.7101005203482, 1008.6822650864954, 15588.376464941275, 17498.300067997137, 17664.470065898044, 17677.646447071245, 17906.91046544759, 41163.7941810301, 41774.58225417828, 42407.03150779539, 43493.78253108841, 43589.346159808265, 53892.730536347066, 55698.443015569326, 56480.15279770889, 60782.69608651928, 61923.07115393183, 11896.643100706993, 12357.567485137977, 12464.937675311565, 13256.867431325949, 13261.204327740366, 13905.791413129013, 13960.170810551552, 14291.714165716836, 14554.345054472362, 14693.265336732908, 11735.882641173479, 12118.939405302917, 12147.210431321935, 12186.2078964867, 12684.0, 7857.096433909945, 7872.330851877655, 12238.388080596113, 12478.18891772032, 12644.873551264369, 7727.961360193163, 8071.636776344961, 8295.709650162215, 8309.459885107448, 8565.0, 12694.365281736062, 12902.935485322514, 13128.0, 13222.338883055616, 13286.468541258242, 11506.367149806842, 12695.174813637084, 12744.936275318563, 12840.935795320964, 13249.205047697169], "value": 9201.355954940733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.8947973641843, 1515.651400177959, 1654.6277087655278, 1771.309189416127, 1784.3754685859942, 7694.115176754675, 8602.311815054789, 8654.0, 9164.221041211496, 9172.587233574488, 8746.650133994632, 9068.0, 9074.818503629924, 9079.863802042975, 9097.681581144645, 2412.3245491262433, 2452.104981681682, 2460.2619214235747, 2460.520198561281, 2470.6047032474808, 2381.30942026812, 2394.784469397754, 2430.5503481855826, 2434.4400787818813, 2438.609822428403, 2358.858468491896, 2392.6052201386838, 2395.4370722880108, 2409.759024097585, 2430.890609922558, 2327.615943369342, 2348.8590684558812, 2351.4826738117586, 2356.7643235676464, 2369.419492224416, 2301.42464383904, 2347.7769611886843, 2348.3542025943, 2360.421696684306, 2361.480474295652, 9112.271018318519, 9165.404248723811, 9180.357374983754, 9181.632734690604, 9244.95377523108, 5225.1117310057, 5375.543078838304, 5453.618246722731, 5566.944330556683, 5567.2762540869835, 3535.0985498697924, 3580.838862251205, 3632.5822530409077, 3633.273345330918, 3642.344378011957, 1214.5141943222693, 1228.281455348622, 1240.0823390690914, 1246.4453318273372, 1249.331607589935, 12339.62981110568, 12398.876011239863, 12400.441980110916, 12402.13185077045, 12416.441260143405, 4623.42207224097, 4727.078219747116, 4854.417469903634, 4877.6829506081995, 4974.850754477371, 10787.406692631981, 10790.94604526988, 10799.67600971972, 10804.67585972422, 10827.83758243627, 5545.417731138253, 5560.054790685593, 5574.888502230014, 5576.804811831566, 5581.079121944834, 4327.242732521796, 4746.667733258639, 4849.878753031202, 4884.902301953941, 5132.486751324837, 3979.403089536535, 4047.817848196838, 4068.9186216275507, 4205.705600607928, 4212.599803018708, 1318.3276528970293, 1321.4648067532664, 1324.9801252981213, 1361.271719630013, 1376.6145479265822, 854.2610641794803, 977.9217662586976, 994.3437331361267, 1040.245821779219, 1074.5648012554927, 6206.224221972254, 6319.368063193736, 6326.398992095744, 6359.554831161867, 6479.416852483299, 446.9955300446954, 458.3972076719104, 460.8962983328791, 465.664721400591, 465.7717718318, 4231.78841057952, 4423.756693381895, 4491.371208030879, 4504.887377815581, 4523.208438523246, 11068.28056176346, 11272.0, 11326.490307936163, 11329.603463878724, 11345.149113816497, 11061.391623460788, 11062.170337224741, 11215.831762523569, 11225.438728063564, 11237.775244495064, 8180.631871565674, 8368.916310836814, 8416.410851240355, 8458.281046111026, 8498.447600905922, 6216.694494156278, 6256.124142620128, 6309.968450157903, 6373.171487706569, 6385.45723613498, 10044.54799534008, 10066.647667331608, 10133.493325333851, 10177.898221017695, 10219.131373833308, 10386.376817390981, 10439.895601043892, 10502.212334075128, 10527.473626318806, 10528.0, 7048.823779405556, 7616.3906887447765, 7922.366210703245, 7992.280694737501, 8071.636776345196, 8805.603747831492, 8864.556772161237, 8881.467111973303, 8888.066752990842, 8947.821043578962, 7759.0, 7990.560519171501, 8007.799805004922, 8074.354051675734, 8088.0, 7895.289423951872, 7911.485753426009, 7912.0901096374655, 7932.0, 7995.720149794729, 7147.2852714728115, 7230.74692385764, 7252.0, 7305.853882922418, 7308.59802710856, 5543.1962365455975, 5575.414581468887, 5629.493345598916, 5662.348829884451, 5720.599558031065, 5503.614746967673, 5607.719614019365, 5652.85867853307, 5675.886482270249, 5696.0], "value": 4725.204322216056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.1169284467714, 325.39801367470176, 330.6313460491551, 335.3025706530417, 337.2142907026628, 5373.355197376311, 5440.945590544094, 5508.228847961289, 5565.137403702428, 5588.133839254917, 5374.543163831079, 5448.37343705474, 5468.48049435304, 5473.17902314653, 5490.533304669098, 4338.956610433886, 4344.784160078367, 4355.869323920288, 4361.34579813029, 4363.258246098171, 4151.12826306476, 4200.180964711883, 4224.9226447255905, 4343.131373725252, 4351.71713838601, 4164.250434921712, 4168.7081904266715, 4169.833206671729, 4187.806475154582, 4191.853285135021, 4178.874633760992, 4187.497500299984, 4194.559571245021, 4210.578942105765, 4232.153569286155, 3654.8121860395477, 3668.468072129553, 3670.853165873362, 3690.2988432197794, 3690.5755838078694, 5079.923801142986, 5302.3297661236975, 5308.442613525563, 5353.437889021675, 5358.223057656657, 4832.251001094836, 4845.079434907357, 4849.393825771778, 4860.489648586883, 4877.561019508261, 5427.782888684487, 5726.77092916287, 5736.1682556029145, 5736.598438109334, 5786.42135786418, 4045.4740883685226, 4055.7566546007038, 4055.898602534931, 4066.247744167309, 4098.52866920305, 6042.9395706042815, 6045.486133678643, 6054.909176362358, 6061.090836374535, 6092.380276481112, 3861.2277544490653, 4127.669786417079, 4162.146759914211, 4165.396017577435, 4171.728837625545, 4088.366303223005, 4090.284200264942, 4103.076807718239, 4114.526829414595, 4118.979405103015, 4809.495003024702, 4809.78355973982, 4817.7350245736825, 4823.975880120647, 4828.975855120702, 5617.522510586564, 5773.249477567973, 5775.3540241031105, 5850.268716410449, 5869.61847479921, 1397.6436008817686, 1421.8649228323293, 1425.49394964786, 1426.1728197645548, 1427.635952832021, 881.4799268431656, 907.1880666803174, 911.6735150356216, 931.1154403316876, 935.9064093590587, 4967.279744437036, 4974.403071631427, 4977.950220497749, 5002.299678045077, 5011.621804003928, 5253.553447956967, 5265.473452654704, 5266.052110620125, 5293.253226435267, 5309.734513274321, 4635.351050852883, 4991.625628077836, 5084.779652883355, 5093.0577843099145, 5129.7691603877165, 2779.8185771047224, 2789.567617019365, 2792.5531914893927, 2798.622186004904, 2821.5908693239367, 5496.367917689437, 5504.889902202013, 5541.141123125922, 5580.330360356783, 5580.414056524088, 5170.948290517122, 5230.503102205284, 5291.841244762663, 5314.415414304423, 5323.866903327448, 5420.075873065084, 5456.863578410572, 5463.644863083887, 5502.2296878437055, 5517.9443109315425, 5260.736963151904, 5290.756672181958, 5371.979323928441, 5376.467706703727, 5390.865228369322, 4856.805727770991, 5107.395228433451, 5142.948570514247, 5149.562287205629, 5151.531813433154, 5443.8094666686475, 5485.286912701324, 5485.807996720096, 5492.940147444709, 5504.2753836849415, 3681.723870709654, 3933.8426462942307, 4050.3721923101966, 4137.751734895915, 4155.750654960712, 5855.243426971806, 5902.730912853757, 5915.526757859447, 5928.644281343133, 5929.695466997254, 5662.207290979184, 5817.243758311392, 5818.4763371296785, 5822.5633077518505, 5825.330087040044, 5706.80026199081, 5711.400302968294, 5730.848033581597, 5734.455226753452, 5744.42555744439, 5660.349059858169, 5666.575006874418, 5669.881565139074, 5703.885922281448, 5709.65742055478, 5525.309336332958, 5710.800121995876, 5728.942710572841, 5768.2501274834, 5796.652200867961, 5607.158926161109, 5645.463680950304, 5660.830175094589, 5684.7157642118555, 5695.971520142372], "value": 4219.064836410762, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.8095635612918, 748.0, 769.3153093746563, 770.4221833624781, 830.3606223208134, 14501.927490362546, 14953.47662831801, 15257.160856152906, 15270.465533706323, 15298.770518442232, 14192.574222773308, 14256.928715356435, 14267.78598321026, 14273.286335683226, 14282.785758213635, 659.1595715462776, 778.17513435758, 784.9372050235982, 794.7417089445925, 799.1369321133192, 805.5368163306093, 810.2019510781876, 812.4597142899964, 814.2468216899374, 814.8573999550084, 857.3698331726176, 862.2369203255133, 866.9739907802776, 867.8654808504692, 868.0754995929346, 853.8676505141713, 861.8190180062131, 863.7754183912165, 864.4078806017835, 865.0570877743259, 628.3559351664535, 630.8643641617074, 631.564220687724, 632.2349956552576, 635.3773302163905, 15525.223738813014, 15588.454404095803, 15590.454334098253, 15590.454334098253, 15639.218039098, 13934.512292069729, 14079.296035198302, 14116.223607701573, 14135.081219720789, 14201.147931124166, 11978.281303121754, 12053.57812476559, 12090.879091209063, 12280.692982675415, 12352.752944941141, 3924.5806595475774, 3957.7625342479255, 3971.6624086952643, 4014.3376342903384, 4086.9795651021554, 78756.60621696913, 81310.0, 81967.0, 82368.9999999994, 82394.0, 10639.787204256027, 10750.677479675622, 10847.132229421628, 10956.835647465294, 10986.285891417032, 22437.43906402353, 22641.320760376886, 22901.770982289963, 22939.426514337276, 23168.76831231666, 8592.312614990786, 8638.740837774876, 8677.739667809976, 8749.606267717969, 8817.470951742916, 4804.95195048052, 4959.479254678279, 4992.750362481861, 5013.924791128136, 5014.774335154853, 3365.781224220467, 3456.5679290088738, 3476.3568739783223, 3482.7213822894614, 3487.3722729908354, 588.8351261646745, 606.1483615520201, 606.5602438232335, 616.5622408090217, 635.4852569418786, 686.9965650171818, 708.1643660480579, 709.6558169287891, 731.0861423220974, 751.3538357012965, 10132.949335253277, 10247.59009639621, 10365.533550990072, 10388.584456621651, 10464.162866970624, 613.2579578709722, 627.5669787846372, 682.1439093937078, 690.9689063992132, 736.1644533454568, 4855.902881942412, 5027.1705168647495, 5128.128233194931, 5168.095583272912, 5203.60972927032, 114480.42759786148, 114753.0, 116438.41780791042, 116543.41728291304, 116745.0, 98627.0, 100431.0, 100557.49721251347, 101235.0, 104247.47876260571, 87725.1227487717, 87883.0, 88145.55927220451, 88768.5561572188, 89642.55178724065, 9647.276454265817, 9673.322867399214, 9744.75638109053, 9753.853692194765, 9995.550200240861, 46351.53648463472, 48186.5181348182, 48429.51570484391, 49000.754996224794, 50620.0, 71398.0, 71627.0, 78927.21072789429, 81239.0, 81557.18442815733, 12213.75572488563, 12453.501859925502, 12630.179038362478, 13018.479260829461, 13085.869141308845, 14451.78322325187, 14519.0, 14568.27158642085, 14685.0, 14781.0, 13422.194668319931, 13827.446902124204, 14079.577612671636, 14256.358463869357, 14289.28553572338, 12542.310172940211, 12692.0, 12993.09048366643, 13421.127626704232, 13492.797608036084, 12711.491540338653, 12983.0, 13199.406026729012, 13552.728945421233, 13580.45678172862, 10075.0, 10119.544620492243, 10209.132223761064, 10255.128314093086, 10292.948535257276, 9771.804563908825, 9879.50602469888, 10101.747456313651, 11403.771924561628, 11423.885761142283], "value": 7563.710255423849, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 108.0, 116.0, 113.0, 112.0, 113.0, 110.0, 113.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 148.0, 179.0, 121.0, 150.0, 150.0, 121.0, 180.0, 118.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 163.0, 168.0, 168.0, 165.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 179.0, 78.0, 76.0, 75.0, 75.0, 176.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 152.0, 84.0, 84.0, 84.0, 146.0, 84.0, 91.0, 145.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 56.0, 52.0, 53.0, 57.0, 54.0, 53.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 65.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 77.0, 82.0, 76.0, 82.0, 79.0, 75.0, 76.0, 76.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 122.0, 136.0, 135.0, 128.0, 122.0, 127.0, 168.0, 136.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 165.0, 161.0, 157.0, 161.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 63.0, 63.0, 64.0, 64.0, 64.0, 62.0], "value": 63.9, "unit": "score"}]}]} 14:40:06 INFO - Return code: 0 14:40:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:40:06 ERROR - # TBPL SUCCESS # 14:40:06 INFO - Running post-action listener: _resource_record_post_action 14:40:06 INFO - [mozharness: 2016-07-29 21:40:06.116006Z] Finished run-tests step (success) 14:40:06 INFO - Running post-run listener: _resource_record_post_run 14:40:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 139264; Write bytes: 557518848; Read time: 12; Write time: 672368 14:40:06 INFO - TinderboxPrint: CPU usage
13.4% 14:40:06 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 12 14:40:06 INFO - TinderboxPrint: I/O write bytes / time
557,518,848 / 672,368 14:40:06 INFO - TinderboxPrint: CPU idle
8,232.2 (86.5%) 14:40:06 INFO - TinderboxPrint: CPU user
1,218.9 (12.8%) 14:40:06 INFO - TinderboxPrint: Swap in / out
0 / 0 14:40:06 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 263294976; Read time: 0; Write time: 366136 14:40:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 139264; Write bytes: 289771520; Read time: 12; Write time: 305936 14:40:06 INFO - Running post-run listener: _upload_blobber_files 14:40:06 INFO - Blob upload gear active. 14:40:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:40:06 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 14:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:40:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:40:11 INFO - (blobuploader) - INFO - Done attempting. 14:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:40:11 INFO - (blobuploader) - INFO - Done attempting. 14:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:40:12 INFO - (blobuploader) - INFO - Done attempting. 14:40:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:40:12 INFO - Return code: 0 14:40:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:40:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:40:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb7a129d66ad2d9267e4a4459398718f363a8c027a5137e2da72f0762118a9269861e82ee30b95bc7d69837cf9d19c823fcdd82014c2b0b300381ed76a9e14c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff6dfa9182d040f625c2346438b1f3d833eb4fbd7e169b2b4ef7d6bfafcff01e1ee277ac2e5b9e47953461caca4731f21fc3310e37573997f4a5894c918eba33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9eab06ed21e43b5d3dfc4e3faf227148403007716d2c7d2d523ea5a78d04299bffe60bb3968b50cedbe2bdd009764730a81f14a0dcd882670bc874a5933f99"} 14:40:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:40:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:40:12 INFO - Contents: 14:40:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb7a129d66ad2d9267e4a4459398718f363a8c027a5137e2da72f0762118a9269861e82ee30b95bc7d69837cf9d19c823fcdd82014c2b0b300381ed76a9e14c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff6dfa9182d040f625c2346438b1f3d833eb4fbd7e169b2b4ef7d6bfafcff01e1ee277ac2e5b9e47953461caca4731f21fc3310e37573997f4a5894c918eba33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9eab06ed21e43b5d3dfc4e3faf227148403007716d2c7d2d523ea5a78d04299bffe60bb3968b50cedbe2bdd009764730a81f14a0dcd882670bc874a5933f99"} 14:40:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:40:12 INFO - Copying logs to upload dir... 14:40:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:40:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.263761 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-29 14:40:12.529143) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 14:40:12.532435) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb7a129d66ad2d9267e4a4459398718f363a8c027a5137e2da72f0762118a9269861e82ee30b95bc7d69837cf9d19c823fcdd82014c2b0b300381ed76a9e14c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff6dfa9182d040f625c2346438b1f3d833eb4fbd7e169b2b4ef7d6bfafcff01e1ee277ac2e5b9e47953461caca4731f21fc3310e37573997f4a5894c918eba33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9eab06ed21e43b5d3dfc4e3faf227148403007716d2c7d2d523ea5a78d04299bffe60bb3968b50cedbe2bdd009764730a81f14a0dcd882670bc874a5933f99"} build_url:https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/GvL79jfSSnOj2lAeIqCqOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abb7a129d66ad2d9267e4a4459398718f363a8c027a5137e2da72f0762118a9269861e82ee30b95bc7d69837cf9d19c823fcdd82014c2b0b300381ed76a9e14c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff6dfa9182d040f625c2346438b1f3d833eb4fbd7e169b2b4ef7d6bfafcff01e1ee277ac2e5b9e47953461caca4731f21fc3310e37573997f4a5894c918eba33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d9eab06ed21e43b5d3dfc4e3faf227148403007716d2c7d2d523ea5a78d04299bffe60bb3968b50cedbe2bdd009764730a81f14a0dcd882670bc874a5933f99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 14:40:12.558047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:40:12.558364) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1469827126.588487-1040943185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:40:12.644518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 14:40:12.644861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 14:40:12.645212) ========= ========= Total master_lag: 0.17 =========