builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1469902496.77 results: success (0) buildid: 20160730083018 builduid: ddfd5044e6274c229969bf630c5fe947 revision: 5b500a963fd364f41d32422d5249233a124f85e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.771918) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.772499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.772773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.823165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.823443) ========= 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=745a4373a2a16df560f216e000000264-1469900557.267178-645988056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 11:14: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-07-30 11:14:57 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.962398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:56.962684) ========= 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=745a4373a2a16df560f216e000000264-1469900557.267178-645988056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019618 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.040567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.040921) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b500a963fd364f41d32422d5249233a124f85e7 --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 5b500a963fd364f41d32422d5249233a124f85e7 --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=745a4373a2a16df560f216e000000264-1469900557.267178-645988056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 11:14:57,378 truncating revision to first 12 chars 2016-07-30 11:14:57,378 Setting DEBUG logging. 2016-07-30 11:14:57,378 attempt 1/10 2016-07-30 11:14:57,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b500a963fd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 11:14:57,796 unpacking tar archive at: fx-team-5b500a963fd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727569 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.786191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.786559) ========= script_repo_revision: 5b500a963fd364f41d32422d5249233a124f85e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.786963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.787254) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 11:14:57.796701) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-30 11:14:57.797001) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1469900557.267178-645988056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:58 INFO - MultiFileLogger online at 20160730 11:14:58 in /builds/slave/test 11:14:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:14:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:58 INFO - {'append_to_log': False, 11:14:58 INFO - 'base_work_dir': '/builds/slave/test', 11:14:58 INFO - 'blob_upload_branch': 'Fx-Team', 11:14:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:58 INFO - 'branch': 'Fx-Team', 11:14:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:58 INFO - 'config_files': ('talos/linux_config.py',), 11:14:58 INFO - 'default_actions': ('clobber', 11:14:58 INFO - 'read-buildbot-config', 11:14:58 INFO - 'download-and-extract', 11:14:58 INFO - 'populate-webroot', 11:14:58 INFO - 'create-virtualenv', 11:14:58 INFO - 'install', 11:14:58 INFO - 'run-tests'), 11:14:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:58 INFO - 'download_minidump_stackwalk': True, 11:14:58 INFO - 'download_symbols': 'ondemand', 11:14:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:58 INFO - 'installer_path': 'installer.exe', 11:14:58 INFO - 'log_level': 'info', 11:14:58 INFO - 'log_name': 'talos', 11:14:58 INFO - 'log_to_console': True, 11:14:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:58 INFO - 'opt_config_files': (), 11:14:58 INFO - 'pip_index': False, 11:14:58 INFO - 'sps_profile': False, 11:14:58 INFO - 'sps_profile_interval': 0, 11:14:58 INFO - 'suite': 'dromaeojs', 11:14:58 INFO - 'system_bits': '32', 11:14:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:58 INFO - 'title': 'talos-linux64-ix-032', 11:14:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:58 INFO - 'use_talos_json': True, 11:14:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:58 INFO - 'work_dir': 'build'} 11:14:58 INFO - [mozharness: 2016-07-30 18:14:58.220502Z] Running clobber step. 11:14:58 INFO - Running pre-action listener: _resource_record_pre_action 11:14:58 INFO - Running main action method: clobber 11:14:58 INFO - rmtree: /builds/slave/test/build 11:14:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:58 INFO - Running post-action listener: _resource_record_post_action 11:14:58 INFO - [mozharness: 2016-07-30 18:14:58.678928Z] Finished clobber step (success) 11:14:58 INFO - [mozharness: 2016-07-30 18:14:58.679030Z] Running read-buildbot-config step. 11:14:58 INFO - Running pre-action listener: _resource_record_pre_action 11:14:58 INFO - Running main action method: read_buildbot_config 11:14:58 INFO - Using buildbot properties: 11:14:58 INFO - { 11:14:58 INFO - "project": "", 11:14:58 INFO - "product": "firefox", 11:14:58 INFO - "script_repo_revision": "production", 11:14:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:14:58 INFO - "repository": "", 11:14:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:14:58 INFO - "buildid": "20160730083018", 11:14:58 INFO - "pgo_build": "True", 11:14:58 INFO - "basedir": "/builds/slave/test", 11:14:58 INFO - "buildnumber": 1399, 11:14:58 INFO - "slavename": "talos-linux64-ix-032", 11:14:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:14:58 INFO - "platform": "ubuntu64_hw", 11:14:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:14:58 INFO - "branch": "fx-team", 11:14:58 INFO - "repo_path": "integration/fx-team", 11:14:58 INFO - "revision": "5b500a963fd364f41d32422d5249233a124f85e7", 11:14:58 INFO - "stage_platform": "linux64-pgo", 11:14:58 INFO - "builduid": "ddfd5044e6274c229969bf630c5fe947", 11:14:58 INFO - "slavebuilddir": "test" 11:14:58 INFO - } 11:14:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:14:58 INFO - Running post-action listener: _resource_record_post_action 11:14:58 INFO - [mozharness: 2016-07-30 18:14:58.681462Z] Finished read-buildbot-config step (success) 11:14:58 INFO - [mozharness: 2016-07-30 18:14:58.681550Z] Running download-and-extract step. 11:14:58 INFO - Running pre-action listener: _resource_record_pre_action 11:14:58 INFO - Running main action method: download_and_extract 11:14:58 INFO - mkdir: /builds/slave/test/build/tests 11:14:58 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')]} 11:14:58 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:14:59 INFO - Downloaded 1361 bytes. 11:14:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:14:59 INFO - Using the following test package requirements: 11:14:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:14:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'jsshell-linux-x86_64.zip'], 11:14:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:14:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:14:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:14:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:14:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14: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')]} 11:14:59 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:14:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:14:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:14:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:00 INFO - Downloaded 21803667 bytes. 11:15:00 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'] 11:15:00 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 11:15:01 INFO - Return code: 0 11:15:01 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 11:15:01 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')]} 11:15:01 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:15:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:09 INFO - Downloaded 21803667 bytes. 11:15:09 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'] 11:15:09 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 11:15:10 INFO - Return code: 0 11:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:10 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:11 INFO - Downloaded 14413723 bytes. 11:15:11 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'] 11:15:11 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 11:15:11 INFO - Return code: 0 11:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:11 INFO - https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:15:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aqbk4CMuQnaewh-1ES6z5w/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 11:15:13 INFO - Downloaded 59376860 bytes. 11:15:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:13 INFO - mkdir: /builds/slave/test/properties 11:15:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:13 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:13 INFO - Contents: 11:15:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:15:14 INFO - Running post-action listener: _resource_record_post_action 11:15:14 INFO - Running post-action listener: set_extra_try_arguments 11:15:14 INFO - [mozharness: 2016-07-30 18:15:14.500553Z] Finished download-and-extract step (success) 11:15:14 INFO - [mozharness: 2016-07-30 18:15:14.500784Z] Running populate-webroot step. 11:15:14 INFO - Running pre-action listener: _resource_record_pre_action 11:15:14 INFO - Running main action method: populate_webroot 11:15:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:15:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:15:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:15:14 INFO - '--tppagecycles', 11:15:14 INFO - '7'], 11:15:14 INFO - 'tests': ['tsvgm']}}, 11:15:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['damp', 'tps']}, 11:15:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'tests': ['damp', 'tps']}, 11:15:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['dromaeo_dom']}, 11:15:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['basic_compositor_video']}, 11:15:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:15:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['a11yr', 11:15:14 INFO - 'ts_paint', 11:15:14 INFO - 'tpaint', 11:15:14 INFO - 'sessionrestore', 11:15:14 INFO - 'sessionrestore_no_auto_restore', 11:15:14 INFO - 'tabpaint']}, 11:15:14 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:14 INFO - 'ts_paint', 11:15:14 INFO - 'tpaint', 11:15:14 INFO - 'sessionrestore', 11:15:14 INFO - 'sessionrestore_no_auto_restore', 11:15:14 INFO - 'tabpaint']}, 11:15:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:15:14 INFO - 'ts_paint', 11:15:14 INFO - 'tpaint', 11:15:14 INFO - 'sessionrestore', 11:15:14 INFO - 'sessionrestore_no_auto_restore', 11:15:14 INFO - 'tabpaint']}, 11:15:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:15:14 INFO - 'ts_paint', 11:15:14 INFO - 'tpaint', 11:15:14 INFO - 'sessionrestore', 11:15:14 INFO - 'sessionrestore_no_auto_restore', 11:15:14 INFO - 'tabpaint']}, 11:15:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['a11yr', 11:15:14 INFO - 'ts_paint', 11:15:14 INFO - 'tpaint', 11:15:14 INFO - 'sessionrestore', 11:15:14 INFO - 'sessionrestore_no_auto_restore', 11:15:14 INFO - 'tabpaint']}, 11:15:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['a11yr', 11:15:14 INFO - 'ts_paint', 11:15:14 INFO - 'tpaint', 11:15:14 INFO - 'sessionrestore', 11:15:14 INFO - 'sessionrestore_no_auto_restore', 11:15:14 INFO - 'tabpaint']}, 11:15:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['tsvgx', 11:15:14 INFO - 'tsvgr_opacity', 11:15:14 INFO - 'tart', 11:15:14 INFO - 'tscrollx', 11:15:14 INFO - 'cart']}, 11:15:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:14 INFO - 'tsvgr_opacity', 11:15:14 INFO - 'tart', 11:15:14 INFO - 'tscrollx', 11:15:14 INFO - 'cart']}, 11:15:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'talos_options': ['--disable-e10s'], 11:15:14 INFO - 'tests': ['tp5o']}, 11:15:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'tests': ['tp5o']}, 11:15:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'talos_options': ['--disable-e10s', 11:15:14 INFO - '--xperf_path', 11:15:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:14 INFO - 'tests': ['tp5n']}, 11:15:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:14 INFO - 'talos_options': ['--xperf_path', 11:15:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:14 INFO - 'tests': ['tp5n']}}, 11:15:14 INFO - 'talos.zip': {'path': '', 11:15:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:15:14 INFO - Running post-action listener: _resource_record_post_action 11:15:14 INFO - [mozharness: 2016-07-30 18:15:14.516052Z] Finished populate-webroot step (success) 11:15:14 INFO - [mozharness: 2016-07-30 18:15:14.516141Z] Running create-virtualenv step. 11:15:14 INFO - Running pre-action listener: _resource_record_pre_action 11:15:14 INFO - Running main action method: create_virtualenv 11:15:14 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:14 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 11:15:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:15:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:14 INFO - Using real prefix '/usr' 11:15:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:15 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:17 INFO - Installing pip.................done. 11:15:17 INFO - Return code: 0 11:15:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:17 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')]} 11:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:17 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')]} 11:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:17 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:17 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 11:15:17 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 11:15:17 INFO - Using env: {'DISPLAY': ':0', 11:15:17 INFO - 'HOME': '/home/cltbld', 11:15:17 INFO - 'LANG': 'en_US.UTF-8', 11:15:17 INFO - 'LANGUAGE': 'en_US:en', 11:15:17 INFO - 'LOGNAME': 'cltbld', 11:15:17 INFO - 'MAIL': '/var/mail/cltbld', 11:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:17 INFO - 'MOZ_NO_REMOTE': '1', 11:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:17 INFO - 'NO_EM_RESTART': '1', 11:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:17 INFO - 'PWD': '/builds/slave/test', 11:15:17 INFO - 'SHELL': '/bin/bash', 11:15:17 INFO - 'SHLVL': '1', 11:15:17 INFO - 'TERM': 'linux', 11:15:17 INFO - 'TMOUT': '86400', 11:15:17 INFO - 'USER': 'cltbld', 11:15:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:17 INFO - '_': '/tools/buildbot/bin/python'} 11:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:17 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 11:15:17 INFO - Cleaning up... 11:15:17 INFO - Return code: 0 11:15:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:17 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')]} 11:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:17 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')]} 11:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:17 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:17 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 11:15:17 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 11:15:17 INFO - Using env: {'DISPLAY': ':0', 11:15:17 INFO - 'HOME': '/home/cltbld', 11:15:17 INFO - 'LANG': 'en_US.UTF-8', 11:15:17 INFO - 'LANGUAGE': 'en_US:en', 11:15:17 INFO - 'LOGNAME': 'cltbld', 11:15:17 INFO - 'MAIL': '/var/mail/cltbld', 11:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:17 INFO - 'MOZ_NO_REMOTE': '1', 11:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:17 INFO - 'NO_EM_RESTART': '1', 11:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:17 INFO - 'PWD': '/builds/slave/test', 11:15:17 INFO - 'SHELL': '/bin/bash', 11:15:17 INFO - 'SHLVL': '1', 11:15:17 INFO - 'TERM': 'linux', 11:15:17 INFO - 'TMOUT': '86400', 11:15:17 INFO - 'USER': 'cltbld', 11:15:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:17 INFO - '_': '/tools/buildbot/bin/python'} 11:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:17 INFO - Downloading/unpacking psutil>=3.1.1 11:15:17 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 11:15:17 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 11:15:17 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 11:15:17 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 11:15:17 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 11:15:17 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 11:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:19 INFO - Installing collected packages: psutil 11:15:19 INFO - Running setup.py install for psutil 11:15:19 INFO - building 'psutil._psutil_linux' extension 11:15:19 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 11:15:19 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 11:15:19 INFO - building 'psutil._psutil_posix' extension 11:15:19 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 11:15:19 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 11:15:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:20 INFO - Successfully installed psutil 11:15:20 INFO - Cleaning up... 11:15:20 INFO - Return code: 0 11:15:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15:20 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')]} 11:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:20 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')]} 11:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:20 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:20 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 11:15:20 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 11:15:20 INFO - Using env: {'DISPLAY': ':0', 11:15:20 INFO - 'HOME': '/home/cltbld', 11:15:20 INFO - 'LANG': 'en_US.UTF-8', 11:15:20 INFO - 'LANGUAGE': 'en_US:en', 11:15:20 INFO - 'LOGNAME': 'cltbld', 11:15:20 INFO - 'MAIL': '/var/mail/cltbld', 11:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:20 INFO - 'MOZ_NO_REMOTE': '1', 11:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:20 INFO - 'NO_EM_RESTART': '1', 11:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:20 INFO - 'PWD': '/builds/slave/test', 11:15:20 INFO - 'SHELL': '/bin/bash', 11:15:20 INFO - 'SHLVL': '1', 11:15:20 INFO - 'TERM': 'linux', 11:15:20 INFO - 'TMOUT': '86400', 11:15:20 INFO - 'USER': 'cltbld', 11:15:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:20 INFO - '_': '/tools/buildbot/bin/python'} 11:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15:20 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 11:15:20 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 11:15:20 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 11:15:20 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 11:15:20 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 11:15:20 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 11:15:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:22 INFO - Installing collected packages: mozsystemmonitor 11:15:22 INFO - Running setup.py install for mozsystemmonitor 11:15:22 INFO - Successfully installed mozsystemmonitor 11:15:22 INFO - Cleaning up... 11:15:22 INFO - Return code: 0 11:15:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:22 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:22 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 11:15:22 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 11:15:22 INFO - Using env: {'DISPLAY': ':0', 11:15:22 INFO - 'HOME': '/home/cltbld', 11:15:22 INFO - 'LANG': 'en_US.UTF-8', 11:15:22 INFO - 'LANGUAGE': 'en_US:en', 11:15:22 INFO - 'LOGNAME': 'cltbld', 11:15:22 INFO - 'MAIL': '/var/mail/cltbld', 11:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:22 INFO - 'MOZ_NO_REMOTE': '1', 11:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:22 INFO - 'NO_EM_RESTART': '1', 11:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:22 INFO - 'PWD': '/builds/slave/test', 11:15:22 INFO - 'SHELL': '/bin/bash', 11:15:22 INFO - 'SHLVL': '1', 11:15:22 INFO - 'TERM': 'linux', 11:15:22 INFO - 'TMOUT': '86400', 11:15:22 INFO - 'USER': 'cltbld', 11:15:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:22 INFO - '_': '/tools/buildbot/bin/python'} 11:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:22 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:22 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 11:15:22 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 11:15:22 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 11:15:22 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 11:15:22 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 11:15:22 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 11:15:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:24 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 11:15:24 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 11:15:24 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 11:15:24 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 11:15:24 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 11:15:24 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 11:15:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:24 INFO - warning: no files found matching '*.txt' 11:15:24 INFO - no previously-included directories found matching 'build' 11:15:24 INFO - no previously-included directories found matching 'dist' 11:15:24 INFO - no previously-included directories found matching '.git*' 11:15:24 INFO - Installing collected packages: jsonschema, functools32 11:15:24 INFO - Running setup.py install for functools32 11:15:24 INFO - warning: no files found matching '*.txt' 11:15:24 INFO - no previously-included directories found matching 'build' 11:15:24 INFO - no previously-included directories found matching 'dist' 11:15:24 INFO - no previously-included directories found matching '.git*' 11:15:24 INFO - Successfully installed jsonschema functools32 11:15:24 INFO - Cleaning up... 11:15:24 INFO - Return code: 0 11:15:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:24 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:24 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 11:15:24 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 11:15:24 INFO - Using env: {'DISPLAY': ':0', 11:15:24 INFO - 'HOME': '/home/cltbld', 11:15:24 INFO - 'LANG': 'en_US.UTF-8', 11:15:24 INFO - 'LANGUAGE': 'en_US:en', 11:15:24 INFO - 'LOGNAME': 'cltbld', 11:15:24 INFO - 'MAIL': '/var/mail/cltbld', 11:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:24 INFO - 'MOZ_NO_REMOTE': '1', 11:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:24 INFO - 'NO_EM_RESTART': '1', 11:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:24 INFO - 'PWD': '/builds/slave/test', 11:15:24 INFO - 'SHELL': '/bin/bash', 11:15:24 INFO - 'SHLVL': '1', 11:15:24 INFO - 'TERM': 'linux', 11:15:24 INFO - 'TMOUT': '86400', 11:15:24 INFO - 'USER': 'cltbld', 11:15:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:24 INFO - '_': '/tools/buildbot/bin/python'} 11:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:15:25 INFO - Cleaning up... 11:15:25 INFO - Return code: 0 11:15:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:25 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')]} 11:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:25 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')]} 11:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:25 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:25 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 11:15:25 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 11:15:25 INFO - Using env: {'DISPLAY': ':0', 11:15:25 INFO - 'HOME': '/home/cltbld', 11:15:25 INFO - 'LANG': 'en_US.UTF-8', 11:15:25 INFO - 'LANGUAGE': 'en_US:en', 11:15:25 INFO - 'LOGNAME': 'cltbld', 11:15:25 INFO - 'MAIL': '/var/mail/cltbld', 11:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:25 INFO - 'MOZ_NO_REMOTE': '1', 11:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:25 INFO - 'NO_EM_RESTART': '1', 11:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:25 INFO - 'PWD': '/builds/slave/test', 11:15:25 INFO - 'SHELL': '/bin/bash', 11:15:25 INFO - 'SHLVL': '1', 11:15:25 INFO - 'TERM': 'linux', 11:15:25 INFO - 'TMOUT': '86400', 11:15:25 INFO - 'USER': 'cltbld', 11:15:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:25 INFO - '_': '/tools/buildbot/bin/python'} 11:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:15:25 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 11:15:25 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 11:15:25 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 11:15:25 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 11:15:25 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 11:15:25 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 11:15:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:27 INFO - Downloading docopt-0.6.1.tar.gz 11:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:27 INFO - Running setup.py install for blobuploader 11:15:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:28 INFO - Running setup.py install for requests 11:15:28 INFO - Running setup.py install for docopt 11:15:28 INFO - Successfully installed blobuploader requests docopt 11:15:28 INFO - Cleaning up... 11:15:28 INFO - Return code: 0 11:15:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:28 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')]} 11:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:28 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')]} 11:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:28 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:28 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 11:15:28 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 11:15:28 INFO - Using env: {'DISPLAY': ':0', 11:15:28 INFO - 'HOME': '/home/cltbld', 11:15:28 INFO - 'LANG': 'en_US.UTF-8', 11:15:28 INFO - 'LANGUAGE': 'en_US:en', 11:15:28 INFO - 'LOGNAME': 'cltbld', 11:15:28 INFO - 'MAIL': '/var/mail/cltbld', 11:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:28 INFO - 'MOZ_NO_REMOTE': '1', 11:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:28 INFO - 'NO_EM_RESTART': '1', 11:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:28 INFO - 'PWD': '/builds/slave/test', 11:15:28 INFO - 'SHELL': '/bin/bash', 11:15:28 INFO - 'SHLVL': '1', 11:15:28 INFO - 'TERM': 'linux', 11:15:28 INFO - 'TMOUT': '86400', 11:15:28 INFO - 'USER': 'cltbld', 11:15:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:28 INFO - '_': '/tools/buildbot/bin/python'} 11:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:28 INFO - Running setup.py (path:/tmp/pip-cy3kju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:28 INFO - Running setup.py (path:/tmp/pip-zkSRIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:28 INFO - Running setup.py (path:/tmp/pip-8n_Auk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:29 INFO - Running setup.py (path:/tmp/pip-QdWdmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:29 INFO - Running setup.py (path:/tmp/pip-kVJJ2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:29 INFO - Running setup.py (path:/tmp/pip-BgefSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:29 INFO - Running setup.py (path:/tmp/pip-z9LuHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:29 INFO - Running setup.py (path:/tmp/pip-iTYraS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:29 INFO - Running setup.py (path:/tmp/pip-tp_Ybw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:29 INFO - Running setup.py (path:/tmp/pip-TkZl1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:29 INFO - Running setup.py (path:/tmp/pip-iCUuJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:29 INFO - Running setup.py (path:/tmp/pip-0lYvs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:29 INFO - Running setup.py (path:/tmp/pip-3fOQ76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:29 INFO - Running setup.py (path:/tmp/pip-mw749S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:29 INFO - Running setup.py (path:/tmp/pip-yiw1d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:29 INFO - Running setup.py (path:/tmp/pip-HEERTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:29 INFO - Running setup.py (path:/tmp/pip-sfwuDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:30 INFO - Running setup.py install for manifestparser 11:15:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Running setup.py install for mozcrash 11:15:30 INFO - Running setup.py install for mozdebug 11:15:30 INFO - Running setup.py install for mozdevice 11:15:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Running setup.py install for mozfile 11:15:30 INFO - Running setup.py install for mozhttpd 11:15:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Running setup.py install for mozinfo 11:15:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Running setup.py install for mozInstall 11:15:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:30 INFO - Running setup.py install for mozleak 11:15:30 INFO - Running setup.py install for mozlog 11:15:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Running setup.py install for moznetwork 11:15:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Running setup.py install for mozprocess 11:15:31 INFO - Running setup.py install for mozprofile 11:15:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Running setup.py install for mozrunner 11:15:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Running setup.py install for mozscreenshot 11:15:31 INFO - Running setup.py install for moztest 11:15:31 INFO - Running setup.py install for mozversion 11:15:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:31 INFO - Cleaning up... 11:15:31 INFO - Return code: 0 11:15:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:31 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:31 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 11:15:31 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 11:15:31 INFO - Using env: {'DISPLAY': ':0', 11:15:31 INFO - 'HOME': '/home/cltbld', 11:15:31 INFO - 'LANG': 'en_US.UTF-8', 11:15:31 INFO - 'LANGUAGE': 'en_US:en', 11:15:31 INFO - 'LOGNAME': 'cltbld', 11:15:31 INFO - 'MAIL': '/var/mail/cltbld', 11:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:31 INFO - 'MOZ_NO_REMOTE': '1', 11:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:31 INFO - 'NO_EM_RESTART': '1', 11:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:31 INFO - 'PWD': '/builds/slave/test', 11:15:31 INFO - 'SHELL': '/bin/bash', 11:15:31 INFO - 'SHLVL': '1', 11:15:31 INFO - 'TERM': 'linux', 11:15:31 INFO - 'TMOUT': '86400', 11:15:31 INFO - 'USER': 'cltbld', 11:15:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:31 INFO - '_': '/tools/buildbot/bin/python'} 11:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:32 INFO - Running setup.py (path:/tmp/pip-5fLUQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:32 INFO - Running setup.py (path:/tmp/pip-EJ8bSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:32 INFO - Running setup.py (path:/tmp/pip-QUvarx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:32 INFO - Running setup.py (path:/tmp/pip-KcLl5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:32 INFO - Running setup.py (path:/tmp/pip-HG4tvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:32 INFO - Running setup.py (path:/tmp/pip-H4pQP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:32 INFO - Running setup.py (path:/tmp/pip-g37kJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:32 INFO - Running setup.py (path:/tmp/pip-MGCrw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:32 INFO - Running setup.py (path:/tmp/pip-PtHGoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:32 INFO - Running setup.py (path:/tmp/pip-t7u4N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:32 INFO - Running setup.py (path:/tmp/pip-nV2zx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:32 INFO - Running setup.py (path:/tmp/pip-Unif77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:32 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)) 11:15:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:32 INFO - Running setup.py (path:/tmp/pip-n9ZHp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:33 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)) 11:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:33 INFO - Running setup.py (path:/tmp/pip-IRECtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:33 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)) 11:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:33 INFO - Running setup.py (path:/tmp/pip-fmWHHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:33 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)) 11:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:33 INFO - Running setup.py (path:/tmp/pip-IKuSj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:33 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)) 11:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:33 INFO - Running setup.py (path:/tmp/pip-DB7ezH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:33 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)) 11:15:33 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)) 11:15:33 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)) 11:15:33 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)) 11:15:33 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)) 11:15:33 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)) 11:15:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:33 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 11:15:33 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 11:15:33 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 11:15:33 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 11:15:33 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 11:15:33 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 11:15:35 INFO - Downloading blessings-1.6.tar.gz 11:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:35 INFO - Installing collected packages: blessings 11:15:35 INFO - Running setup.py install for blessings 11:15:35 INFO - Successfully installed blessings 11:15:35 INFO - Cleaning up... 11:15:35 INFO - Return code: 0 11:15:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:35 INFO - Reading from file tmpfile_stdout 11:15:35 INFO - Current package versions: 11:15:35 INFO - argparse == 1.2.1 11:15:35 INFO - blessings == 1.6 11:15:35 INFO - blobuploader == 1.2.4 11:15:35 INFO - docopt == 0.6.1 11:15:35 INFO - functools32 == 3.2.3-2 11:15:35 INFO - jsonschema == 2.5.1 11:15:35 INFO - manifestparser == 1.1 11:15:35 INFO - mozInstall == 1.12 11:15:35 INFO - mozcrash == 0.17 11:15:35 INFO - mozdebug == 0.1 11:15:35 INFO - mozdevice == 0.48 11:15:35 INFO - mozfile == 1.2 11:15:35 INFO - mozhttpd == 0.7 11:15:35 INFO - mozinfo == 0.9 11:15:35 INFO - mozleak == 0.1 11:15:35 INFO - mozlog == 3.3 11:15:35 INFO - moznetwork == 0.27 11:15:35 INFO - mozprocess == 0.23 11:15:35 INFO - mozprofile == 0.28 11:15:35 INFO - mozrunner == 6.12 11:15:35 INFO - mozscreenshot == 0.1 11:15:35 INFO - mozsystemmonitor == 0.3 11:15:35 INFO - moztest == 0.7 11:15:35 INFO - mozversion == 1.4 11:15:35 INFO - psutil == 3.1.1 11:15:35 INFO - requests == 1.2.3 11:15:35 INFO - wsgiref == 0.1.2 11:15:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:35 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15:35 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 11:15:35 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 11:15:35 INFO - Using env: {'DISPLAY': ':0', 11:15:35 INFO - 'HOME': '/home/cltbld', 11:15:35 INFO - 'LANG': 'en_US.UTF-8', 11:15:35 INFO - 'LANGUAGE': 'en_US:en', 11:15:35 INFO - 'LOGNAME': 'cltbld', 11:15:35 INFO - 'MAIL': '/var/mail/cltbld', 11:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:35 INFO - 'MOZ_NO_REMOTE': '1', 11:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:35 INFO - 'NO_EM_RESTART': '1', 11:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:35 INFO - 'PWD': '/builds/slave/test', 11:15:35 INFO - 'SHELL': '/bin/bash', 11:15:35 INFO - 'SHLVL': '1', 11:15:35 INFO - 'TERM': 'linux', 11:15:35 INFO - 'TMOUT': '86400', 11:15:35 INFO - 'USER': 'cltbld', 11:15:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:35 INFO - '_': '/tools/buildbot/bin/python'} 11:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 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)) 11:15:35 INFO - Cleaning up... 11:15:35 INFO - Return code: 0 11:15:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a4180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, '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': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', '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 11:15: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', 'jsonschema'] in /builds/slave/test/build 11:15: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 jsonschema 11:15:35 INFO - Using env: {'DISPLAY': ':0', 11:15:35 INFO - 'HOME': '/home/cltbld', 11:15:35 INFO - 'LANG': 'en_US.UTF-8', 11:15:35 INFO - 'LANGUAGE': 'en_US:en', 11:15:35 INFO - 'LOGNAME': 'cltbld', 11:15:35 INFO - 'MAIL': '/var/mail/cltbld', 11:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:35 INFO - 'MOZ_NO_REMOTE': '1', 11:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:35 INFO - 'NO_EM_RESTART': '1', 11:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:35 INFO - 'PWD': '/builds/slave/test', 11:15:35 INFO - 'SHELL': '/bin/bash', 11:15:35 INFO - 'SHLVL': '1', 11:15:35 INFO - 'TERM': 'linux', 11:15:35 INFO - 'TMOUT': '86400', 11:15:35 INFO - 'USER': 'cltbld', 11:15:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:35 INFO - '_': '/tools/buildbot/bin/python'} 11:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:15:36 INFO - Cleaning up... 11:15:36 INFO - Return code: 0 11:15:36 INFO - Running post-action listener: _resource_record_post_action 11:15:36 INFO - Running post-action listener: _start_resource_monitoring 11:15:36 INFO - Starting resource monitoring. 11:15:36 INFO - [mozharness: 2016-07-30 18:15:36.120390Z] Finished create-virtualenv step (success) 11:15:36 INFO - [mozharness: 2016-07-30 18:15:36.120827Z] Running install step. 11:15:36 INFO - Running pre-action listener: _resource_record_pre_action 11:15:36 INFO - Running main action method: install 11:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:36 INFO - Reading from file tmpfile_stdout 11:15:36 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:36 INFO - Reading from file tmpfile_stdout 11:15:36 INFO - Output received: 11:15:36 INFO - Usage: mozinstall [options] installer 11:15:36 INFO - Options: 11:15:36 INFO - -h, --help show this help message and exit 11:15:36 INFO - -d DEST, --destination=DEST 11:15:36 INFO - Directory to install application into. [default: 11:15:36 INFO - "/builds/slave/test"] 11:15:36 INFO - --app=APP Application being installed. [default: firefox] 11:15:36 INFO - mkdir: /builds/slave/test/build/application 11:15:36 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'] 11:15:36 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 11:15:53 INFO - Reading from file tmpfile_stdout 11:15:53 INFO - Output received: 11:15:53 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:53 INFO - Running post-action listener: _resource_record_post_action 11:15:53 INFO - [mozharness: 2016-07-30 18:15:53.454268Z] Finished install step (success) 11:15:53 INFO - [mozharness: 2016-07-30 18:15:53.454544Z] Running run-tests step. 11:15:53 INFO - Running pre-action listener: _resource_record_pre_action 11:15:53 INFO - Running main action method: run_tests 11:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:53 INFO - Python 2.7.3 11:15:53 INFO - Return code: 0 11:15:53 INFO - grabbing minidump binary from tooltool 11:15:53 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')]} 11:15:53 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 0x26a23b0>, '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 0x26a32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a3740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:53 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 11:15:53 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 11:15:53 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 11:15:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:53 INFO - Return code: 0 11:15:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 11:15:53 INFO - Using env: {'DISPLAY': ':0', 11:15:53 INFO - 'HOME': '/home/cltbld', 11:15:53 INFO - 'LANG': 'en_US.UTF-8', 11:15:53 INFO - 'LANGUAGE': 'en_US:en', 11:15:53 INFO - 'LOGNAME': 'cltbld', 11:15:53 INFO - 'MAIL': '/var/mail/cltbld', 11:15:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:53 INFO - 'MOZ_NO_REMOTE': '1', 11:15:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:53 INFO - 'NO_EM_RESTART': '1', 11:15:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:53 INFO - 'PWD': '/builds/slave/test', 11:15:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:53 INFO - 'SHELL': '/bin/bash', 11:15:53 INFO - 'SHLVL': '1', 11:15:53 INFO - 'TERM': 'linux', 11:15:53 INFO - 'TMOUT': '86400', 11:15:53 INFO - 'USER': 'cltbld', 11:15:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469900557.267178-645988056', 11:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:53 INFO - '_': '/tools/buildbot/bin/python'} 11:15:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:15:53 INFO - mozversion application_buildid: 20160730083018 11:15:53 INFO - mozversion application_changeset: 5b500a963fd364f41d32422d5249233a124f85e7 11:15:53 INFO - mozversion application_display_name: Nightly 11:15:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:53 INFO - mozversion application_name: Firefox 11:15:53 INFO - mozversion application_remotingname: firefox 11:15:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:15:53 INFO - mozversion application_vendor: Mozilla 11:15:53 INFO - mozversion application_version: 50.0a1 11:15:53 INFO - mozversion platform_buildid: 20160730083018 11:15:53 INFO - mozversion platform_changeset: 5b500a963fd364f41d32422d5249233a124f85e7 11:15:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:15:53 INFO - mozversion platform_version: 50.0a1 11:15:53 INFO - using testdate: 1469902553 11:15:53 INFO - actual date: 1469902553 11:15:53 INFO - starting webserver on 'localhost:55660' 11:15:53 INFO - SUITE-START | Running 2 tests 11:15:53 INFO - TEST-START | dromaeo_css 11:15:53 INFO - operating with platform_type : linux_ 11:15:53 INFO - Initialising browser for dromaeo_css test... 11:15:53 INFO - TEST-INFO | started process 30826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxO8N3U/profile http://localhost:55660/getInfo.html) 11:15:58 INFO - PROCESS | 30826 | __metrics Screen width/height:1600/1200 11:15:58 INFO - PROCESS | 30826 | colorDepth:24 11:15:58 INFO - PROCESS | 30826 | Browser inner width/height: 1024/697 11:15:58 INFO - PROCESS | 30826 | __metrics 11:15:59 INFO - PROCESS | 30826 | 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" 11:15:59 INFO - PROCESS | 30826 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:00 INFO - TEST-INFO | 30826: exit 0 11:16:00 INFO - Browser initialized. 11:16:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:00 INFO - TEST-INFO | started process 30906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxO8N3U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:12 INFO - PROCESS | 30906 | RSS: Main: 155602944 11:16:12 INFO - PROCESS | 30906 | 11:17:04 INFO - PROCESS | 30906 | 1469902624089 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] 11:19:12 INFO - PROCESS | 30906 | Cycle 1(1): loaded http://localhost:55660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55660/tests/dromaeo/cssquery-ext.html) 11:19:13 INFO - PROCESS | 30906 | RSS: Main: 279166976 11:19:13 INFO - PROCESS | 30906 | 11:22:16 INFO - PROCESS | 30906 | Cycle 1(1): loaded http://localhost:55660/tests/dromaeo/cssquery-ext.html (next: http://localhost:55660/tests/dromaeo/cssquery-jquery.html) 11:22:16 INFO - PROCESS | 30906 | RSS: Main: 246575104 11:22:16 INFO - PROCESS | 30906 | 11:25:18 INFO - PROCESS | 30906 | Cycle 1(1): loaded http://localhost:55660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55660/tests/dromaeo/cssquery-mootools.html) 11:25:18 INFO - PROCESS | 30906 | RSS: Main: 184045568 11:25:18 INFO - PROCESS | 30906 | 11:28:20 INFO - PROCESS | 30906 | Cycle 1(1): loaded http://localhost:55660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55660/tests/dromaeo/cssquery-prototype.html) 11:28:21 INFO - PROCESS | 30906 | RSS: Main: 216580096 11:28:21 INFO - PROCESS | 30906 | 11:31:24 INFO - PROCESS | 30906 | Cycle 1(1): loaded http://localhost:55660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55660/tests/dromaeo/cssquery-yui.html) 11:31:24 INFO - PROCESS | 30906 | RSS: Main: 184475648 11:31:24 INFO - PROCESS | 30906 | 11:34:27 INFO - PROCESS | 30906 | Cycle 1(1): loaded http://localhost:55660/tests/dromaeo/cssquery-yui.html (next: http://localhost:55660/tests/dromaeo/cssquery-dojo.html) 11:34:28 INFO - PROCESS | 30906 | RSS: Main: 274989056 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | __start_tp_report 11:34:28 INFO - PROCESS | 30906 | _x_x_mozilla_page_load 11:34:28 INFO - PROCESS | 30906 | _x_x_mozilla_page_load_details 11:34:28 INFO - PROCESS | 30906 | |i|pagename|runs| 11:34:28 INFO - PROCESS | 30906 | |0;dojo.html;3012.9849350753243;3014.095771268619;3038.164504761191;3043.4978228592286;3050.5424186372043;5268.841934741954;5270.525652691257;5273.947260527393;5367.75845086971;5418.7019713915715;5341.0653135701195;5375.838724838261;5386.380566234884;5415.539679127279;5454.972725136378;4848.733319667417;4884.291777692232;4890.682105663138;4911.091448082117;5033.572146367563;4919.77860996256;4965.3296804931415;4970.6520543561965;4971.154903666367;4987.301777751118;4791.928121078169;4807.687500312469;4856.975715121437;4862.270659401082;4899.8040078396825;4858.975705121487;4869.1478991176755;4885.487023862514;4939.851804445872;4971.801127954877;4868.853934381974;4910.459849416561;4910.901781964377;4918.754062296906;4952.801887924478;5226.3989641191365;5270.683758974474;5413.512783849433;5444.673319600797;5471.23402723619;5708.457696518824;5782.421757824226;5802.448767367094;5808.854778630568;5811.215485909391;5787.768489260425;5793.478586927196;5819.505342045931;5823.912641310384;5841.386654401269;5188.221766734982;5295.682259064469;5329.413764485904;5441.1838224266285;5443.8094666686475;5921.496672782861;5934.851628709317;5941.079132734433;5944.227250457413;5956.910646340309;5714.2571465710025;5715.1713001614535;5715.942840571624;5717.914231286534;5722.141678748221;5542.695151766691;5588.30146231721;5647.1529270609735;5798.9420105799245;5802.564807639444;5604.943950560442;5632.464915832989;5676.68778217202;5716.085426331767;5727.656340619576;5565.332160140809;5571.247881536022;5608.719564021782;5614.971925140429;5617.691026993472;4281.100968796588;4329.545397733255;4331.848385306562;4353.455818022747;4392;3925.4111883217747;3944.4872166618156;3949.9012524687114;3951.407288906687;3951.4467974483596;5342.732863356817;5354.143337066051;5371.919421208685;5402.35171779389;5423.4847689470225;5785.537157027427;5792.391798861143;5814.767409303665;5823.970880145572;5842.357340692521;5290.65610735301;5328.573714102862;5335.119705248668;5338.252644629755;5365.38298095724;4841.1285968526;4945.579625731853;4967.379077615298;4968.726720030433;5009.398872135367;5996.400359963969;6079.939200607937;6132.141500189977;6137.447629713347;6141.017437210025;5771.163181338598;5785.4793068623185;5837.94162058374;5840.1531777892815;5842.123681447647;5899.941000590111;6008.188894499187;6008.24896887889;6012.128241405059;6018.8194354169445;5589.77640894376;5619.662820230636;5628.577856660685;5643.097104463266;5709.429057094258;5709.628874123168;5716.942830571641;5720.971395142998;5721.942780572141;5731.168980497721;5462.754176062166;5586.190002449704;5591.384947655836;5596.972015139898;5599.748011339581;5525.751341189736;5615.073512870331;5626.774929002794;5646.124850648156;5686.061799802987;5574.86062848432;5611.607187496836;5617;5630.74661640219;5633.802816901389;5425.918611220756;5675.659460432387;5720.799772007959;5729;5729.427057294237;5441.673499590037;5465.890682186255;5493.670379777226;5534.1975413565615;5558.221848941233 11:34:28 INFO - PROCESS | 30906 | |1;ext.html;589.4900910712236;607.4108115128325;611.8164550634808;615.1142355008789;620.6245221640908;43464.782676086616;44468.11063778723;44715.552844471546;47923;48024.27963580549;46013.53986460134;46688.766556167175;46717.29924051142;46745.29882051764;46767;9026.187643112102;9140.177384035436;9165.770855728593;9165.816683666357;9167.495787731672;9072.909270907272;9133.223675987516;9150.542472876363;9167.724968250963;9171.678991235309;9109.817803643957;9185.678501252458;9200.585973631203;9211.723648290563;9216.723498295061;9140.131687489678;9167.26661867049;9168.266538676957;9177;9179.49512776797;8970.775730606721;9012.459252444874;9021.458712477206;9021.774455638595;9035.593398297093;44124.77937610292;44361.556384436386;44576.10847783059;44631;44740;3288.6053673559086;3326.234965957819;3361.2605226850296;3391.8304084795664;3411.812350320756;33479.33041339184;34020.149496262544;34621.480677789856;34692;34709.47935780965;4370.737755734666;4434.623057040156;4480.551944805526;4483.775811209426;4522.34426008227;339457;340869;342581;342756;342854;58974;59263.40736592665;59329.40670593325;59352.70323648354;59371.70314148402;55827;56299.71850140723;56314;56372.15441768377;56417;16723.749143762852;17103.23035463407;17108.486745397408;17116.65766684684;17119.315227390765;12900.612981610566;12942.805857912139;12956;12971.935140324238;12989.41547630359;16363.83636163647;17312.653746924992;17420.651586968444;17521.474355769347;17666.646667066587;6471.9029214561815;6502.512311576651;6533.509986751013;6556.508261880283;6592.670366481657;981.8919918808925;1010.5503051142172;1041.890601486848;1075.295681328731;1182.4442512019336;33248.3350332992;33320.83377081839;33563.496547551804;33813.49279760806;33846.47378923451;882.2809410330689;1115.682030621269;1121.2263538158645;1186.2289511817214;1190.9579118271513;16424.425145119865;16951;16984.405545806083;16993.150342482826;17175.656486870193;561138;567908;568511;568663;568798;59445.70277148586;59609.701951489966;59620;59762.402375976555;59854.40145598575;1238.0900038471716;1287.7102651903433;1306.875846794553;1367.9384427700777;1387.2994137960266;33590.3281934355;35768;36068.63931360653;38326.61673383231;38331.23337533178;54100.729496353844;54857.72571137119;59910;60218;60393.69803151132;472458;477952;479942;482314;483272;45596.31605525853;46440.53559464497;46841.53158468508;46948.7652561735;49002.264966026254;50490.747546262035;50511;51260.23109653433;51504.712382190744;51747;42961.57038429576;44850.775746121064;45045.32432013457;45220.54779452295;45238.77380613076;43496.34755478607;44284.84866545516;44339.55660443354;44726;45254.773726131156;44123.77938110417;44143.55856441394;44304.778476107414;44338.55661443473;45030.54969450395;35124.82437587796;37978.62021379861;38233.80883095678;38361.808190958865;39400.605993939695;29135;29346.853265733534;29477.26306842346;29814;29968.700312996592 11:34:28 INFO - PROCESS | 30906 | |2;jquery.html;365.786015181119;370.09696340928133;376.79088106101113;381.6469765466943;392.2351414741253;18276.90861545692;19559.608807823835;19730.21079156832;20205.494862628442;20429.387118386436;17911.373101941434;18621.813781862176;19017.049147542635;19102.808971910275;19147.138378772954;5095.617828662856;5342.626016178869;5346.946530534684;5353.759080841352;5374.865628359303;5121.206213036985;5212.713300768456;5253.711045892474;5265.078611243017;5267.1309233976535;5242.580593552507;5250.6324557281005;5250.842474725764;5252.317198764155;5257.973710131444;5166.17341225404;5249.685018898859;5561.721913904309;5623.578231632603;5643.915341269884;4985.950140498585;4988.775505102243;4990.500949905017;5004.049230646166;5008.273800298973;13850.09974351664;14125.78811317831;14127;14245.358958846877;18405.171767270505;2292.839501234914;2322.8722420266877;2425.9029638814427;2478.95042099157;2502.3744063984004;9980.55087521056;10057.446840423774;10100;10575.947120264427;10601.469926503643;1904.666932588746;1914.5309399197147;1926.5376309685714;1952.0727654364064;1966.9016549172484;78659;78849.60575197145;81045;81715;82677.58661206656;9369.672061477815;9446.102620251066;9768.462734549526;9797.412155270707;10057.195424366033;13423.530176443777;13457.865421345661;13462.192268463923;13482.258475783927;13495;7289.890651640229;7599.810004749815;7605.23947605235;7720.034995625547;7727.1886451922865;7461.85076298471;7568.243175682388;7732.922670773332;7743.303102720783;7775.066991961001;4132.628063474302;4282.186384586918;4409.801558929792;4652.883677908012;4790.281457781361;1778.48423957051;1808.9457316280532;1848.112905805221;1868.719692046204;1944.4847115514401;902.566767951387;923.0769230769231;996.875390576178;1018.9847152292722;1068.7702144038913;20419.4895127623;20751.377458676263;20781.376558703265;20793.584128317652;20866.791332086486;965.8937516873139;966.5795379010153;970.2383628851318;996.3971797062818;1026.1226651213105;10595.576176952836;11191.72020699489;11251.156163287786;11284.21010529255;11290.491927863266;165673;165688;165896;166085;166396.16801916156;88705.55647221723;89411;89729.55135224282;91198;93052;928.5403725156091;952.2619969523674;973.2068364283086;979.4221409368507;982.6364245229311;17261;17681.911590441967;17887.73168402501;17922.91038544799;18087.457376278733;41750.16499670051;41949.79025104855;42329.5767042338;43107.568924310355;43483.78258108689;57033.714831425576;57596.424035759104;57822.4217757817;58884.705576471846;59305;6668.499862510234;7656.387489000978;7687.846243075219;7905.56519391439;8137.430379873352;11646;12985.350732463528;13025.934870325587;13120.409581569043;13253.602391928258;11528.481218345363;11738.647840564796;11759.823602645796;11788;12013.939930300292;11316.660500184678;11373.260738052;11630.476628551567;11647.417629118341;11976.401179941142;11465.942670286595;11501.424928753697;11690.88309116932;11706.70733231676;12255.816162757745;7230.168530618836;7391.445641577011;7570.772876813704;7646.273604007611;8034.83930321402;11430.71423214393;11662.70843228926;11945;12087.153899226969;12160.513579456723 11:34:28 INFO - PROCESS | 30906 | |3;mootools.html;1298.2794549025286;1430.5779794960486;1502.2638906935601;1595.3937503748573;1753.7632419623346;8446.113158118393;8764.03595604483;8784.077671844452;9090.727278181665;9141.77145571361;8994.68518601849;9067.546622668873;9076.773080672987;9081.228095611865;9082.182603565678;2355.081518207896;2388.8088952883813;2393.712754469457;2393.9281821545383;2395;2395.700537432821;2419.177479656916;2452.2520631207476;2456.6192240202795;2457.606782914734;2320.3734991552355;2358.811295096388;2366.443885686871;2370.502194539149;2391.390195500145;2311.7572654871165;2313.9652905206435;2338.3920180752957;2340.052278827069;2370.194133994433;2294.9426264343356;2314.756950520188;2334.3113781434517;2337.0885354711677;2337.415646088478;8859.778505537348;8935.463872167691;8982.326325525546;9043.41217820846;9051.954740226256;5090.083784918713;5173.146430838945;5191.896162076738;5193.662411943249;5207.218917162418;3331.53358529806;3335.9589024130455;3391.559097317333;3400.4559270516597;3427.7771944823508;1142.4801715219555;1143.3711458697683;1908.0841196225751;1910.646530391882;1932.21745193197;12335.321557314344;12367;12402.81395779064;12454.688632784162;12482.43829027696;4340;4419.18245124653;4546.4544254689645;4551.089782043605;4557.361969324297;9783.951080244553;9789.140063387933;9790.265730070274;9793.706188814347;9794.020597940149;5176.3270774799785;5183.714895680774;5200.24596433515;5209.01028804526;5213.843584692465;4000.299947509174;4287.678424118141;4412.42638457005;4845.685030473008;4882.218844984785;3845.3655146901006;3892.1048158923604;3983.382575700771;4001.899952501211;4006.8797936061965;1116.6203490813164;1168.474186616009;1172.1677608897608;1172.695099274195;1189.6133756529164;902.6660135749814;917.5458148216676;1004.638330201127;1012.2205901455837;1013.2198207380276;6056.636601803906;6074;6110.7861224856915;6139.171211886427;6236.970899801482;437.8423767443718;443.74041185905963;444.27583039645174;452.93432452294235;453.47623494863484;4111.588841115865;4154.522229943595;4164.104717485755;4179.080602267496;4210.073783767566;10863.40251286171;11301.208915375844;11315.321080735182;11326;11355.659330220107;11216.719582010352;11261.099112071015;11270.54917803295;11289.0968722502;11296.717582060513;8024.839503209903;8249.711260105867;8333.708320208763;8550.358723095793;8563.871541926876;5979.760809567742;6032.1856549365275;6120.296165940974;6123.234595675541;6228.003519436868;10429.791404172025;10463.529141188512;10593.841092383775;10594.947025264824;10611.946940265248;9479.763005924631;10311.690649280534;10398.896011040095;10621.575136994434;10738.248322617343;7709.7301594443925;7895.447318687867;7920.089189743023;8167.754967350989;8171.142030086755;8182.877256841271;8493.91506084956;8538.060813310407;8572.65709371643;8584.227419532272;7258.274172582699;7328.96335518319;7597.050368703912;7620.69517219305;7691.538507689556;7609.277118673717;7623.618819059136;7655.655495502604;7783.416243781852;7854.842903142019;7197.604131772803;7241.674124664508;7260.96369518149;7298.671559779928;7379.741709040158;4999.200127979506;5052.747362631927;5096.668716533413;5120.539151476385;5181.948180518147;5171.9482805171465;5197.4542673020305;5301.522862942354;5357.70532620694;5434.130539113723 11:34:28 INFO - PROCESS | 30906 | |4;prototype.html;312.8060602426496;313.09827696234856;318.6558516801855;328.9490129030001;333.8831409006846;5067.923981140286;5157.3295471588735;5187.766550505227;5225.634205605605;5241.475852414761;5127.359080114986;5143.81996630118;5155.71643559604;5171.655369603902;5173.8787097290115;4071;4080.367543030835;4082;4086;4136.028033412145;3934.488516492852;4082.5509193988637;4099.036726369316;4123.670106391482;4154.646855017312;3998.6001399860074;4051.1695102504063;4055.229506393776;4069.8779036628803;4072.328065869128;4013.598640135978;4035.354343305072;4038.717289789716;4042.979785101085;4046.6964977626503;3467.3932061889323;3572.821358932069;3583.4087375583;3585.2650206707563;3606.683560500425;5025.321581586476;5049.293098966147;5053.494650534917;5070.974645126751;5077.314562534048;4570.177368073745;4616.976915115437;4626.375439315717;4626.976865115686;4628.305754136906;5134.743262836843;5347.759350829222;5364.249005139283;5374.140137578008;5416.512513873731;3883.2427676603074;3883.475730776337;3895.824687889052;3911.1786524829536;3918.5493668228232;5633.408492108351;5636.859078523029;5637.379888212294;5659.51894089003;5678.375378708298;3896.337622604164;3992.642501549487;4001.1197536541913;4006.338954072545;4013.418054382098;4031.4557534732435;4036.57615950321;4038.818253178614;4065.4918135233097;4089.7137200395687;4616.422947131608;4622.260438329851;4650.581447669726;4658.487566367697;4661.790219440133;5247.9737601311745;5394.811181608625;5409.215663728737;5474.452554744494;5474.877650081724;1356.7286542691304;1384.439302082658;1384.8615138486273;1386.9167849928835;1397.2943663450096;866.181458521691;891.9598618062203;904.9140331668481;911.9239297628861;915.6017132547363;4643.490865468736;4705.64707646921;4711.845597828554;4732.550407711262;4744.644151688637;4951.900961980812;4959.776810043557;4963.131451995886;4982.953579748293;5055.649123157749;4377.715448495837;4668.789904454307;4702.811887524461;4706.95293047072;4733.502982186821;2612.7517885800817;2630.855302958356;2651.2576478586025;2663.414048909237;2668.2389622848827;5180.948190518122;5183.304681565564;5193.246979187997;5200.349956255468;5234.345706786652;4805.10786263128;4972.687700219343;5027.824026159067;5029.64792464524;5080.034793389244;5141.331626888556;5156.92264616031;5180.663256888291;5231.044459880156;5242.659227150223;5032.320636714143;5041.747912604428;5049.394072711299;5095.41402738675;5104.668196567211;4746.928796067993;4876.341693871282;4920.507949205051;4940.851774446773;4945.357103576512;5069.949300506948;5112.565431938327;5120.257562653469;5182.2898443514305;5205.817796377109;3647.231092919985;3752.0994961208567;3833.5208098987628;3933.7639741615594;3957.881263562098;5507.972460137674;5515.69663668486;5532.197831314517;5537.335519737658;5538;5381.946180538144;5388.434214407587;5391.865203369947;5427;5440;5179.792808287626;5259.8422047338645;5297.549708274686;5311.920321195263;5366.382865970463;5322.680639161508;5332.866678333073;5360.839174824761;5363.678179309254;5366.946330536644;5204.9739751301;5355.732213389393;5377.623566350318;5384.488473595002;5451.264079349237;5332.22682710997;5346.823698786417;5353.143497040611;5355.866103347292;5356.946430535801 11:34:28 INFO - PROCESS | 30906 | |5;yui.html;793.3018943329869;804.851102546029;806.4919100966387;834.849727049131;840.5125027484053;13261.138026028302;14101.929490352533;14144.434222631095;14144.787828182572;14199.14805111694;13084;13442.327883605805;13551.25468099254;13682.794758078637;13688.178709277425;780.445883422769;805.1948051948052;807.4267270238138;807.8424707182102;808.8058865872177;654.3358491131481;789.1004255149135;807.9919200808005;811.8498077855616;815.6166601697192;854.692310768123;855.0252711908429;857.5155037403878;857.9613917373701;857.9656813727444;844.6790219716469;845.188618925832;845.3068483843251;845.6575087089708;846.0228436156187;505.39100384037147;599.8470390050553;614.594367717309;619.5353484886335;621.3041393639108;12962.935185324108;13053.673658158526;13060.934695326558;13093.607191784262;13139.474421023147;13490.325483725872;14397.136171829723;14413.351399187062;14494.202818844959;14648.560543183616;13181.934090329583;13221.338933053308;13239.40422680972;13269.933650331783;13384.464621415229;4081.0435526977026;4147.460830092099;4207.305794543897;4254.191703576311;4315.805788739514;73120.26879731241;74347.62826185889;75212;75578.24421755767;76801.99999999945;9827.656032038987;9867.708629629058;10101.848472272923;10336.844947325797;10414.114800241912;19870.50323741918;19943.301984430764;19947;19974.90012549928;19977.500562485762;8194.549299788569;8195.836083278302;8248.175182481704;8429.831403371898;8461.2807911327;4737.644676649265;4832.206717726568;4846.588040016568;4884.096442158212;4902.852914412573;3360.899173024813;3428.5200071989943;3430.073880052422;3437.1922598189403;3441.346144232588;607.271274470637;616.5684021185189;628.7579281976472;632.2886752403546;633.5027003801994;718.4791026505742;728.4609389052064;734.6363550042763;740.6074780366414;743.2975837833196;9391.248700103975;9413.529323533796;9606.375585586915;9652.179564737076;9794.314397992215;626.9686515674198;629.8960671489153;710.8400609862842;738.6159197217416;783.6121120045614;4662.7668616569035;4849.703766817937;4993.60818152765;5205.115130427761;5270.552003079782;113696.43151784188;114464;114588.42705786417;114598;118621.40689296498;58553;70593.64703176451;98468;99587;101350;86730;88914;88941.55529222313;91562.08437915669;91892;9344.205742511962;9435.292353073684;9510.47692376926;9632.711018669452;9819.509024548886;50197.24704129368;52357.47642523526;52431;52499.47500524946;53544.19683704826;61557;73238.63380683062;73428.63285683538;75022.6248868774;75087.62456187684;11867.516560429945;11898.702532436759;11912.702182445508;11949.402529873298;12285.938570307091;13269.66825829362;13338.26639534835;13681.179129252278;14349.139051656934;14440.711185776436;13470.393832277767;13477;13899.791503127259;14065.929670351583;14401.351939162554;13288.202707837561;13421.060525763103;13731.176129432266;13884.652883677989;14191.787123192953;12515.374231288217;12577.748445030866;12637.2417654941;13129.474821007052;13278.203307801563;10307.484625768831;10365.274430789772;10435.32170408921;10645.733856653336;10805.081568066802;10088.949555252177;10783.51474183648;11118.166137539878;11177.329360238411;11196.66410007701 11:34:28 INFO - PROCESS | 30906 | __end_tp_report 11:34:28 INFO - PROCESS | 30906 | __start_cc_report 11:34:28 INFO - PROCESS | 30906 | _x_x_mozilla_cycle_collect,1019 11:34:28 INFO - PROCESS | 30906 | __end_cc_report 11:34:28 INFO - PROCESS | 30906 | __startTimestamp1469903668085__endTimestamp 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | ------- Summary: start ------- 11:34:28 INFO - PROCESS | 30906 | Number of tests: 6 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | [#0] dojo.html Cycles:165 Average:5337.95 Median:5542.70 stddev:621.87 (11.2%) stddev-sans-first:596.44 11:34:28 INFO - PROCESS | 30906 | Values: 3013.0 3014.1 3038.2 3043.5 3050.5 5268.8 5270.5 5273.9 5367.8 5418.7 5341.1 5375.8 5386.4 5415.5 5455.0 4848.7 4884.3 4890.7 4911.1 5033.6 4919.8 4965.3 4970.7 4971.2 4987.3 4791.9 4807.7 4857.0 4862.3 4899.8 4859.0 4869.1 4885.5 4939.9 4971.8 4868.9 4910.5 4910.9 4918.8 4952.8 5226.4 5270.7 5413.5 5444.7 5471.2 5708.5 5782.4 5802.4 5808.9 5811.2 5787.8 5793.5 5819.5 5823.9 5841.4 5188.2 5295.7 5329.4 5441.2 5443.8 5921.5 5934.9 5941.1 5944.2 5956.9 5714.3 5715.2 5715.9 5717.9 5722.1 5542.7 5588.3 5647.2 5798.9 5802.6 5604.9 5632.5 5676.7 5716.1 5727.7 5565.3 5571.2 5608.7 5615.0 5617.7 4281.1 4329.5 4331.8 4353.5 4392.0 3925.4 3944.5 3949.9 3951.4 3951.4 5342.7 5354.1 5371.9 5402.4 5423.5 5785.5 5792.4 5814.8 5824.0 5842.4 5290.7 5328.6 5335.1 5338.3 5365.4 4841.1 4945.6 4967.4 4968.7 5009.4 5996.4 6079.9 6132.1 6137.4 6141.0 5771.2 5785.5 5837.9 5840.2 5842.1 5899.9 6008.2 6008.2 6012.1 6018.8 5589.8 5619.7 5628.6 5643.1 5709.4 5709.6 5716.9 5721.0 5721.9 5731.2 5462.8 5586.2 5591.4 5597.0 5599.7 5525.8 5615.1 5626.8 5646.1 5686.1 5574.9 5611.6 5617.0 5630.7 5633.8 5425.9 5675.7 5720.8 5729.0 5729.4 5441.7 5465.9 5493.7 5534.2 5558.2 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | [#1] ext.html Cycles:180 Average:63587.49 Median:45037.94 stddev:125115.55 (277.8%) stddev-sans-first:125377.13 11:34:28 INFO - PROCESS | 30906 | Values: 589.5 607.4 611.8 615.1 620.6 43464.8 44468.1 44715.6 47923.0 48024.3 46013.5 46688.8 46717.3 46745.3 46767.0 9026.2 9140.2 9165.8 9165.8 9167.5 9072.9 9133.2 9150.5 9167.7 9171.7 9109.8 9185.7 9200.6 9211.7 9216.7 9140.1 9167.3 9168.3 9177.0 9179.5 8970.8 9012.5 9021.5 9021.8 9035.6 44124.8 44361.6 44576.1 44631.0 44740.0 3288.6 3326.2 3361.3 3391.8 3411.8 33479.3 34020.1 34621.5 34692.0 34709.5 4370.7 4434.6 4480.6 4483.8 4522.3 339457.0 340869.0 342581.0 342756.0 342854.0 58974.0 59263.4 59329.4 59352.7 59371.7 55827.0 56299.7 56314.0 56372.2 56417.0 16723.7 17103.2 17108.5 17116.7 17119.3 12900.6 12942.8 12956.0 12971.9 12989.4 16363.8 17312.7 17420.7 17521.5 17666.6 6471.9 6502.5 6533.5 6556.5 6592.7 981.9 1010.6 1041.9 1075.3 1182.4 33248.3 33320.8 33563.5 33813.5 33846.5 882.3 1115.7 1121.2 1186.2 1191.0 16424.4 16951.0 16984.4 16993.2 17175.7 561138.0 567908.0 568511.0 568663.0 568798.0 59445.7 59609.7 59620.0 59762.4 59854.4 1238.1 1287.7 1306.9 1367.9 1387.3 33590.3 35768.0 36068.6 38326.6 38331.2 54100.7 54857.7 59910.0 60218.0 60393.7 472458.0 477952.0 479942.0 482314.0 483272.0 45596.3 46440.5 46841.5 46948.8 49002.3 50490.7 50511.0 51260.2 51504.7 51747.0 42961.6 44850.8 45045.3 45220.5 45238.8 43496.3 44284.8 44339.6 44726.0 45254.8 44123.8 44143.6 44304.8 44338.6 45030.5 35124.8 37978.6 38233.8 38361.8 39400.6 29135.0 29346.9 29477.3 29814.0 29968.7 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | [#2] jquery.html Cycles:180 Average:19564.77 Median:379.22 stddev:32129.94 (8472.7%) stddev-sans-first:32187.74 11:34:28 INFO - PROCESS | 30906 | Values: 365.8 370.1 376.8 381.6 392.2 18276.9 19559.6 19730.2 20205.5 20429.4 17911.4 18621.8 19017.0 19102.8 19147.1 5095.6 5342.6 5346.9 5353.8 5374.9 5121.2 5212.7 5253.7 5265.1 5267.1 5242.6 5250.6 5250.8 5252.3 5258.0 5166.2 5249.7 5561.7 5623.6 5643.9 4986.0 4988.8 4990.5 5004.0 5008.3 13850.1 14125.8 14127.0 14245.4 18405.2 2292.8 2322.9 2425.9 2479.0 2502.4 9980.6 10057.4 10100.0 10575.9 10601.5 1904.7 1914.5 1926.5 1952.1 1966.9 78659.0 78849.6 81045.0 81715.0 82677.6 9369.7 9446.1 9768.5 9797.4 10057.2 13423.5 13457.9 13462.2 13482.3 13495.0 7289.9 7599.8 7605.2 7720.0 7727.2 7461.9 7568.2 7732.9 7743.3 7775.1 4132.6 4282.2 4409.8 4652.9 4790.3 1778.5 1808.9 1848.1 1868.7 1944.5 902.6 923.1 996.9 1019.0 1068.8 20419.5 20751.4 20781.4 20793.6 20866.8 965.9 966.6 970.2 996.4 1026.1 10595.6 11191.7 11251.2 11284.2 11290.5 165673.0 165688.0 165896.0 166085.0 166396.2 88705.6 89411.0 89729.6 91198.0 93052.0 928.5 952.3 973.2 979.4 982.6 17261.0 17681.9 17887.7 17922.9 18087.5 41750.2 41949.8 42329.6 43107.6 43483.8 57033.7 57596.4 57822.4 58884.7 59305.0 6668.5 7656.4 7687.8 7905.6 8137.4 11646.0 12985.4 13025.9 13120.4 13253.6 11528.5 11738.6 11759.8 11788.0 12013.9 11316.7 11373.3 11630.5 11647.4 11976.4 11465.9 11501.4 11690.9 11706.7 12255.8 7230.2 7391.4 7570.8 7646.3 8034.8 11430.7 11662.7 11945.0 12087.2 12160.5 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | [#3] mootools.html Cycles:180 Average:5851.98 Median:453.21 stddev:3363.25 (742.1%) stddev-sans-first:3355.27 11:34:28 INFO - PROCESS | 30906 | Values: 1298.3 1430.6 1502.3 1595.4 1753.8 8446.1 8764.0 8784.1 9090.7 9141.8 8994.7 9067.5 9076.8 9081.2 9082.2 2355.1 2388.8 2393.7 2393.9 2395.0 2395.7 2419.2 2452.3 2456.6 2457.6 2320.4 2358.8 2366.4 2370.5 2391.4 2311.8 2314.0 2338.4 2340.1 2370.2 2294.9 2314.8 2334.3 2337.1 2337.4 8859.8 8935.5 8982.3 9043.4 9052.0 5090.1 5173.1 5191.9 5193.7 5207.2 3331.5 3336.0 3391.6 3400.5 3427.8 1142.5 1143.4 1908.1 1910.6 1932.2 12335.3 12367.0 12402.8 12454.7 12482.4 4340.0 4419.2 4546.5 4551.1 4557.4 9784.0 9789.1 9790.3 9793.7 9794.0 5176.3 5183.7 5200.2 5209.0 5213.8 4000.3 4287.7 4412.4 4845.7 4882.2 3845.4 3892.1 3983.4 4001.9 4006.9 1116.6 1168.5 1172.2 1172.7 1189.6 902.7 917.5 1004.6 1012.2 1013.2 6056.6 6074.0 6110.8 6139.2 6237.0 437.8 443.7 444.3 452.9 453.5 4111.6 4154.5 4164.1 4179.1 4210.1 10863.4 11301.2 11315.3 11326.0 11355.7 11216.7 11261.1 11270.5 11289.1 11296.7 8024.8 8249.7 8333.7 8550.4 8563.9 5979.8 6032.2 6120.3 6123.2 6228.0 10429.8 10463.5 10593.8 10594.9 10611.9 9479.8 10311.7 10398.9 10621.6 10738.2 7709.7 7895.4 7920.1 8167.8 8171.1 8182.9 8493.9 8538.1 8572.7 8584.2 7258.3 7329.0 7597.1 7620.7 7691.5 7609.3 7623.6 7655.7 7783.4 7854.8 7197.6 7241.7 7261.0 7298.7 7379.7 4999.2 5052.7 5096.7 5120.5 5181.9 5171.9 5197.5 5301.5 5357.7 5434.1 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | [#4] prototype.html Cycles:180 Average:4413.85 Median:5004.14 stddev:1266.52 (25.3%) stddev-sans-first:1232.10 11:34:28 INFO - PROCESS | 30906 | Values: 312.8 313.1 318.7 328.9 333.9 5067.9 5157.3 5187.8 5225.6 5241.5 5127.4 5143.8 5155.7 5171.7 5173.9 4071.0 4080.4 4082.0 4086.0 4136.0 3934.5 4082.6 4099.0 4123.7 4154.6 3998.6 4051.2 4055.2 4069.9 4072.3 4013.6 4035.4 4038.7 4043.0 4046.7 3467.4 3572.8 3583.4 3585.3 3606.7 5025.3 5049.3 5053.5 5071.0 5077.3 4570.2 4617.0 4626.4 4627.0 4628.3 5134.7 5347.8 5364.2 5374.1 5416.5 3883.2 3883.5 3895.8 3911.2 3918.5 5633.4 5636.9 5637.4 5659.5 5678.4 3896.3 3992.6 4001.1 4006.3 4013.4 4031.5 4036.6 4038.8 4065.5 4089.7 4616.4 4622.3 4650.6 4658.5 4661.8 5248.0 5394.8 5409.2 5474.5 5474.9 1356.7 1384.4 1384.9 1386.9 1397.3 866.2 892.0 904.9 911.9 915.6 4643.5 4705.6 4711.8 4732.6 4744.6 4951.9 4959.8 4963.1 4983.0 5055.6 4377.7 4668.8 4702.8 4707.0 4733.5 2612.8 2630.9 2651.3 2663.4 2668.2 5180.9 5183.3 5193.2 5200.3 5234.3 4805.1 4972.7 5027.8 5029.6 5080.0 5141.3 5156.9 5180.7 5231.0 5242.7 5032.3 5041.7 5049.4 5095.4 5104.7 4746.9 4876.3 4920.5 4940.9 4945.4 5069.9 5112.6 5120.3 5182.3 5205.8 3647.2 3752.1 3833.5 3933.8 3957.9 5508.0 5515.7 5532.2 5537.3 5538.0 5381.9 5388.4 5391.9 5427.0 5440.0 5179.8 5259.8 5297.5 5311.9 5366.4 5322.7 5332.9 5360.8 5363.7 5366.9 5205.0 5355.7 5377.6 5384.5 5451.3 5332.2 5346.8 5353.1 5355.9 5356.9 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - PROCESS | 30906 | [#5] yui.html Cycles:180 Average:20186.74 Median:4948.23 stddev:29276.06 (591.6%) stddev-sans-first:29321.97 11:34:28 INFO - PROCESS | 30906 | Values: 793.3 804.9 806.5 834.8 840.5 13261.1 14101.9 14144.4 14144.8 14199.1 13084.0 13442.3 13551.3 13682.8 13688.2 780.4 805.2 807.4 807.8 808.8 654.3 789.1 808.0 811.8 815.6 854.7 855.0 857.5 858.0 858.0 844.7 845.2 845.3 845.7 846.0 505.4 599.8 614.6 619.5 621.3 12962.9 13053.7 13060.9 13093.6 13139.5 13490.3 14397.1 14413.4 14494.2 14648.6 13181.9 13221.3 13239.4 13269.9 13384.5 4081.0 4147.5 4207.3 4254.2 4315.8 73120.3 74347.6 75212.0 75578.2 76802.0 9827.7 9867.7 10101.8 10336.8 10414.1 19870.5 19943.3 19947.0 19974.9 19977.5 8194.5 8195.8 8248.2 8429.8 8461.3 4737.6 4832.2 4846.6 4884.1 4902.9 3360.9 3428.5 3430.1 3437.2 3441.3 607.3 616.6 628.8 632.3 633.5 718.5 728.5 734.6 740.6 743.3 9391.2 9413.5 9606.4 9652.2 9794.3 627.0 629.9 710.8 738.6 783.6 4662.8 4849.7 4993.6 5205.1 5270.6 113696.4 114464.0 114588.4 114598.0 118621.4 58553.0 70593.6 98468.0 99587.0 101350.0 86730.0 88914.0 88941.6 91562.1 91892.0 9344.2 9435.3 9510.5 9632.7 9819.5 50197.2 52357.5 52431.0 52499.5 53544.2 61557.0 73238.6 73428.6 75022.6 75087.6 11867.5 11898.7 11912.7 11949.4 12285.9 13269.7 13338.3 13681.2 14349.1 14440.7 13470.4 13477.0 13899.8 14065.9 14401.4 13288.2 13421.1 13731.2 13884.7 14191.8 12515.4 12577.7 12637.2 13129.5 13278.2 10307.5 10365.3 10435.3 10645.7 10805.1 10088.9 10783.5 11118.2 11177.3 11196.7 11:34:28 INFO - PROCESS | 30906 | -------- Summary: end -------- 11:34:28 INFO - PROCESS | 30906 | 11:34:28 INFO - TEST-INFO | 30906: exit 0 11:34:28 INFO - TEST-OK | dromaeo_css | took 1115189ms 11:34:28 INFO - TEST-START | kraken 11:34:28 INFO - operating with platform_type : linux_ 11:34:28 INFO - Initialising browser for kraken test... 11:34:28 INFO - TEST-INFO | started process 31096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VFbW1/profile http://localhost:55660/getInfo.html) 11:34:33 INFO - PROCESS | 31096 | __metrics Screen width/height:1600/1200 11:34:33 INFO - PROCESS | 31096 | colorDepth:24 11:34:33 INFO - PROCESS | 31096 | Browser inner width/height: 1024/697 11:34:33 INFO - PROCESS | 31096 | __metrics 11:34:34 INFO - PROCESS | 31096 | 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" 11:34:34 INFO - PROCESS | 31096 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:35 INFO - TEST-INFO | 31096: exit 0 11:34:35 INFO - Browser initialized. 11:34:35 INFO - Running cycle 1/1 for kraken test... 11:34:35 INFO - TEST-INFO | started process 31177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VFbW1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:47 INFO - PROCESS | 31177 | RSS: Main: 156332032 11:34:47 INFO - PROCESS | 31177 | 11:34:50 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55660/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:50 INFO - PROCESS | 31177 | RSS: Main: 213225472 11:34:50 INFO - PROCESS | 31177 | 11:34:53 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55660/tests/kraken/driver.html?testName=audio-dft) 11:34:54 INFO - PROCESS | 31177 | RSS: Main: 191315968 11:34:54 INFO - PROCESS | 31177 | 11:34:57 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55660/tests/kraken/driver.html?testName=audio-fft) 11:34:57 INFO - PROCESS | 31177 | RSS: Main: 270090240 11:34:57 INFO - PROCESS | 31177 | 11:35:00 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55660/tests/kraken/driver.html?testName=audio-oscillator) 11:35:00 INFO - PROCESS | 31177 | RSS: Main: 179765248 11:35:00 INFO - PROCESS | 31177 | 11:35:02 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:03 INFO - PROCESS | 31177 | RSS: Main: 183984128 11:35:03 INFO - PROCESS | 31177 | 11:35:06 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55660/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:06 INFO - PROCESS | 31177 | RSS: Main: 219193344 11:35:06 INFO - PROCESS | 31177 | 11:35:10 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55660/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:10 INFO - PROCESS | 31177 | RSS: Main: 219242496 11:35:10 INFO - PROCESS | 31177 | 11:35:13 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55660/tests/kraken/driver.html?testName=json-parse-financial) 11:35:14 INFO - PROCESS | 31177 | RSS: Main: 219615232 11:35:14 INFO - PROCESS | 31177 | 11:35:15 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:16 INFO - PROCESS | 31177 | RSS: Main: 183742464 11:35:16 INFO - PROCESS | 31177 | 11:35:18 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:18 INFO - PROCESS | 31177 | RSS: Main: 188370944 11:35:18 INFO - PROCESS | 31177 | 11:35:20 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:21 INFO - PROCESS | 31177 | RSS: Main: 193785856 11:35:21 INFO - PROCESS | 31177 | 11:35:24 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:35:24 INFO - PROCESS | 31177 | RSS: Main: 187441152 11:35:24 INFO - PROCESS | 31177 | 11:35:27 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:35:27 INFO - PROCESS | 31177 | RSS: Main: 192491520 11:35:27 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | Cycle 1(1): loaded http://localhost:55660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55660/tests/kraken/driver.html?testName=ai-astar) 11:35:29 INFO - PROCESS | 31177 | RSS: Main: 243961856 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | __start_tp_report 11:35:29 INFO - PROCESS | 31177 | _x_x_mozilla_page_load 11:35:29 INFO - PROCESS | 31177 | _x_x_mozilla_page_load_details 11:35:29 INFO - PROCESS | 31177 | |i|pagename|runs| 11:35:29 INFO - PROCESS | 31177 | |0;ai-astar;102;112;111;110;112;110;111;111;110;109 11:35:29 INFO - PROCESS | 31177 | |1;audio-beat-detection;146;117;118;182;117;119;149;116;144;115 11:35:29 INFO - PROCESS | 31177 | |2;audio-dft;160;160;160;162;161;160;160;161;160;162 11:35:29 INFO - PROCESS | 31177 | |3;audio-fft;75;74;75;112;74;75;74;75;99;75 11:35:29 INFO - PROCESS | 31177 | |4;audio-oscillator;83;83;117;83;83;85;121;84;83;119 11:35:29 INFO - PROCESS | 31177 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 11:35:29 INFO - PROCESS | 31177 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;146 11:35:29 INFO - PROCESS | 31177 | |7;imaging-desaturate;95;94;94;94;95;94;95;95;94;94 11:35:29 INFO - PROCESS | 31177 | |8;json-parse-financial;55;53;53;54;53;54;58;54;53;52 11:35:29 INFO - PROCESS | 31177 | |9;json-stringify-tinderbox;62;62;62;61;62;62;63;62;62;62 11:35:29 INFO - PROCESS | 31177 | |10;stanford-crypto-aes;76;76;76;76;76;76;75;76;75;80 11:35:29 INFO - PROCESS | 31177 | |11;stanford-crypto-ccm;127;126;131;120;118;119;122;131;200;133 11:35:29 INFO - PROCESS | 31177 | |12;stanford-crypto-pbkdf2;156;159;155;164;158;158;156;156;159;158 11:35:29 INFO - PROCESS | 31177 | |13;stanford-crypto-sha256-iterative;65;63;65;62;63;61;64;62;61;61 11:35:29 INFO - PROCESS | 31177 | __end_tp_report 11:35:29 INFO - PROCESS | 31177 | __start_cc_report 11:35:29 INFO - PROCESS | 31177 | _x_x_mozilla_cycle_collect,1641 11:35:29 INFO - PROCESS | 31177 | __end_cc_report 11:35:29 INFO - PROCESS | 31177 | __startTimestamp1469903729849__endTimestamp 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | ------- Summary: start ------- 11:35:29 INFO - PROCESS | 31177 | Number of tests: 14 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.90 (2.6%) stddev-sans-first:1.00 11:35:29 INFO - PROCESS | 31177 | Values: 102.0 112.0 111.0 110.0 112.0 110.0 111.0 111.0 110.0 109.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:131.50 stddev:22.33 (17.0%) stddev-sans-first:23.13 11:35:29 INFO - PROCESS | 31177 | Values: 146.0 117.0 118.0 182.0 117.0 119.0 149.0 116.0 144.0 115.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 11:35:29 INFO - PROCESS | 31177 | Values: 160.0 160.0 160.0 162.0 161.0 160.0 160.0 161.0 160.0 162.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:13.38 (17.8%) stddev-sans-first:14.03 11:35:29 INFO - PROCESS | 31177 | Values: 75.0 74.0 75.0 112.0 74.0 75.0 74.0 75.0 99.0 75.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:17.22 (20.7%) stddev-sans-first:17.79 11:35:29 INFO - PROCESS | 31177 | Values: 83.0 83.0 117.0 83.0 83.0 85.0 121.0 84.0 83.0 119.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:35:29 INFO - PROCESS | 31177 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:35:29 INFO - PROCESS | 31177 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:35:29 INFO - PROCESS | 31177 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.66 (3.1%) stddev-sans-first:1.72 11:35:29 INFO - PROCESS | 31177 | Values: 55.0 53.0 53.0 54.0 53.0 54.0 58.0 54.0 53.0 52.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 11:35:29 INFO - PROCESS | 31177 | Values: 62.0 62.0 62.0 61.0 62.0 62.0 63.0 62.0 62.0 62.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.40 (1.8%) stddev-sans-first:1.48 11:35:29 INFO - PROCESS | 31177 | Values: 76.0 76.0 76.0 76.0 76.0 76.0 75.0 76.0 75.0 80.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:129.00 stddev:24.25 (18.8%) stddev-sans-first:25.63 11:35:29 INFO - PROCESS | 31177 | Values: 127.0 126.0 131.0 120.0 118.0 119.0 122.0 131.0 200.0 133.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:158.00 stddev:2.56 (1.6%) stddev-sans-first:2.62 11:35:29 INFO - PROCESS | 31177 | Values: 156.0 159.0 155.0 164.0 158.0 158.0 156.0 156.0 159.0 158.0 11:35:29 INFO - PROCESS | 31177 | 11:35:29 INFO - PROCESS | 31177 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.42 11:35:29 INFO - PROCESS | 31177 | Values: 65.0 63.0 65.0 62.0 63.0 61.0 64.0 62.0 61.0 61.0 11:35:29 INFO - PROCESS | 31177 | -------- Summary: end -------- 11:35:29 INFO - PROCESS | 31177 | 11:35:30 INFO - TEST-INFO | 31177: exit 0 11:35:30 INFO - TEST-OK | kraken | took 62048ms 11:35:30 INFO - SUITE-END | took 1177s 11:35:31 INFO - Completed test suite (00:19:37) 11:35:31 INFO - javascript benchmark 11:35:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3012.9849350753243, 3014.095771268619, 3038.164504761191, 3043.4978228592286, 3050.5424186372043, 5268.841934741954, 5270.525652691257, 5273.947260527393, 5367.75845086971, 5418.7019713915715, 5341.0653135701195, 5375.838724838261, 5386.380566234884, 5415.539679127279, 5454.972725136378, 4848.733319667417, 4884.291777692232, 4890.682105663138, 4911.091448082117, 5033.572146367563, 4919.77860996256, 4965.3296804931415, 4970.6520543561965, 4971.154903666367, 4987.301777751118, 4791.928121078169, 4807.687500312469, 4856.975715121437, 4862.270659401082, 4899.8040078396825, 4858.975705121487, 4869.1478991176755, 4885.487023862514, 4939.851804445872, 4971.801127954877, 4868.853934381974, 4910.459849416561, 4910.901781964377, 4918.754062296906, 4952.801887924478, 5226.3989641191365, 5270.683758974474, 5413.512783849433, 5444.673319600797, 5471.23402723619, 5708.457696518824, 5782.421757824226, 5802.448767367094, 5808.854778630568, 5811.215485909391, 5787.768489260425, 5793.478586927196, 5819.505342045931, 5823.912641310384, 5841.386654401269, 5188.221766734982, 5295.682259064469, 5329.413764485904, 5441.1838224266285, 5443.8094666686475, 5921.496672782861, 5934.851628709317, 5941.079132734433, 5944.227250457413, 5956.910646340309, 5714.2571465710025, 5715.1713001614535, 5715.942840571624, 5717.914231286534, 5722.141678748221, 5542.695151766691, 5588.30146231721, 5647.1529270609735, 5798.9420105799245, 5802.564807639444, 5604.943950560442, 5632.464915832989, 5676.68778217202, 5716.085426331767, 5727.656340619576, 5565.332160140809, 5571.247881536022, 5608.719564021782, 5614.971925140429, 5617.691026993472, 4281.100968796588, 4329.545397733255, 4331.848385306562, 4353.455818022747, 4392.0, 3925.4111883217747, 3944.4872166618156, 3949.9012524687114, 3951.407288906687, 3951.4467974483596, 5342.732863356817, 5354.143337066051, 5371.919421208685, 5402.35171779389, 5423.4847689470225, 5785.537157027427, 5792.391798861143, 5814.767409303665, 5823.970880145572, 5842.357340692521, 5290.65610735301, 5328.573714102862, 5335.119705248668, 5338.252644629755, 5365.38298095724, 4841.1285968526, 4945.579625731853, 4967.379077615298, 4968.726720030433, 5009.398872135367, 5996.400359963969, 6079.939200607937, 6132.141500189977, 6137.447629713347, 6141.017437210025, 5771.163181338598, 5785.4793068623185, 5837.94162058374, 5840.1531777892815, 5842.123681447647, 5899.941000590111, 6008.188894499187, 6008.24896887889, 6012.128241405059, 6018.8194354169445, 5589.77640894376, 5619.662820230636, 5628.577856660685, 5643.097104463266, 5709.429057094258, 5709.628874123168, 5716.942830571641, 5720.971395142998, 5721.942780572141, 5731.168980497721, 5462.754176062166, 5586.190002449704, 5591.384947655836, 5596.972015139898, 5599.748011339581, 5525.751341189736, 5615.073512870331, 5626.774929002794, 5646.124850648156, 5686.061799802987, 5574.86062848432, 5611.607187496836, 5617.0, 5630.74661640219, 5633.802816901389, 5425.918611220756, 5675.659460432387, 5720.799772007959, 5729.0, 5729.427057294237, 5441.673499590037, 5465.890682186255, 5493.670379777226, 5534.1975413565615, 5558.221848941233], "value": 5294.605207100088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4900910712236, 607.4108115128325, 611.8164550634808, 615.1142355008789, 620.6245221640908, 43464.782676086616, 44468.11063778723, 44715.552844471546, 47923.0, 48024.27963580549, 46013.53986460134, 46688.766556167175, 46717.29924051142, 46745.29882051764, 46767.0, 9026.187643112102, 9140.177384035436, 9165.770855728593, 9165.816683666357, 9167.495787731672, 9072.909270907272, 9133.223675987516, 9150.542472876363, 9167.724968250963, 9171.678991235309, 9109.817803643957, 9185.678501252458, 9200.585973631203, 9211.723648290563, 9216.723498295061, 9140.131687489678, 9167.26661867049, 9168.266538676957, 9177.0, 9179.49512776797, 8970.775730606721, 9012.459252444874, 9021.458712477206, 9021.774455638595, 9035.593398297093, 44124.77937610292, 44361.556384436386, 44576.10847783059, 44631.0, 44740.0, 3288.6053673559086, 3326.234965957819, 3361.2605226850296, 3391.8304084795664, 3411.812350320756, 33479.33041339184, 34020.149496262544, 34621.480677789856, 34692.0, 34709.47935780965, 4370.737755734666, 4434.623057040156, 4480.551944805526, 4483.775811209426, 4522.34426008227, 339457.0, 340869.0, 342581.0, 342756.0, 342854.0, 58974.0, 59263.40736592665, 59329.40670593325, 59352.70323648354, 59371.70314148402, 55827.0, 56299.71850140723, 56314.0, 56372.15441768377, 56417.0, 16723.749143762852, 17103.23035463407, 17108.486745397408, 17116.65766684684, 17119.315227390765, 12900.612981610566, 12942.805857912139, 12956.0, 12971.935140324238, 12989.41547630359, 16363.83636163647, 17312.653746924992, 17420.651586968444, 17521.474355769347, 17666.646667066587, 6471.9029214561815, 6502.512311576651, 6533.509986751013, 6556.508261880283, 6592.670366481657, 981.8919918808925, 1010.5503051142172, 1041.890601486848, 1075.295681328731, 1182.4442512019336, 33248.3350332992, 33320.83377081839, 33563.496547551804, 33813.49279760806, 33846.47378923451, 882.2809410330689, 1115.682030621269, 1121.2263538158645, 1186.2289511817214, 1190.9579118271513, 16424.425145119865, 16951.0, 16984.405545806083, 16993.150342482826, 17175.656486870193, 561138.0, 567908.0, 568511.0, 568663.0, 568798.0, 59445.70277148586, 59609.701951489966, 59620.0, 59762.402375976555, 59854.40145598575, 1238.0900038471716, 1287.7102651903433, 1306.875846794553, 1367.9384427700777, 1387.2994137960266, 33590.3281934355, 35768.0, 36068.63931360653, 38326.61673383231, 38331.23337533178, 54100.729496353844, 54857.72571137119, 59910.0, 60218.0, 60393.69803151132, 472458.0, 477952.0, 479942.0, 482314.0, 483272.0, 45596.31605525853, 46440.53559464497, 46841.53158468508, 46948.7652561735, 49002.264966026254, 50490.747546262035, 50511.0, 51260.23109653433, 51504.712382190744, 51747.0, 42961.57038429576, 44850.775746121064, 45045.32432013457, 45220.54779452295, 45238.77380613076, 43496.34755478607, 44284.84866545516, 44339.55660443354, 44726.0, 45254.773726131156, 44123.77938110417, 44143.55856441394, 44304.778476107414, 44338.55661443473, 45030.54969450395, 35124.82437587796, 37978.62021379861, 38233.80883095678, 38361.808190958865, 39400.605993939695, 29135.0, 29346.853265733534, 29477.26306842346, 29814.0, 29968.700312996592], "value": 20964.623977291856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.786015181119, 370.09696340928133, 376.79088106101113, 381.6469765466943, 392.2351414741253, 18276.90861545692, 19559.608807823835, 19730.21079156832, 20205.494862628442, 20429.387118386436, 17911.373101941434, 18621.813781862176, 19017.049147542635, 19102.808971910275, 19147.138378772954, 5095.617828662856, 5342.626016178869, 5346.946530534684, 5353.759080841352, 5374.865628359303, 5121.206213036985, 5212.713300768456, 5253.711045892474, 5265.078611243017, 5267.1309233976535, 5242.580593552507, 5250.6324557281005, 5250.842474725764, 5252.317198764155, 5257.973710131444, 5166.17341225404, 5249.685018898859, 5561.721913904309, 5623.578231632603, 5643.915341269884, 4985.950140498585, 4988.775505102243, 4990.500949905017, 5004.049230646166, 5008.273800298973, 13850.09974351664, 14125.78811317831, 14127.0, 14245.358958846877, 18405.171767270505, 2292.839501234914, 2322.8722420266877, 2425.9029638814427, 2478.95042099157, 2502.3744063984004, 9980.55087521056, 10057.446840423774, 10100.0, 10575.947120264427, 10601.469926503643, 1904.666932588746, 1914.5309399197147, 1926.5376309685714, 1952.0727654364064, 1966.9016549172484, 78659.0, 78849.60575197145, 81045.0, 81715.0, 82677.58661206656, 9369.672061477815, 9446.102620251066, 9768.462734549526, 9797.412155270707, 10057.195424366033, 13423.530176443777, 13457.865421345661, 13462.192268463923, 13482.258475783927, 13495.0, 7289.890651640229, 7599.810004749815, 7605.23947605235, 7720.034995625547, 7727.1886451922865, 7461.85076298471, 7568.243175682388, 7732.922670773332, 7743.303102720783, 7775.066991961001, 4132.628063474302, 4282.186384586918, 4409.801558929792, 4652.883677908012, 4790.281457781361, 1778.48423957051, 1808.9457316280532, 1848.112905805221, 1868.719692046204, 1944.4847115514401, 902.566767951387, 923.0769230769231, 996.875390576178, 1018.9847152292722, 1068.7702144038913, 20419.4895127623, 20751.377458676263, 20781.376558703265, 20793.584128317652, 20866.791332086486, 965.8937516873139, 966.5795379010153, 970.2383628851318, 996.3971797062818, 1026.1226651213105, 10595.576176952836, 11191.72020699489, 11251.156163287786, 11284.21010529255, 11290.491927863266, 165673.0, 165688.0, 165896.0, 166085.0, 166396.16801916156, 88705.55647221723, 89411.0, 89729.55135224282, 91198.0, 93052.0, 928.5403725156091, 952.2619969523674, 973.2068364283086, 979.4221409368507, 982.6364245229311, 17261.0, 17681.911590441967, 17887.73168402501, 17922.91038544799, 18087.457376278733, 41750.16499670051, 41949.79025104855, 42329.5767042338, 43107.568924310355, 43483.78258108689, 57033.714831425576, 57596.424035759104, 57822.4217757817, 58884.705576471846, 59305.0, 6668.499862510234, 7656.387489000978, 7687.846243075219, 7905.56519391439, 8137.430379873352, 11646.0, 12985.350732463528, 13025.934870325587, 13120.409581569043, 13253.602391928258, 11528.481218345363, 11738.647840564796, 11759.823602645796, 11788.0, 12013.939930300292, 11316.660500184678, 11373.260738052, 11630.476628551567, 11647.417629118341, 11976.401179941142, 11465.942670286595, 11501.424928753697, 11690.88309116932, 11706.70733231676, 12255.816162757745, 7230.168530618836, 7391.445641577011, 7570.772876813704, 7646.273604007611, 8034.83930321402, 11430.71423214393, 11662.70843228926, 11945.0, 12087.153899226969, 12160.513579456723], "value": 8574.18372752343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.2794549025286, 1430.5779794960486, 1502.2638906935601, 1595.3937503748573, 1753.7632419623346, 8446.113158118393, 8764.03595604483, 8784.077671844452, 9090.727278181665, 9141.77145571361, 8994.68518601849, 9067.546622668873, 9076.773080672987, 9081.228095611865, 9082.182603565678, 2355.081518207896, 2388.8088952883813, 2393.712754469457, 2393.9281821545383, 2395.0, 2395.700537432821, 2419.177479656916, 2452.2520631207476, 2456.6192240202795, 2457.606782914734, 2320.3734991552355, 2358.811295096388, 2366.443885686871, 2370.502194539149, 2391.390195500145, 2311.7572654871165, 2313.9652905206435, 2338.3920180752957, 2340.052278827069, 2370.194133994433, 2294.9426264343356, 2314.756950520188, 2334.3113781434517, 2337.0885354711677, 2337.415646088478, 8859.778505537348, 8935.463872167691, 8982.326325525546, 9043.41217820846, 9051.954740226256, 5090.083784918713, 5173.146430838945, 5191.896162076738, 5193.662411943249, 5207.218917162418, 3331.53358529806, 3335.9589024130455, 3391.559097317333, 3400.4559270516597, 3427.7771944823508, 1142.4801715219555, 1143.3711458697683, 1908.0841196225751, 1910.646530391882, 1932.21745193197, 12335.321557314344, 12367.0, 12402.81395779064, 12454.688632784162, 12482.43829027696, 4340.0, 4419.18245124653, 4546.4544254689645, 4551.089782043605, 4557.361969324297, 9783.951080244553, 9789.140063387933, 9790.265730070274, 9793.706188814347, 9794.020597940149, 5176.3270774799785, 5183.714895680774, 5200.24596433515, 5209.01028804526, 5213.843584692465, 4000.299947509174, 4287.678424118141, 4412.42638457005, 4845.685030473008, 4882.218844984785, 3845.3655146901006, 3892.1048158923604, 3983.382575700771, 4001.899952501211, 4006.8797936061965, 1116.6203490813164, 1168.474186616009, 1172.1677608897608, 1172.695099274195, 1189.6133756529164, 902.6660135749814, 917.5458148216676, 1004.638330201127, 1012.2205901455837, 1013.2198207380276, 6056.636601803906, 6074.0, 6110.7861224856915, 6139.171211886427, 6236.970899801482, 437.8423767443718, 443.74041185905963, 444.27583039645174, 452.93432452294235, 453.47623494863484, 4111.588841115865, 4154.522229943595, 4164.104717485755, 4179.080602267496, 4210.073783767566, 10863.40251286171, 11301.208915375844, 11315.321080735182, 11326.0, 11355.659330220107, 11216.719582010352, 11261.099112071015, 11270.54917803295, 11289.0968722502, 11296.717582060513, 8024.839503209903, 8249.711260105867, 8333.708320208763, 8550.358723095793, 8563.871541926876, 5979.760809567742, 6032.1856549365275, 6120.296165940974, 6123.234595675541, 6228.003519436868, 10429.791404172025, 10463.529141188512, 10593.841092383775, 10594.947025264824, 10611.946940265248, 9479.763005924631, 10311.690649280534, 10398.896011040095, 10621.575136994434, 10738.248322617343, 7709.7301594443925, 7895.447318687867, 7920.089189743023, 8167.754967350989, 8171.142030086755, 8182.877256841271, 8493.91506084956, 8538.060813310407, 8572.65709371643, 8584.227419532272, 7258.274172582699, 7328.96335518319, 7597.050368703912, 7620.69517219305, 7691.538507689556, 7609.277118673717, 7623.618819059136, 7655.655495502604, 7783.416243781852, 7854.842903142019, 7197.604131772803, 7241.674124664508, 7260.96369518149, 7298.671559779928, 7379.741709040158, 4999.200127979506, 5052.747362631927, 5096.668716533413, 5120.539151476385, 5181.948180518147, 5171.9482805171465, 5197.4542673020305, 5301.522862942354, 5357.70532620694, 5434.130539113723], "value": 4611.045657016126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8060602426496, 313.09827696234856, 318.6558516801855, 328.9490129030001, 333.8831409006846, 5067.923981140286, 5157.3295471588735, 5187.766550505227, 5225.634205605605, 5241.475852414761, 5127.359080114986, 5143.81996630118, 5155.71643559604, 5171.655369603902, 5173.8787097290115, 4071.0, 4080.367543030835, 4082.0, 4086.0, 4136.028033412145, 3934.488516492852, 4082.5509193988637, 4099.036726369316, 4123.670106391482, 4154.646855017312, 3998.6001399860074, 4051.1695102504063, 4055.229506393776, 4069.8779036628803, 4072.328065869128, 4013.598640135978, 4035.354343305072, 4038.717289789716, 4042.979785101085, 4046.6964977626503, 3467.3932061889323, 3572.821358932069, 3583.4087375583, 3585.2650206707563, 3606.683560500425, 5025.321581586476, 5049.293098966147, 5053.494650534917, 5070.974645126751, 5077.314562534048, 4570.177368073745, 4616.976915115437, 4626.375439315717, 4626.976865115686, 4628.305754136906, 5134.743262836843, 5347.759350829222, 5364.249005139283, 5374.140137578008, 5416.512513873731, 3883.2427676603074, 3883.475730776337, 3895.824687889052, 3911.1786524829536, 3918.5493668228232, 5633.408492108351, 5636.859078523029, 5637.379888212294, 5659.51894089003, 5678.375378708298, 3896.337622604164, 3992.642501549487, 4001.1197536541913, 4006.338954072545, 4013.418054382098, 4031.4557534732435, 4036.57615950321, 4038.818253178614, 4065.4918135233097, 4089.7137200395687, 4616.422947131608, 4622.260438329851, 4650.581447669726, 4658.487566367697, 4661.790219440133, 5247.9737601311745, 5394.811181608625, 5409.215663728737, 5474.452554744494, 5474.877650081724, 1356.7286542691304, 1384.439302082658, 1384.8615138486273, 1386.9167849928835, 1397.2943663450096, 866.181458521691, 891.9598618062203, 904.9140331668481, 911.9239297628861, 915.6017132547363, 4643.490865468736, 4705.64707646921, 4711.845597828554, 4732.550407711262, 4744.644151688637, 4951.900961980812, 4959.776810043557, 4963.131451995886, 4982.953579748293, 5055.649123157749, 4377.715448495837, 4668.789904454307, 4702.811887524461, 4706.95293047072, 4733.502982186821, 2612.7517885800817, 2630.855302958356, 2651.2576478586025, 2663.414048909237, 2668.2389622848827, 5180.948190518122, 5183.304681565564, 5193.246979187997, 5200.349956255468, 5234.345706786652, 4805.10786263128, 4972.687700219343, 5027.824026159067, 5029.64792464524, 5080.034793389244, 5141.331626888556, 5156.92264616031, 5180.663256888291, 5231.044459880156, 5242.659227150223, 5032.320636714143, 5041.747912604428, 5049.394072711299, 5095.41402738675, 5104.668196567211, 4746.928796067993, 4876.341693871282, 4920.507949205051, 4940.851774446773, 4945.357103576512, 5069.949300506948, 5112.565431938327, 5120.257562653469, 5182.2898443514305, 5205.817796377109, 3647.231092919985, 3752.0994961208567, 3833.5208098987628, 3933.7639741615594, 3957.881263562098, 5507.972460137674, 5515.69663668486, 5532.197831314517, 5537.335519737658, 5538.0, 5381.946180538144, 5388.434214407587, 5391.865203369947, 5427.0, 5440.0, 5179.792808287626, 5259.8422047338645, 5297.549708274686, 5311.920321195263, 5366.382865970463, 5322.680639161508, 5332.866678333073, 5360.839174824761, 5363.678179309254, 5366.946330536644, 5204.9739751301, 5355.732213389393, 5377.623566350318, 5384.488473595002, 5451.264079349237, 5332.22682710997, 5346.823698786417, 5353.143497040611, 5355.866103347292, 5356.946430535801], "value": 4011.296168936662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.3018943329869, 804.851102546029, 806.4919100966387, 834.849727049131, 840.5125027484053, 13261.138026028302, 14101.929490352533, 14144.434222631095, 14144.787828182572, 14199.14805111694, 13084.0, 13442.327883605805, 13551.25468099254, 13682.794758078637, 13688.178709277425, 780.445883422769, 805.1948051948052, 807.4267270238138, 807.8424707182102, 808.8058865872177, 654.3358491131481, 789.1004255149135, 807.9919200808005, 811.8498077855616, 815.6166601697192, 854.692310768123, 855.0252711908429, 857.5155037403878, 857.9613917373701, 857.9656813727444, 844.6790219716469, 845.188618925832, 845.3068483843251, 845.6575087089708, 846.0228436156187, 505.39100384037147, 599.8470390050553, 614.594367717309, 619.5353484886335, 621.3041393639108, 12962.935185324108, 13053.673658158526, 13060.934695326558, 13093.607191784262, 13139.474421023147, 13490.325483725872, 14397.136171829723, 14413.351399187062, 14494.202818844959, 14648.560543183616, 13181.934090329583, 13221.338933053308, 13239.40422680972, 13269.933650331783, 13384.464621415229, 4081.0435526977026, 4147.460830092099, 4207.305794543897, 4254.191703576311, 4315.805788739514, 73120.26879731241, 74347.62826185889, 75212.0, 75578.24421755767, 76801.99999999945, 9827.656032038987, 9867.708629629058, 10101.848472272923, 10336.844947325797, 10414.114800241912, 19870.50323741918, 19943.301984430764, 19947.0, 19974.90012549928, 19977.500562485762, 8194.549299788569, 8195.836083278302, 8248.175182481704, 8429.831403371898, 8461.2807911327, 4737.644676649265, 4832.206717726568, 4846.588040016568, 4884.096442158212, 4902.852914412573, 3360.899173024813, 3428.5200071989943, 3430.073880052422, 3437.1922598189403, 3441.346144232588, 607.271274470637, 616.5684021185189, 628.7579281976472, 632.2886752403546, 633.5027003801994, 718.4791026505742, 728.4609389052064, 734.6363550042763, 740.6074780366414, 743.2975837833196, 9391.248700103975, 9413.529323533796, 9606.375585586915, 9652.179564737076, 9794.314397992215, 626.9686515674198, 629.8960671489153, 710.8400609862842, 738.6159197217416, 783.6121120045614, 4662.7668616569035, 4849.703766817937, 4993.60818152765, 5205.115130427761, 5270.552003079782, 113696.43151784188, 114464.0, 114588.42705786417, 114598.0, 118621.40689296498, 58553.0, 70593.64703176451, 98468.0, 99587.0, 101350.0, 86730.0, 88914.0, 88941.55529222313, 91562.08437915669, 91892.0, 9344.205742511962, 9435.292353073684, 9510.47692376926, 9632.711018669452, 9819.509024548886, 50197.24704129368, 52357.47642523526, 52431.0, 52499.47500524946, 53544.19683704826, 61557.0, 73238.63380683062, 73428.63285683538, 75022.6248868774, 75087.62456187684, 11867.516560429945, 11898.702532436759, 11912.702182445508, 11949.402529873298, 12285.938570307091, 13269.66825829362, 13338.26639534835, 13681.179129252278, 14349.139051656934, 14440.711185776436, 13470.393832277767, 13477.0, 13899.791503127259, 14065.929670351583, 14401.351939162554, 13288.202707837561, 13421.060525763103, 13731.176129432266, 13884.652883677989, 14191.787123192953, 12515.374231288217, 12577.748445030866, 12637.2417654941, 13129.474821007052, 13278.203307801563, 10307.484625768831, 10365.274430789772, 10435.32170408921, 10645.733856653336, 10805.081568066802, 10088.949555252177, 10783.51474183648, 11118.166137539878, 11177.329360238411, 11196.66410007701], "value": 7403.27861037122, "unit": "score"}], "name": "dromaeo_css", "value": 7120.5199183962995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 112.0, 110.0, 111.0, 111.0, 110.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 118.0, 182.0, 117.0, 119.0, 149.0, 116.0, 144.0, 115.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 162.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 112.0, 74.0, 75.0, 74.0, 75.0, 99.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 117.0, 83.0, 83.0, 85.0, 121.0, 84.0, 83.0, 119.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 53.0, 54.0, 58.0, 54.0, 53.0, 52.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 76.0, 75.0, 76.0, 75.0, 80.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 131.0, 120.0, 118.0, 119.0, 122.0, 131.0, 200.0, 133.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 155.0, 164.0, 158.0, 158.0, 156.0, 156.0, 159.0, 158.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 62.0, 63.0, 61.0, 64.0, 62.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1479.3000000000002, "alertThreshold": 2.0}]} 11:35:31 INFO - Return code: 0 11:35:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:35:31 INFO - # TBPL SUCCESS # 11:35:31 INFO - Running post-action listener: _resource_record_post_action 11:35:31 INFO - [mozharness: 2016-07-30 18:35:31.149348Z] Finished run-tests step (success) 11:35:31 INFO - Running post-run listener: _resource_record_post_run 11:35:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549535744; Read time: 28; Write time: 1125328 11:35:31 INFO - TinderboxPrint: CPU usage
13.2% 11:35:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 11:35:31 INFO - TinderboxPrint: I/O write bytes / time
549,535,744 / 1,125,328 11:35:31 INFO - TinderboxPrint: CPU idle
8,275.1 (86.8%) 11:35:31 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 11:35:31 INFO - TinderboxPrint: Swap in / out
0 / 0 11:35:31 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 247586816; Read time: 0; Write time: 746376 11:35:31 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 290689024; Read time: 0; Write time: 377212 11:35:31 INFO - Running post-run listener: _upload_blobber_files 11:35:31 INFO - Blob upload gear active. 11:35:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:35:31 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 11:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:35:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:35 INFO - (blobuploader) - INFO - Done attempting. 11:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:35 INFO - (blobuploader) - INFO - Done attempting. 11:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:36 INFO - (blobuploader) - INFO - Done attempting. 11:35:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:36 INFO - Return code: 0 11:35:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/381b618fdfc08046c39b83183f324b1ff66be7948b87606758cb12475044c0566bd1378e1374e541893b04f05266580663ae4879f1994727a9d26956a9fc0854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c53c1fdd3d476127e9bed9830259f356d2924e29daaae08eab23c62bcd803a51ad21e4e0033df49e67a6a5b694c433549905b0b80877eef6e41529c08cfc276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320f604f14e8372b58bb55ca4535dc7fdfd4204be7a782a6af3c810df30dc2473f4e0781cf16b1f0fb6e95d590c55ba123f60d28b998edb9953a535cdfe52851"} 11:35:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:36 INFO - Contents: 11:35:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/381b618fdfc08046c39b83183f324b1ff66be7948b87606758cb12475044c0566bd1378e1374e541893b04f05266580663ae4879f1994727a9d26956a9fc0854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c53c1fdd3d476127e9bed9830259f356d2924e29daaae08eab23c62bcd803a51ad21e4e0033df49e67a6a5b694c433549905b0b80877eef6e41529c08cfc276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320f604f14e8372b58bb55ca4535dc7fdfd4204be7a782a6af3c810df30dc2473f4e0781cf16b1f0fb6e95d590c55ba123f60d28b998edb9953a535cdfe52851"} 11:35:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:35:36 INFO - Copying logs to upload dir... 11:35:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:35:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.604420 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-30 11:35:36.423247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 11:35:36.426857) ========= 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=745a4373a2a16df560f216e000000264-1469900557.267178-645988056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/381b618fdfc08046c39b83183f324b1ff66be7948b87606758cb12475044c0566bd1378e1374e541893b04f05266580663ae4879f1994727a9d26956a9fc0854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c53c1fdd3d476127e9bed9830259f356d2924e29daaae08eab23c62bcd803a51ad21e4e0033df49e67a6a5b694c433549905b0b80877eef6e41529c08cfc276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320f604f14e8372b58bb55ca4535dc7fdfd4204be7a782a6af3c810df30dc2473f4e0781cf16b1f0fb6e95d590c55ba123f60d28b998edb9953a535cdfe52851"} build_url:https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/Aqbk4CMuQnaewh-1ES6z5w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/381b618fdfc08046c39b83183f324b1ff66be7948b87606758cb12475044c0566bd1378e1374e541893b04f05266580663ae4879f1994727a9d26956a9fc0854", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c53c1fdd3d476127e9bed9830259f356d2924e29daaae08eab23c62bcd803a51ad21e4e0033df49e67a6a5b694c433549905b0b80877eef6e41529c08cfc276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/320f604f14e8372b58bb55ca4535dc7fdfd4204be7a782a6af3c810df30dc2473f4e0781cf16b1f0fb6e95d590c55ba123f60d28b998edb9953a535cdfe52851"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 11:35:36.452653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:35:36.452986) ========= 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=745a4373a2a16df560f216e000000264-1469900557.267178-645988056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 11:35:36.536460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 11:35:36.536789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 11:35:36.537095) ========= ========= Total master_lag: 0.21 =========