builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1470223634.2 results: success (0) buildid: 20160803034441 builduid: 17a97d0ec7cc4c8783445c3d5162d0f7 revision: 8af80e4c3def3275ddef3cb965dada9aa50887d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.200609) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.201114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.201444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.223251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.223777) ========= 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=db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 04:27:14-- 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% 42.9M=0s 2016-08-03 04:27:14 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.368090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.368781) ========= 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=db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016304 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:14.421316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 04:27:14.422116) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8af80e4c3def3275ddef3cb965dada9aa50887d6 --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 8af80e4c3def3275ddef3cb965dada9aa50887d6 --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=db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 04:27:14,559 truncating revision to first 12 chars 2016-08-03 04:27:14,559 Setting DEBUG logging. 2016-08-03 04:27:14,560 attempt 1/10 2016-08-03 04:27:14,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8af80e4c3def?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 04:27:15,305 unpacking tar archive at: fx-team-8af80e4c3def/testing/mozharness/ program finished with exit code 0 elapsedTime=1.128686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-03 04:27:15.568635) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:15.569197) ========= script_repo_revision: 8af80e4c3def3275ddef3cb965dada9aa50887d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:15.569950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:15.571277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 04:27:15.584339) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-03 04:27:15.584877) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:27:15 INFO - MultiFileLogger online at 20160803 04:27:15 in /builds/slave/test 04:27:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:27:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:15 INFO - {'append_to_log': False, 04:27:15 INFO - 'base_work_dir': '/builds/slave/test', 04:27:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:27:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:15 INFO - 'branch': 'Fx-Team-Non-PGO', 04:27:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:15 INFO - 'config_files': ('talos/linux_config.py',), 04:27:15 INFO - 'default_actions': ('clobber', 04:27:15 INFO - 'read-buildbot-config', 04:27:15 INFO - 'download-and-extract', 04:27:15 INFO - 'populate-webroot', 04:27:15 INFO - 'create-virtualenv', 04:27:15 INFO - 'install', 04:27:15 INFO - 'run-tests'), 04:27:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:15 INFO - 'download_minidump_stackwalk': True, 04:27:15 INFO - 'download_symbols': 'ondemand', 04:27:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:15 INFO - 'installer_path': 'installer.exe', 04:27:15 INFO - 'log_level': 'info', 04:27:15 INFO - 'log_name': 'talos', 04:27:15 INFO - 'log_to_console': True, 04:27:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:27:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:27:15 INFO - 'opt_config_files': (), 04:27:15 INFO - 'pip_index': False, 04:27:15 INFO - 'sps_profile': False, 04:27:15 INFO - 'sps_profile_interval': 0, 04:27:15 INFO - 'suite': 'dromaeojs', 04:27:15 INFO - 'system_bits': '32', 04:27:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:15 INFO - 'title': 'talos-linux64-ix-049', 04:27:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:15 INFO - 'use_talos_json': True, 04:27:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:15 INFO - 'work_dir': 'build'} 04:27:15 INFO - [mozharness: 2016-08-03 11:27:15.813861Z] Running clobber step. 04:27:15 INFO - Running pre-action listener: _resource_record_pre_action 04:27:15 INFO - Running main action method: clobber 04:27:15 INFO - rmtree: /builds/slave/test/build 04:27:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:16 INFO - Running post-action listener: _resource_record_post_action 04:27:16 INFO - [mozharness: 2016-08-03 11:27:16.276419Z] Finished clobber step (success) 04:27:16 INFO - [mozharness: 2016-08-03 11:27:16.276521Z] Running read-buildbot-config step. 04:27:16 INFO - Running pre-action listener: _resource_record_pre_action 04:27:16 INFO - Running main action method: read_buildbot_config 04:27:16 INFO - Using buildbot properties: 04:27:16 INFO - { 04:27:16 INFO - "project": "", 04:27:16 INFO - "product": "firefox", 04:27:16 INFO - "script_repo_revision": "production", 04:27:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:27:16 INFO - "repository": "", 04:27:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:27:16 INFO - "buildid": "20160803034441", 04:27:16 INFO - "pgo_build": "False", 04:27:16 INFO - "basedir": "/builds/slave/test", 04:27:16 INFO - "buildnumber": 2061, 04:27:16 INFO - "slavename": "talos-linux64-ix-049", 04:27:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:27:16 INFO - "platform": "ubuntu64_hw", 04:27:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:27:16 INFO - "branch": "fx-team", 04:27:16 INFO - "repo_path": "integration/fx-team", 04:27:16 INFO - "revision": "8af80e4c3def3275ddef3cb965dada9aa50887d6", 04:27:16 INFO - "stage_platform": "linux64", 04:27:16 INFO - "builduid": "17a97d0ec7cc4c8783445c3d5162d0f7", 04:27:16 INFO - "slavebuilddir": "test" 04:27:16 INFO - } 04:27:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:27:16 INFO - Running post-action listener: _resource_record_post_action 04:27:16 INFO - [mozharness: 2016-08-03 11:27:16.278993Z] Finished read-buildbot-config step (success) 04:27:16 INFO - [mozharness: 2016-08-03 11:27:16.279081Z] Running download-and-extract step. 04:27:16 INFO - Running pre-action listener: _resource_record_pre_action 04:27:16 INFO - Running main action method: download_and_extract 04:27:16 INFO - mkdir: /builds/slave/test/build/tests 04:27:16 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')]} 04:27:16 INFO - https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:27:16 INFO - Downloaded 1361 bytes. 04:27:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:27:16 INFO - Using the following test package requirements: 04:27:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:27:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:27:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'jsshell-linux-x86_64.zip'], 04:27:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:27:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:27:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:27:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:27:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:27:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:27:16 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')]} 04:27:16 INFO - https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:27:17 INFO - Downloaded 20239290 bytes. 04:27:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:27:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:27:18 INFO - Return code: 0 04:27:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:27:18 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')]} 04:27:18 INFO - https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:27:19 INFO - Downloaded 20239290 bytes. 04:27:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:27:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:27:21 INFO - Return code: 0 04:27:21 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')]} 04:27:21 INFO - https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:27:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:27:22 INFO - Downloaded 14413723 bytes. 04:27:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:27:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:27:22 INFO - Return code: 0 04:27:22 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')]} 04:27:22 INFO - https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:27:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:27:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:27:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:27:23 INFO - Downloaded 55680427 bytes. 04:27:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:27:23 INFO - mkdir: /builds/slave/test/properties 04:27:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:23 INFO - Contents: 04:27:23 INFO - build_url:https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:27:24 INFO - Running post-action listener: _resource_record_post_action 04:27:24 INFO - Running post-action listener: set_extra_try_arguments 04:27:24 INFO - [mozharness: 2016-08-03 11:27:24.263098Z] Finished download-and-extract step (success) 04:27:24 INFO - [mozharness: 2016-08-03 11:27:24.263332Z] Running populate-webroot step. 04:27:24 INFO - Running pre-action listener: _resource_record_pre_action 04:27:24 INFO - Running main action method: populate_webroot 04:27:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:24 INFO - '--tppagecycles', 04:27:24 INFO - '7'], 04:27:24 INFO - 'tests': ['tsvgm']}}, 04:27:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['damp', 'tps']}, 04:27:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'tests': ['damp', 'tps']}, 04:27:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['dromaeo_dom']}, 04:27:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['basic_compositor_video']}, 04:27:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['a11yr', 04:27:24 INFO - 'ts_paint', 04:27:24 INFO - 'tpaint', 04:27:24 INFO - 'sessionrestore', 04:27:24 INFO - 'sessionrestore_no_auto_restore', 04:27:24 INFO - 'tabpaint']}, 04:27:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:24 INFO - 'ts_paint', 04:27:24 INFO - 'tpaint', 04:27:24 INFO - 'sessionrestore', 04:27:24 INFO - 'sessionrestore_no_auto_restore', 04:27:24 INFO - 'tabpaint']}, 04:27:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:24 INFO - 'ts_paint', 04:27:24 INFO - 'tpaint', 04:27:24 INFO - 'sessionrestore', 04:27:24 INFO - 'sessionrestore_no_auto_restore', 04:27:24 INFO - 'tabpaint']}, 04:27:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:24 INFO - 'ts_paint', 04:27:24 INFO - 'tpaint', 04:27:24 INFO - 'sessionrestore', 04:27:24 INFO - 'sessionrestore_no_auto_restore', 04:27:24 INFO - 'tabpaint']}, 04:27:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['a11yr', 04:27:24 INFO - 'ts_paint', 04:27:24 INFO - 'tpaint', 04:27:24 INFO - 'sessionrestore', 04:27:24 INFO - 'sessionrestore_no_auto_restore', 04:27:24 INFO - 'tabpaint']}, 04:27:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['a11yr', 04:27:24 INFO - 'ts_paint', 04:27:24 INFO - 'tpaint', 04:27:24 INFO - 'sessionrestore', 04:27:24 INFO - 'sessionrestore_no_auto_restore', 04:27:24 INFO - 'tabpaint']}, 04:27:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['tsvgx', 04:27:24 INFO - 'tsvgr_opacity', 04:27:24 INFO - 'tart', 04:27:24 INFO - 'tscrollx', 04:27:24 INFO - 'cart']}, 04:27:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:24 INFO - 'tsvgr_opacity', 04:27:24 INFO - 'tart', 04:27:24 INFO - 'tscrollx', 04:27:24 INFO - 'cart']}, 04:27:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'talos_options': ['--disable-e10s'], 04:27:24 INFO - 'tests': ['tp5o']}, 04:27:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'tests': ['tp5o']}, 04:27:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'talos_options': ['--disable-e10s', 04:27:24 INFO - '--xperf_path', 04:27:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:24 INFO - 'tests': ['tp5n']}, 04:27:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:24 INFO - 'talos_options': ['--xperf_path', 04:27:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:24 INFO - 'tests': ['tp5n']}}, 04:27:24 INFO - 'talos.zip': {'path': '', 04:27:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:24 INFO - Running post-action listener: _resource_record_post_action 04:27:24 INFO - [mozharness: 2016-08-03 11:27:24.280507Z] Finished populate-webroot step (success) 04:27:24 INFO - [mozharness: 2016-08-03 11:27:24.280597Z] Running create-virtualenv step. 04:27:24 INFO - Running pre-action listener: _resource_record_pre_action 04:27:24 INFO - Running main action method: create_virtualenv 04:27:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:24 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 04:27:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:24 INFO - Using real prefix '/usr' 04:27:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:26 INFO - Installing pip.................done. 04:27:26 INFO - Return code: 0 04:27:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:27:26 INFO - Using env: {'DISPLAY': ':0', 04:27:26 INFO - 'HOME': '/home/cltbld', 04:27:26 INFO - 'LANG': 'en_US.UTF-8', 04:27:26 INFO - 'LANGUAGE': 'en_US:en', 04:27:26 INFO - 'LOGNAME': 'cltbld', 04:27:26 INFO - 'MAIL': '/var/mail/cltbld', 04:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:26 INFO - 'MOZ_NO_REMOTE': '1', 04:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:26 INFO - 'NO_EM_RESTART': '1', 04:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:26 INFO - 'PWD': '/builds/slave/test', 04:27:26 INFO - 'SHELL': '/bin/bash', 04:27:26 INFO - 'SHLVL': '1', 04:27:26 INFO - 'TERM': 'linux', 04:27:26 INFO - 'TMOUT': '86400', 04:27:26 INFO - 'USER': 'cltbld', 04:27:26 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:26 INFO - '_': '/tools/buildbot/bin/python'} 04:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:27 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 04:27:27 INFO - Cleaning up... 04:27:27 INFO - Return code: 0 04:27:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:27 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:27 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 04:27:27 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 04:27:27 INFO - Using env: {'DISPLAY': ':0', 04:27:27 INFO - 'HOME': '/home/cltbld', 04:27:27 INFO - 'LANG': 'en_US.UTF-8', 04:27:27 INFO - 'LANGUAGE': 'en_US:en', 04:27:27 INFO - 'LOGNAME': 'cltbld', 04:27:27 INFO - 'MAIL': '/var/mail/cltbld', 04:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:27 INFO - 'MOZ_NO_REMOTE': '1', 04:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:27 INFO - 'NO_EM_RESTART': '1', 04:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:27 INFO - 'PWD': '/builds/slave/test', 04:27:27 INFO - 'SHELL': '/bin/bash', 04:27:27 INFO - 'SHLVL': '1', 04:27:27 INFO - 'TERM': 'linux', 04:27:27 INFO - 'TMOUT': '86400', 04:27:27 INFO - 'USER': 'cltbld', 04:27:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:27 INFO - '_': '/tools/buildbot/bin/python'} 04:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:27 INFO - Downloading/unpacking psutil>=3.1.1 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:29 INFO - Installing collected packages: psutil 04:27:29 INFO - Running setup.py install for psutil 04:27:29 INFO - building 'psutil._psutil_linux' extension 04:27:29 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 04:27:29 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 04:27:29 INFO - building 'psutil._psutil_posix' extension 04:27:29 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 04:27:29 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 04:27:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:29 INFO - Successfully installed psutil 04:27:29 INFO - Cleaning up... 04:27:29 INFO - Return code: 0 04:27:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:29 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')]} 04:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:29 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')]} 04:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:29 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:29 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 04:27:29 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 04:27:29 INFO - Using env: {'DISPLAY': ':0', 04:27:29 INFO - 'HOME': '/home/cltbld', 04:27:29 INFO - 'LANG': 'en_US.UTF-8', 04:27:29 INFO - 'LANGUAGE': 'en_US:en', 04:27:29 INFO - 'LOGNAME': 'cltbld', 04:27:29 INFO - 'MAIL': '/var/mail/cltbld', 04:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:29 INFO - 'MOZ_NO_REMOTE': '1', 04:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:29 INFO - 'NO_EM_RESTART': '1', 04:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:29 INFO - 'PWD': '/builds/slave/test', 04:27:29 INFO - 'SHELL': '/bin/bash', 04:27:29 INFO - 'SHLVL': '1', 04:27:29 INFO - 'TERM': 'linux', 04:27:29 INFO - 'TMOUT': '86400', 04:27:29 INFO - 'USER': 'cltbld', 04:27:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:29 INFO - '_': '/tools/buildbot/bin/python'} 04:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:32 INFO - Installing collected packages: mozsystemmonitor 04:27:32 INFO - Running setup.py install for mozsystemmonitor 04:27:32 INFO - Successfully installed mozsystemmonitor 04:27:32 INFO - Cleaning up... 04:27:32 INFO - Return code: 0 04:27:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:32 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:32 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 04:27:32 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 04:27:32 INFO - Using env: {'DISPLAY': ':0', 04:27:32 INFO - 'HOME': '/home/cltbld', 04:27:32 INFO - 'LANG': 'en_US.UTF-8', 04:27:32 INFO - 'LANGUAGE': 'en_US:en', 04:27:32 INFO - 'LOGNAME': 'cltbld', 04:27:32 INFO - 'MAIL': '/var/mail/cltbld', 04:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:32 INFO - 'MOZ_NO_REMOTE': '1', 04:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:32 INFO - 'NO_EM_RESTART': '1', 04:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:32 INFO - 'PWD': '/builds/slave/test', 04:27:32 INFO - 'SHELL': '/bin/bash', 04:27:32 INFO - 'SHLVL': '1', 04:27:32 INFO - 'TERM': 'linux', 04:27:32 INFO - 'TMOUT': '86400', 04:27:32 INFO - 'USER': 'cltbld', 04:27:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:32 INFO - '_': '/tools/buildbot/bin/python'} 04:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:32 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 04:27:32 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 04:27:32 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 04:27:32 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 04:27:32 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 04:27:32 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 04:27:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:34 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 04:27:34 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 04:27:34 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 04:27:34 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 04:27:34 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 04:27:34 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 04:27:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:34 INFO - warning: no files found matching '*.txt' 04:27:34 INFO - no previously-included directories found matching 'build' 04:27:34 INFO - no previously-included directories found matching 'dist' 04:27:34 INFO - no previously-included directories found matching '.git*' 04:27:34 INFO - Installing collected packages: jsonschema, functools32 04:27:34 INFO - Running setup.py install for functools32 04:27:34 INFO - warning: no files found matching '*.txt' 04:27:34 INFO - no previously-included directories found matching 'build' 04:27:34 INFO - no previously-included directories found matching 'dist' 04:27:34 INFO - no previously-included directories found matching '.git*' 04:27:34 INFO - Successfully installed jsonschema functools32 04:27:34 INFO - Cleaning up... 04:27:34 INFO - Return code: 0 04:27:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:34 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:34 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 04:27:34 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 04:27:34 INFO - Using env: {'DISPLAY': ':0', 04:27:34 INFO - 'HOME': '/home/cltbld', 04:27:34 INFO - 'LANG': 'en_US.UTF-8', 04:27:34 INFO - 'LANGUAGE': 'en_US:en', 04:27:34 INFO - 'LOGNAME': 'cltbld', 04:27:34 INFO - 'MAIL': '/var/mail/cltbld', 04:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:34 INFO - 'MOZ_NO_REMOTE': '1', 04:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:34 INFO - 'NO_EM_RESTART': '1', 04:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:34 INFO - 'PWD': '/builds/slave/test', 04:27:34 INFO - 'SHELL': '/bin/bash', 04:27:34 INFO - 'SHLVL': '1', 04:27:34 INFO - 'TERM': 'linux', 04:27:34 INFO - 'TMOUT': '86400', 04:27:34 INFO - 'USER': 'cltbld', 04:27:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:34 INFO - '_': '/tools/buildbot/bin/python'} 04:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:34 INFO - Cleaning up... 04:27:34 INFO - Return code: 0 04:27:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:34 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:34 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 04:27:34 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 04:27:34 INFO - Using env: {'DISPLAY': ':0', 04:27:34 INFO - 'HOME': '/home/cltbld', 04:27:34 INFO - 'LANG': 'en_US.UTF-8', 04:27:34 INFO - 'LANGUAGE': 'en_US:en', 04:27:34 INFO - 'LOGNAME': 'cltbld', 04:27:34 INFO - 'MAIL': '/var/mail/cltbld', 04:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:34 INFO - 'MOZ_NO_REMOTE': '1', 04:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:34 INFO - 'NO_EM_RESTART': '1', 04:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:34 INFO - 'PWD': '/builds/slave/test', 04:27:34 INFO - 'SHELL': '/bin/bash', 04:27:34 INFO - 'SHLVL': '1', 04:27:34 INFO - 'TERM': 'linux', 04:27:34 INFO - 'TMOUT': '86400', 04:27:34 INFO - 'USER': 'cltbld', 04:27:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:34 INFO - '_': '/tools/buildbot/bin/python'} 04:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:35 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 04:27:35 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 04:27:35 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 04:27:35 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 04:27:35 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 04:27:35 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 04:27:37 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:37 INFO - Downloading docopt-0.6.1.tar.gz 04:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:37 INFO - Running setup.py install for blobuploader 04:27:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:37 INFO - Running setup.py install for requests 04:27:38 INFO - Running setup.py install for docopt 04:27:38 INFO - Successfully installed blobuploader requests docopt 04:27:38 INFO - Cleaning up... 04:27:38 INFO - Return code: 0 04:27:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:38 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 04:27:38 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 04:27:38 INFO - Using env: {'DISPLAY': ':0', 04:27:38 INFO - 'HOME': '/home/cltbld', 04:27:38 INFO - 'LANG': 'en_US.UTF-8', 04:27:38 INFO - 'LANGUAGE': 'en_US:en', 04:27:38 INFO - 'LOGNAME': 'cltbld', 04:27:38 INFO - 'MAIL': '/var/mail/cltbld', 04:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:38 INFO - 'MOZ_NO_REMOTE': '1', 04:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:38 INFO - 'NO_EM_RESTART': '1', 04:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:38 INFO - 'PWD': '/builds/slave/test', 04:27:38 INFO - 'SHELL': '/bin/bash', 04:27:38 INFO - 'SHLVL': '1', 04:27:38 INFO - 'TERM': 'linux', 04:27:38 INFO - 'TMOUT': '86400', 04:27:38 INFO - 'USER': 'cltbld', 04:27:38 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:38 INFO - '_': '/tools/buildbot/bin/python'} 04:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:38 INFO - Running setup.py (path:/tmp/pip-KocIDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:38 INFO - Running setup.py (path:/tmp/pip-tCE7zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:38 INFO - Running setup.py (path:/tmp/pip-bbZ5Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:38 INFO - Running setup.py (path:/tmp/pip-DNO1HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:38 INFO - Running setup.py (path:/tmp/pip-8cw9wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:38 INFO - Running setup.py (path:/tmp/pip-aNLOaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:39 INFO - Running setup.py (path:/tmp/pip-vSdLi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:39 INFO - Running setup.py (path:/tmp/pip-WWxo4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:39 INFO - Running setup.py (path:/tmp/pip-G4HzIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:39 INFO - Running setup.py (path:/tmp/pip-m7OZbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:39 INFO - Running setup.py (path:/tmp/pip-IWftER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:39 INFO - Running setup.py (path:/tmp/pip-3YT1rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:39 INFO - Running setup.py (path:/tmp/pip-rds21L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:39 INFO - Running setup.py (path:/tmp/pip-Ly1gDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:39 INFO - Running setup.py (path:/tmp/pip-3We9e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:39 INFO - Running setup.py (path:/tmp/pip-DZpdIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:39 INFO - Running setup.py (path:/tmp/pip-fvTRe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:39 INFO - Running setup.py install for manifestparser 04:27:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:39 INFO - Running setup.py install for mozcrash 04:27:40 INFO - Running setup.py install for mozdebug 04:27:40 INFO - Running setup.py install for mozdevice 04:27:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Running setup.py install for mozfile 04:27:40 INFO - Running setup.py install for mozhttpd 04:27:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Running setup.py install for mozinfo 04:27:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Running setup.py install for mozInstall 04:27:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Running setup.py install for mozleak 04:27:40 INFO - Running setup.py install for mozlog 04:27:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Running setup.py install for moznetwork 04:27:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:40 INFO - Running setup.py install for mozprocess 04:27:41 INFO - Running setup.py install for mozprofile 04:27:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:41 INFO - Running setup.py install for mozrunner 04:27:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:41 INFO - Running setup.py install for mozscreenshot 04:27:41 INFO - Running setup.py install for moztest 04:27:41 INFO - Running setup.py install for mozversion 04:27:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:41 INFO - Cleaning up... 04:27:41 INFO - Return code: 0 04:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:41 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:41 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 04:27:41 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 04:27:41 INFO - Using env: {'DISPLAY': ':0', 04:27:41 INFO - 'HOME': '/home/cltbld', 04:27:41 INFO - 'LANG': 'en_US.UTF-8', 04:27:41 INFO - 'LANGUAGE': 'en_US:en', 04:27:41 INFO - 'LOGNAME': 'cltbld', 04:27:41 INFO - 'MAIL': '/var/mail/cltbld', 04:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:41 INFO - 'MOZ_NO_REMOTE': '1', 04:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:41 INFO - 'NO_EM_RESTART': '1', 04:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:41 INFO - 'PWD': '/builds/slave/test', 04:27:41 INFO - 'SHELL': '/bin/bash', 04:27:41 INFO - 'SHLVL': '1', 04:27:41 INFO - 'TERM': 'linux', 04:27:41 INFO - 'TMOUT': '86400', 04:27:41 INFO - 'USER': 'cltbld', 04:27:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:41 INFO - '_': '/tools/buildbot/bin/python'} 04:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:41 INFO - Running setup.py (path:/tmp/pip-Onva35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:41 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)) 04:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:41 INFO - Running setup.py (path:/tmp/pip-qjAZcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:41 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)) 04:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:41 INFO - Running setup.py (path:/tmp/pip-WFDoS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:42 INFO - Running setup.py (path:/tmp/pip-qS8Gcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:42 INFO - Running setup.py (path:/tmp/pip-CtqivO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:42 INFO - Running setup.py (path:/tmp/pip-Il56Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:42 INFO - Running setup.py (path:/tmp/pip-4s2cyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:42 INFO - Running setup.py (path:/tmp/pip-R2NbIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:42 INFO - Running setup.py (path:/tmp/pip-Cw7nE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:42 INFO - Running setup.py (path:/tmp/pip-xtG9QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:42 INFO - Running setup.py (path:/tmp/pip-WB5FxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:42 INFO - Running setup.py (path:/tmp/pip-hYyo1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:42 INFO - Running setup.py (path:/tmp/pip-0JHeVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:42 INFO - Running setup.py (path:/tmp/pip-7qAr33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:42 INFO - Running setup.py (path:/tmp/pip-6rhIXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:42 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)) 04:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:42 INFO - Running setup.py (path:/tmp/pip-ExNzdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:43 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)) 04:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:43 INFO - Running setup.py (path:/tmp/pip-GUkF4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:43 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)) 04:27:43 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)) 04:27:43 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)) 04:27:43 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)) 04:27:43 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)) 04:27:43 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)) 04:27:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:44 INFO - Downloading blessings-1.6.tar.gz 04:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:45 INFO - Installing collected packages: blessings 04:27:45 INFO - Running setup.py install for blessings 04:27:45 INFO - Successfully installed blessings 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:45 INFO - Reading from file tmpfile_stdout 04:27:45 INFO - Current package versions: 04:27:45 INFO - argparse == 1.2.1 04:27:45 INFO - blessings == 1.6 04:27:45 INFO - blobuploader == 1.2.4 04:27:45 INFO - docopt == 0.6.1 04:27:45 INFO - functools32 == 3.2.3-2 04:27:45 INFO - jsonschema == 2.5.1 04:27:45 INFO - manifestparser == 1.1 04:27:45 INFO - mozInstall == 1.12 04:27:45 INFO - mozcrash == 0.17 04:27:45 INFO - mozdebug == 0.1 04:27:45 INFO - mozdevice == 0.48 04:27:45 INFO - mozfile == 1.2 04:27:45 INFO - mozhttpd == 0.7 04:27:45 INFO - mozinfo == 0.9 04:27:45 INFO - mozleak == 0.1 04:27:45 INFO - mozlog == 3.3 04:27:45 INFO - moznetwork == 0.27 04:27:45 INFO - mozprocess == 0.23 04:27:45 INFO - mozprofile == 0.28 04:27:45 INFO - mozrunner == 6.12 04:27:45 INFO - mozscreenshot == 0.1 04:27:45 INFO - mozsystemmonitor == 0.3 04:27:45 INFO - moztest == 0.7 04:27:45 INFO - mozversion == 1.4 04:27:45 INFO - psutil == 3.1.1 04:27:45 INFO - requests == 1.2.3 04:27:45 INFO - wsgiref == 0.1.2 04:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:45 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:45 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 04:27:45 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 04:27:45 INFO - Using env: {'DISPLAY': ':0', 04:27:45 INFO - 'HOME': '/home/cltbld', 04:27:45 INFO - 'LANG': 'en_US.UTF-8', 04:27:45 INFO - 'LANGUAGE': 'en_US:en', 04:27:45 INFO - 'LOGNAME': 'cltbld', 04:27:45 INFO - 'MAIL': '/var/mail/cltbld', 04:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:45 INFO - 'MOZ_NO_REMOTE': '1', 04:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:45 INFO - 'NO_EM_RESTART': '1', 04:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:45 INFO - 'PWD': '/builds/slave/test', 04:27:45 INFO - 'SHELL': '/bin/bash', 04:27:45 INFO - 'SHLVL': '1', 04:27:45 INFO - 'TERM': 'linux', 04:27:45 INFO - 'TMOUT': '86400', 04:27:45 INFO - 'USER': 'cltbld', 04:27:45 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:45 INFO - '_': '/tools/buildbot/bin/python'} 04:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 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)) 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:45 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 0x25ac030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x286d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, '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': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', '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 04:27:45 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 04:27:45 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 04:27:45 INFO - Using env: {'DISPLAY': ':0', 04:27:45 INFO - 'HOME': '/home/cltbld', 04:27:45 INFO - 'LANG': 'en_US.UTF-8', 04:27:45 INFO - 'LANGUAGE': 'en_US:en', 04:27:45 INFO - 'LOGNAME': 'cltbld', 04:27:45 INFO - 'MAIL': '/var/mail/cltbld', 04:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:45 INFO - 'MOZ_NO_REMOTE': '1', 04:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:45 INFO - 'NO_EM_RESTART': '1', 04:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:45 INFO - 'PWD': '/builds/slave/test', 04:27:45 INFO - 'SHELL': '/bin/bash', 04:27:45 INFO - 'SHLVL': '1', 04:27:45 INFO - 'TERM': 'linux', 04:27:45 INFO - 'TMOUT': '86400', 04:27:45 INFO - 'USER': 'cltbld', 04:27:45 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:45 INFO - '_': '/tools/buildbot/bin/python'} 04:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Running post-action listener: _resource_record_post_action 04:27:45 INFO - Running post-action listener: _start_resource_monitoring 04:27:45 INFO - Starting resource monitoring. 04:27:45 INFO - [mozharness: 2016-08-03 11:27:45.881957Z] Finished create-virtualenv step (success) 04:27:45 INFO - [mozharness: 2016-08-03 11:27:45.882394Z] Running install step. 04:27:45 INFO - Running pre-action listener: _resource_record_pre_action 04:27:45 INFO - Running main action method: install 04:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:46 INFO - Reading from file tmpfile_stdout 04:27:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:46 INFO - Reading from file tmpfile_stdout 04:27:46 INFO - Output received: 04:27:46 INFO - Usage: mozinstall [options] installer 04:27:46 INFO - Options: 04:27:46 INFO - -h, --help show this help message and exit 04:27:46 INFO - -d DEST, --destination=DEST 04:27:46 INFO - Directory to install application into. [default: 04:27:46 INFO - "/builds/slave/test"] 04:27:46 INFO - --app=APP Application being installed. [default: firefox] 04:27:46 INFO - mkdir: /builds/slave/test/build/application 04:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:28:02 INFO - Reading from file tmpfile_stdout 04:28:02 INFO - Output received: 04:28:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:28:02 INFO - Running post-action listener: _resource_record_post_action 04:28:02 INFO - [mozharness: 2016-08-03 11:28:02.214227Z] Finished install step (success) 04:28:02 INFO - [mozharness: 2016-08-03 11:28:02.214505Z] Running run-tests step. 04:28:02 INFO - Running pre-action listener: _resource_record_pre_action 04:28:02 INFO - Running main action method: run_tests 04:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:02 INFO - Python 2.7.3 04:28:02 INFO - Return code: 0 04:28:02 INFO - grabbing minidump binary from tooltool 04:28: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')]} 04:28:02 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 0x286b3b0>, '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 0x286c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x286c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:02 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 04:28:02 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 04:28:02 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 04:28:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:02 INFO - Return code: 0 04:28:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:28:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:28:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:28:02 INFO - Using env: {'DISPLAY': ':0', 04:28:02 INFO - 'HOME': '/home/cltbld', 04:28:02 INFO - 'LANG': 'en_US.UTF-8', 04:28:02 INFO - 'LANGUAGE': 'en_US:en', 04:28:02 INFO - 'LOGNAME': 'cltbld', 04:28:02 INFO - 'MAIL': '/var/mail/cltbld', 04:28:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:02 INFO - 'MOZ_NO_REMOTE': '1', 04:28:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:02 INFO - 'NO_EM_RESTART': '1', 04:28:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:02 INFO - 'PWD': '/builds/slave/test', 04:28:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:02 INFO - 'SHELL': '/bin/bash', 04:28:02 INFO - 'SHLVL': '1', 04:28:02 INFO - 'TERM': 'linux', 04:28:02 INFO - 'TMOUT': '86400', 04:28:02 INFO - 'USER': 'cltbld', 04:28:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387', 04:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:02 INFO - '_': '/tools/buildbot/bin/python'} 04:28:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:28:02 INFO - mozversion application_buildid: 20160803034441 04:28:02 INFO - mozversion application_changeset: 8af80e4c3def3275ddef3cb965dada9aa50887d6 04:28:02 INFO - mozversion application_display_name: Nightly 04:28:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:02 INFO - mozversion application_name: Firefox 04:28:02 INFO - mozversion application_remotingname: firefox 04:28:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:28:02 INFO - mozversion application_vendor: Mozilla 04:28:02 INFO - mozversion application_version: 51.0a1 04:28:02 INFO - mozversion platform_buildid: 20160803034441 04:28:02 INFO - mozversion platform_changeset: 8af80e4c3def3275ddef3cb965dada9aa50887d6 04:28:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:28:02 INFO - mozversion platform_version: 51.0a1 04:28:02 INFO - using testdate: 1470223682 04:28:02 INFO - actual date: 1470223682 04:28:02 INFO - starting webserver on 'localhost:55972' 04:28:02 INFO - SUITE-START | Running 2 tests 04:28:02 INFO - TEST-START | dromaeo_css 04:28:02 INFO - operating with platform_type : linux_ 04:28:02 INFO - Initialising browser for dromaeo_css test... 04:28:02 INFO - TEST-INFO | started process 5043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp73v_VR/profile http://localhost:55972/getInfo.html) 04:28:06 INFO - PROCESS | 5043 | __metrics Screen width/height:1600/1200 04:28:06 INFO - PROCESS | 5043 | colorDepth:24 04:28:06 INFO - PROCESS | 5043 | Browser inner width/height: 1024/697 04:28:06 INFO - PROCESS | 5043 | __metrics 04:28:07 INFO - PROCESS | 5043 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:28:07 INFO - PROCESS | 5043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:08 INFO - TEST-INFO | 5043: exit 0 04:28:08 INFO - Browser initialized. 04:28:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:08 INFO - TEST-INFO | started process 5120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp73v_VR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:20 INFO - PROCESS | 5120 | RSS: Main: 157278208 04:28:20 INFO - PROCESS | 5120 | 04:29:12 INFO - PROCESS | 5120 | 1470223752738 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] 04:31:24 INFO - PROCESS | 5120 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55972/tests/dromaeo/cssquery-ext.html) 04:31:25 INFO - PROCESS | 5120 | RSS: Main: 246980608 04:31:25 INFO - PROCESS | 5120 | 04:34:28 INFO - PROCESS | 5120 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-ext.html (next: http://localhost:55972/tests/dromaeo/cssquery-jquery.html) 04:34:28 INFO - PROCESS | 5120 | RSS: Main: 243535872 04:34:28 INFO - PROCESS | 5120 | 04:37:31 INFO - PROCESS | 5120 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55972/tests/dromaeo/cssquery-mootools.html) 04:37:31 INFO - PROCESS | 5120 | RSS: Main: 209756160 04:37:31 INFO - PROCESS | 5120 | 04:40:33 INFO - PROCESS | 5120 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55972/tests/dromaeo/cssquery-prototype.html) 04:40:34 INFO - PROCESS | 5120 | RSS: Main: 207523840 04:40:34 INFO - PROCESS | 5120 | 04:43:37 INFO - PROCESS | 5120 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55972/tests/dromaeo/cssquery-yui.html) 04:43:38 INFO - PROCESS | 5120 | RSS: Main: 189530112 04:43:38 INFO - PROCESS | 5120 | 04:46:40 INFO - PROCESS | 5120 | Cycle 1(1): loaded http://localhost:55972/tests/dromaeo/cssquery-yui.html (next: http://localhost:55972/tests/dromaeo/cssquery-dojo.html) 04:46:40 INFO - PROCESS | 5120 | RSS: Main: 279687168 04:46:40 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | __start_tp_report 04:46:41 INFO - PROCESS | 5120 | _x_x_mozilla_page_load 04:46:41 INFO - PROCESS | 5120 | _x_x_mozilla_page_load_details 04:46:41 INFO - PROCESS | 5120 | |i|pagename|runs| 04:46:41 INFO - PROCESS | 5120 | |0;dojo.html;2647.774939130174;2664.8934042638293;2686.7716244119256;2692.892284308629;2702.216357256396;4548.79530421131;4678;4703.952960470394;4786.114568804774;4823.686460380077;4687;4707.2939059141145;4713.293006049094;4724.031573527427;4767.070421267854;4253.404523366731;4276.486821581407;4344.847930322439;4396.934045989313;4471.910561788763;4411.27214009688;4437.622802061828;4463.285874260119;4482.372467854503;4483.461984561857;4259.10558782656;4325.026868954492;4335.263005289108;4340.739555626673;4443.711158774686;4294.441722576045;4340.13197360526;4341.327094300388;4356.934645980313;4357.803898824561;4338.1540599583095;4391.341298805173;4392.714473559208;4401.757903315316;4440.644748420119;4662.7202367858035;4800.303955926371;4854.951450485485;4856.4172299323955;4871.8782030449165;4984.22744474607;5022.949770502285;5033.119204139261;5049.5455409013;5102.005109003746;5053.140966035783;5076.593872490192;5104.974475127638;5119.155339368999;5140.948590514085;4637.049404871993;4724.692894961817;4773.997460533292;4776.689515181502;4781.832635857728;5212.68723876561;5266.526012658879;5287.127623942083;5294.788208471695;5305.230741542455;5027.64806463544;5061.924071138936;5072.087024335581;5081.822136225288;5091.236314552847;4898.289747986522;4996.075725990703;5134.12719837621;5140.948590514122;5143.228515722597;4989;5048.066107770001;5074.340335756402;5078.035173317058;5092.745362731848;5025.346704928409;5032.597392208614;5047.4447810740785;5051.823186188466;5101.0818052750865;4252.1920835041865;4362.563743625676;4366.497852746975;4372;4418.116376724668;3760.4547340635454;3785.8107094645156;3797.962020379761;3821.3885778275344;3842.8462861485227;4314.201872653569;4315.223259813201;4322.15717935006;4322.416473776;4366.476022877211;5037.647364684437;5066.493350664978;5073.213651883964;5087.465816089331;5090.312807770978;4236.872893813191;4309.1381723655395;4338.110687309158;4350.238708226111;4408.53710360414;4549.45406551216;4549.590536851633;4577.61090307321;4585.403897493305;4596.850787303174;4725.078609671081;4742.502037286174;4779.4742578317055;4790.137775200358;4792.305115758196;4942.975285123552;5065.13892638245;5129.589632829439;5138.023775482647;5204.635675502678;4807.399075115611;4833.32333473307;4842.9757851211925;4845.41854977405;4889.486603906538;5063.240513922794;5068.214426763858;5070.797168113381;5077.695338279715;5144.485551444825;4956.77694503741;5067.746612669425;5126.282320475211;5130.230465430215;5189.870253243699;5012.223105418666;5021.573166280907;5030.974845125751;5031.773570189277;5071.39143302806;5007.173816320412;5017.874553136201;5020.24696295544;5024.196128619404;5028.069807085701;4651.883702907455;4869.853904382874;4921.50784921505;4924.507549245047;4973.104841128632;5063.26582645507;5073.720945348041;5083.262926875508;5084.3898732152375;5124.231365295235;4950.084234416644;4963.354763880672;4963.476026629984;4963.801447942042;4965.8013679452415 04:46:41 INFO - PROCESS | 5120 | |1;ext.html;558.4582954534101;573.2318692951445;576.2422414524902;578.2656026845906;579.5595347535872;28299.292517687067;30566.235844103907;30650.23374415638;30723.692763072362;40046;36754;40750.7962460188;40982.59017409825;41107.794461027726;41111.177776444456;5935.436133567315;6015.969920150415;6020.729067191987;6031.788887388942;6033.607815491979;7619.695212191506;7685.730999415022;7703.576303303316;7709.3061624453785;7714.6914123435;7717.575533345664;7767.262110099531;7768.611569421535;7769.028871391076;7771.533707977511;7603.163651998276;7680.961595192016;7711.305982461549;7718.228177182293;7729.652165652531;7610.581418022007;7683.193264707237;7690.346320562759;7691.7307894223995;7695.461317707763;37949.24101517982;38344.42483362752;38370.42444363337;38402.807985959895;38432.423513647314;3002.4145291668133;3209.5667084943466;3518.437050071976;3528.735344849121;3606.098475381155;28968.710312896812;29092.854535727187;29369;29480.26299342512;30774.53838192429;3210.3097833965808;3248.96751032489;3271.6401195868434;3276.2792185719104;3285.7535684823733;189662;190011;190560;190604;191382.9999999986;51742.741286294084;51822.48177518252;52154.73922630362;52228;52256.21615675768;33232.33535329328;34215.31569368599;34385;56093.71953140208;56102;14522.636934076732;14731.926340368229;14735.189564573837;14738;14743.336549855283;10369.274150809522;10426.739331516772;10433.478326083665;10435.791284174275;10446.373217606968;18144.364947226783;18234.817651823578;18248.36130735418;18299.54251143732;18305.63388732218;6595.274519802818;6732.158480189976;6764.661766911635;6860.588364698134;6954.269801670853;804.5373910001772;888.391451855481;897.6902968475865;920.1488623023677;936.7260525685062;27787.444251114863;27989;27991.160265192077;28352.291192720346;28707.85646071756;924.5885580916562;934.9018353072966;948.7296120605732;960.596549449233;1024.9743756406149;14695.92652036733;14698.412063517553;14889.329980150918;14952.102873827605;15018.774718379233;403281;405135;405588;406025;406240;49700.254496182584;50249.24626130611;50274.245886311735;50289;50302;1045.5399624165343;1097.7036200225893;1173.1142987044727;1182.633383651071;1221.5907670930337;27286.454270914866;29172.416551669274;29223.41553168882;29750.70249297566;29937.55093673553;42510.5748942519;43187;43226.567734323515;43239.13521729485;43240.78379608082;336941;337057;337480;339073;339502;21821.89089054608;24718.752812471645;25345.239642810746;25829.354266142745;25843;40265.396019060325;40557;41106.889311068655;41159.1768164641;41204.79397602993;32871.50692739563;33095.17262068467;33759.66240337565;33930.49104263487;35326.64673353233;35485.82257088801;35619;35658.28683426369;35779.82110089537;35948.28103437969;34826;35136.82431587826;35269.29461410809;36187.638123618424;36846.26307473782;31157.8442107788;33004.17489562684;33548.329033419686;33937.32125357528;34252.48621270733;25446.49107017886;25707.35731606725;25796;25972;26027.34931626649 04:46:41 INFO - PROCESS | 5120 | |2;jquery.html;360.3010160289039;364.6517575715192;369.65991288015033;376.9302679004386;380.9371453710138;15998.200089995511;16872.746908796362;17518.386856460027;17605.471835844946;17667.381641642514;13821;14357.641058973504;14411;14439;14504;4275.44419225501;4351.608355248027;4378.912421751563;4392.86821395357;4394.3188805735;3747.812609369534;3960.069383694844;4780.928286075712;5626.887462250753;5877.6473411595225;5942.2869255689375;5944.435278648543;5954.851128721795;5956.19591355168;5956.344802071769;5729.140628905656;6032.849178770544;6053.424924632175;6057.757689692407;6060.30306514752;4701.576858082789;5322.121849894763;5338.62629615927;5339.092354299778;5339.893202135935;11654.242474239232;12329;12366.690832729164;12373.938130309381;12501.062420318513;1841.5304097455198;1878.201764250202;1947.9415617531497;2269.4212975691257;2305.5734689082574;8760.08019157992;8853.291736661116;8857.512836793974;9032.367734258605;9500.667476638284;1648.406573633491;1675.0954484578313;1698.7112190927571;1701.6766814305365;1729.9221535030954;61813.12775286341;62755;66774.66612666905;66931.66534167346;67329;9416.95291523538;9535.61857525705;10170.08469237772;10179.338343007681;10225.948870255601;12360.567380141652;12365.38173091342;12365.381730913597;12378.133530652767;12398;6837.897431538531;7022.192447868459;7076;7104.396126329217;7174.067371241706;6759.898601520981;6875.965620171867;7022.719091236396;7026.929730702627;7039.190493093258;3774.226283611853;3847.3074846527893;3925.1953349563273;3929.980350098231;3957.089869330013;1373.32020649779;1576.2355257700005;1662.4098445051832;1670.3819586752736;1803.2877013579562;856.7044369692446;865.5585651317873;876.8597024476053;935.0369119806475;948.5778828421425;15861.717336319129;16723.414680486123;17003.319867205173;17315.65368692619;17584.208710608054;829.4235506323048;861.3410740783306;868.5440143924491;870.2863651805459;926.2358554192817;9178.908210917938;9365.953170234105;9985.750356241153;10296.279260451845;10303.433311167957;386039;389145;396800;400718;404779;49249.50750492521;58510.70744646335;76642;80647;84896.57551712326;829.7884039569992;916.170865366844;920.4983284110176;948.8244674735196;951.8048799995984;12402.379881006094;15587.220638968232;15707.842921570638;16421.17894105314;16480;33359.166020849676;33941.49087763636;34938.12654683551;37257.44113838349;38431.61568384392;43977.05354339399;48354.516454835;50186.24720629267;50373.49626503688;50544.24183637322;6429.132067170872;6706.497012723968;6908.620025898624;6918.342757438036;7134.965430012723;9391.671291505038;11020;11299.830502542303;11467.4266286687;11553.768924621629;9131.497767622579;9498.525073746147;9598.232141428809;9888.85166722514;9938.552765125442;10050.798984020425;10120.342177758423;10126.746831329276;10156.949215253877;10388.37669739818;9826.4104153751;9852.359596626196;9917.30578859473;10135.493225338556;10349.793004140025;6610.305917878746;6702.128723266139;6779.93220067793;7024.543404678884;7084.22073571917;7489.70041198346;8726.214640682369;8853.114688531095;9052.683156089506;9989.350692204984 04:46:41 INFO - PROCESS | 5120 | |3;mootools.html;1319.5183757928355;1350.8851747601454;1396.5461225101837;1551.3329268414577;1557.5015994881635;7239.348458638721;7799.688012479494;7806.063272407305;7808.297253247207;7809.219078092202;6426.710798014089;6660.234073081597;6674.799756007315;6819.147606549182;7525.849483010336;1897.5540747924226;2108.2621082621035;2178.106976139783;2186.6173419651495;2208.6797414374905;2129.7976692214215;2145.9034343454505;2156.6872803443493;2158.287765037534;2160.2007257314817;2020.8585399022074;2115.598036373092;2126.4683829042738;2127;2127.4787677019153;2117.894105294729;2125.861818981761;2131.435169680036;2178.7930146636045;2180.2042254576963;2102.390306811038;2108.4518025313378;2115.4499830044147;2122.172352782416;2123.2462475821017;7571.924280757177;7875.173106823816;7975.960120199362;7980.800479987989;7987.880181797278;4329.177456283296;4447.110577884436;4447.221736196185;4453.22068637987;4453.51011388747;2706.404590989979;2810.789190810697;2845.8434786086755;2846.6299381080535;2852.857357132135;926.4302453990747;939.3189937295406;947.0434860790582;950.95720692569;957.0716405087054;10862.565497380096;10865.891341086566;10892;10899.564017439294;10921.508532115995;4148.2947898857265;4184.372344148402;4278.208531421635;4298.871033868989;4302.892427689333;9242.86135707965;9256.444613323087;9257.166854982948;9258.675946341846;9271.67549135777;4526.02690421561;4531.8896870266335;4532.592066714012;4533.750643714628;4538.546145385435;4119.546849846514;4189.6438802701505;4192.350185721218;4194.664426845845;4224.070704445017;3186.474231751781;3553.4314509678843;3617.3488772020764;3679.4296883983025;3684.410494320896;1188.9167758257013;1194.8745381734966;1200.591798788416;1202.897753690946;1213.9757204855853;596.6300893446005;632.6362341653476;708.939740122085;722.1334398721555;733.5708610462832;4768.165571025057;4887.437944636341;4924.212126059813;4947.109520286311;5021.372328458942;786.1902240692096;830.5722552885269;836.93304535637;841.4110122913985;862.2670729879552;3236.449803533405;3270.5257737627912;3274.754393420503;3316.767826252139;3342.1978725106287;9072.455652660861;9229.938557066023;9318.767030824149;9329.90670093304;9334.113259240361;9121.81756364869;9183.954080229556;9198.2181514572;9201.263898888074;9206.539673016323;7290.270972902667;7386.630668466555;7394.741184058532;7400.222976587488;7400.5189662671755;4743.709970270734;4790.688605240648;4799.328094066903;4822.95177048239;4862.440819305683;8489.193526614961;8528.829423411622;8620.353473489387;8662.956685216534;8684.956575217084;8778.606989893791;8830.42602230853;8857.202851743374;8921.776955576162;8952.552372381486;6535.150430444202;6625.138731964814;6632.767853125118;6640.203175618956;6642.5018123641885;5927.703614819328;6903.102596662603;7134.500584959003;7196.172440169447;7351.485396022227;6524.902126468011;6573.638449885302;6638.966805165944;6643.56816806906;6692.6319052450635;6239.656818874824;6260.780872669435;6288.622682639057;6309.053641953744;6467.223933128054;5970.164177015308;5971.253593300838;6021.126936594257;6022.156898034366;6026.487748541423;4297.462817147856;4298;4387.495438024668;4411.757353345469;4452.087322099027;4159.667226621924;4161.25097482456;4177.874663760092;4283.807228674779;4298.892527686833 04:46:41 INFO - PROCESS | 5120 | |4;prototype.html;281.8388240449349;289.2450703663439;295.7427038476526;297.4155783884666;299.8995336562252;4584.381108550345;4739.763011849407;4750.97624511877;4792.8801779955475;4806.663533552648;4588.403507544014;4691.413573303337;4710.2228132358205;4713.835015774449;4735.218688916333;3720.7767533947913;3732.4028155495125;3738.981305093471;3739.7943113128767;3739.9626003740022;3562.430011198209;3617.656322649344;3723.553173619156;3731.141837377405;3735.9626403736024;3711.870084547041;3727.8881633551036;3738.831752571141;3745.2883952049024;3746.363118269887;3719.6652301293016;3720.349563046192;3726.4596633488127;3736.271427071722;3738.719596030309;3275.9344813103603;3302.091924720697;3309.635940046593;3309.891186452541;3317.933641327184;4564.360989461478;4631.60631346336;4647.34937108805;4662.743549104798;4691.272852707836;4260.595243451898;4276.935845962313;4279.636230920375;4290.592393722592;4293.22721910056;4980.203167493184;4982.427020892571;4984.476629953875;4986.5013498650205;4988.65079444439;3518.5953615334306;3567.340042092221;3586.5875424326277;3592.964070359289;3615.620359862203;5194.142966410538;5203.895922081575;5207.635465517377;5208.817691380821;5209.270702101709;3682.2635472905527;3695.279420512974;3696.7412281140064;3704.2221133561716;3709.629037096269;3764.416515440111;3790.5640851302455;3805.657490825839;3806.2958352704836;3806.3148633246283;4178.26880295947;4240.194363071007;4240.664190779895;4283.957160428356;4305.547917468683;4978.531333256698;4982.60139188864;4985.925211121836;4992.675476094042;4995.900081998339;1214.1561614677714;1247.419949723383;1272.8027155790867;1281.128832393981;1304.7260075384277;887.3034667785757;888.7689200807707;905.2712566383992;908.8409528332515;915.0803442540205;4375.387445757597;4384.69307148503;4385.079133382025;4390.385346051556;4392.560743925582;5091.796328146833;5094.490550944876;5096.159133742965;5114.74426278692;5124.461931497213;4369.300911854088;4379.824807007748;4398.119231903109;4400.801963911567;4402.427684401007;2296.9655455168186;2401.6277476991095;2405.5549723301247;2409.2772168349425;2411.9276421707377;4257.957420425818;4288.935665965013;4318.438602981592;4320.287152619845;4341.891452713644;4626.83806066786;4627;4630.3748993886065;4637.6289896808175;4679.368285281512;4137.524184718796;4290.163418133434;4291.69958102936;4306.246406878847;4348.760388399976;4512.6615503838;4521.751303678329;4529.188324670026;4559.33584241756;4566.538707613532;4441.955580444283;4450.532694067077;4457.3091170868565;4459.977700111479;4476.216662084187;3989.5212574491247;4239.95760042408;4291.699581029298;4306.621880998051;4314.309710446313;3343.2477692518987;3351.7933543924655;3361.2857442703908;3376.109378747909;3385.7460690447824;4558.794854231502;4564.360989461545;4584.289435137559;4589.908201836011;4901.975490122527;4826.155422801066;4908.9754551227015;4992.126377883928;4997.900041999213;5051.797928082836;4976.8755781105765;4993.575546078624;5022.347094877789;5024.522670346311;5038.269450929668;4730.4796472387325;4853.611711063036;4855.830045948375;4903.705777653352;4935.531124543163;4999.525045120708;5020.774065167003;5041.773120209526;5056;5061.139606267017;4919.532644398776;4937.5556199942175;4938.777755001105;4946.282788995503;4955.876103097451 04:46:41 INFO - PROCESS | 5120 | |5;yui.html;606.1211243696638;606.7209083821441;622.5579838314798;656.5765081522421;678.6301465701192;11203.6638900833;12259.938700306497;12297.3236471994;12305.63083107506;12307.261564306147;11081.72295692606;11092.611758588451;11169.888301116986;11191.496382662779;11210.383428911407;738.9556626602395;757.9621018949058;759.8024513626442;760.1600231743927;760.4258784617606;565.5051829649057;593.8485686150026;709.5317090720126;749.1347493644822;752.8644843928091;797.3979645367739;806.7297455352464;808.1231863428187;809.6437567470324;809.9190080991883;799.3325573146429;799.8720204767209;800.2597597222575;800.9399295052895;801.2508304735092;435.1167130724634;549.2420459765538;586.7301041520906;587.4830149468484;587.5006244691978;10792.190585706103;11137.498812553455;11139.387333696643;11169.106471482262;11201;11176.385298808644;11431.714207144805;11519.654410367702;11740.882591174064;12101.334426606532;10247.84628230577;10304.072633463024;10343.844842327371;10517.63188288414;10588.417637029961;3942.448057271984;3970.3647416413237;3985.8206380712936;4059.7361171523758;4064.6748260139116;63764.36235637677;66448.3355166447;66466;67164.66417667881;68550.3144968554;9792.755181120387;9894.406335619886;9902.801943961225;10031.448270345201;10142.18862490999;16181;16685.749713754303;17374.218160182823;17388;17467.737983930252;6088.4824789893355;6186.566940314135;6458.942710643195;6499.610023398611;6558.751322328964;3439.9312013759586;3473.8089405082965;3516.8065756383135;3529.1882866940746;3559.750817442806;2606.1790535981104;2674.3314171457137;2696.7842572594145;2696.8651567421944;2714.7013828478853;502.6406119624486;527.1933941070168;538.090626840638;538.9272448219518;539.6708008115047;380.5015429786988;440.6584896705015;441.7592412135394;456.46821453006874;475.7597413306327;6958.93041069593;7051.435885129177;7168.068151140318;7425.220351863085;7523.510971786816;422.8287543544808;428.7191889312505;430.5285712145196;448.1194452900067;467.89472368716764;3190.1546090286092;3234.5795046643784;3306.7189288910713;3421.811800350955;3439.2605589798313;59622;63844;104783.4760826191;108921;109533;89613;93347.14799869157;94242.52878735699;94839;96691.51654241825;76860.23139768642;77158.22841771622;78024.60987695026;80503.59748201222;80554;6118.877622447615;6160.537959653134;6330.493560515056;6418.550701450854;6454.935450645621;31751.523727144573;35186;39994.80002600085;41991.160176796904;44890.10219795651;61526;61648.383516164264;64552.354476456516;64633;65450.345496544425;8125.268725814705;8154.551499667576;8155.755327340189;8164.265216130577;8692.130786921258;9217.76955576116;9276.397034192756;9520.190783783455;10726.141908647445;11120.88879111231;9627.470489122885;9913.851292230478;10028.398296102258;10098.293119481566;10340.844887326846;9554.235661146953;9655.22758179358;9678.032196780267;9898.257630677585;9949.303548751517;9093.40892841963;9361.765955850886;9512;9595.808083838423;9704.805903881741;7782.766517004499;8091.959540202261;8153.510789352657;8289.95855020721;8345.248927596545;7994.480358776661;8575.61409736551;8591.484510929115;8979.910200898168;9314.673986410444 04:46:41 INFO - PROCESS | 5120 | __end_tp_report 04:46:41 INFO - PROCESS | 5120 | __start_cc_report 04:46:41 INFO - PROCESS | 5120 | _x_x_mozilla_cycle_collect,1021 04:46:41 INFO - PROCESS | 5120 | __end_cc_report 04:46:41 INFO - PROCESS | 5120 | __startTimestamp1470224801000__endTimestamp 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | ------- Summary: start ------- 04:46:41 INFO - PROCESS | 5120 | Number of tests: 6 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | [#0] dojo.html Cycles:165 Average:4711.75 Median:4854.95 stddev:498.08 (10.3%) stddev-sans-first:472.56 04:46:41 INFO - PROCESS | 5120 | Values: 2647.8 2664.9 2686.8 2692.9 2702.2 4548.8 4678.0 4704.0 4786.1 4823.7 4687.0 4707.3 4713.3 4724.0 4767.1 4253.4 4276.5 4344.8 4396.9 4471.9 4411.3 4437.6 4463.3 4482.4 4483.5 4259.1 4325.0 4335.3 4340.7 4443.7 4294.4 4340.1 4341.3 4356.9 4357.8 4338.2 4391.3 4392.7 4401.8 4440.6 4662.7 4800.3 4855.0 4856.4 4871.9 4984.2 5022.9 5033.1 5049.5 5102.0 5053.1 5076.6 5105.0 5119.2 5140.9 4637.0 4724.7 4774.0 4776.7 4781.8 5212.7 5266.5 5287.1 5294.8 5305.2 5027.6 5061.9 5072.1 5081.8 5091.2 4898.3 4996.1 5134.1 5140.9 5143.2 4989.0 5048.1 5074.3 5078.0 5092.7 5025.3 5032.6 5047.4 5051.8 5101.1 4252.2 4362.6 4366.5 4372.0 4418.1 3760.5 3785.8 3798.0 3821.4 3842.8 4314.2 4315.2 4322.2 4322.4 4366.5 5037.6 5066.5 5073.2 5087.5 5090.3 4236.9 4309.1 4338.1 4350.2 4408.5 4549.5 4549.6 4577.6 4585.4 4596.9 4725.1 4742.5 4779.5 4790.1 4792.3 4943.0 5065.1 5129.6 5138.0 5204.6 4807.4 4833.3 4843.0 4845.4 4889.5 5063.2 5068.2 5070.8 5077.7 5144.5 4956.8 5067.7 5126.3 5130.2 5189.9 5012.2 5021.6 5031.0 5031.8 5071.4 5007.2 5017.9 5020.2 5024.2 5028.1 4651.9 4869.9 4921.5 4924.5 4973.1 5063.3 5073.7 5083.3 5084.4 5124.2 4950.1 4963.4 4963.5 4963.8 4965.8 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | [#1] ext.html Cycles:180 Average:46132.51 Median:35552.41 stddev:85673.23 (241.0%) stddev-sans-first:85845.23 04:46:41 INFO - PROCESS | 5120 | Values: 558.5 573.2 576.2 578.3 579.6 28299.3 30566.2 30650.2 30723.7 40046.0 36754.0 40750.8 40982.6 41107.8 41111.2 5935.4 6016.0 6020.7 6031.8 6033.6 7619.7 7685.7 7703.6 7709.3 7714.7 7717.6 7767.3 7768.6 7769.0 7771.5 7603.2 7681.0 7711.3 7718.2 7729.7 7610.6 7683.2 7690.3 7691.7 7695.5 37949.2 38344.4 38370.4 38402.8 38432.4 3002.4 3209.6 3518.4 3528.7 3606.1 28968.7 29092.9 29369.0 29480.3 30774.5 3210.3 3249.0 3271.6 3276.3 3285.8 189662.0 190011.0 190560.0 190604.0 191383.0 51742.7 51822.5 52154.7 52228.0 52256.2 33232.3 34215.3 34385.0 56093.7 56102.0 14522.6 14731.9 14735.2 14738.0 14743.3 10369.3 10426.7 10433.5 10435.8 10446.4 18144.4 18234.8 18248.4 18299.5 18305.6 6595.3 6732.2 6764.7 6860.6 6954.3 804.5 888.4 897.7 920.1 936.7 27787.4 27989.0 27991.2 28352.3 28707.9 924.6 934.9 948.7 960.6 1025.0 14695.9 14698.4 14889.3 14952.1 15018.8 403281.0 405135.0 405588.0 406025.0 406240.0 49700.3 50249.2 50274.2 50289.0 50302.0 1045.5 1097.7 1173.1 1182.6 1221.6 27286.5 29172.4 29223.4 29750.7 29937.6 42510.6 43187.0 43226.6 43239.1 43240.8 336941.0 337057.0 337480.0 339073.0 339502.0 21821.9 24718.8 25345.2 25829.4 25843.0 40265.4 40557.0 41106.9 41159.2 41204.8 32871.5 33095.2 33759.7 33930.5 35326.6 35485.8 35619.0 35658.3 35779.8 35948.3 34826.0 35136.8 35269.3 36187.6 36846.3 31157.8 33004.2 33548.3 33937.3 34252.5 25446.5 25707.4 25796.0 25972.0 26027.3 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | [#2] jquery.html Cycles:180 Average:23547.12 Median:26567.72 stddev:65147.23 (245.2%) stddev-sans-first:65306.72 04:46:41 INFO - PROCESS | 5120 | Values: 360.3 364.7 369.7 376.9 380.9 15998.2 16872.7 17518.4 17605.5 17667.4 13821.0 14357.6 14411.0 14439.0 14504.0 4275.4 4351.6 4378.9 4392.9 4394.3 3747.8 3960.1 4780.9 5626.9 5877.6 5942.3 5944.4 5954.9 5956.2 5956.3 5729.1 6032.8 6053.4 6057.8 6060.3 4701.6 5322.1 5338.6 5339.1 5339.9 11654.2 12329.0 12366.7 12373.9 12501.1 1841.5 1878.2 1947.9 2269.4 2305.6 8760.1 8853.3 8857.5 9032.4 9500.7 1648.4 1675.1 1698.7 1701.7 1729.9 61813.1 62755.0 66774.7 66931.7 67329.0 9417.0 9535.6 10170.1 10179.3 10225.9 12360.6 12365.4 12365.4 12378.1 12398.0 6837.9 7022.2 7076.0 7104.4 7174.1 6759.9 6876.0 7022.7 7026.9 7039.2 3774.2 3847.3 3925.2 3930.0 3957.1 1373.3 1576.2 1662.4 1670.4 1803.3 856.7 865.6 876.9 935.0 948.6 15861.7 16723.4 17003.3 17315.7 17584.2 829.4 861.3 868.5 870.3 926.2 9178.9 9366.0 9985.8 10296.3 10303.4 386039.0 389145.0 396800.0 400718.0 404779.0 49249.5 58510.7 76642.0 80647.0 84896.6 829.8 916.2 920.5 948.8 951.8 12402.4 15587.2 15707.8 16421.2 16480.0 33359.2 33941.5 34938.1 37257.4 38431.6 43977.1 48354.5 50186.2 50373.5 50544.2 6429.1 6706.5 6908.6 6918.3 7135.0 9391.7 11020.0 11299.8 11467.4 11553.8 9131.5 9498.5 9598.2 9888.9 9938.6 10050.8 10120.3 10126.7 10156.9 10388.4 9826.4 9852.4 9917.3 10135.5 10349.8 6610.3 6702.1 6779.9 7024.5 7084.2 7489.7 8726.2 8853.1 9052.7 9989.4 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | [#3] mootools.html Cycles:180 Average:4980.96 Median:4874.94 stddev:2829.32 (58.0%) stddev-sans-first:2823.88 04:46:41 INFO - PROCESS | 5120 | Values: 1319.5 1350.9 1396.5 1551.3 1557.5 7239.3 7799.7 7806.1 7808.3 7809.2 6426.7 6660.2 6674.8 6819.1 7525.8 1897.6 2108.3 2178.1 2186.6 2208.7 2129.8 2145.9 2156.7 2158.3 2160.2 2020.9 2115.6 2126.5 2127.0 2127.5 2117.9 2125.9 2131.4 2178.8 2180.2 2102.4 2108.5 2115.4 2122.2 2123.2 7571.9 7875.2 7976.0 7980.8 7987.9 4329.2 4447.1 4447.2 4453.2 4453.5 2706.4 2810.8 2845.8 2846.6 2852.9 926.4 939.3 947.0 951.0 957.1 10862.6 10865.9 10892.0 10899.6 10921.5 4148.3 4184.4 4278.2 4298.9 4302.9 9242.9 9256.4 9257.2 9258.7 9271.7 4526.0 4531.9 4532.6 4533.8 4538.5 4119.5 4189.6 4192.4 4194.7 4224.1 3186.5 3553.4 3617.3 3679.4 3684.4 1188.9 1194.9 1200.6 1202.9 1214.0 596.6 632.6 708.9 722.1 733.6 4768.2 4887.4 4924.2 4947.1 5021.4 786.2 830.6 836.9 841.4 862.3 3236.4 3270.5 3274.8 3316.8 3342.2 9072.5 9229.9 9318.8 9329.9 9334.1 9121.8 9184.0 9198.2 9201.3 9206.5 7290.3 7386.6 7394.7 7400.2 7400.5 4743.7 4790.7 4799.3 4823.0 4862.4 8489.2 8528.8 8620.4 8663.0 8685.0 8778.6 8830.4 8857.2 8921.8 8952.6 6535.2 6625.1 6632.8 6640.2 6642.5 5927.7 6903.1 7134.5 7196.2 7351.5 6524.9 6573.6 6639.0 6643.6 6692.6 6239.7 6260.8 6288.6 6309.1 6467.2 5970.2 5971.3 6021.1 6022.2 6026.5 4297.5 4298.0 4387.5 4411.8 4452.1 4159.7 4161.3 4177.9 4283.8 4298.9 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | [#4] prototype.html Cycles:180 Average:4027.21 Median:4391.47 stddev:1153.74 (26.3%) stddev-sans-first:1122.21 04:46:41 INFO - PROCESS | 5120 | Values: 281.8 289.2 295.7 297.4 299.9 4584.4 4739.8 4751.0 4792.9 4806.7 4588.4 4691.4 4710.2 4713.8 4735.2 3720.8 3732.4 3739.0 3739.8 3740.0 3562.4 3617.7 3723.6 3731.1 3736.0 3711.9 3727.9 3738.8 3745.3 3746.4 3719.7 3720.3 3726.5 3736.3 3738.7 3275.9 3302.1 3309.6 3309.9 3317.9 4564.4 4631.6 4647.3 4662.7 4691.3 4260.6 4276.9 4279.6 4290.6 4293.2 4980.2 4982.4 4984.5 4986.5 4988.7 3518.6 3567.3 3586.6 3593.0 3615.6 5194.1 5203.9 5207.6 5208.8 5209.3 3682.3 3695.3 3696.7 3704.2 3709.6 3764.4 3790.6 3805.7 3806.3 3806.3 4178.3 4240.2 4240.7 4284.0 4305.5 4978.5 4982.6 4985.9 4992.7 4995.9 1214.2 1247.4 1272.8 1281.1 1304.7 887.3 888.8 905.3 908.8 915.1 4375.4 4384.7 4385.1 4390.4 4392.6 5091.8 5094.5 5096.2 5114.7 5124.5 4369.3 4379.8 4398.1 4400.8 4402.4 2297.0 2401.6 2405.6 2409.3 2411.9 4258.0 4288.9 4318.4 4320.3 4341.9 4626.8 4627.0 4630.4 4637.6 4679.4 4137.5 4290.2 4291.7 4306.2 4348.8 4512.7 4521.8 4529.2 4559.3 4566.5 4442.0 4450.5 4457.3 4460.0 4476.2 3989.5 4240.0 4291.7 4306.6 4314.3 3343.2 3351.8 3361.3 3376.1 3385.7 4558.8 4564.4 4584.3 4589.9 4902.0 4826.2 4909.0 4992.1 4997.9 5051.8 4976.9 4993.6 5022.3 5024.5 5038.3 4730.5 4853.6 4855.8 4903.7 4935.5 4999.5 5020.8 5041.8 5056.0 5061.1 4919.5 4937.6 4938.8 4946.3 4955.9 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - PROCESS | 5120 | [#5] yui.html Cycles:180 Average:17140.53 Median:6103.68 stddev:26259.90 (430.2%) stddev-sans-first:26304.22 04:46:41 INFO - PROCESS | 5120 | Values: 606.1 606.7 622.6 656.6 678.6 11203.7 12259.9 12297.3 12305.6 12307.3 11081.7 11092.6 11169.9 11191.5 11210.4 739.0 758.0 759.8 760.2 760.4 565.5 593.8 709.5 749.1 752.9 797.4 806.7 808.1 809.6 809.9 799.3 799.9 800.3 800.9 801.3 435.1 549.2 586.7 587.5 587.5 10792.2 11137.5 11139.4 11169.1 11201.0 11176.4 11431.7 11519.7 11740.9 12101.3 10247.8 10304.1 10343.8 10517.6 10588.4 3942.4 3970.4 3985.8 4059.7 4064.7 63764.4 66448.3 66466.0 67164.7 68550.3 9792.8 9894.4 9902.8 10031.4 10142.2 16181.0 16685.7 17374.2 17388.0 17467.7 6088.5 6186.6 6458.9 6499.6 6558.8 3439.9 3473.8 3516.8 3529.2 3559.8 2606.2 2674.3 2696.8 2696.9 2714.7 502.6 527.2 538.1 538.9 539.7 380.5 440.7 441.8 456.5 475.8 6958.9 7051.4 7168.1 7425.2 7523.5 422.8 428.7 430.5 448.1 467.9 3190.2 3234.6 3306.7 3421.8 3439.3 59622.0 63844.0 104783.5 108921.0 109533.0 89613.0 93347.1 94242.5 94839.0 96691.5 76860.2 77158.2 78024.6 80503.6 80554.0 6118.9 6160.5 6330.5 6418.6 6454.9 31751.5 35186.0 39994.8 41991.2 44890.1 61526.0 61648.4 64552.4 64633.0 65450.3 8125.3 8154.6 8155.8 8164.3 8692.1 9217.8 9276.4 9520.2 10726.1 11120.9 9627.5 9913.9 10028.4 10098.3 10340.8 9554.2 9655.2 9678.0 9898.3 9949.3 9093.4 9361.8 9512.0 9595.8 9704.8 7782.8 8092.0 8153.5 8290.0 8345.2 7994.5 8575.6 8591.5 8979.9 9314.7 04:46:41 INFO - PROCESS | 5120 | -------- Summary: end -------- 04:46:41 INFO - PROCESS | 5120 | 04:46:41 INFO - TEST-INFO | 5120: exit 0 04:46:41 INFO - TEST-OK | dromaeo_css | took 1119304ms 04:46:41 INFO - TEST-START | kraken 04:46:41 INFO - operating with platform_type : linux_ 04:46:41 INFO - Initialising browser for kraken test... 04:46:41 INFO - TEST-INFO | started process 5306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDEsBGM/profile http://localhost:55972/getInfo.html) 04:46:46 INFO - PROCESS | 5306 | __metrics Screen width/height:1600/1200 04:46:46 INFO - PROCESS | 5306 | colorDepth:24 04:46:46 INFO - PROCESS | 5306 | Browser inner width/height: 1024/697 04:46:46 INFO - PROCESS | 5306 | __metrics 04:46:46 INFO - PROCESS | 5306 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:46:46 INFO - PROCESS | 5306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:47 INFO - TEST-INFO | 5306: exit 0 04:46:47 INFO - Browser initialized. 04:46:47 INFO - Running cycle 1/1 for kraken test... 04:46:47 INFO - TEST-INFO | started process 5383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDEsBGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:59 INFO - PROCESS | 5383 | RSS: Main: 157540352 04:46:59 INFO - PROCESS | 5383 | 04:47:02 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:03 INFO - PROCESS | 5383 | RSS: Main: 214126592 04:47:03 INFO - PROCESS | 5383 | 04:47:06 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-dft) 04:47:06 INFO - PROCESS | 5383 | RSS: Main: 192192512 04:47:06 INFO - PROCESS | 5383 | 04:47:10 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-fft) 04:47:10 INFO - PROCESS | 5383 | RSS: Main: 272121856 04:47:10 INFO - PROCESS | 5383 | 04:47:13 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55972/tests/kraken/driver.html?testName=audio-oscillator) 04:47:13 INFO - PROCESS | 5383 | RSS: Main: 180191232 04:47:13 INFO - PROCESS | 5383 | 04:47:15 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:16 INFO - PROCESS | 5383 | RSS: Main: 185352192 04:47:16 INFO - PROCESS | 5383 | 04:47:19 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55972/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:20 INFO - PROCESS | 5383 | RSS: Main: 221732864 04:47:20 INFO - PROCESS | 5383 | 04:47:23 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55972/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:24 INFO - PROCESS | 5383 | RSS: Main: 214679552 04:47:24 INFO - PROCESS | 5383 | 04:47:27 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55972/tests/kraken/driver.html?testName=json-parse-financial) 04:47:27 INFO - PROCESS | 5383 | RSS: Main: 218259456 04:47:27 INFO - PROCESS | 5383 | 04:47:29 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:30 INFO - PROCESS | 5383 | RSS: Main: 184188928 04:47:30 INFO - PROCESS | 5383 | 04:47:32 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:32 INFO - PROCESS | 5383 | RSS: Main: 188665856 04:47:32 INFO - PROCESS | 5383 | 04:47:34 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:35 INFO - PROCESS | 5383 | RSS: Main: 193085440 04:47:35 INFO - PROCESS | 5383 | 04:47:38 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:39 INFO - PROCESS | 5383 | RSS: Main: 187973632 04:47:39 INFO - PROCESS | 5383 | 04:47:41 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:42 INFO - PROCESS | 5383 | RSS: Main: 192008192 04:47:42 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | Cycle 1(1): loaded http://localhost:55972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55972/tests/kraken/driver.html?testName=ai-astar) 04:47:44 INFO - PROCESS | 5383 | RSS: Main: 242958336 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | __start_tp_report 04:47:44 INFO - PROCESS | 5383 | _x_x_mozilla_page_load 04:47:44 INFO - PROCESS | 5383 | _x_x_mozilla_page_load_details 04:47:44 INFO - PROCESS | 5383 | |i|pagename|runs| 04:47:44 INFO - PROCESS | 5383 | |0;ai-astar;107;117;117;115;117;115;114;116;114;116 04:47:44 INFO - PROCESS | 5383 | |1;audio-beat-detection;153;122;124;188;123;126;161;122;180;122 04:47:44 INFO - PROCESS | 5383 | |2;audio-dft;161;161;162;160;160;161;163;162;162;161 04:47:44 INFO - PROCESS | 5383 | |3;audio-fft;75;77;76;123;77;78;75;76;105;76 04:47:44 INFO - PROCESS | 5383 | |4;audio-oscillator;86;86;128;85;84;85;123;85;84;124 04:47:44 INFO - PROCESS | 5383 | |5;imaging-gaussian-blur;117;117;117;117;116;117;118;117;117;117 04:47:44 INFO - PROCESS | 5383 | |6;imaging-darkroom;146;147;147;146;146;146;146;147;148;147 04:47:44 INFO - PROCESS | 5383 | |7;imaging-desaturate;95;96;95;94;95;94;95;95;95;95 04:47:44 INFO - PROCESS | 5383 | |8;json-parse-financial;65;62;62;62;61;65;63;62;65;62 04:47:44 INFO - PROCESS | 5383 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;65;65 04:47:44 INFO - PROCESS | 5383 | |10;stanford-crypto-aes;79;78;79;88;82;79;78;78;78;77 04:47:44 INFO - PROCESS | 5383 | |11;stanford-crypto-ccm;133;131;133;129;139;131;131;128;234;134 04:47:44 INFO - PROCESS | 5383 | |12;stanford-crypto-pbkdf2;168;166;164;165;169;174;168;167;168;169 04:47:44 INFO - PROCESS | 5383 | |13;stanford-crypto-sha256-iterative;70;67;68;71;65;68;68;66;66;68 04:47:44 INFO - PROCESS | 5383 | __end_tp_report 04:47:44 INFO - PROCESS | 5383 | __start_cc_report 04:47:44 INFO - PROCESS | 5383 | _x_x_mozilla_cycle_collect,1914 04:47:44 INFO - PROCESS | 5383 | __end_cc_report 04:47:44 INFO - PROCESS | 5383 | __startTimestamp1470224864552__endTimestamp 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | ------- Summary: start ------- 04:47:44 INFO - PROCESS | 5383 | Number of tests: 14 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.97 (2.6%) stddev-sans-first:1.22 04:47:44 INFO - PROCESS | 5383 | Values: 107.0 117.0 117.0 115.0 117.0 115.0 114.0 116.0 114.0 116.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:139.50 stddev:26.21 (18.8%) stddev-sans-first:27.50 04:47:44 INFO - PROCESS | 5383 | Values: 153.0 122.0 124.0 188.0 123.0 126.0 161.0 122.0 180.0 122.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 04:47:44 INFO - PROCESS | 5383 | Values: 161.0 161.0 162.0 160.0 160.0 161.0 163.0 162.0 162.0 161.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:16.50 (21.7%) stddev-sans-first:17.19 04:47:44 INFO - PROCESS | 5383 | Values: 75.0 77.0 76.0 123.0 77.0 78.0 75.0 76.0 105.0 76.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:19.37 (22.8%) stddev-sans-first:20.14 04:47:44 INFO - PROCESS | 5383 | Values: 86.0 86.0 128.0 85.0 84.0 85.0 123.0 85.0 84.0 124.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:47:44 INFO - PROCESS | 5383 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:47:44 INFO - PROCESS | 5383 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 148.0 147.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:47:44 INFO - PROCESS | 5383 | Values: 95.0 96.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.50 stddev:1.52 (2.4%) stddev-sans-first:1.41 04:47:44 INFO - PROCESS | 5383 | Values: 65.0 62.0 62.0 62.0 61.0 65.0 63.0 62.0 65.0 62.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:47:44 INFO - PROCESS | 5383 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:3.24 (4.1%) stddev-sans-first:3.43 04:47:44 INFO - PROCESS | 5383 | Values: 79.0 78.0 79.0 88.0 82.0 79.0 78.0 78.0 78.0 77.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:133.00 stddev:32.36 (24.3%) stddev-sans-first:34.15 04:47:44 INFO - PROCESS | 5383 | Values: 133.0 131.0 133.0 129.0 139.0 131.0 131.0 128.0 234.0 134.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:2.74 (1.6%) stddev-sans-first:2.91 04:47:44 INFO - PROCESS | 5383 | Values: 168.0 166.0 164.0 165.0 169.0 174.0 168.0 167.0 168.0 169.0 04:47:44 INFO - PROCESS | 5383 | 04:47:44 INFO - PROCESS | 5383 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.74 04:47:44 INFO - PROCESS | 5383 | Values: 70.0 67.0 68.0 71.0 65.0 68.0 68.0 66.0 66.0 68.0 04:47:44 INFO - PROCESS | 5383 | -------- Summary: end -------- 04:47:44 INFO - PROCESS | 5383 | 04:47:45 INFO - TEST-INFO | 5383: exit 0 04:47:45 INFO - TEST-OK | kraken | took 63862ms 04:47:45 INFO - SUITE-END | took 1183s 04:47:45 INFO - Completed test suite (00:19:43) 04:47:45 INFO - javascript benchmark 04:47:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.774939130174, 2664.8934042638293, 2686.7716244119256, 2692.892284308629, 2702.216357256396, 4548.79530421131, 4678.0, 4703.952960470394, 4786.114568804774, 4823.686460380077, 4687.0, 4707.2939059141145, 4713.293006049094, 4724.031573527427, 4767.070421267854, 4253.404523366731, 4276.486821581407, 4344.847930322439, 4396.934045989313, 4471.910561788763, 4411.27214009688, 4437.622802061828, 4463.285874260119, 4482.372467854503, 4483.461984561857, 4259.10558782656, 4325.026868954492, 4335.263005289108, 4340.739555626673, 4443.711158774686, 4294.441722576045, 4340.13197360526, 4341.327094300388, 4356.934645980313, 4357.803898824561, 4338.1540599583095, 4391.341298805173, 4392.714473559208, 4401.757903315316, 4440.644748420119, 4662.7202367858035, 4800.303955926371, 4854.951450485485, 4856.4172299323955, 4871.8782030449165, 4984.22744474607, 5022.949770502285, 5033.119204139261, 5049.5455409013, 5102.005109003746, 5053.140966035783, 5076.593872490192, 5104.974475127638, 5119.155339368999, 5140.948590514085, 4637.049404871993, 4724.692894961817, 4773.997460533292, 4776.689515181502, 4781.832635857728, 5212.68723876561, 5266.526012658879, 5287.127623942083, 5294.788208471695, 5305.230741542455, 5027.64806463544, 5061.924071138936, 5072.087024335581, 5081.822136225288, 5091.236314552847, 4898.289747986522, 4996.075725990703, 5134.12719837621, 5140.948590514122, 5143.228515722597, 4989.0, 5048.066107770001, 5074.340335756402, 5078.035173317058, 5092.745362731848, 5025.346704928409, 5032.597392208614, 5047.4447810740785, 5051.823186188466, 5101.0818052750865, 4252.1920835041865, 4362.563743625676, 4366.497852746975, 4372.0, 4418.116376724668, 3760.4547340635454, 3785.8107094645156, 3797.962020379761, 3821.3885778275344, 3842.8462861485227, 4314.201872653569, 4315.223259813201, 4322.15717935006, 4322.416473776, 4366.476022877211, 5037.647364684437, 5066.493350664978, 5073.213651883964, 5087.465816089331, 5090.312807770978, 4236.872893813191, 4309.1381723655395, 4338.110687309158, 4350.238708226111, 4408.53710360414, 4549.45406551216, 4549.590536851633, 4577.61090307321, 4585.403897493305, 4596.850787303174, 4725.078609671081, 4742.502037286174, 4779.4742578317055, 4790.137775200358, 4792.305115758196, 4942.975285123552, 5065.13892638245, 5129.589632829439, 5138.023775482647, 5204.635675502678, 4807.399075115611, 4833.32333473307, 4842.9757851211925, 4845.41854977405, 4889.486603906538, 5063.240513922794, 5068.214426763858, 5070.797168113381, 5077.695338279715, 5144.485551444825, 4956.77694503741, 5067.746612669425, 5126.282320475211, 5130.230465430215, 5189.870253243699, 5012.223105418666, 5021.573166280907, 5030.974845125751, 5031.773570189277, 5071.39143302806, 5007.173816320412, 5017.874553136201, 5020.24696295544, 5024.196128619404, 5028.069807085701, 4651.883702907455, 4869.853904382874, 4921.50784921505, 4924.507549245047, 4973.104841128632, 5063.26582645507, 5073.720945348041, 5083.262926875508, 5084.3898732152375, 5124.231365295235, 4950.084234416644, 4963.354763880672, 4963.476026629984, 4963.801447942042, 4965.8013679452415], "value": 4680.003575146015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.4582954534101, 573.2318692951445, 576.2422414524902, 578.2656026845906, 579.5595347535872, 28299.292517687067, 30566.235844103907, 30650.23374415638, 30723.692763072362, 40046.0, 36754.0, 40750.7962460188, 40982.59017409825, 41107.794461027726, 41111.177776444456, 5935.436133567315, 6015.969920150415, 6020.729067191987, 6031.788887388942, 6033.607815491979, 7619.695212191506, 7685.730999415022, 7703.576303303316, 7709.3061624453785, 7714.6914123435, 7717.575533345664, 7767.262110099531, 7768.611569421535, 7769.028871391076, 7771.533707977511, 7603.163651998276, 7680.961595192016, 7711.305982461549, 7718.228177182293, 7729.652165652531, 7610.581418022007, 7683.193264707237, 7690.346320562759, 7691.7307894223995, 7695.461317707763, 37949.24101517982, 38344.42483362752, 38370.42444363337, 38402.807985959895, 38432.423513647314, 3002.4145291668133, 3209.5667084943466, 3518.437050071976, 3528.735344849121, 3606.098475381155, 28968.710312896812, 29092.854535727187, 29369.0, 29480.26299342512, 30774.53838192429, 3210.3097833965808, 3248.96751032489, 3271.6401195868434, 3276.2792185719104, 3285.7535684823733, 189662.0, 190011.0, 190560.0, 190604.0, 191382.9999999986, 51742.741286294084, 51822.48177518252, 52154.73922630362, 52228.0, 52256.21615675768, 33232.33535329328, 34215.31569368599, 34385.0, 56093.71953140208, 56102.0, 14522.636934076732, 14731.926340368229, 14735.189564573837, 14738.0, 14743.336549855283, 10369.274150809522, 10426.739331516772, 10433.478326083665, 10435.791284174275, 10446.373217606968, 18144.364947226783, 18234.817651823578, 18248.36130735418, 18299.54251143732, 18305.63388732218, 6595.274519802818, 6732.158480189976, 6764.661766911635, 6860.588364698134, 6954.269801670853, 804.5373910001772, 888.391451855481, 897.6902968475865, 920.1488623023677, 936.7260525685062, 27787.444251114863, 27989.0, 27991.160265192077, 28352.291192720346, 28707.85646071756, 924.5885580916562, 934.9018353072966, 948.7296120605732, 960.596549449233, 1024.9743756406149, 14695.92652036733, 14698.412063517553, 14889.329980150918, 14952.102873827605, 15018.774718379233, 403281.0, 405135.0, 405588.0, 406025.0, 406240.0, 49700.254496182584, 50249.24626130611, 50274.245886311735, 50289.0, 50302.0, 1045.5399624165343, 1097.7036200225893, 1173.1142987044727, 1182.633383651071, 1221.5907670930337, 27286.454270914866, 29172.416551669274, 29223.41553168882, 29750.70249297566, 29937.55093673553, 42510.5748942519, 43187.0, 43226.567734323515, 43239.13521729485, 43240.78379608082, 336941.0, 337057.0, 337480.0, 339073.0, 339502.0, 21821.89089054608, 24718.752812471645, 25345.239642810746, 25829.354266142745, 25843.0, 40265.396019060325, 40557.0, 41106.889311068655, 41159.1768164641, 41204.79397602993, 32871.50692739563, 33095.17262068467, 33759.66240337565, 33930.49104263487, 35326.64673353233, 35485.82257088801, 35619.0, 35658.28683426369, 35779.82110089537, 35948.28103437969, 34826.0, 35136.82431587826, 35269.29461410809, 36187.638123618424, 36846.26307473782, 31157.8442107788, 33004.17489562684, 33548.329033419686, 33937.32125357528, 34252.48621270733, 25446.49107017886, 25707.35731606725, 25796.0, 25972.0, 26027.34931626649], "value": 17015.726864019634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.3010160289039, 364.6517575715192, 369.65991288015033, 376.9302679004386, 380.9371453710138, 15998.200089995511, 16872.746908796362, 17518.386856460027, 17605.471835844946, 17667.381641642514, 13821.0, 14357.641058973504, 14411.0, 14439.0, 14504.0, 4275.44419225501, 4351.608355248027, 4378.912421751563, 4392.86821395357, 4394.3188805735, 3747.812609369534, 3960.069383694844, 4780.928286075712, 5626.887462250753, 5877.6473411595225, 5942.2869255689375, 5944.435278648543, 5954.851128721795, 5956.19591355168, 5956.344802071769, 5729.140628905656, 6032.849178770544, 6053.424924632175, 6057.757689692407, 6060.30306514752, 4701.576858082789, 5322.121849894763, 5338.62629615927, 5339.092354299778, 5339.893202135935, 11654.242474239232, 12329.0, 12366.690832729164, 12373.938130309381, 12501.062420318513, 1841.5304097455198, 1878.201764250202, 1947.9415617531497, 2269.4212975691257, 2305.5734689082574, 8760.08019157992, 8853.291736661116, 8857.512836793974, 9032.367734258605, 9500.667476638284, 1648.406573633491, 1675.0954484578313, 1698.7112190927571, 1701.6766814305365, 1729.9221535030954, 61813.12775286341, 62755.0, 66774.66612666905, 66931.66534167346, 67329.0, 9416.95291523538, 9535.61857525705, 10170.08469237772, 10179.338343007681, 10225.948870255601, 12360.567380141652, 12365.38173091342, 12365.381730913597, 12378.133530652767, 12398.0, 6837.897431538531, 7022.192447868459, 7076.0, 7104.396126329217, 7174.067371241706, 6759.898601520981, 6875.965620171867, 7022.719091236396, 7026.929730702627, 7039.190493093258, 3774.226283611853, 3847.3074846527893, 3925.1953349563273, 3929.980350098231, 3957.089869330013, 1373.32020649779, 1576.2355257700005, 1662.4098445051832, 1670.3819586752736, 1803.2877013579562, 856.7044369692446, 865.5585651317873, 876.8597024476053, 935.0369119806475, 948.5778828421425, 15861.717336319129, 16723.414680486123, 17003.319867205173, 17315.65368692619, 17584.208710608054, 829.4235506323048, 861.3410740783306, 868.5440143924491, 870.2863651805459, 926.2358554192817, 9178.908210917938, 9365.953170234105, 9985.750356241153, 10296.279260451845, 10303.433311167957, 386039.0, 389145.0, 396800.0, 400718.0, 404779.0, 49249.50750492521, 58510.70744646335, 76642.0, 80647.0, 84896.57551712326, 829.7884039569992, 916.170865366844, 920.4983284110176, 948.8244674735196, 951.8048799995984, 12402.379881006094, 15587.220638968232, 15707.842921570638, 16421.17894105314, 16480.0, 33359.166020849676, 33941.49087763636, 34938.12654683551, 37257.44113838349, 38431.61568384392, 43977.05354339399, 48354.516454835, 50186.24720629267, 50373.49626503688, 50544.24183637322, 6429.132067170872, 6706.497012723968, 6908.620025898624, 6918.342757438036, 7134.965430012723, 9391.671291505038, 11020.0, 11299.830502542303, 11467.4266286687, 11553.768924621629, 9131.497767622579, 9498.525073746147, 9598.232141428809, 9888.85166722514, 9938.552765125442, 10050.798984020425, 10120.342177758423, 10126.746831329276, 10156.949215253877, 10388.37669739818, 9826.4104153751, 9852.359596626196, 9917.30578859473, 10135.493225338556, 10349.793004140025, 6610.305917878746, 6702.128723266139, 6779.93220067793, 7024.543404678884, 7084.22073571917, 7489.70041198346, 8726.214640682369, 8853.114688531095, 9052.683156089506, 9989.350692204984], "value": 7795.045038457132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.5183757928355, 1350.8851747601454, 1396.5461225101837, 1551.3329268414577, 1557.5015994881635, 7239.348458638721, 7799.688012479494, 7806.063272407305, 7808.297253247207, 7809.219078092202, 6426.710798014089, 6660.234073081597, 6674.799756007315, 6819.147606549182, 7525.849483010336, 1897.5540747924226, 2108.2621082621035, 2178.106976139783, 2186.6173419651495, 2208.6797414374905, 2129.7976692214215, 2145.9034343454505, 2156.6872803443493, 2158.287765037534, 2160.2007257314817, 2020.8585399022074, 2115.598036373092, 2126.4683829042738, 2127.0, 2127.4787677019153, 2117.894105294729, 2125.861818981761, 2131.435169680036, 2178.7930146636045, 2180.2042254576963, 2102.390306811038, 2108.4518025313378, 2115.4499830044147, 2122.172352782416, 2123.2462475821017, 7571.924280757177, 7875.173106823816, 7975.960120199362, 7980.800479987989, 7987.880181797278, 4329.177456283296, 4447.110577884436, 4447.221736196185, 4453.22068637987, 4453.51011388747, 2706.404590989979, 2810.789190810697, 2845.8434786086755, 2846.6299381080535, 2852.857357132135, 926.4302453990747, 939.3189937295406, 947.0434860790582, 950.95720692569, 957.0716405087054, 10862.565497380096, 10865.891341086566, 10892.0, 10899.564017439294, 10921.508532115995, 4148.2947898857265, 4184.372344148402, 4278.208531421635, 4298.871033868989, 4302.892427689333, 9242.86135707965, 9256.444613323087, 9257.166854982948, 9258.675946341846, 9271.67549135777, 4526.02690421561, 4531.8896870266335, 4532.592066714012, 4533.750643714628, 4538.546145385435, 4119.546849846514, 4189.6438802701505, 4192.350185721218, 4194.664426845845, 4224.070704445017, 3186.474231751781, 3553.4314509678843, 3617.3488772020764, 3679.4296883983025, 3684.410494320896, 1188.9167758257013, 1194.8745381734966, 1200.591798788416, 1202.897753690946, 1213.9757204855853, 596.6300893446005, 632.6362341653476, 708.939740122085, 722.1334398721555, 733.5708610462832, 4768.165571025057, 4887.437944636341, 4924.212126059813, 4947.109520286311, 5021.372328458942, 786.1902240692096, 830.5722552885269, 836.93304535637, 841.4110122913985, 862.2670729879552, 3236.449803533405, 3270.5257737627912, 3274.754393420503, 3316.767826252139, 3342.1978725106287, 9072.455652660861, 9229.938557066023, 9318.767030824149, 9329.90670093304, 9334.113259240361, 9121.81756364869, 9183.954080229556, 9198.2181514572, 9201.263898888074, 9206.539673016323, 7290.270972902667, 7386.630668466555, 7394.741184058532, 7400.222976587488, 7400.5189662671755, 4743.709970270734, 4790.688605240648, 4799.328094066903, 4822.95177048239, 4862.440819305683, 8489.193526614961, 8528.829423411622, 8620.353473489387, 8662.956685216534, 8684.956575217084, 8778.606989893791, 8830.42602230853, 8857.202851743374, 8921.776955576162, 8952.552372381486, 6535.150430444202, 6625.138731964814, 6632.767853125118, 6640.203175618956, 6642.5018123641885, 5927.703614819328, 6903.102596662603, 7134.500584959003, 7196.172440169447, 7351.485396022227, 6524.902126468011, 6573.638449885302, 6638.966805165944, 6643.56816806906, 6692.6319052450635, 6239.656818874824, 6260.780872669435, 6288.622682639057, 6309.053641953744, 6467.223933128054, 5970.164177015308, 5971.253593300838, 6021.126936594257, 6022.156898034366, 6026.487748541423, 4297.462817147856, 4298.0, 4387.495438024668, 4411.757353345469, 4452.087322099027, 4159.667226621924, 4161.25097482456, 4177.874663760092, 4283.807228674779, 4298.892527686833], "value": 3997.664413325447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.8388240449349, 289.2450703663439, 295.7427038476526, 297.4155783884666, 299.8995336562252, 4584.381108550345, 4739.763011849407, 4750.97624511877, 4792.8801779955475, 4806.663533552648, 4588.403507544014, 4691.413573303337, 4710.2228132358205, 4713.835015774449, 4735.218688916333, 3720.7767533947913, 3732.4028155495125, 3738.981305093471, 3739.7943113128767, 3739.9626003740022, 3562.430011198209, 3617.656322649344, 3723.553173619156, 3731.141837377405, 3735.9626403736024, 3711.870084547041, 3727.8881633551036, 3738.831752571141, 3745.2883952049024, 3746.363118269887, 3719.6652301293016, 3720.349563046192, 3726.4596633488127, 3736.271427071722, 3738.719596030309, 3275.9344813103603, 3302.091924720697, 3309.635940046593, 3309.891186452541, 3317.933641327184, 4564.360989461478, 4631.60631346336, 4647.34937108805, 4662.743549104798, 4691.272852707836, 4260.595243451898, 4276.935845962313, 4279.636230920375, 4290.592393722592, 4293.22721910056, 4980.203167493184, 4982.427020892571, 4984.476629953875, 4986.5013498650205, 4988.65079444439, 3518.5953615334306, 3567.340042092221, 3586.5875424326277, 3592.964070359289, 3615.620359862203, 5194.142966410538, 5203.895922081575, 5207.635465517377, 5208.817691380821, 5209.270702101709, 3682.2635472905527, 3695.279420512974, 3696.7412281140064, 3704.2221133561716, 3709.629037096269, 3764.416515440111, 3790.5640851302455, 3805.657490825839, 3806.2958352704836, 3806.3148633246283, 4178.26880295947, 4240.194363071007, 4240.664190779895, 4283.957160428356, 4305.547917468683, 4978.531333256698, 4982.60139188864, 4985.925211121836, 4992.675476094042, 4995.900081998339, 1214.1561614677714, 1247.419949723383, 1272.8027155790867, 1281.128832393981, 1304.7260075384277, 887.3034667785757, 888.7689200807707, 905.2712566383992, 908.8409528332515, 915.0803442540205, 4375.387445757597, 4384.69307148503, 4385.079133382025, 4390.385346051556, 4392.560743925582, 5091.796328146833, 5094.490550944876, 5096.159133742965, 5114.74426278692, 5124.461931497213, 4369.300911854088, 4379.824807007748, 4398.119231903109, 4400.801963911567, 4402.427684401007, 2296.9655455168186, 2401.6277476991095, 2405.5549723301247, 2409.2772168349425, 2411.9276421707377, 4257.957420425818, 4288.935665965013, 4318.438602981592, 4320.287152619845, 4341.891452713644, 4626.83806066786, 4627.0, 4630.3748993886065, 4637.6289896808175, 4679.368285281512, 4137.524184718796, 4290.163418133434, 4291.69958102936, 4306.246406878847, 4348.760388399976, 4512.6615503838, 4521.751303678329, 4529.188324670026, 4559.33584241756, 4566.538707613532, 4441.955580444283, 4450.532694067077, 4457.3091170868565, 4459.977700111479, 4476.216662084187, 3989.5212574491247, 4239.95760042408, 4291.699581029298, 4306.621880998051, 4314.309710446313, 3343.2477692518987, 3351.7933543924655, 3361.2857442703908, 3376.109378747909, 3385.7460690447824, 4558.794854231502, 4564.360989461545, 4584.289435137559, 4589.908201836011, 4901.975490122527, 4826.155422801066, 4908.9754551227015, 4992.126377883928, 4997.900041999213, 5051.797928082836, 4976.8755781105765, 4993.575546078624, 5022.347094877789, 5024.522670346311, 5038.269450929668, 4730.4796472387325, 4853.611711063036, 4855.830045948375, 4903.705777653352, 4935.531124543163, 4999.525045120708, 5020.774065167003, 5041.773120209526, 5056.0, 5061.139606267017, 4919.532644398776, 4937.5556199942175, 4938.777755001105, 4946.282788995503, 4955.876103097451], "value": 3666.582372719526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1211243696638, 606.7209083821441, 622.5579838314798, 656.5765081522421, 678.6301465701192, 11203.6638900833, 12259.938700306497, 12297.3236471994, 12305.63083107506, 12307.261564306147, 11081.72295692606, 11092.611758588451, 11169.888301116986, 11191.496382662779, 11210.383428911407, 738.9556626602395, 757.9621018949058, 759.8024513626442, 760.1600231743927, 760.4258784617606, 565.5051829649057, 593.8485686150026, 709.5317090720126, 749.1347493644822, 752.8644843928091, 797.3979645367739, 806.7297455352464, 808.1231863428187, 809.6437567470324, 809.9190080991883, 799.3325573146429, 799.8720204767209, 800.2597597222575, 800.9399295052895, 801.2508304735092, 435.1167130724634, 549.2420459765538, 586.7301041520906, 587.4830149468484, 587.5006244691978, 10792.190585706103, 11137.498812553455, 11139.387333696643, 11169.106471482262, 11201.0, 11176.385298808644, 11431.714207144805, 11519.654410367702, 11740.882591174064, 12101.334426606532, 10247.84628230577, 10304.072633463024, 10343.844842327371, 10517.63188288414, 10588.417637029961, 3942.448057271984, 3970.3647416413237, 3985.8206380712936, 4059.7361171523758, 4064.6748260139116, 63764.36235637677, 66448.3355166447, 66466.0, 67164.66417667881, 68550.3144968554, 9792.755181120387, 9894.406335619886, 9902.801943961225, 10031.448270345201, 10142.18862490999, 16181.0, 16685.749713754303, 17374.218160182823, 17388.0, 17467.737983930252, 6088.4824789893355, 6186.566940314135, 6458.942710643195, 6499.610023398611, 6558.751322328964, 3439.9312013759586, 3473.8089405082965, 3516.8065756383135, 3529.1882866940746, 3559.750817442806, 2606.1790535981104, 2674.3314171457137, 2696.7842572594145, 2696.8651567421944, 2714.7013828478853, 502.6406119624486, 527.1933941070168, 538.090626840638, 538.9272448219518, 539.6708008115047, 380.5015429786988, 440.6584896705015, 441.7592412135394, 456.46821453006874, 475.7597413306327, 6958.93041069593, 7051.435885129177, 7168.068151140318, 7425.220351863085, 7523.510971786816, 422.8287543544808, 428.7191889312505, 430.5285712145196, 448.1194452900067, 467.89472368716764, 3190.1546090286092, 3234.5795046643784, 3306.7189288910713, 3421.811800350955, 3439.2605589798313, 59622.0, 63844.0, 104783.4760826191, 108921.0, 109533.0, 89613.0, 93347.14799869157, 94242.52878735699, 94839.0, 96691.51654241825, 76860.23139768642, 77158.22841771622, 78024.60987695026, 80503.59748201222, 80554.0, 6118.877622447615, 6160.537959653134, 6330.493560515056, 6418.550701450854, 6454.935450645621, 31751.523727144573, 35186.0, 39994.80002600085, 41991.160176796904, 44890.10219795651, 61526.0, 61648.383516164264, 64552.354476456516, 64633.0, 65450.345496544425, 8125.268725814705, 8154.551499667576, 8155.755327340189, 8164.265216130577, 8692.130786921258, 9217.76955576116, 9276.397034192756, 9520.190783783455, 10726.141908647445, 11120.88879111231, 9627.470489122885, 9913.851292230478, 10028.398296102258, 10098.293119481566, 10340.844887326846, 9554.235661146953, 9655.22758179358, 9678.032196780267, 9898.257630677585, 9949.303548751517, 9093.40892841963, 9361.765955850886, 9512.0, 9595.808083838423, 9704.805903881741, 7782.766517004499, 8091.959540202261, 8153.510789352657, 8289.95855020721, 8345.248927596545, 7994.480358776661, 8575.61409736551, 8591.484510929115, 8979.910200898168, 9314.673986410444], "value": 5947.845061380908, "unit": "score"}], "name": "dromaeo_css", "value": 6150.336315123505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 115.0, 117.0, 115.0, 114.0, 116.0, 114.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 124.0, 188.0, 123.0, 126.0, 161.0, 122.0, 180.0, 122.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 160.0, 161.0, 163.0, 162.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 123.0, 77.0, 78.0, 75.0, 76.0, 105.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 128.0, 85.0, 84.0, 85.0, 123.0, 85.0, 84.0, 124.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 62.0, 61.0, 65.0, 63.0, 62.0, 65.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 88.0, 82.0, 79.0, 78.0, 78.0, 78.0, 77.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 133.0, 129.0, 139.0, 131.0, 131.0, 128.0, 234.0, 134.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 164.0, 165.0, 169.0, 174.0, 168.0, 167.0, 168.0, 169.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 71.0, 65.0, 68.0, 68.0, 66.0, 66.0, 68.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1542.8, "alertThreshold": 2.0}]} 04:47:45 INFO - Return code: 0 04:47:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:45 INFO - # TBPL SUCCESS # 04:47:45 INFO - Running post-action listener: _resource_record_post_action 04:47:45 INFO - [mozharness: 2016-08-03 11:47:45.845888Z] Finished run-tests step (success) 04:47:45 INFO - Running post-run listener: _resource_record_post_run 04:47:45 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529707008; Read time: 8; Write time: 472136 04:47:45 INFO - TinderboxPrint: CPU usage
13.1% 04:47:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:47:45 INFO - TinderboxPrint: I/O write bytes / time
529,707,008 / 472,136 04:47:45 INFO - TinderboxPrint: CPU idle
8,320.1 (86.9%) 04:47:45 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 04:47:45 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249339904; Read time: 0; Write time: 259824 04:47:45 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 279990272; Read time: 0; Write time: 212276 04:47:46 INFO - Running post-run listener: _upload_blobber_files 04:47:46 INFO - Blob upload gear active. 04:47:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:46 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 04:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:47:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:47 INFO - (blobuploader) - INFO - Done attempting. 04:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:48 INFO - (blobuploader) - INFO - Done attempting. 04:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:53 INFO - (blobuploader) - INFO - Done attempting. 04:47:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:53 INFO - Return code: 0 04:47:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ff883895c21968bfe5c53be81d6d8766422cd2629ea7a9eb18fb3b793f070009b7748d34dc5284e2ed70d8a2a5d96df27c75e3ed95302d67fd8d83fb371bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d7640a508db51a335a8ec25594ab61d88cba3e001adcc590329be775293da159f770f32c20c690985f914204a01effa87f2f16a022e0497fe726a9b269ba3b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82195b00e7042ac4203bad40d06792ff2c79a0726522e1754089cf8f84d0ed976c01298480bbd63374991e9c85f5420633718e446d26565c2d0617a86e442fd3"} 04:47:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:53 INFO - Contents: 04:47:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ff883895c21968bfe5c53be81d6d8766422cd2629ea7a9eb18fb3b793f070009b7748d34dc5284e2ed70d8a2a5d96df27c75e3ed95302d67fd8d83fb371bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d7640a508db51a335a8ec25594ab61d88cba3e001adcc590329be775293da159f770f32c20c690985f914204a01effa87f2f16a022e0497fe726a9b269ba3b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82195b00e7042ac4203bad40d06792ff2c79a0726522e1754089cf8f84d0ed976c01298480bbd63374991e9c85f5420633718e446d26565c2d0617a86e442fd3"} 04:47:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:53 INFO - Copying logs to upload dir... 04:47:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.794474 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-03 04:47:53.393594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 04:47:53.397885) ========= 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=db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ff883895c21968bfe5c53be81d6d8766422cd2629ea7a9eb18fb3b793f070009b7748d34dc5284e2ed70d8a2a5d96df27c75e3ed95302d67fd8d83fb371bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d7640a508db51a335a8ec25594ab61d88cba3e001adcc590329be775293da159f770f32c20c690985f914204a01effa87f2f16a022e0497fe726a9b269ba3b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82195b00e7042ac4203bad40d06792ff2c79a0726522e1754089cf8f84d0ed976c01298480bbd63374991e9c85f5420633718e446d26565c2d0617a86e442fd3"} build_url:https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/OdXrvgwESGO5phd8LbKBxw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68ff883895c21968bfe5c53be81d6d8766422cd2629ea7a9eb18fb3b793f070009b7748d34dc5284e2ed70d8a2a5d96df27c75e3ed95302d67fd8d83fb371bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d7640a508db51a335a8ec25594ab61d88cba3e001adcc590329be775293da159f770f32c20c690985f914204a01effa87f2f16a022e0497fe726a9b269ba3b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82195b00e7042ac4203bad40d06792ff2c79a0726522e1754089cf8f84d0ed976c01298480bbd63374991e9c85f5420633718e446d26565c2d0617a86e442fd3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 04:47:53.423164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 04:47:53.423491) ========= 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=db7e7c15f3ca076d53731445000001ba-1470223633.131572-847511387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 04:47:53.508987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 04:47:53.509307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 04:47:53.509584) ========= ========= Total master_lag: 0.18 =========