builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1469868896.99 results: success (0) buildid: 20160730005025 builduid: 3f3091f308c44c2d935d40d1084afe25 revision: c3565c8b1cdb575db1c80c7791984a6490598b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:56.994715) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:56.995129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:56.995418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.085075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.085349) ========= 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=0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 01:54:57-- 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% 88.6M=0s 2016-07-30 01:54:57 (88.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.236416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.236701) ========= 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=0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019956 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.285753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.286105) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3565c8b1cdb575db1c80c7791984a6490598b84 --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 c3565c8b1cdb575db1c80c7791984a6490598b84 --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=0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 01:54:57,728 truncating revision to first 12 chars 2016-07-30 01:54:57,728 Setting DEBUG logging. 2016-07-30 01:54:57,728 attempt 1/10 2016-07-30 01:54:57,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3565c8b1cdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 01:54:58,076 unpacking tar archive at: fx-team-c3565c8b1cdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673406 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.972898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.973253) ========= script_repo_revision: c3565c8b1cdb575db1c80c7791984a6490598b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.973775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:57.974082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 01:54:58.013526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-30 01:54:58.013989) ========= /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=0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:54:58 INFO - MultiFileLogger online at 20160730 01:54:58 in /builds/slave/test 01:54:58 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 01:54:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:58 INFO - {'append_to_log': False, 01:54:58 INFO - 'base_work_dir': '/builds/slave/test', 01:54:58 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:54:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:58 INFO - 'branch': 'Fx-Team-Non-PGO', 01:54:58 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:58 INFO - 'config_files': ('talos/linux_config.py',), 01:54:58 INFO - 'default_actions': ('clobber', 01:54:58 INFO - 'read-buildbot-config', 01:54:58 INFO - 'download-and-extract', 01:54:58 INFO - 'populate-webroot', 01:54:58 INFO - 'create-virtualenv', 01:54:58 INFO - 'install', 01:54:58 INFO - 'run-tests'), 01:54:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:58 INFO - 'download_minidump_stackwalk': True, 01:54:58 INFO - 'download_symbols': 'ondemand', 01:54:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:58 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:58 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:58 INFO - 'installer_path': 'installer.exe', 01:54:58 INFO - 'log_level': 'info', 01:54:58 INFO - 'log_name': 'talos', 01:54:58 INFO - 'log_to_console': True, 01:54:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:54:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:54:58 INFO - 'opt_config_files': (), 01:54:58 INFO - 'pip_index': False, 01:54:58 INFO - 'sps_profile': False, 01:54:58 INFO - 'sps_profile_interval': 0, 01:54:58 INFO - 'suite': 'dromaeojs', 01:54:58 INFO - 'system_bits': '32', 01:54:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:58 INFO - 'title': 'talos-linux64-ix-058', 01:54:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:58 INFO - 'use_talos_json': True, 01:54:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:58 INFO - 'work_dir': 'build'} 01:54:58 INFO - [mozharness: 2016-07-30 08:54:58.555619Z] Running clobber step. 01:54:58 INFO - Running pre-action listener: _resource_record_pre_action 01:54:58 INFO - Running main action method: clobber 01:54:58 INFO - rmtree: /builds/slave/test/build 01:54:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:59 INFO - Running post-action listener: _resource_record_post_action 01:54:59 INFO - [mozharness: 2016-07-30 08:54:59.045243Z] Finished clobber step (success) 01:54:59 INFO - [mozharness: 2016-07-30 08:54:59.045345Z] Running read-buildbot-config step. 01:54:59 INFO - Running pre-action listener: _resource_record_pre_action 01:54:59 INFO - Running main action method: read_buildbot_config 01:54:59 INFO - Using buildbot properties: 01:54:59 INFO - { 01:54:59 INFO - "project": "", 01:54:59 INFO - "product": "firefox", 01:54:59 INFO - "script_repo_revision": "production", 01:54:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:54:59 INFO - "repository": "", 01:54:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:54:59 INFO - "buildid": "20160730005025", 01:54:59 INFO - "pgo_build": "False", 01:54:59 INFO - "basedir": "/builds/slave/test", 01:54:59 INFO - "buildnumber": 3198, 01:54:59 INFO - "slavename": "talos-linux64-ix-058", 01:54:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:54:59 INFO - "platform": "ubuntu64_hw", 01:54:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:54:59 INFO - "branch": "fx-team", 01:54:59 INFO - "repo_path": "integration/fx-team", 01:54:59 INFO - "revision": "c3565c8b1cdb575db1c80c7791984a6490598b84", 01:54:59 INFO - "stage_platform": "linux64", 01:54:59 INFO - "builduid": "3f3091f308c44c2d935d40d1084afe25", 01:54:59 INFO - "slavebuilddir": "test" 01:54:59 INFO - } 01:54:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:54:59 INFO - Running post-action listener: _resource_record_post_action 01:54:59 INFO - [mozharness: 2016-07-30 08:54:59.047788Z] Finished read-buildbot-config step (success) 01:54:59 INFO - [mozharness: 2016-07-30 08:54:59.047877Z] Running download-and-extract step. 01:54:59 INFO - Running pre-action listener: _resource_record_pre_action 01:54:59 INFO - Running main action method: download_and_extract 01:54:59 INFO - mkdir: /builds/slave/test/build/tests 01:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:59 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:55:04 INFO - Downloaded 1361 bytes. 01:55:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:55:04 INFO - Using the following test package requirements: 01:55:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:55:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:55:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'jsshell-linux-x86_64.zip'], 01:55:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:55:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:55:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:55:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:55:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:55:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:04 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:55:08 INFO - Downloaded 20231869 bytes. 01:55:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:55:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:55:09 INFO - Return code: 0 01:55:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:09 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:55:20 INFO - Downloaded 20231869 bytes. 01:55:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:55:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:55:21 INFO - Return code: 0 01:55: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')]} 01:55:21 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:55:22 INFO - Downloaded 14413725 bytes. 01:55:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:55:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:55:22 INFO - Return code: 0 01:55: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')]} 01:55:22 INFO - https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:55:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:55:24 INFO - Downloaded 55584976 bytes. 01:55:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:24 INFO - mkdir: /builds/slave/test/properties 01:55:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:24 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:24 INFO - Contents: 01:55:24 INFO - build_url:https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:24 INFO - Running post-action listener: _resource_record_post_action 01:55:24 INFO - Running post-action listener: set_extra_try_arguments 01:55:24 INFO - [mozharness: 2016-07-30 08:55:24.789948Z] Finished download-and-extract step (success) 01:55:24 INFO - [mozharness: 2016-07-30 08:55:24.790181Z] Running populate-webroot step. 01:55:24 INFO - Running pre-action listener: _resource_record_pre_action 01:55:24 INFO - Running main action method: populate_webroot 01:55:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:24 INFO - '--tppagecycles', 01:55:24 INFO - '7'], 01:55:24 INFO - 'tests': ['tsvgm']}}, 01:55:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:55:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:55:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:55:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['damp', 'tps']}, 01:55:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'tests': ['damp', 'tps']}, 01:55:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['dromaeo_dom']}, 01:55:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['basic_compositor_video']}, 01:55:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:55:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['a11yr', 01:55:24 INFO - 'ts_paint', 01:55:24 INFO - 'tpaint', 01:55:24 INFO - 'sessionrestore', 01:55:24 INFO - 'sessionrestore_no_auto_restore', 01:55:24 INFO - 'tabpaint']}, 01:55:24 INFO - 'other-e10s': {'tests': ['a11yr', 01:55:24 INFO - 'ts_paint', 01:55:24 INFO - 'tpaint', 01:55:24 INFO - 'sessionrestore', 01:55:24 INFO - 'sessionrestore_no_auto_restore', 01:55:24 INFO - 'tabpaint']}, 01:55:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:55:24 INFO - 'ts_paint', 01:55:24 INFO - 'tpaint', 01:55:24 INFO - 'sessionrestore', 01:55:24 INFO - 'sessionrestore_no_auto_restore', 01:55:24 INFO - 'tabpaint']}, 01:55:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:55:24 INFO - 'ts_paint', 01:55:24 INFO - 'tpaint', 01:55:24 INFO - 'sessionrestore', 01:55:24 INFO - 'sessionrestore_no_auto_restore', 01:55:24 INFO - 'tabpaint']}, 01:55:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['a11yr', 01:55:24 INFO - 'ts_paint', 01:55:24 INFO - 'tpaint', 01:55:24 INFO - 'sessionrestore', 01:55:24 INFO - 'sessionrestore_no_auto_restore', 01:55:24 INFO - 'tabpaint']}, 01:55:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['a11yr', 01:55:24 INFO - 'ts_paint', 01:55:24 INFO - 'tpaint', 01:55:24 INFO - 'sessionrestore', 01:55:24 INFO - 'sessionrestore_no_auto_restore', 01:55:24 INFO - 'tabpaint']}, 01:55:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['tsvgx', 01:55:24 INFO - 'tsvgr_opacity', 01:55:24 INFO - 'tart', 01:55:24 INFO - 'tscrollx', 01:55:24 INFO - 'cart']}, 01:55:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:55:24 INFO - 'tsvgr_opacity', 01:55:24 INFO - 'tart', 01:55:24 INFO - 'tscrollx', 01:55:24 INFO - 'cart']}, 01:55:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'talos_options': ['--disable-e10s'], 01:55:24 INFO - 'tests': ['tp5o']}, 01:55:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'tests': ['tp5o']}, 01:55:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'talos_options': ['--disable-e10s', 01:55:24 INFO - '--xperf_path', 01:55:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:24 INFO - 'tests': ['tp5n']}, 01:55:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:24 INFO - 'talos_options': ['--xperf_path', 01:55:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:24 INFO - 'tests': ['tp5n']}}, 01:55:24 INFO - 'talos.zip': {'path': '', 01:55:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:24 INFO - Running post-action listener: _resource_record_post_action 01:55:24 INFO - [mozharness: 2016-07-30 08:55:24.810306Z] Finished populate-webroot step (success) 01:55:24 INFO - [mozharness: 2016-07-30 08:55:24.810394Z] Running create-virtualenv step. 01:55:24 INFO - Running pre-action listener: _resource_record_pre_action 01:55:24 INFO - Running main action method: create_virtualenv 01:55:24 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55: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 01:55:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:25 INFO - Using real prefix '/usr' 01:55:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:25 INFO - Installing distribute.............................................................................................................................................................................................done. 01:55:27 INFO - Installing pip.................done. 01:55:27 INFO - Return code: 0 01:55:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:55: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')]} 01:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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')]} 01:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55: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', 'pip>=1.5'] in /builds/slave/test/build 01:55: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 pip>=1.5 01:55:27 INFO - Using env: {'DISPLAY': ':0', 01:55:27 INFO - 'HOME': '/home/cltbld', 01:55:27 INFO - 'LANG': 'en_US.UTF-8', 01:55:27 INFO - 'LANGUAGE': 'en_US:en', 01:55:27 INFO - 'LOGNAME': 'cltbld', 01:55:27 INFO - 'MAIL': '/var/mail/cltbld', 01:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:27 INFO - 'MOZ_NO_REMOTE': '1', 01:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:27 INFO - 'NO_EM_RESTART': '1', 01:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:27 INFO - 'PWD': '/builds/slave/test', 01:55:27 INFO - 'SHELL': '/bin/bash', 01:55:27 INFO - 'SHLVL': '1', 01:55:27 INFO - 'TERM': 'linux', 01:55:27 INFO - 'TMOUT': '86400', 01:55:27 INFO - 'USER': 'cltbld', 01:55:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:27 INFO - '_': '/tools/buildbot/bin/python'} 01:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55: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 01:55:27 INFO - Cleaning up... 01:55:27 INFO - Return code: 0 01:55:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:55: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')]} 01:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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')]} 01:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55: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 01:55: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 01:55:27 INFO - Using env: {'DISPLAY': ':0', 01:55:27 INFO - 'HOME': '/home/cltbld', 01:55:27 INFO - 'LANG': 'en_US.UTF-8', 01:55:27 INFO - 'LANGUAGE': 'en_US:en', 01:55:27 INFO - 'LOGNAME': 'cltbld', 01:55:27 INFO - 'MAIL': '/var/mail/cltbld', 01:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:27 INFO - 'MOZ_NO_REMOTE': '1', 01:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:27 INFO - 'NO_EM_RESTART': '1', 01:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:27 INFO - 'PWD': '/builds/slave/test', 01:55:27 INFO - 'SHELL': '/bin/bash', 01:55:27 INFO - 'SHLVL': '1', 01:55:27 INFO - 'TERM': 'linux', 01:55:27 INFO - 'TMOUT': '86400', 01:55:27 INFO - 'USER': 'cltbld', 01:55:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:27 INFO - '_': '/tools/buildbot/bin/python'} 01:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:27 INFO - Downloading/unpacking psutil>=3.1.1 01:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:29 INFO - Installing collected packages: psutil 01:55:29 INFO - Running setup.py install for psutil 01:55:29 INFO - building 'psutil._psutil_linux' extension 01:55: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 01:55:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:55:30 INFO - building 'psutil._psutil_posix' extension 01:55:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:55:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:55:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:30 INFO - Successfully installed psutil 01:55:30 INFO - Cleaning up... 01:55:30 INFO - Return code: 0 01:55:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:30 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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:55:30 INFO - Using env: {'DISPLAY': ':0', 01:55:30 INFO - 'HOME': '/home/cltbld', 01:55:30 INFO - 'LANG': 'en_US.UTF-8', 01:55:30 INFO - 'LANGUAGE': 'en_US:en', 01:55:30 INFO - 'LOGNAME': 'cltbld', 01:55:30 INFO - 'MAIL': '/var/mail/cltbld', 01:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:30 INFO - 'MOZ_NO_REMOTE': '1', 01:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:30 INFO - 'NO_EM_RESTART': '1', 01:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:30 INFO - 'PWD': '/builds/slave/test', 01:55:30 INFO - 'SHELL': '/bin/bash', 01:55:30 INFO - 'SHLVL': '1', 01:55:30 INFO - 'TERM': 'linux', 01:55:30 INFO - 'TMOUT': '86400', 01:55:30 INFO - 'USER': 'cltbld', 01:55:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:30 INFO - '_': '/tools/buildbot/bin/python'} 01:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:55:32 INFO - Installing collected packages: mozsystemmonitor 01:55:32 INFO - Running setup.py install for mozsystemmonitor 01:55:32 INFO - Successfully installed mozsystemmonitor 01:55:32 INFO - Cleaning up... 01:55:32 INFO - Return code: 0 01:55:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:55: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')]} 01:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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')]} 01:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55: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 01:55: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 01:55:32 INFO - Using env: {'DISPLAY': ':0', 01:55:32 INFO - 'HOME': '/home/cltbld', 01:55:32 INFO - 'LANG': 'en_US.UTF-8', 01:55:32 INFO - 'LANGUAGE': 'en_US:en', 01:55:32 INFO - 'LOGNAME': 'cltbld', 01:55:32 INFO - 'MAIL': '/var/mail/cltbld', 01:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:32 INFO - 'MOZ_NO_REMOTE': '1', 01:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:32 INFO - 'NO_EM_RESTART': '1', 01:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:32 INFO - 'PWD': '/builds/slave/test', 01:55:32 INFO - 'SHELL': '/bin/bash', 01:55:32 INFO - 'SHLVL': '1', 01:55:32 INFO - 'TERM': 'linux', 01:55:32 INFO - 'TMOUT': '86400', 01:55:32 INFO - 'USER': 'cltbld', 01:55:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:32 INFO - '_': '/tools/buildbot/bin/python'} 01:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:32 INFO - Downloading/unpacking jsonschema==2.5.1 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:35 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:35 INFO - warning: no files found matching '*.txt' 01:55:35 INFO - no previously-included directories found matching 'build' 01:55:35 INFO - no previously-included directories found matching 'dist' 01:55:35 INFO - no previously-included directories found matching '.git*' 01:55:35 INFO - Installing collected packages: jsonschema, functools32 01:55:35 INFO - Running setup.py install for functools32 01:55:35 INFO - warning: no files found matching '*.txt' 01:55:35 INFO - no previously-included directories found matching 'build' 01:55:35 INFO - no previously-included directories found matching 'dist' 01:55:35 INFO - no previously-included directories found matching '.git*' 01:55:35 INFO - Successfully installed jsonschema functools32 01:55:35 INFO - Cleaning up... 01:55:35 INFO - Return code: 0 01:55:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:35 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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55:35 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 01:55:35 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 01:55:35 INFO - Using env: {'DISPLAY': ':0', 01:55:35 INFO - 'HOME': '/home/cltbld', 01:55:35 INFO - 'LANG': 'en_US.UTF-8', 01:55:35 INFO - 'LANGUAGE': 'en_US:en', 01:55:35 INFO - 'LOGNAME': 'cltbld', 01:55:35 INFO - 'MAIL': '/var/mail/cltbld', 01:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:35 INFO - 'MOZ_NO_REMOTE': '1', 01:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:35 INFO - 'NO_EM_RESTART': '1', 01:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:35 INFO - 'PWD': '/builds/slave/test', 01:55:35 INFO - 'SHELL': '/bin/bash', 01:55:35 INFO - 'SHLVL': '1', 01:55:35 INFO - 'TERM': 'linux', 01:55:35 INFO - 'TMOUT': '86400', 01:55:35 INFO - 'USER': 'cltbld', 01:55:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:35 INFO - '_': '/tools/buildbot/bin/python'} 01:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:55:35 INFO - Cleaning up... 01:55:35 INFO - Return code: 0 01:55:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:35 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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:55:35 INFO - Using env: {'DISPLAY': ':0', 01:55:35 INFO - 'HOME': '/home/cltbld', 01:55:35 INFO - 'LANG': 'en_US.UTF-8', 01:55:35 INFO - 'LANGUAGE': 'en_US:en', 01:55:35 INFO - 'LOGNAME': 'cltbld', 01:55:35 INFO - 'MAIL': '/var/mail/cltbld', 01:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:35 INFO - 'MOZ_NO_REMOTE': '1', 01:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:35 INFO - 'NO_EM_RESTART': '1', 01:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:35 INFO - 'PWD': '/builds/slave/test', 01:55:35 INFO - 'SHELL': '/bin/bash', 01:55:35 INFO - 'SHLVL': '1', 01:55:35 INFO - 'TERM': 'linux', 01:55:35 INFO - 'TMOUT': '86400', 01:55:35 INFO - 'USER': 'cltbld', 01:55:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:35 INFO - '_': '/tools/buildbot/bin/python'} 01:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:35 INFO - Downloading/unpacking blobuploader==1.2.4 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:37 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:38 INFO - Downloading docopt-0.6.1.tar.gz 01:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:38 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:38 INFO - Running setup.py install for blobuploader 01:55:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:38 INFO - Running setup.py install for requests 01:55:38 INFO - Running setup.py install for docopt 01:55:38 INFO - Successfully installed blobuploader requests docopt 01:55:38 INFO - Cleaning up... 01:55:38 INFO - Return code: 0 01:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55: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 01:55: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 01:55:38 INFO - Using env: {'DISPLAY': ':0', 01:55:38 INFO - 'HOME': '/home/cltbld', 01:55:38 INFO - 'LANG': 'en_US.UTF-8', 01:55:38 INFO - 'LANGUAGE': 'en_US:en', 01:55:38 INFO - 'LOGNAME': 'cltbld', 01:55:38 INFO - 'MAIL': '/var/mail/cltbld', 01:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:38 INFO - 'MOZ_NO_REMOTE': '1', 01:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:38 INFO - 'NO_EM_RESTART': '1', 01:55:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:38 INFO - 'PWD': '/builds/slave/test', 01:55:38 INFO - 'SHELL': '/bin/bash', 01:55:38 INFO - 'SHLVL': '1', 01:55:38 INFO - 'TERM': 'linux', 01:55:38 INFO - 'TMOUT': '86400', 01:55:38 INFO - 'USER': 'cltbld', 01:55:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:38 INFO - '_': '/tools/buildbot/bin/python'} 01:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:39 INFO - Running setup.py (path:/tmp/pip-KVY5Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:39 INFO - Running setup.py (path:/tmp/pip-KrYpJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:39 INFO - Running setup.py (path:/tmp/pip-yZxXsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:39 INFO - Running setup.py (path:/tmp/pip-quZDBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:39 INFO - Running setup.py (path:/tmp/pip-osIByI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:39 INFO - Running setup.py (path:/tmp/pip-01vUcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:39 INFO - Running setup.py (path:/tmp/pip-e5oxIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:39 INFO - Running setup.py (path:/tmp/pip-OqJ3D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:39 INFO - Running setup.py (path:/tmp/pip-EkR2Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:39 INFO - Running setup.py (path:/tmp/pip-AHQiqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:39 INFO - Running setup.py (path:/tmp/pip-iA929F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:39 INFO - Running setup.py (path:/tmp/pip-_G32py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:40 INFO - Running setup.py (path:/tmp/pip-x2oeqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:40 INFO - Running setup.py (path:/tmp/pip-cL0UKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:40 INFO - Running setup.py (path:/tmp/pip-ppV5op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:40 INFO - Running setup.py (path:/tmp/pip-wNe7he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:40 INFO - Running setup.py (path:/tmp/pip-qCHU95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:40 INFO - Running setup.py install for manifestparser 01:55:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:55:40 INFO - Running setup.py install for mozcrash 01:55:40 INFO - Running setup.py install for mozdebug 01:55:40 INFO - Running setup.py install for mozdevice 01:55:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:55:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:55:40 INFO - Running setup.py install for mozfile 01:55:40 INFO - Running setup.py install for mozhttpd 01:55:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for mozinfo 01:55:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for mozInstall 01:55:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for mozleak 01:55:41 INFO - Running setup.py install for mozlog 01:55:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for moznetwork 01:55:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for mozprocess 01:55:41 INFO - Running setup.py install for mozprofile 01:55:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for mozrunner 01:55:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:55:41 INFO - Running setup.py install for mozscreenshot 01:55:42 INFO - Running setup.py install for moztest 01:55:42 INFO - Running setup.py install for mozversion 01:55:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:55:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:42 INFO - Cleaning up... 01:55:42 INFO - Return code: 0 01:55:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:42 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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:55:42 INFO - Using env: {'DISPLAY': ':0', 01:55:42 INFO - 'HOME': '/home/cltbld', 01:55:42 INFO - 'LANG': 'en_US.UTF-8', 01:55:42 INFO - 'LANGUAGE': 'en_US:en', 01:55:42 INFO - 'LOGNAME': 'cltbld', 01:55:42 INFO - 'MAIL': '/var/mail/cltbld', 01:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:42 INFO - 'MOZ_NO_REMOTE': '1', 01:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:42 INFO - 'NO_EM_RESTART': '1', 01:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:42 INFO - 'PWD': '/builds/slave/test', 01:55:42 INFO - 'SHELL': '/bin/bash', 01:55:42 INFO - 'SHLVL': '1', 01:55:42 INFO - 'TERM': 'linux', 01:55:42 INFO - 'TMOUT': '86400', 01:55:42 INFO - 'USER': 'cltbld', 01:55:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:42 INFO - '_': '/tools/buildbot/bin/python'} 01:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:42 INFO - Running setup.py (path:/tmp/pip-9lWV4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:42 INFO - Running setup.py (path:/tmp/pip-rt_EIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:42 INFO - Running setup.py (path:/tmp/pip-PkXhG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55: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)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:42 INFO - Running setup.py (path:/tmp/pip-cbcszH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55: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)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:42 INFO - Running setup.py (path:/tmp/pip-mCvJRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55: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)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:42 INFO - Running setup.py (path:/tmp/pip-v0afnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55: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)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:42 INFO - Running setup.py (path:/tmp/pip-RVRUfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55: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)) 01:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:42 INFO - Running setup.py (path:/tmp/pip-nfCeQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:43 INFO - Running setup.py (path:/tmp/pip-3dFaUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:43 INFO - Running setup.py (path:/tmp/pip-fQfO4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:43 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)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:43 INFO - Running setup.py (path:/tmp/pip-ooR49v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:43 INFO - Running setup.py (path:/tmp/pip-yBUH8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:43 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)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:43 INFO - Running setup.py (path:/tmp/pip-DBGuCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:43 INFO - Running setup.py (path:/tmp/pip-YaMeQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:43 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)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:43 INFO - Running setup.py (path:/tmp/pip-pTqyiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:43 INFO - Running setup.py (path:/tmp/pip-gQ0sT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55: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)) 01:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:43 INFO - Running setup.py (path:/tmp/pip-SSM8m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55: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)) 01:55: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)) 01:55: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)) 01:55: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)) 01:55: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)) 01:55: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)) 01:55:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55: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 01:55:45 INFO - Downloading blessings-1.6.tar.gz 01:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:45 INFO - Installing collected packages: blessings 01:55:45 INFO - Running setup.py install for blessings 01:55:45 INFO - Successfully installed blessings 01:55:45 INFO - Cleaning up... 01:55:45 INFO - Return code: 0 01:55:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:46 INFO - Reading from file tmpfile_stdout 01:55:46 INFO - Current package versions: 01:55:46 INFO - argparse == 1.2.1 01:55:46 INFO - blessings == 1.6 01:55:46 INFO - blobuploader == 1.2.4 01:55:46 INFO - docopt == 0.6.1 01:55:46 INFO - functools32 == 3.2.3-2 01:55:46 INFO - jsonschema == 2.5.1 01:55:46 INFO - manifestparser == 1.1 01:55:46 INFO - mozInstall == 1.12 01:55:46 INFO - mozcrash == 0.17 01:55:46 INFO - mozdebug == 0.1 01:55:46 INFO - mozdevice == 0.48 01:55:46 INFO - mozfile == 1.2 01:55:46 INFO - mozhttpd == 0.7 01:55:46 INFO - mozinfo == 0.9 01:55:46 INFO - mozleak == 0.1 01:55:46 INFO - mozlog == 3.3 01:55:46 INFO - moznetwork == 0.27 01:55:46 INFO - mozprocess == 0.23 01:55:46 INFO - mozprofile == 0.28 01:55:46 INFO - mozrunner == 6.12 01:55:46 INFO - mozscreenshot == 0.1 01:55:46 INFO - mozsystemmonitor == 0.3 01:55:46 INFO - moztest == 0.7 01:55:46 INFO - mozversion == 1.4 01:55:46 INFO - psutil == 3.1.1 01:55:46 INFO - requests == 1.2.3 01:55:46 INFO - wsgiref == 0.1.2 01:55:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:46 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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:55:46 INFO - Using env: {'DISPLAY': ':0', 01:55:46 INFO - 'HOME': '/home/cltbld', 01:55:46 INFO - 'LANG': 'en_US.UTF-8', 01:55:46 INFO - 'LANGUAGE': 'en_US:en', 01:55:46 INFO - 'LOGNAME': 'cltbld', 01:55:46 INFO - 'MAIL': '/var/mail/cltbld', 01:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:46 INFO - 'MOZ_NO_REMOTE': '1', 01:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:46 INFO - 'NO_EM_RESTART': '1', 01:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:46 INFO - 'PWD': '/builds/slave/test', 01:55:46 INFO - 'SHELL': '/bin/bash', 01:55:46 INFO - 'SHLVL': '1', 01:55:46 INFO - 'TERM': 'linux', 01:55:46 INFO - 'TMOUT': '86400', 01:55:46 INFO - 'USER': 'cltbld', 01:55:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:46 INFO - '_': '/tools/buildbot/bin/python'} 01:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:55:46 INFO - Cleaning up... 01:55:46 INFO - Return code: 0 01:55:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:46 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 0x1e12030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, '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': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:55:46 INFO - Using env: {'DISPLAY': ':0', 01:55:46 INFO - 'HOME': '/home/cltbld', 01:55:46 INFO - 'LANG': 'en_US.UTF-8', 01:55:46 INFO - 'LANGUAGE': 'en_US:en', 01:55:46 INFO - 'LOGNAME': 'cltbld', 01:55:46 INFO - 'MAIL': '/var/mail/cltbld', 01:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:46 INFO - 'MOZ_NO_REMOTE': '1', 01:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:46 INFO - 'NO_EM_RESTART': '1', 01:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:46 INFO - 'PWD': '/builds/slave/test', 01:55:46 INFO - 'SHELL': '/bin/bash', 01:55:46 INFO - 'SHLVL': '1', 01:55:46 INFO - 'TERM': 'linux', 01:55:46 INFO - 'TMOUT': '86400', 01:55:46 INFO - 'USER': 'cltbld', 01:55:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:46 INFO - '_': '/tools/buildbot/bin/python'} 01:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:55:46 INFO - Cleaning up... 01:55:46 INFO - Return code: 0 01:55:46 INFO - Running post-action listener: _resource_record_post_action 01:55:46 INFO - Running post-action listener: _start_resource_monitoring 01:55:46 INFO - Starting resource monitoring. 01:55:46 INFO - [mozharness: 2016-07-30 08:55:46.537467Z] Finished create-virtualenv step (success) 01:55:46 INFO - [mozharness: 2016-07-30 08:55:46.537899Z] Running install step. 01:55:46 INFO - Running pre-action listener: _resource_record_pre_action 01:55:46 INFO - Running main action method: install 01:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:46 INFO - Reading from file tmpfile_stdout 01:55:46 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:55:46 INFO - Reading from file tmpfile_stdout 01:55:46 INFO - Output received: 01:55:46 INFO - Usage: mozinstall [options] installer 01:55:46 INFO - Options: 01:55:46 INFO - -h, --help show this help message and exit 01:55:46 INFO - -d DEST, --destination=DEST 01:55:46 INFO - Directory to install application into. [default: 01:55:46 INFO - "/builds/slave/test"] 01:55:46 INFO - --app=APP Application being installed. [default: firefox] 01:55:46 INFO - mkdir: /builds/slave/test/build/application 01:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:56:02 INFO - Reading from file tmpfile_stdout 01:56:02 INFO - Output received: 01:56:02 INFO - /builds/slave/test/build/application/firefox/firefox 01:56:02 INFO - Running post-action listener: _resource_record_post_action 01:56:02 INFO - [mozharness: 2016-07-30 08:56:02.864476Z] Finished install step (success) 01:56:02 INFO - [mozharness: 2016-07-30 08:56:02.864755Z] Running run-tests step. 01:56:02 INFO - Running pre-action listener: _resource_record_pre_action 01:56:02 INFO - Running main action method: run_tests 01:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:02 INFO - Python 2.7.3 01:56:02 INFO - Return code: 0 01:56:02 INFO - grabbing minidump binary from tooltool 01:56: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')]} 01:56: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 0x20d13b0>, '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 0x20d22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56: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 01:56: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 01:56: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 01:56:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:02 INFO - Return code: 0 01:56:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:56:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:56:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56: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/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:56: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/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:56:02 INFO - Using env: {'DISPLAY': ':0', 01:56:02 INFO - 'HOME': '/home/cltbld', 01:56:02 INFO - 'LANG': 'en_US.UTF-8', 01:56:02 INFO - 'LANGUAGE': 'en_US:en', 01:56:02 INFO - 'LOGNAME': 'cltbld', 01:56:02 INFO - 'MAIL': '/var/mail/cltbld', 01:56:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:02 INFO - 'MOZ_NO_REMOTE': '1', 01:56:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:02 INFO - 'NO_EM_RESTART': '1', 01:56:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:02 INFO - 'PWD': '/builds/slave/test', 01:56:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:02 INFO - 'SHELL': '/bin/bash', 01:56:02 INFO - 'SHLVL': '1', 01:56:02 INFO - 'TERM': 'linux', 01:56:02 INFO - 'TMOUT': '86400', 01:56:02 INFO - 'USER': 'cltbld', 01:56:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959', 01:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:02 INFO - '_': '/tools/buildbot/bin/python'} 01:56: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/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:56:03 INFO - mozversion application_buildid: 20160730005025 01:56:03 INFO - mozversion application_changeset: c3565c8b1cdb575db1c80c7791984a6490598b84 01:56:03 INFO - mozversion application_display_name: Nightly 01:56:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:03 INFO - mozversion application_name: Firefox 01:56:03 INFO - mozversion application_remotingname: firefox 01:56:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:56:03 INFO - mozversion application_vendor: Mozilla 01:56:03 INFO - mozversion application_version: 50.0a1 01:56:03 INFO - mozversion platform_buildid: 20160730005025 01:56:03 INFO - mozversion platform_changeset: c3565c8b1cdb575db1c80c7791984a6490598b84 01:56:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:03 INFO - mozversion platform_version: 50.0a1 01:56:03 INFO - using testdate: 1469868963 01:56:03 INFO - actual date: 1469868963 01:56:03 INFO - starting webserver on 'localhost:38396' 01:56:03 INFO - SUITE-START | Running 2 tests 01:56:03 INFO - TEST-START | dromaeo_css 01:56:03 INFO - operating with platform_type : linux_ 01:56:03 INFO - Initialising browser for dromaeo_css test... 01:56:03 INFO - TEST-INFO | started process 23772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA__HSv/profile http://localhost:38396/getInfo.html) 01:56:07 INFO - PROCESS | 23772 | __metrics Screen width/height:1600/1200 01:56:07 INFO - PROCESS | 23772 | colorDepth:24 01:56:07 INFO - PROCESS | 23772 | Browser inner width/height: 1024/697 01:56:07 INFO - PROCESS | 23772 | __metrics 01:56:08 INFO - PROCESS | 23772 | 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" 01:56:08 INFO - PROCESS | 23772 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:56:09 INFO - TEST-INFO | 23772: exit 0 01:56:09 INFO - Browser initialized. 01:56:09 INFO - Running cycle 1/1 for dromaeo_css test... 01:56:09 INFO - TEST-INFO | started process 23852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA__HSv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:21 INFO - PROCESS | 23852 | RSS: Main: 157302784 01:56:21 INFO - PROCESS | 23852 | 01:57:12 INFO - PROCESS | 23852 | 1469869032845 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:59:25 INFO - PROCESS | 23852 | Cycle 1(1): loaded http://localhost:38396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38396/tests/dromaeo/cssquery-ext.html) 01:59:26 INFO - PROCESS | 23852 | RSS: Main: 239747072 01:59:26 INFO - PROCESS | 23852 | 02:02:28 INFO - PROCESS | 23852 | Cycle 1(1): loaded http://localhost:38396/tests/dromaeo/cssquery-ext.html (next: http://localhost:38396/tests/dromaeo/cssquery-jquery.html) 02:02:29 INFO - PROCESS | 23852 | RSS: Main: 247214080 02:02:29 INFO - PROCESS | 23852 | 02:05:31 INFO - PROCESS | 23852 | Cycle 1(1): loaded http://localhost:38396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38396/tests/dromaeo/cssquery-mootools.html) 02:05:32 INFO - PROCESS | 23852 | RSS: Main: 225591296 02:05:32 INFO - PROCESS | 23852 | 02:08:34 INFO - PROCESS | 23852 | Cycle 1(1): loaded http://localhost:38396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38396/tests/dromaeo/cssquery-prototype.html) 02:08:34 INFO - PROCESS | 23852 | RSS: Main: 188706816 02:08:34 INFO - PROCESS | 23852 | 02:11:37 INFO - PROCESS | 23852 | Cycle 1(1): loaded http://localhost:38396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38396/tests/dromaeo/cssquery-yui.html) 02:11:38 INFO - PROCESS | 23852 | RSS: Main: 189984768 02:11:38 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | Cycle 1(1): loaded http://localhost:38396/tests/dromaeo/cssquery-yui.html (next: http://localhost:38396/tests/dromaeo/cssquery-dojo.html) 02:14:41 INFO - PROCESS | 23852 | RSS: Main: 278790144 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | __start_tp_report 02:14:41 INFO - PROCESS | 23852 | _x_x_mozilla_page_load 02:14:41 INFO - PROCESS | 23852 | _x_x_mozilla_page_load_details 02:14:41 INFO - PROCESS | 23852 | |i|pagename|runs| 02:14:41 INFO - PROCESS | 23852 | |0;dojo.html;2672.3052006478315;2673.438577898641;2704.932376690583;2710.0243912191618;2719.116287206657;4658.930116048262;4766.880827979302;4788.880277993052;4880.243562247852;4888.755562221888;4751.738654374008;4767.308740232665;4789.257665061912;4814.518548145184;4901.681390709601;4415.514293427728;4427.2695005324085;4444.088961762831;4447.3773671685985;4570.657200709943;4535.365048893141;4535.818567257323;4537.228671125917;4545.272756358983;4552.726836389811;4307.590778876001;4353.869383918487;4368.257396242615;4461.687681862271;4472.239719247703;4333.501647310568;4374.77506298237;4405.933910991338;4406.493253275882;4408.58118478744;4362.214801335758;4364.10535840152;4366.148601022802;4430.468343798732;4457.977710111429;4744.098621261949;4817.084753896748;4856.927146092811;4858.416989961192;4860.951390486085;4928.6303527235605;4931.482194369575;5128.25640282157;5183.300254465675;5214.113600687854;5218.791248350061;5223.190405487156;5264.078786212397;5274.789008439658;5277.815276465343;4861.683990540603;4878.609711223129;4907;4913.434954980223;4918.729469879191;5067.163917953497;5291.867703307371;5332;5336.439673834269;5421.105517589633;5136.666116702402;5156.20078887773;5178.792848286102;5188.273641690166;5194.4026436959475;5235.110031294613;5241.24002019705;5290.603204759582;5292.735363231823;5296.788128474818;4931.630127740434;5040.747962601855;5050.242463630485;5060.038592667382;5124.692518448905;5061.949380506221;5066.290719299301;5068.0370729562;5069.239614057921;5127.07712611726;4412.757298348622;4429.313456414261;4429.911401771947;4431;4469.374287599739;3770.2271034437877;3805.06775839921;3812.8093595320124;3838.9040273992814;3873;4481.686281960297;4495.77521123949;4499.0776890737325;4536.79584418702;4545.818167273338;5152.278680984665;5161.870953226199;5170.1986192140275;5174.353205849269;5220.086484865134;4354.107407981356;4464.464264288306;4479.17135329965;4511.571400716926;4512.503624601291;4724.362211101457;4741.051789642085;4742.359781429463;4776.95223047772;4783.545563171493;4924.60603151747;4939.777710003131;4940.333055037524;4942.110420124268;4991;5043.52086551777;5146.125158722951;5152.4847515248175;5173.611979101507;5194.68831870089;4932.926006109839;4939.901201975868;4962.181240095344;4969.975150124226;4987.850364489072;5127.769250383667;5130.897382052263;5135.178371460698;5141.0489059522615;5183.844484665466;5039.722815245197;5150.97424512875;5186.273921651047;5209.4009188943755;5211.55701765339;4967.205247160437;5005.67463114911;5005.8748531285555;5052.469490703424;5053.469385714594;5052.418971818141;5068;5070.112730272114;5074.873128171826;5117.641765076558;4800.66395352322;4905.877353066059;4989.900201996013;4999.8750031248055;5043.041822053798;4962.057209130254;5056.898862022813;5058.797648094035;5096.668716533413;5113.233015047773;4916.287138364989;4926.950730492649;4928.728919909439;4929.679570827885;4948.134076536664 02:14:41 INFO - PROCESS | 23852 | |1;ext.html;555.2088274209252;579.4495229531946;585.3970410477207;587.1339773833596;589.440031969629;38716.41925371118;40772.38841417377;40829.18341633165;43999.340009899795;44049.714034315846;40793.18413631726;41389.37915931264;41415.79292103543;41427.37858932118;41566.7921660392;7311.817204569875;7817.804554886145;7960.24377684122;7966.4025198110085;7968.442209045369;9886.851697224547;10203.183745300395;10213.438260895648;10496.370217786918;10502.264841461101;10282;10349.327293725884;10360.585576576928;10362.533685984112;10364;10092.798144037151;10144.847827282596;10184.185265178769;10188.898111018869;10198.949005255;9943.900560994442;10003.64987225451;10009.249306301983;10010.349327293703;10014.799704005953;38865.222695545934;39101;39113.21773564541;39163.60836391628;39183.21633567341;2996.101169649118;3209.1335339458215;3387.3225354929114;3521.9295614087573;3542.2738338640515;29703.40593188124;29800.850995744884;29974.40051198964;30139;31212.375752484822;2866.240446281737;2870.1389583125188;2878.7121287871255;2900.767938564931;2970.4059188162237;254628;255327;256977;257310;259907;31584.684153158174;54196.72901635546;54719;54802.25988700549;54845.45154548483;31918.68081319157;34230.55002849663;34324.48513272303;34328.14179645529;34370.14074648104;13832.93083534596;14023.929880350533;14026.929865350608;14035.228062456663;14041.578752637437;8955.328350373618;10943.124550035978;11239.325640461599;11476.713082172846;11660.416979151008;7914.960425197953;7967.322777563856;7984.20157984197;8041.517508949481;8046.356291496666;3051.9542206866913;3069.309405383771;3085.537169424604;3095.628524577065;3166.4458719723957;835.3442547600105;855.1363123245443;944.8960614332418;954.0554850697898;983.188869182927;28087.57868631972;28154.43691126166;28445.857770711013;28534.857325713238;28978.42043159125;909.3043821476575;911.4349103555838;999.4453078541479;1005.516862627633;1007.1439276614965;14749.23918153248;14929.925350373396;15002.549923502313;15092.471763488225;15121;389293;392879;393468;393645;394033;50396;50837;50859.237111443355;50869.23696144487;51067.48932510702;1088.9346639201674;1107.972300692473;1109.3510296476652;1173.3370645585217;1201.405304374323;22983.77016229883;29746.405071898007;31328.21679458032;31368.843155784074;32339.35321293608;47759.761201193774;48133.5186648129;48472.27291590558;48523;48553;357293;358385;358469;360581;361515;24772;25709.742902570735;25751.227463176136;39206.803965981126;39774;41221.58778412177;41447;41578;42359;42937.35593966155;35144.297114057066;36926.44610330901;36994.26011479701;37326.44010339793;37807.24385512329;36533;36728.63271367252;36814.63185368112;37404.25191496209;37535.62464375321;35331.82334088313;35509.64490355063;36137;36381.63618363783;36666.8166659165;31080.844595776878;33026.83486582552;33305.66694333123;33442.83278583689;33800.49299260464;25003.374915627253;25373.350732203085;25397;25535.87232063828;25694.743052569982 02:14:41 INFO - PROCESS | 23852 | |2;jquery.html;350.19455252918283;361.1999421281862;370.39810308249093;374.3598446656218;391.3093390166357;12703.364831758421;13324.866751332484;15167.317470713831;16969.91515042426;16995.320187192527;15898;17147.57131071721;17150.22823972921;17225.74161387577;17254.482365529024;4970.453250142481;5041.495850414965;5053.191489361703;5061.316722242487;5067.923981140286;3717.721170912179;5674.943250567483;5913.113033045056;5969.910451343233;6076.149339092531;4943.357363542735;6029.547783916202;6035.185249991239;6040.033594624861;6040.939590604104;5087.694738315695;5239.764210610531;5246.580273578104;5248.921266181011;5251.238570407269;5054.646174767768;5094.898102037939;5105.15764898795;5108.208227724708;5356.0894647909945;11456;11530.711732206762;11574.710632234177;11600.883991160064;11619.76760464786;1771.1852547828014;1796.9011704356255;1885.3032270956248;1925.2491528303972;2130.7336582927132;8550.358723095793;8600.440971336842;8638.09300023501;8793.956030219872;9044.502552359683;1564.1475395909256;1608.28431348049;1652.4051341517045;1674.907880066596;1704.676111538816;72006.27993720048;73112;74185.62907185484;75123.62438187774;75508;10123.493825308706;10135.189184865194;10187.185025197967;10418.968301181349;10444.843327350096;14130.15219086858;14165.575032749033;14174.503892363924;14176;14198.716025679636;7166.390856777232;7436.553806771611;7522.849543009109;7554.320111190019;7573.545587264672;6982.197047339621;7022.789316320519;7157.534760240567;7159.140903091662;7401.925980740231;4236.533981262059;4381.737095774264;4384.978075109604;4519.751413672279;4533.320001999727;1679.2863033210836;1786.2854858056621;1826.6803309420798;1853.9536511587048;1914.3108480946848;783.4868161354322;785.9882101768478;815.979600509992;844.6916875340579;885.2165833237631;16700.83299167017;17179.31282748701;17303.3943811966;17561.385351512636;17622.295108195784;843.3169133002287;844.2823599940002;845;845.7420486751477;865.1262225152641;7560.735374261874;9471.810563788824;9645.37305075168;9911.851322230172;10024.849627255597;401913;402901;405041;411907;417898;52817;72894.2710572898;77868.61065694748;78337.60831195922;80180.19819801844;898.9775255618662;899.8560230363241;917.7155081924625;945.0313428735601;948.772294649293;11457.713557161138;14708.264586770405;15534.689306213586;15930;16741.24664390081;37972.81013594914;38990.02524936899;39049.60950390573;39456.40815387829;39770.60229397785;48943.75528122336;49467.25799113088;49530.504694952586;49570;49815;6957.930420695729;7006.334398232159;7135.571865688075;7531.924680753123;7596.050493688289;11911.307494676677;12146.635600931986;12260.632181034583;12828.743425131632;12878.227306361649;9883.752906177404;9888.653897113567;10504.527296271533;10524.789504210026;10608;10136.847947280648;10211.642592509226;10347.689569312932;10412.32319899204;10696.89303106959;10457.895421045692;10719.196060295353;10724.463776810971;10758.838617420588;10773.676789696321;7025.508214424941;7123.074000379917;7144.214136444883;7210.351068403869;7449.478536502393;9918.107370336704;10040.899591003996;10075.596976120873;10301.639442619473;10697.411642359744 02:14:41 INFO - PROCESS | 23852 | |3;mootools.html;1342.8388593368795;1402.7264683386738;1445.9855401445989;1676.2373120230297;1711.093120646058;7855.882161767571;8151.307138893201;8158.918410815898;8174.141715119916;8180.977377827771;6557.311482294362;6717.7312907483765;6722.159730033746;6908.550944188624;7982.560959147245;1948.4154753573907;2157.1587081038406;2226.1540614566443;2233.4304752288144;2253.954920901581;2204.2946257197705;2229.721284839395;2249.80876625487;2251.2908433843368;2251.4371407148215;2262.502249505106;2263.5020295534955;2263.7736226377397;2266.705328307326;2266.8866556672183;2148.7743786902306;2164.718586583742;2192.8245740340894;2193.3419974007734;2195.2536137713255;2147.538279269949;2152.5264441822774;2163.729533808274;2165.6751487277033;2189.704389907358;8075.919240807575;8157.510549366998;8162.14297498766;8162.428629995903;8169.387295952827;4754.5245475452175;4893.192623217201;4896.926546101811;4905.509449055102;4905.533974272438;2851.9144425667264;2985.9402811943855;3005.1885990782584;3034.5903303054024;3037.878484860603;897.4660077254024;918.7060140754961;925.9722208333761;927.9304052196112;939.1125386509751;10915.672529824118;10994.945025274823;11007.174461915309;11019.118470522339;11026.283291586022;4253.5108462527205;4358.280883654225;4414.779261037;4515.593596576324;4524.5927866492175;9358.438493690264;9370.90629093714;9371.718848434557;9372.20336271411;9376.249900008119;4851.80592776285;4853.635977301717;4855.44162421319;4857.077155340545;4882.926756098661;4355.891102722394;4411.360352748833;4418.315161150027;4419.18245124653;4435.534268901783;3703.666669999713;3781.829817658157;3867.8646247381207;3870.3807390817333;3871.670907972854;1204.2774335398865;1259.238160912653;1260.2564486952742;1264.9241045537296;1268.1656497727572;670.5306285600002;796.3668883237724;807.9052883343103;815.502543448496;838.3209600223838;5133.948660513422;5234.527251178995;5286.15421532553;5298.099323115002;5395.109806881899;832.388194676912;850.4727069217125;857.34413173922;871.4205053639386;912.2610685344891;3558.839852206657;3692.132348898007;3745.700343972476;3769.0388950817364;3795.221979494197;9353.345265831327;9499.620015199453;9615.711528654152;9688.951555242178;9932.702018939442;9867.506624668882;9870.062344077302;9870.703878883645;9870.901290986998;9879.308448408687;7160.534565253241;7449.180590135081;7554.093508778982;7562.054743157106;7562.810929726801;5237.580993520433;5365.624406291522;5503.889922201613;5583.944160558342;5667.744951477111;8971.820563588823;9027.684031058881;9050.27597792162;9120.498372589305;9133.680321188727;8984.101589840964;9116.4074335168;9232.307576931622;9327.813443731224;9371.671991480265;6330.936690633035;6867.725290988305;6978.651067446709;7111.2533184017;7177.820554486179;7804.8829267559895;7853;7856.135825059125;7858.135605083322;7872.094709108525;6661.800145995628;6840.726370945106;6870.62211578368;6937.202221744564;7077.610731409822;6864.759733409307;6875.243723190545;6918.7232510699005;6952.443804495527;6968.198657154492;6118.235220597426;6179.536534759821;6238.781642642486;6294.8426289341305;6328.525360598066;4322.805473753626;4518.548145185455;4582;4627.0514544518965;4752.596029337545;4482.8655140345845;4571.542845715402;4595.241785105554;4658.068386322817;4668.393108895958 02:14:41 INFO - PROCESS | 23852 | |4;prototype.html;299.76468472249286;301.34307210281577;308.7823084725269;310.74829388195576;311.20331950207475;4906.975465122674;4945.604351651864;4958.950410495899;4970.403551573807;4971.45314015458;4837.346958160647;4847.515248475151;4894.388201474816;4900.730459824708;4905.607551395889;3884.7280690351686;3898.7660740355527;3899.610038996099;3905.6875449963936;3914.843406263746;3779.7732136071786;3862.86479973201;3887.688984881203;3920.4707364505853;3922.8234729437245;3860.36304009838;3868.729188956774;3868.9613103869024;3874.3607304794673;3875.534935807693;3823.7896915669626;3838.827252773604;3846.4614953906475;3859.9807000964956;3864.903377415559;3233.5149727541057;3246.788958717676;3322.4517954537473;3404.8127352995575;3442.1050526862946;4709.835155769531;4711.528847115261;4717.858464246078;4766.571008609242;4775.426948766136;4380.452443444569;4385.627221686161;4388.319810429357;4398.208322501949;4399.5160532341415;4739.431268247798;4813.687110337817;5036.143855544567;5094.923576146361;5104.795808167706;3671.2473942841652;3676.761010534307;3686.7603605765808;3686.944695829565;3717.6096509866343;5263.921041184385;5282.154855223184;5288.418273989896;5305.442928492491;5379.81170659029;3535.911602209914;3737.0844143185095;3810.2760475509563;3813.199228162117;3815.6565909067763;3749.9062523436587;3755.2677227940835;3769.8869033929027;3772.9434058489146;3782.0544863784053;4295.205387003414;4309.267424537836;4321.438213032286;4329.870103896888;4336.02439451121;5111.974440127776;5117.181250999822;5120.61595380348;5123.103456895028;5131.307273518028;1226.9509219631116;1292.7349893271858;1304.5825335892423;1305.764962306794;1306.5688322853437;809.7287408718146;832.3341326938425;839.3872473094675;840.6217202258886;846.699421705298;4014.3577027675433;4065.7153999220363;4068.4507591475362;4077.4903137107863;4083.959160408417;4616.699914505613;4628.490866004737;4648.3259927310355;4655;4674.532546745366;4052.9392059119136;4066.4916885389325;4074.1851629674184;4124.298869192245;4127.876163715094;2320;2455.717592476888;2462.876856157185;2467.3708204407762;2469.7777200051723;4442.333649952533;4736.976315118402;4801.375821143229;4971.651984361132;4974.552290293891;5338.599605029561;5342.385625653022;5346.304980352607;5358.651687640291;5361.329833770778;4962.652614317035;4968.962725282761;4990.326305948723;4997.850494386239;5012.398512178562;4986.626003049858;5183.352080989876;5216.765605324723;5221.138512145453;5221.791128354823;5142.820001299937;5150.253213284128;5154.871128221825;5156.40701319338;5168.397796683041;4845.224764037878;4982.526659967298;4984.053029924303;5004.974975125101;5020.3724534433195;3679.5032670589126;3680.153564680192;3692.1877187018813;3701.759385639925;3709.870154544578;5188;5193.454687257784;5211.8891848801295;5228.607854410859;5245.213218017328;5033.194688849767;5040.202687508468;5044.747762611782;5047.697138171721;5057.848264552069;4825.662203645711;5031.345925029723;5125.410577783454;5125.718085505333;5129.589362925225;5028.497150284942;5056.873578160576;5058.721770302669;5059.291699162194;5074.2642316864585;4962.404511458503;5148;5155.355580552431;5155.948440515547;5163.922541161811;4953.628477864103;4966.205407134841;4974.517837513683;4983;4988.628127265031 02:14:41 INFO - PROCESS | 23852 | |5;yui.html;580.1240127407616;594.2423410152055;601;634.7112064010876;672.1295921781294;11500.309981401122;11802.822957655642;12130.939345303283;12492.81260781089;12501.312427816467;11874.584389546368;12486.875131248686;12505.749885002295;12506.187097838656;12515.374231288444;625.583986648878;731.5427857589007;774.248978490863;788.6135793461192;788.8067423481256;758.5221310574331;775.255754475704;778.7663700889739;778.9376849851998;784.2549577900988;809.8906647602587;812.0377352836907;812.0661239574478;812.7358608452247;812.7358608452247;655.0730716036802;784.8469548438056;803.5580430763057;803.863343231652;804.3725893802844;567.7218163100092;572.3961220911937;576.878855440358;581.764385423904;584.6725833533193;11720.765584688259;11779.882201177965;11845.348505832177;11909.642710718606;11934.16460847741;11472.942635286854;11833.112516561207;11905.743711527679;12065.819012714815;12463.252204867737;10750.086242669382;10953.780924381548;10976.890231097666;11062.336259824437;11407.201495895291;3879.631435013669;3942.7634341939574;3949.3483575210344;3971.5829837866895;4067.3898915162667;61046.69476652633;61049;61071.38928610701;61142.69428652873;61215.69392153011;9139.77150571241;9194.724158275263;9252;9603.567839447242;9630.711078667511;15820.841791581937;16214.918925405298;16328.591785205228;16590.917045414695;17110;6529.608223506605;6572.244191917895;6655.201375834931;6702.899456508157;6726.226483954408;3426.0578340956436;3446.6208717041104;3455.9654403456148;3605.747597668138;3624.347617428888;2822.435512897429;2897.2322334581354;2934.2664333916523;2934.9706502934696;2939.882404703788;505.5020804507557;511.0953612106551;511.8080719730101;512.0322590304328;517.218999311043;527.3487243254577;580.5239703443136;583.5244275915115;590.5600327755764;596.686739461786;7475.439342049368;7889.960550197212;7941;7946.602669866599;8222.054463736747;548.3995025447128;580.1732531143105;586.7037146241121;588.7909792023855;591.2284468768213;3615.7649752765988;3870.767753934773;3880.708946828999;3946.7039972002217;3971.543272523639;53465.46534534605;53715;53856.73071634617;53982;53989.1901621476;82608.58695706484;84513.15486845053;85787.57106214428;86111.13888861156;87986;62676.68661656663;70555;74328.62835685679;74756;77813;7274.8908766367485;7531.623418829146;7609;7615.923840761743;7816.765497035098;33682.494762579074;38344.61655383522;38716;44971.32543011923;45957.540424595325;59431.702841485516;59481.40518594759;59615.40384596099;60682.39317606944;60685;10457.633982810565;10783.946080269863;10835.67492975212;10982.341059536453;10986.890131098588;12062.939685301868;12125.211861228992;12244.142909996215;12385.133040687426;12622.368881555702;8020.679172833022;11054.944725276322;11416.828747568627;11527.654170374903;12031.217970831867;11271;11474.368909710047;11579.305241685526;11950.641480755592;12058.758824823279;10498.842517362093;10865.239433239598;11175.72060698489;11473.541058357907;11693.239939403911;9000.684976025808;9677.612895484102;9987.25095617817;10070.748231293983;10220;9819.55811988448;10081.596736130472;10091.646792362231;10154.847677284994;10191.796164076528 02:14:41 INFO - PROCESS | 23852 | __end_tp_report 02:14:41 INFO - PROCESS | 23852 | __start_cc_report 02:14:41 INFO - PROCESS | 23852 | _x_x_mozilla_cycle_collect,983 02:14:41 INFO - PROCESS | 23852 | __end_cc_report 02:14:41 INFO - PROCESS | 23852 | __startTimestamp1469870081746__endTimestamp 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | ------- Summary: start ------- 02:14:41 INFO - PROCESS | 23852 | Number of tests: 6 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | [#0] dojo.html Cycles:165 Average:4785.43 Median:4929.68 stddev:502.62 (10.2%) stddev-sans-first:476.04 02:14:41 INFO - PROCESS | 23852 | Values: 2672.3 2673.4 2704.9 2710.0 2719.1 4658.9 4766.9 4788.9 4880.2 4888.8 4751.7 4767.3 4789.3 4814.5 4901.7 4415.5 4427.3 4444.1 4447.4 4570.7 4535.4 4535.8 4537.2 4545.3 4552.7 4307.6 4353.9 4368.3 4461.7 4472.2 4333.5 4374.8 4405.9 4406.5 4408.6 4362.2 4364.1 4366.1 4430.5 4458.0 4744.1 4817.1 4856.9 4858.4 4861.0 4928.6 4931.5 5128.3 5183.3 5214.1 5218.8 5223.2 5264.1 5274.8 5277.8 4861.7 4878.6 4907.0 4913.4 4918.7 5067.2 5291.9 5332.0 5336.4 5421.1 5136.7 5156.2 5178.8 5188.3 5194.4 5235.1 5241.2 5290.6 5292.7 5296.8 4931.6 5040.7 5050.2 5060.0 5124.7 5061.9 5066.3 5068.0 5069.2 5127.1 4412.8 4429.3 4429.9 4431.0 4469.4 3770.2 3805.1 3812.8 3838.9 3873.0 4481.7 4495.8 4499.1 4536.8 4545.8 5152.3 5161.9 5170.2 5174.4 5220.1 4354.1 4464.5 4479.2 4511.6 4512.5 4724.4 4741.1 4742.4 4777.0 4783.5 4924.6 4939.8 4940.3 4942.1 4991.0 5043.5 5146.1 5152.5 5173.6 5194.7 4932.9 4939.9 4962.2 4970.0 4987.9 5127.8 5130.9 5135.2 5141.0 5183.8 5039.7 5151.0 5186.3 5209.4 5211.6 4967.2 5005.7 5005.9 5052.5 5053.5 5052.4 5068.0 5070.1 5074.9 5117.6 4800.7 4905.9 4989.9 4999.9 5043.0 4962.1 5056.9 5058.8 5096.7 5113.2 4916.3 4927.0 4928.7 4929.7 4948.1 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | [#1] ext.html Cycles:180 Average:48677.00 Median:34757.22 stddev:89968.32 (258.8%) stddev-sans-first:90148.15 02:14:41 INFO - PROCESS | 23852 | Values: 555.2 579.4 585.4 587.1 589.4 38716.4 40772.4 40829.2 43999.3 44049.7 40793.2 41389.4 41415.8 41427.4 41566.8 7311.8 7817.8 7960.2 7966.4 7968.4 9886.9 10203.2 10213.4 10496.4 10502.3 10282.0 10349.3 10360.6 10362.5 10364.0 10092.8 10144.8 10184.2 10188.9 10198.9 9943.9 10003.6 10009.2 10010.3 10014.8 38865.2 39101.0 39113.2 39163.6 39183.2 2996.1 3209.1 3387.3 3521.9 3542.3 29703.4 29800.9 29974.4 30139.0 31212.4 2866.2 2870.1 2878.7 2900.8 2970.4 254628.0 255327.0 256977.0 257310.0 259907.0 31584.7 54196.7 54719.0 54802.3 54845.5 31918.7 34230.6 34324.5 34328.1 34370.1 13832.9 14023.9 14026.9 14035.2 14041.6 8955.3 10943.1 11239.3 11476.7 11660.4 7915.0 7967.3 7984.2 8041.5 8046.4 3052.0 3069.3 3085.5 3095.6 3166.4 835.3 855.1 944.9 954.1 983.2 28087.6 28154.4 28445.9 28534.9 28978.4 909.3 911.4 999.4 1005.5 1007.1 14749.2 14929.9 15002.5 15092.5 15121.0 389293.0 392879.0 393468.0 393645.0 394033.0 50396.0 50837.0 50859.2 50869.2 51067.5 1088.9 1108.0 1109.4 1173.3 1201.4 22983.8 29746.4 31328.2 31368.8 32339.4 47759.8 48133.5 48472.3 48523.0 48553.0 357293.0 358385.0 358469.0 360581.0 361515.0 24772.0 25709.7 25751.2 39206.8 39774.0 41221.6 41447.0 41578.0 42359.0 42937.4 35144.3 36926.4 36994.3 37326.4 37807.2 36533.0 36728.6 36814.6 37404.3 37535.6 35331.8 35509.6 36137.0 36381.6 36666.8 31080.8 33026.8 33305.7 33442.8 33800.5 25003.4 25373.4 25397.0 25535.9 25694.7 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | [#2] jquery.html Cycles:180 Average:24538.64 Median:4383.36 stddev:67305.96 (1535.5%) stddev-sans-first:67470.26 02:14:41 INFO - PROCESS | 23852 | Values: 350.2 361.2 370.4 374.4 391.3 12703.4 13324.9 15167.3 16969.9 16995.3 15898.0 17147.6 17150.2 17225.7 17254.5 4970.5 5041.5 5053.2 5061.3 5067.9 3717.7 5674.9 5913.1 5969.9 6076.1 4943.4 6029.5 6035.2 6040.0 6040.9 5087.7 5239.8 5246.6 5248.9 5251.2 5054.6 5094.9 5105.2 5108.2 5356.1 11456.0 11530.7 11574.7 11600.9 11619.8 1771.2 1796.9 1885.3 1925.2 2130.7 8550.4 8600.4 8638.1 8794.0 9044.5 1564.1 1608.3 1652.4 1674.9 1704.7 72006.3 73112.0 74185.6 75123.6 75508.0 10123.5 10135.2 10187.2 10419.0 10444.8 14130.2 14165.6 14174.5 14176.0 14198.7 7166.4 7436.6 7522.8 7554.3 7573.5 6982.2 7022.8 7157.5 7159.1 7401.9 4236.5 4381.7 4385.0 4519.8 4533.3 1679.3 1786.3 1826.7 1854.0 1914.3 783.5 786.0 816.0 844.7 885.2 16700.8 17179.3 17303.4 17561.4 17622.3 843.3 844.3 845.0 845.7 865.1 7560.7 9471.8 9645.4 9911.9 10024.8 401913.0 402901.0 405041.0 411907.0 417898.0 52817.0 72894.3 77868.6 78337.6 80180.2 899.0 899.9 917.7 945.0 948.8 11457.7 14708.3 15534.7 15930.0 16741.2 37972.8 38990.0 39049.6 39456.4 39770.6 48943.8 49467.3 49530.5 49570.0 49815.0 6957.9 7006.3 7135.6 7531.9 7596.1 11911.3 12146.6 12260.6 12828.7 12878.2 9883.8 9888.7 10504.5 10524.8 10608.0 10136.8 10211.6 10347.7 10412.3 10696.9 10457.9 10719.2 10724.5 10758.8 10773.7 7025.5 7123.1 7144.2 7210.4 7449.5 9918.1 10040.9 10075.6 10301.6 10697.4 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | [#3] mootools.html Cycles:180 Average:5246.79 Median:5380.37 stddev:2932.74 (54.5%) stddev-sans-first:2926.30 02:14:41 INFO - PROCESS | 23852 | Values: 1342.8 1402.7 1446.0 1676.2 1711.1 7855.9 8151.3 8158.9 8174.1 8181.0 6557.3 6717.7 6722.2 6908.6 7982.6 1948.4 2157.2 2226.2 2233.4 2254.0 2204.3 2229.7 2249.8 2251.3 2251.4 2262.5 2263.5 2263.8 2266.7 2266.9 2148.8 2164.7 2192.8 2193.3 2195.3 2147.5 2152.5 2163.7 2165.7 2189.7 8075.9 8157.5 8162.1 8162.4 8169.4 4754.5 4893.2 4896.9 4905.5 4905.5 2851.9 2985.9 3005.2 3034.6 3037.9 897.5 918.7 926.0 927.9 939.1 10915.7 10994.9 11007.2 11019.1 11026.3 4253.5 4358.3 4414.8 4515.6 4524.6 9358.4 9370.9 9371.7 9372.2 9376.2 4851.8 4853.6 4855.4 4857.1 4882.9 4355.9 4411.4 4418.3 4419.2 4435.5 3703.7 3781.8 3867.9 3870.4 3871.7 1204.3 1259.2 1260.3 1264.9 1268.2 670.5 796.4 807.9 815.5 838.3 5133.9 5234.5 5286.2 5298.1 5395.1 832.4 850.5 857.3 871.4 912.3 3558.8 3692.1 3745.7 3769.0 3795.2 9353.3 9499.6 9615.7 9689.0 9932.7 9867.5 9870.1 9870.7 9870.9 9879.3 7160.5 7449.2 7554.1 7562.1 7562.8 5237.6 5365.6 5503.9 5583.9 5667.7 8971.8 9027.7 9050.3 9120.5 9133.7 8984.1 9116.4 9232.3 9327.8 9371.7 6330.9 6867.7 6978.7 7111.3 7177.8 7804.9 7853.0 7856.1 7858.1 7872.1 6661.8 6840.7 6870.6 6937.2 7077.6 6864.8 6875.2 6918.7 6952.4 6968.2 6118.2 6179.5 6238.8 6294.8 6328.5 4322.8 4518.5 4582.0 4627.1 4752.6 4482.9 4571.5 4595.2 4658.1 4668.4 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | [#4] prototype.html Cycles:180 Average:4191.26 Median:4753.00 stddev:1226.95 (25.8%) stddev-sans-first:1195.12 02:14:41 INFO - PROCESS | 23852 | Values: 299.8 301.3 308.8 310.7 311.2 4907.0 4945.6 4959.0 4970.4 4971.5 4837.3 4847.5 4894.4 4900.7 4905.6 3884.7 3898.8 3899.6 3905.7 3914.8 3779.8 3862.9 3887.7 3920.5 3922.8 3860.4 3868.7 3869.0 3874.4 3875.5 3823.8 3838.8 3846.5 3860.0 3864.9 3233.5 3246.8 3322.5 3404.8 3442.1 4709.8 4711.5 4717.9 4766.6 4775.4 4380.5 4385.6 4388.3 4398.2 4399.5 4739.4 4813.7 5036.1 5094.9 5104.8 3671.2 3676.8 3686.8 3686.9 3717.6 5263.9 5282.2 5288.4 5305.4 5379.8 3535.9 3737.1 3810.3 3813.2 3815.7 3749.9 3755.3 3769.9 3772.9 3782.1 4295.2 4309.3 4321.4 4329.9 4336.0 5112.0 5117.2 5120.6 5123.1 5131.3 1227.0 1292.7 1304.6 1305.8 1306.6 809.7 832.3 839.4 840.6 846.7 4014.4 4065.7 4068.5 4077.5 4084.0 4616.7 4628.5 4648.3 4655.0 4674.5 4052.9 4066.5 4074.2 4124.3 4127.9 2320.0 2455.7 2462.9 2467.4 2469.8 4442.3 4737.0 4801.4 4971.7 4974.6 5338.6 5342.4 5346.3 5358.7 5361.3 4962.7 4969.0 4990.3 4997.9 5012.4 4986.6 5183.4 5216.8 5221.1 5221.8 5142.8 5150.3 5154.9 5156.4 5168.4 4845.2 4982.5 4984.1 5005.0 5020.4 3679.5 3680.2 3692.2 3701.8 3709.9 5188.0 5193.5 5211.9 5228.6 5245.2 5033.2 5040.2 5044.7 5047.7 5057.8 4825.7 5031.3 5125.4 5125.7 5129.6 5028.5 5056.9 5058.7 5059.3 5074.3 4962.4 5148.0 5155.4 5155.9 5163.9 4953.6 4966.2 4974.5 4983.0 4988.6 02:14:41 INFO - PROCESS | 23852 | 02:14:41 INFO - PROCESS | 23852 | [#5] yui.html Cycles:180 Average:16016.01 Median:26996.41 stddev:21967.77 (81.4%) stddev-sans-first:21998.82 02:14:41 INFO - PROCESS | 23852 | Values: 580.1 594.2 601.0 634.7 672.1 11500.3 11802.8 12130.9 12492.8 12501.3 11874.6 12486.9 12505.7 12506.2 12515.4 625.6 731.5 774.2 788.6 788.8 758.5 775.3 778.8 778.9 784.3 809.9 812.0 812.1 812.7 812.7 655.1 784.8 803.6 803.9 804.4 567.7 572.4 576.9 581.8 584.7 11720.8 11779.9 11845.3 11909.6 11934.2 11472.9 11833.1 11905.7 12065.8 12463.3 10750.1 10953.8 10976.9 11062.3 11407.2 3879.6 3942.8 3949.3 3971.6 4067.4 61046.7 61049.0 61071.4 61142.7 61215.7 9139.8 9194.7 9252.0 9603.6 9630.7 15820.8 16214.9 16328.6 16590.9 17110.0 6529.6 6572.2 6655.2 6702.9 6726.2 3426.1 3446.6 3456.0 3605.7 3624.3 2822.4 2897.2 2934.3 2935.0 2939.9 505.5 511.1 511.8 512.0 517.2 527.3 580.5 583.5 590.6 596.7 7475.4 7890.0 7941.0 7946.6 8222.1 548.4 580.2 586.7 588.8 591.2 3615.8 3870.8 3880.7 3946.7 3971.5 53465.5 53715.0 53856.7 53982.0 53989.2 82608.6 84513.2 85787.6 86111.1 87986.0 62676.7 70555.0 74328.6 74756.0 77813.0 7274.9 7531.6 7609.0 7615.9 7816.8 33682.5 38344.6 38716.0 44971.3 45957.5 59431.7 59481.4 59615.4 60682.4 60685.0 10457.6 10783.9 10835.7 10982.3 10986.9 12062.9 12125.2 12244.1 12385.1 12622.4 8020.7 11054.9 11416.8 11527.7 12031.2 11271.0 11474.4 11579.3 11950.6 12058.8 10498.8 10865.2 11175.7 11473.5 11693.2 9000.7 9677.6 9987.3 10070.7 10220.0 9819.6 10081.6 10091.6 10154.8 10191.8 02:14:41 INFO - PROCESS | 23852 | -------- Summary: end -------- 02:14:41 INFO - PROCESS | 23852 | 02:14:42 INFO - TEST-INFO | 23852: exit 0 02:14:42 INFO - TEST-OK | dromaeo_css | took 1119495ms 02:14:42 INFO - TEST-START | kraken 02:14:42 INFO - operating with platform_type : linux_ 02:14:42 INFO - Initialising browser for kraken test... 02:14:42 INFO - TEST-INFO | started process 24041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjB9U3T/profile http://localhost:38396/getInfo.html) 02:14:46 INFO - PROCESS | 24041 | __metrics Screen width/height:1600/1200 02:14:46 INFO - PROCESS | 24041 | colorDepth:24 02:14:46 INFO - PROCESS | 24041 | Browser inner width/height: 1024/697 02:14:46 INFO - PROCESS | 24041 | __metrics 02:14:47 INFO - PROCESS | 24041 | 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" 02:14:47 INFO - PROCESS | 24041 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:48 INFO - TEST-INFO | 24041: exit 0 02:14:48 INFO - Browser initialized. 02:14:48 INFO - Running cycle 1/1 for kraken test... 02:14:48 INFO - TEST-INFO | started process 24122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjB9U3T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:00 INFO - PROCESS | 24122 | RSS: Main: 157302784 02:15:00 INFO - PROCESS | 24122 | 02:15:03 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38396/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:04 INFO - PROCESS | 24122 | RSS: Main: 214106112 02:15:04 INFO - PROCESS | 24122 | 02:15:07 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38396/tests/kraken/driver.html?testName=audio-dft) 02:15:07 INFO - PROCESS | 24122 | RSS: Main: 191537152 02:15:07 INFO - PROCESS | 24122 | 02:15:10 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38396/tests/kraken/driver.html?testName=audio-fft) 02:15:11 INFO - PROCESS | 24122 | RSS: Main: 271261696 02:15:11 INFO - PROCESS | 24122 | 02:15:13 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38396/tests/kraken/driver.html?testName=audio-oscillator) 02:15:14 INFO - PROCESS | 24122 | RSS: Main: 180178944 02:15:14 INFO - PROCESS | 24122 | 02:15:16 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:17 INFO - PROCESS | 24122 | RSS: Main: 185212928 02:15:17 INFO - PROCESS | 24122 | 02:15:20 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38396/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:20 INFO - PROCESS | 24122 | RSS: Main: 221171712 02:15:20 INFO - PROCESS | 24122 | 02:15:24 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38396/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:25 INFO - PROCESS | 24122 | RSS: Main: 215556096 02:15:25 INFO - PROCESS | 24122 | 02:15:27 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38396/tests/kraken/driver.html?testName=json-parse-financial) 02:15:28 INFO - PROCESS | 24122 | RSS: Main: 218177536 02:15:28 INFO - PROCESS | 24122 | 02:15:30 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:30 INFO - PROCESS | 24122 | RSS: Main: 184246272 02:15:30 INFO - PROCESS | 24122 | 02:15:32 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:33 INFO - PROCESS | 24122 | RSS: Main: 190214144 02:15:33 INFO - PROCESS | 24122 | 02:15:35 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:36 INFO - PROCESS | 24122 | RSS: Main: 193392640 02:15:36 INFO - PROCESS | 24122 | 02:15:38 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:39 INFO - PROCESS | 24122 | RSS: Main: 188194816 02:15:39 INFO - PROCESS | 24122 | 02:15:42 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:43 INFO - PROCESS | 24122 | RSS: Main: 192118784 02:15:43 INFO - PROCESS | 24122 | 02:15:44 INFO - PROCESS | 24122 | Cycle 1(1): loaded http://localhost:38396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38396/tests/kraken/driver.html?testName=ai-astar) 02:15:45 INFO - PROCESS | 24122 | RSS: Main: 242061312 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | __start_tp_report 02:15:45 INFO - PROCESS | 24122 | _x_x_mozilla_page_load 02:15:45 INFO - PROCESS | 24122 | _x_x_mozilla_page_load_details 02:15:45 INFO - PROCESS | 24122 | |i|pagename|runs| 02:15:45 INFO - PROCESS | 24122 | |0;ai-astar;105;114;115;114;113;114;113;115;112;115 02:15:45 INFO - PROCESS | 24122 | |1;audio-beat-detection;153;123;124;194;122;124;146;124;184;123 02:15:45 INFO - PROCESS | 24122 | |2;audio-dft;163;161;161;160;161;162;163;161;162;161 02:15:45 INFO - PROCESS | 24122 | |3;audio-fft;74;77;77;119;75;78;74;75;99;74 02:15:45 INFO - PROCESS | 24122 | |4;audio-oscillator;85;86;120;84;85;87;117;85;87;121 02:15:45 INFO - PROCESS | 24122 | |5;imaging-gaussian-blur;117;117;119;117;117;117;119;116;116;117 02:15:45 INFO - PROCESS | 24122 | |6;imaging-darkroom;147;148;148;146;146;146;147;146;146;146 02:15:45 INFO - PROCESS | 24122 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 02:15:45 INFO - PROCESS | 24122 | |8;json-parse-financial;63;62;62;60;61;63;62;62;62;61 02:15:45 INFO - PROCESS | 24122 | |9;json-stringify-tinderbox;67;67;66;67;66;66;66;67;66;65 02:15:45 INFO - PROCESS | 24122 | |10;stanford-crypto-aes;79;78;78;78;81;84;78;87;85;83 02:15:45 INFO - PROCESS | 24122 | |11;stanford-crypto-ccm;136;131;131;129;128;126;126;130;177;128 02:15:45 INFO - PROCESS | 24122 | |12;stanford-crypto-pbkdf2;165;169;167;164;170;164;166;165;163;164 02:15:45 INFO - PROCESS | 24122 | |13;stanford-crypto-sha256-iterative;70;71;73;69;69;67;67;66;72;66 02:15:45 INFO - PROCESS | 24122 | __end_tp_report 02:15:45 INFO - PROCESS | 24122 | __start_cc_report 02:15:45 INFO - PROCESS | 24122 | _x_x_mozilla_cycle_collect,1947 02:15:45 INFO - PROCESS | 24122 | __end_cc_report 02:15:45 INFO - PROCESS | 24122 | __startTimestamp1469870145062__endTimestamp 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | ------- Summary: start ------- 02:15:45 INFO - PROCESS | 24122 | Number of tests: 14 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:1.05 02:15:45 INFO - PROCESS | 24122 | Values: 105.0 114.0 115.0 114.0 113.0 114.0 113.0 115.0 112.0 115.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:135.00 stddev:27.28 (20.2%) stddev-sans-first:28.63 02:15:45 INFO - PROCESS | 24122 | Values: 153.0 123.0 124.0 194.0 122.0 124.0 146.0 124.0 184.0 123.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 02:15:45 INFO - PROCESS | 24122 | Values: 163.0 161.0 161.0 160.0 161.0 162.0 163.0 161.0 162.0 161.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:14.96 (19.7%) stddev-sans-first:15.57 02:15:45 INFO - PROCESS | 24122 | Values: 74.0 77.0 77.0 119.0 75.0 78.0 74.0 75.0 99.0 74.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:16.36 (19.3%) stddev-sans-first:16.89 02:15:45 INFO - PROCESS | 24122 | Values: 85.0 86.0 120.0 84.0 85.0 87.0 117.0 85.0 87.0 121.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 02:15:45 INFO - PROCESS | 24122 | Values: 117.0 117.0 119.0 117.0 117.0 117.0 119.0 116.0 116.0 117.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 02:15:45 INFO - PROCESS | 24122 | Values: 147.0 148.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:15:45 INFO - PROCESS | 24122 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 02:15:45 INFO - PROCESS | 24122 | Values: 63.0 62.0 62.0 60.0 61.0 63.0 62.0 62.0 62.0 61.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 02:15:45 INFO - PROCESS | 24122 | Values: 67.0 67.0 66.0 67.0 66.0 66.0 66.0 67.0 66.0 65.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:82.00 stddev:3.41 (4.2%) stddev-sans-first:3.54 02:15:45 INFO - PROCESS | 24122 | Values: 79.0 78.0 78.0 78.0 81.0 84.0 78.0 87.0 85.0 83.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:130.50 stddev:15.32 (11.7%) stddev-sans-first:16.23 02:15:45 INFO - PROCESS | 24122 | Values: 136.0 131.0 131.0 129.0 128.0 126.0 126.0 130.0 177.0 128.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:2.31 (1.4%) stddev-sans-first:2.44 02:15:45 INFO - PROCESS | 24122 | Values: 165.0 169.0 167.0 164.0 170.0 164.0 166.0 165.0 163.0 164.0 02:15:45 INFO - PROCESS | 24122 | 02:15:45 INFO - PROCESS | 24122 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:2.49 (3.6%) stddev-sans-first:2.62 02:15:45 INFO - PROCESS | 24122 | Values: 70.0 71.0 73.0 69.0 69.0 67.0 67.0 66.0 72.0 66.0 02:15:45 INFO - PROCESS | 24122 | -------- Summary: end -------- 02:15:45 INFO - PROCESS | 24122 | 02:15:46 INFO - TEST-INFO | 24122: exit 0 02:15:46 INFO - TEST-OK | kraken | took 63528ms 02:15:46 INFO - SUITE-END | took 1183s 02:15:46 INFO - Completed test suite (00:19:43) 02:15:46 INFO - javascript benchmark 02:15:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.3052006478315, 2673.438577898641, 2704.932376690583, 2710.0243912191618, 2719.116287206657, 4658.930116048262, 4766.880827979302, 4788.880277993052, 4880.243562247852, 4888.755562221888, 4751.738654374008, 4767.308740232665, 4789.257665061912, 4814.518548145184, 4901.681390709601, 4415.514293427728, 4427.2695005324085, 4444.088961762831, 4447.3773671685985, 4570.657200709943, 4535.365048893141, 4535.818567257323, 4537.228671125917, 4545.272756358983, 4552.726836389811, 4307.590778876001, 4353.869383918487, 4368.257396242615, 4461.687681862271, 4472.239719247703, 4333.501647310568, 4374.77506298237, 4405.933910991338, 4406.493253275882, 4408.58118478744, 4362.214801335758, 4364.10535840152, 4366.148601022802, 4430.468343798732, 4457.977710111429, 4744.098621261949, 4817.084753896748, 4856.927146092811, 4858.416989961192, 4860.951390486085, 4928.6303527235605, 4931.482194369575, 5128.25640282157, 5183.300254465675, 5214.113600687854, 5218.791248350061, 5223.190405487156, 5264.078786212397, 5274.789008439658, 5277.815276465343, 4861.683990540603, 4878.609711223129, 4907.0, 4913.434954980223, 4918.729469879191, 5067.163917953497, 5291.867703307371, 5332.0, 5336.439673834269, 5421.105517589633, 5136.666116702402, 5156.20078887773, 5178.792848286102, 5188.273641690166, 5194.4026436959475, 5235.110031294613, 5241.24002019705, 5290.603204759582, 5292.735363231823, 5296.788128474818, 4931.630127740434, 5040.747962601855, 5050.242463630485, 5060.038592667382, 5124.692518448905, 5061.949380506221, 5066.290719299301, 5068.0370729562, 5069.239614057921, 5127.07712611726, 4412.757298348622, 4429.313456414261, 4429.911401771947, 4431.0, 4469.374287599739, 3770.2271034437877, 3805.06775839921, 3812.8093595320124, 3838.9040273992814, 3873.0, 4481.686281960297, 4495.77521123949, 4499.0776890737325, 4536.79584418702, 4545.818167273338, 5152.278680984665, 5161.870953226199, 5170.1986192140275, 5174.353205849269, 5220.086484865134, 4354.107407981356, 4464.464264288306, 4479.17135329965, 4511.571400716926, 4512.503624601291, 4724.362211101457, 4741.051789642085, 4742.359781429463, 4776.95223047772, 4783.545563171493, 4924.60603151747, 4939.777710003131, 4940.333055037524, 4942.110420124268, 4991.0, 5043.52086551777, 5146.125158722951, 5152.4847515248175, 5173.611979101507, 5194.68831870089, 4932.926006109839, 4939.901201975868, 4962.181240095344, 4969.975150124226, 4987.850364489072, 5127.769250383667, 5130.897382052263, 5135.178371460698, 5141.0489059522615, 5183.844484665466, 5039.722815245197, 5150.97424512875, 5186.273921651047, 5209.4009188943755, 5211.55701765339, 4967.205247160437, 5005.67463114911, 5005.8748531285555, 5052.469490703424, 5053.469385714594, 5052.418971818141, 5068.0, 5070.112730272114, 5074.873128171826, 5117.641765076558, 4800.66395352322, 4905.877353066059, 4989.900201996013, 4999.8750031248055, 5043.041822053798, 4962.057209130254, 5056.898862022813, 5058.797648094035, 5096.668716533413, 5113.233015047773, 4916.287138364989, 4926.950730492649, 4928.728919909439, 4929.679570827885, 4948.134076536664], "value": 4753.2003131617685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.2088274209252, 579.4495229531946, 585.3970410477207, 587.1339773833596, 589.440031969629, 38716.41925371118, 40772.38841417377, 40829.18341633165, 43999.340009899795, 44049.714034315846, 40793.18413631726, 41389.37915931264, 41415.79292103543, 41427.37858932118, 41566.7921660392, 7311.817204569875, 7817.804554886145, 7960.24377684122, 7966.4025198110085, 7968.442209045369, 9886.851697224547, 10203.183745300395, 10213.438260895648, 10496.370217786918, 10502.264841461101, 10282.0, 10349.327293725884, 10360.585576576928, 10362.533685984112, 10364.0, 10092.798144037151, 10144.847827282596, 10184.185265178769, 10188.898111018869, 10198.949005255, 9943.900560994442, 10003.64987225451, 10009.249306301983, 10010.349327293703, 10014.799704005953, 38865.222695545934, 39101.0, 39113.21773564541, 39163.60836391628, 39183.21633567341, 2996.101169649118, 3209.1335339458215, 3387.3225354929114, 3521.9295614087573, 3542.2738338640515, 29703.40593188124, 29800.850995744884, 29974.40051198964, 30139.0, 31212.375752484822, 2866.240446281737, 2870.1389583125188, 2878.7121287871255, 2900.767938564931, 2970.4059188162237, 254628.0, 255327.0, 256977.0, 257310.0, 259907.0, 31584.684153158174, 54196.72901635546, 54719.0, 54802.25988700549, 54845.45154548483, 31918.68081319157, 34230.55002849663, 34324.48513272303, 34328.14179645529, 34370.14074648104, 13832.93083534596, 14023.929880350533, 14026.929865350608, 14035.228062456663, 14041.578752637437, 8955.328350373618, 10943.124550035978, 11239.325640461599, 11476.713082172846, 11660.416979151008, 7914.960425197953, 7967.322777563856, 7984.20157984197, 8041.517508949481, 8046.356291496666, 3051.9542206866913, 3069.309405383771, 3085.537169424604, 3095.628524577065, 3166.4458719723957, 835.3442547600105, 855.1363123245443, 944.8960614332418, 954.0554850697898, 983.188869182927, 28087.57868631972, 28154.43691126166, 28445.857770711013, 28534.857325713238, 28978.42043159125, 909.3043821476575, 911.4349103555838, 999.4453078541479, 1005.516862627633, 1007.1439276614965, 14749.23918153248, 14929.925350373396, 15002.549923502313, 15092.471763488225, 15121.0, 389293.0, 392879.0, 393468.0, 393645.0, 394033.0, 50396.0, 50837.0, 50859.237111443355, 50869.23696144487, 51067.48932510702, 1088.9346639201674, 1107.972300692473, 1109.3510296476652, 1173.3370645585217, 1201.405304374323, 22983.77016229883, 29746.405071898007, 31328.21679458032, 31368.843155784074, 32339.35321293608, 47759.761201193774, 48133.5186648129, 48472.27291590558, 48523.0, 48553.0, 357293.0, 358385.0, 358469.0, 360581.0, 361515.0, 24772.0, 25709.742902570735, 25751.227463176136, 39206.803965981126, 39774.0, 41221.58778412177, 41447.0, 41578.0, 42359.0, 42937.35593966155, 35144.297114057066, 36926.44610330901, 36994.26011479701, 37326.44010339793, 37807.24385512329, 36533.0, 36728.63271367252, 36814.63185368112, 37404.25191496209, 37535.62464375321, 35331.82334088313, 35509.64490355063, 36137.0, 36381.63618363783, 36666.8166659165, 31080.844595776878, 33026.83486582552, 33305.66694333123, 33442.83278583689, 33800.49299260464, 25003.374915627253, 25373.350732203085, 25397.0, 25535.87232063828, 25694.743052569982], "value": 17293.522101334467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.19455252918283, 361.1999421281862, 370.39810308249093, 374.3598446656218, 391.3093390166357, 12703.364831758421, 13324.866751332484, 15167.317470713831, 16969.91515042426, 16995.320187192527, 15898.0, 17147.57131071721, 17150.22823972921, 17225.74161387577, 17254.482365529024, 4970.453250142481, 5041.495850414965, 5053.191489361703, 5061.316722242487, 5067.923981140286, 3717.721170912179, 5674.943250567483, 5913.113033045056, 5969.910451343233, 6076.149339092531, 4943.357363542735, 6029.547783916202, 6035.185249991239, 6040.033594624861, 6040.939590604104, 5087.694738315695, 5239.764210610531, 5246.580273578104, 5248.921266181011, 5251.238570407269, 5054.646174767768, 5094.898102037939, 5105.15764898795, 5108.208227724708, 5356.0894647909945, 11456.0, 11530.711732206762, 11574.710632234177, 11600.883991160064, 11619.76760464786, 1771.1852547828014, 1796.9011704356255, 1885.3032270956248, 1925.2491528303972, 2130.7336582927132, 8550.358723095793, 8600.440971336842, 8638.09300023501, 8793.956030219872, 9044.502552359683, 1564.1475395909256, 1608.28431348049, 1652.4051341517045, 1674.907880066596, 1704.676111538816, 72006.27993720048, 73112.0, 74185.62907185484, 75123.62438187774, 75508.0, 10123.493825308706, 10135.189184865194, 10187.185025197967, 10418.968301181349, 10444.843327350096, 14130.15219086858, 14165.575032749033, 14174.503892363924, 14176.0, 14198.716025679636, 7166.390856777232, 7436.553806771611, 7522.849543009109, 7554.320111190019, 7573.545587264672, 6982.197047339621, 7022.789316320519, 7157.534760240567, 7159.140903091662, 7401.925980740231, 4236.533981262059, 4381.737095774264, 4384.978075109604, 4519.751413672279, 4533.320001999727, 1679.2863033210836, 1786.2854858056621, 1826.6803309420798, 1853.9536511587048, 1914.3108480946848, 783.4868161354322, 785.9882101768478, 815.979600509992, 844.6916875340579, 885.2165833237631, 16700.83299167017, 17179.31282748701, 17303.3943811966, 17561.385351512636, 17622.295108195784, 843.3169133002287, 844.2823599940002, 845.0, 845.7420486751477, 865.1262225152641, 7560.735374261874, 9471.810563788824, 9645.37305075168, 9911.851322230172, 10024.849627255597, 401913.0, 402901.0, 405041.0, 411907.0, 417898.0, 52817.0, 72894.2710572898, 77868.61065694748, 78337.60831195922, 80180.19819801844, 898.9775255618662, 899.8560230363241, 917.7155081924625, 945.0313428735601, 948.772294649293, 11457.713557161138, 14708.264586770405, 15534.689306213586, 15930.0, 16741.24664390081, 37972.81013594914, 38990.02524936899, 39049.60950390573, 39456.40815387829, 39770.60229397785, 48943.75528122336, 49467.25799113088, 49530.504694952586, 49570.0, 49815.0, 6957.930420695729, 7006.334398232159, 7135.571865688075, 7531.924680753123, 7596.050493688289, 11911.307494676677, 12146.635600931986, 12260.632181034583, 12828.743425131632, 12878.227306361649, 9883.752906177404, 9888.653897113567, 10504.527296271533, 10524.789504210026, 10608.0, 10136.847947280648, 10211.642592509226, 10347.689569312932, 10412.32319899204, 10696.89303106959, 10457.895421045692, 10719.196060295353, 10724.463776810971, 10758.838617420588, 10773.676789696321, 7025.508214424941, 7123.074000379917, 7144.214136444883, 7210.351068403869, 7449.478536502393, 9918.107370336704, 10040.899591003996, 10075.596976120873, 10301.639442619473, 10697.411642359744], "value": 8039.712948287827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.8388593368795, 1402.7264683386738, 1445.9855401445989, 1676.2373120230297, 1711.093120646058, 7855.882161767571, 8151.307138893201, 8158.918410815898, 8174.141715119916, 8180.977377827771, 6557.311482294362, 6717.7312907483765, 6722.159730033746, 6908.550944188624, 7982.560959147245, 1948.4154753573907, 2157.1587081038406, 2226.1540614566443, 2233.4304752288144, 2253.954920901581, 2204.2946257197705, 2229.721284839395, 2249.80876625487, 2251.2908433843368, 2251.4371407148215, 2262.502249505106, 2263.5020295534955, 2263.7736226377397, 2266.705328307326, 2266.8866556672183, 2148.7743786902306, 2164.718586583742, 2192.8245740340894, 2193.3419974007734, 2195.2536137713255, 2147.538279269949, 2152.5264441822774, 2163.729533808274, 2165.6751487277033, 2189.704389907358, 8075.919240807575, 8157.510549366998, 8162.14297498766, 8162.428629995903, 8169.387295952827, 4754.5245475452175, 4893.192623217201, 4896.926546101811, 4905.509449055102, 4905.533974272438, 2851.9144425667264, 2985.9402811943855, 3005.1885990782584, 3034.5903303054024, 3037.878484860603, 897.4660077254024, 918.7060140754961, 925.9722208333761, 927.9304052196112, 939.1125386509751, 10915.672529824118, 10994.945025274823, 11007.174461915309, 11019.118470522339, 11026.283291586022, 4253.5108462527205, 4358.280883654225, 4414.779261037, 4515.593596576324, 4524.5927866492175, 9358.438493690264, 9370.90629093714, 9371.718848434557, 9372.20336271411, 9376.249900008119, 4851.80592776285, 4853.635977301717, 4855.44162421319, 4857.077155340545, 4882.926756098661, 4355.891102722394, 4411.360352748833, 4418.315161150027, 4419.18245124653, 4435.534268901783, 3703.666669999713, 3781.829817658157, 3867.8646247381207, 3870.3807390817333, 3871.670907972854, 1204.2774335398865, 1259.238160912653, 1260.2564486952742, 1264.9241045537296, 1268.1656497727572, 670.5306285600002, 796.3668883237724, 807.9052883343103, 815.502543448496, 838.3209600223838, 5133.948660513422, 5234.527251178995, 5286.15421532553, 5298.099323115002, 5395.109806881899, 832.388194676912, 850.4727069217125, 857.34413173922, 871.4205053639386, 912.2610685344891, 3558.839852206657, 3692.132348898007, 3745.700343972476, 3769.0388950817364, 3795.221979494197, 9353.345265831327, 9499.620015199453, 9615.711528654152, 9688.951555242178, 9932.702018939442, 9867.506624668882, 9870.062344077302, 9870.703878883645, 9870.901290986998, 9879.308448408687, 7160.534565253241, 7449.180590135081, 7554.093508778982, 7562.054743157106, 7562.810929726801, 5237.580993520433, 5365.624406291522, 5503.889922201613, 5583.944160558342, 5667.744951477111, 8971.820563588823, 9027.684031058881, 9050.27597792162, 9120.498372589305, 9133.680321188727, 8984.101589840964, 9116.4074335168, 9232.307576931622, 9327.813443731224, 9371.671991480265, 6330.936690633035, 6867.725290988305, 6978.651067446709, 7111.2533184017, 7177.820554486179, 7804.8829267559895, 7853.0, 7856.135825059125, 7858.135605083322, 7872.094709108525, 6661.800145995628, 6840.726370945106, 6870.62211578368, 6937.202221744564, 7077.610731409822, 6864.759733409307, 6875.243723190545, 6918.7232510699005, 6952.443804495527, 6968.198657154492, 6118.235220597426, 6179.536534759821, 6238.781642642486, 6294.8426289341305, 6328.525360598066, 4322.805473753626, 4518.548145185455, 4582.0, 4627.0514544518965, 4752.596029337545, 4482.8655140345845, 4571.542845715402, 4595.241785105554, 4658.068386322817, 4668.393108895958], "value": 4220.496227482489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.76468472249286, 301.34307210281577, 308.7823084725269, 310.74829388195576, 311.20331950207475, 4906.975465122674, 4945.604351651864, 4958.950410495899, 4970.403551573807, 4971.45314015458, 4837.346958160647, 4847.515248475151, 4894.388201474816, 4900.730459824708, 4905.607551395889, 3884.7280690351686, 3898.7660740355527, 3899.610038996099, 3905.6875449963936, 3914.843406263746, 3779.7732136071786, 3862.86479973201, 3887.688984881203, 3920.4707364505853, 3922.8234729437245, 3860.36304009838, 3868.729188956774, 3868.9613103869024, 3874.3607304794673, 3875.534935807693, 3823.7896915669626, 3838.827252773604, 3846.4614953906475, 3859.9807000964956, 3864.903377415559, 3233.5149727541057, 3246.788958717676, 3322.4517954537473, 3404.8127352995575, 3442.1050526862946, 4709.835155769531, 4711.528847115261, 4717.858464246078, 4766.571008609242, 4775.426948766136, 4380.452443444569, 4385.627221686161, 4388.319810429357, 4398.208322501949, 4399.5160532341415, 4739.431268247798, 4813.687110337817, 5036.143855544567, 5094.923576146361, 5104.795808167706, 3671.2473942841652, 3676.761010534307, 3686.7603605765808, 3686.944695829565, 3717.6096509866343, 5263.921041184385, 5282.154855223184, 5288.418273989896, 5305.442928492491, 5379.81170659029, 3535.911602209914, 3737.0844143185095, 3810.2760475509563, 3813.199228162117, 3815.6565909067763, 3749.9062523436587, 3755.2677227940835, 3769.8869033929027, 3772.9434058489146, 3782.0544863784053, 4295.205387003414, 4309.267424537836, 4321.438213032286, 4329.870103896888, 4336.02439451121, 5111.974440127776, 5117.181250999822, 5120.61595380348, 5123.103456895028, 5131.307273518028, 1226.9509219631116, 1292.7349893271858, 1304.5825335892423, 1305.764962306794, 1306.5688322853437, 809.7287408718146, 832.3341326938425, 839.3872473094675, 840.6217202258886, 846.699421705298, 4014.3577027675433, 4065.7153999220363, 4068.4507591475362, 4077.4903137107863, 4083.959160408417, 4616.699914505613, 4628.490866004737, 4648.3259927310355, 4655.0, 4674.532546745366, 4052.9392059119136, 4066.4916885389325, 4074.1851629674184, 4124.298869192245, 4127.876163715094, 2320.0, 2455.717592476888, 2462.876856157185, 2467.3708204407762, 2469.7777200051723, 4442.333649952533, 4736.976315118402, 4801.375821143229, 4971.651984361132, 4974.552290293891, 5338.599605029561, 5342.385625653022, 5346.304980352607, 5358.651687640291, 5361.329833770778, 4962.652614317035, 4968.962725282761, 4990.326305948723, 4997.850494386239, 5012.398512178562, 4986.626003049858, 5183.352080989876, 5216.765605324723, 5221.138512145453, 5221.791128354823, 5142.820001299937, 5150.253213284128, 5154.871128221825, 5156.40701319338, 5168.397796683041, 4845.224764037878, 4982.526659967298, 4984.053029924303, 5004.974975125101, 5020.3724534433195, 3679.5032670589126, 3680.153564680192, 3692.1877187018813, 3701.759385639925, 3709.870154544578, 5188.0, 5193.454687257784, 5211.8891848801295, 5228.607854410859, 5245.213218017328, 5033.194688849767, 5040.202687508468, 5044.747762611782, 5047.697138171721, 5057.848264552069, 4825.662203645711, 5031.345925029723, 5125.410577783454, 5125.718085505333, 5129.589362925225, 5028.497150284942, 5056.873578160576, 5058.721770302669, 5059.291699162194, 5074.2642316864585, 4962.404511458503, 5148.0, 5155.355580552431, 5155.948440515547, 5163.922541161811, 4953.628477864103, 4966.205407134841, 4974.517837513683, 4983.0, 4988.628127265031], "value": 3800.744303505735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1240127407616, 594.2423410152055, 601.0, 634.7112064010876, 672.1295921781294, 11500.309981401122, 11802.822957655642, 12130.939345303283, 12492.81260781089, 12501.312427816467, 11874.584389546368, 12486.875131248686, 12505.749885002295, 12506.187097838656, 12515.374231288444, 625.583986648878, 731.5427857589007, 774.248978490863, 788.6135793461192, 788.8067423481256, 758.5221310574331, 775.255754475704, 778.7663700889739, 778.9376849851998, 784.2549577900988, 809.8906647602587, 812.0377352836907, 812.0661239574478, 812.7358608452247, 812.7358608452247, 655.0730716036802, 784.8469548438056, 803.5580430763057, 803.863343231652, 804.3725893802844, 567.7218163100092, 572.3961220911937, 576.878855440358, 581.764385423904, 584.6725833533193, 11720.765584688259, 11779.882201177965, 11845.348505832177, 11909.642710718606, 11934.16460847741, 11472.942635286854, 11833.112516561207, 11905.743711527679, 12065.819012714815, 12463.252204867737, 10750.086242669382, 10953.780924381548, 10976.890231097666, 11062.336259824437, 11407.201495895291, 3879.631435013669, 3942.7634341939574, 3949.3483575210344, 3971.5829837866895, 4067.3898915162667, 61046.69476652633, 61049.0, 61071.38928610701, 61142.69428652873, 61215.69392153011, 9139.77150571241, 9194.724158275263, 9252.0, 9603.567839447242, 9630.711078667511, 15820.841791581937, 16214.918925405298, 16328.591785205228, 16590.917045414695, 17110.0, 6529.608223506605, 6572.244191917895, 6655.201375834931, 6702.899456508157, 6726.226483954408, 3426.0578340956436, 3446.6208717041104, 3455.9654403456148, 3605.747597668138, 3624.347617428888, 2822.435512897429, 2897.2322334581354, 2934.2664333916523, 2934.9706502934696, 2939.882404703788, 505.5020804507557, 511.0953612106551, 511.8080719730101, 512.0322590304328, 517.218999311043, 527.3487243254577, 580.5239703443136, 583.5244275915115, 590.5600327755764, 596.686739461786, 7475.439342049368, 7889.960550197212, 7941.0, 7946.602669866599, 8222.054463736747, 548.3995025447128, 580.1732531143105, 586.7037146241121, 588.7909792023855, 591.2284468768213, 3615.7649752765988, 3870.767753934773, 3880.708946828999, 3946.7039972002217, 3971.543272523639, 53465.46534534605, 53715.0, 53856.73071634617, 53982.0, 53989.1901621476, 82608.58695706484, 84513.15486845053, 85787.57106214428, 86111.13888861156, 87986.0, 62676.68661656663, 70555.0, 74328.62835685679, 74756.0, 77813.0, 7274.8908766367485, 7531.623418829146, 7609.0, 7615.923840761743, 7816.765497035098, 33682.494762579074, 38344.61655383522, 38716.0, 44971.32543011923, 45957.540424595325, 59431.702841485516, 59481.40518594759, 59615.40384596099, 60682.39317606944, 60685.0, 10457.633982810565, 10783.946080269863, 10835.67492975212, 10982.341059536453, 10986.890131098588, 12062.939685301868, 12125.211861228992, 12244.142909996215, 12385.133040687426, 12622.368881555702, 8020.679172833022, 11054.944725276322, 11416.828747568627, 11527.654170374903, 12031.217970831867, 11271.0, 11474.368909710047, 11579.305241685526, 11950.641480755592, 12058.758824823279, 10498.842517362093, 10865.239433239598, 11175.72060698489, 11473.541058357907, 11693.239939403911, 9000.684976025808, 9677.612895484102, 9987.25095617817, 10070.748231293983, 10220.0, 9819.55811988448, 10081.596736130472, 10091.646792362231, 10154.847677284994, 10191.796164076528], "value": 6246.799435990203, "unit": "score"}], "name": "dromaeo_css", "value": 6360.743648035437, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 115.0, 112.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 124.0, 194.0, 122.0, 124.0, 146.0, 124.0, 184.0, 123.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 161.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 119.0, 75.0, 78.0, 74.0, 75.0, 99.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 120.0, 84.0, 85.0, 87.0, 117.0, 85.0, 87.0, 121.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 119.0, 116.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 60.0, 61.0, 63.0, 62.0, 62.0, 62.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 81.0, 84.0, 78.0, 87.0, 85.0, 83.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 131.0, 129.0, 128.0, 126.0, 126.0, 130.0, 177.0, 128.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 167.0, 164.0, 170.0, 164.0, 166.0, 165.0, 163.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 73.0, 69.0, 69.0, 67.0, 67.0, 66.0, 72.0, 66.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1531.1000000000001, "alertThreshold": 2.0}]} 02:15:46 INFO - Return code: 0 02:15:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:15:46 INFO - # TBPL SUCCESS # 02:15:46 INFO - Running post-action listener: _resource_record_post_action 02:15:46 INFO - [mozharness: 2016-07-30 09:15:46.368997Z] Finished run-tests step (success) 02:15:46 INFO - Running post-run listener: _resource_record_post_run 02:15:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521936896; Read time: 8; Write time: 527876 02:15:46 INFO - TinderboxPrint: CPU usage
13.0% 02:15:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:15:46 INFO - TinderboxPrint: I/O write bytes / time
521,936,896 / 527,876 02:15:46 INFO - TinderboxPrint: CPU idle
8,322.9 (87.0%) 02:15:46 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 02:15:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:15:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236810240; Read time: 0; Write time: 261416 02:15:46 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284352512; Read time: 0; Write time: 266420 02:15:47 INFO - Running post-run listener: _upload_blobber_files 02:15:47 INFO - Blob upload gear active. 02:15:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:15:47 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 02:15:47 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'] 02:15:47 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 02:15:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:15:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:15:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:15:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:48 INFO - (blobuploader) - INFO - Done attempting. 02:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:15:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:48 INFO - (blobuploader) - INFO - Done attempting. 02:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:15:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:53 INFO - (blobuploader) - INFO - Done attempting. 02:15:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:15:53 INFO - Return code: 0 02:15:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:15:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:15:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ffb9ec736730e8ba98b534a5d9b7cf8e43b9fd3cb4843688b86239448e1c99d9ed55f32bc68cc8e088bc02d874e68230b971da342f6b73e2f5bd28966d1b146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3aa4ff28a535078cd2627bf83b82e6277dd11001b25434d24f663538f87a851cd8a4fc0de28c70e44129a8b6da0e9d6e592ce1341184eb97924b0ca69a8013f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7618f7c8e7ee2cdcfb3354774b3e4543185f8b503b9fe1dc6a7628426d44f95d36356e67ee03f7d63e776617ac23468939b27a170f3330177220487405cf9042"} 02:15:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:15:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:15:53 INFO - Contents: 02:15:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ffb9ec736730e8ba98b534a5d9b7cf8e43b9fd3cb4843688b86239448e1c99d9ed55f32bc68cc8e088bc02d874e68230b971da342f6b73e2f5bd28966d1b146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3aa4ff28a535078cd2627bf83b82e6277dd11001b25434d24f663538f87a851cd8a4fc0de28c70e44129a8b6da0e9d6e592ce1341184eb97924b0ca69a8013f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7618f7c8e7ee2cdcfb3354774b3e4543185f8b503b9fe1dc6a7628426d44f95d36356e67ee03f7d63e776617ac23468939b27a170f3330177220487405cf9042"} 02:15:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:15:53 INFO - Copying logs to upload dir... 02:15:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:15:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.682167 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-30 02:15:52.733519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 02:15:52.740824) ========= 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=0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959 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/0ffb9ec736730e8ba98b534a5d9b7cf8e43b9fd3cb4843688b86239448e1c99d9ed55f32bc68cc8e088bc02d874e68230b971da342f6b73e2f5bd28966d1b146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3aa4ff28a535078cd2627bf83b82e6277dd11001b25434d24f663538f87a851cd8a4fc0de28c70e44129a8b6da0e9d6e592ce1341184eb97924b0ca69a8013f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7618f7c8e7ee2cdcfb3354774b3e4543185f8b503b9fe1dc6a7628426d44f95d36356e67ee03f7d63e776617ac23468939b27a170f3330177220487405cf9042"} build_url:https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/QJq3jpplS0ylnGivzSmtQw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ffb9ec736730e8ba98b534a5d9b7cf8e43b9fd3cb4843688b86239448e1c99d9ed55f32bc68cc8e088bc02d874e68230b971da342f6b73e2f5bd28966d1b146", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3aa4ff28a535078cd2627bf83b82e6277dd11001b25434d24f663538f87a851cd8a4fc0de28c70e44129a8b6da0e9d6e592ce1341184eb97924b0ca69a8013f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7618f7c8e7ee2cdcfb3354774b3e4543185f8b503b9fe1dc6a7628426d44f95d36356e67ee03f7d63e776617ac23468939b27a170f3330177220487405cf9042"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 02:15:52.769233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 02:15:52.769601) ========= 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=0e2a256762fed810e2f0f810000001b3-1469867843.263745-5057959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 02:15:52.851323) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 02:15:52.854717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 02:15:52.855072) ========= ========= Total master_lag: 0.19 =========