builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1464600257.8 results: success (0) buildid: 20160529191945 builduid: b6ab4b49b47e40b9aba09230e2d6b98b revision: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.797556) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.798079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.798372) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.832438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.832801) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 02:24:18-- 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% 36.6M=0s 2016-05-30 02:24:18 (36.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074811 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.958128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.958523) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019401 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.998670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:17.999025) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0354aa795ba11ec139cbe286e7217ba4fd0ad3e --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 e0354aa795ba11ec139cbe286e7217ba4fd0ad3e --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=337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 02:24:18,734 truncating revision to first 12 chars 2016-05-30 02:24:18,734 Setting DEBUG logging. 2016-05-30 02:24:18,734 attempt 1/10 2016-05-30 02:24:18,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0354aa795ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 02:24:19,046 unpacking tar archive at: fx-team-e0354aa795ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:18.656938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:18.657276) ========= script_repo_revision: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:18.657733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:18.658023) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 02:24:18.706330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-30 02:24:18.706773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:19 INFO - MultiFileLogger online at 20160530 02:24:19 in /builds/slave/test 02:24:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:24:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:19 INFO - {'append_to_log': False, 02:24:19 INFO - 'base_work_dir': '/builds/slave/test', 02:24:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:24:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:19 INFO - 'branch': 'Fx-Team-Non-PGO', 02:24:19 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:19 INFO - 'config_files': ('talos/linux_config.py',), 02:24:19 INFO - 'default_actions': ('clobber', 02:24:19 INFO - 'read-buildbot-config', 02:24:19 INFO - 'download-and-extract', 02:24:19 INFO - 'populate-webroot', 02:24:19 INFO - 'create-virtualenv', 02:24:19 INFO - 'install', 02:24:19 INFO - 'run-tests'), 02:24:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:19 INFO - 'download_minidump_stackwalk': True, 02:24:19 INFO - 'download_symbols': 'ondemand', 02:24:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:19 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:19 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:19 INFO - 'installer_path': 'installer.exe', 02:24:19 INFO - 'log_level': 'info', 02:24:19 INFO - 'log_name': 'talos', 02:24:19 INFO - 'log_to_console': True, 02:24:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:19 INFO - 'opt_config_files': (), 02:24:19 INFO - 'pip_index': False, 02:24:19 INFO - 'sps_profile': False, 02:24:19 INFO - 'sps_profile_interval': 0, 02:24:19 INFO - 'suite': 'dromaeojs', 02:24:19 INFO - 'system_bits': '32', 02:24:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:19 INFO - 'title': 'talos-linux64-ix-060', 02:24:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:19 INFO - 'use_talos_json': True, 02:24:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:19 INFO - 'work_dir': 'build'} 02:24:19 INFO - ##### 02:24:19 INFO - ##### Running clobber step. 02:24:19 INFO - ##### 02:24:19 INFO - Running pre-action listener: _resource_record_pre_action 02:24:19 INFO - Running main action method: clobber 02:24:19 INFO - rmtree: /builds/slave/test/build 02:24:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:19 INFO - Running post-action listener: _resource_record_post_action 02:24:20 INFO - ##### 02:24:20 INFO - ##### Finished clobber step (success) 02:24:20 INFO - ##### 02:24:20 INFO - ##### 02:24:20 INFO - ##### Running read-buildbot-config step. 02:24:20 INFO - ##### 02:24:20 INFO - Running pre-action listener: _resource_record_pre_action 02:24:20 INFO - Running main action method: read_buildbot_config 02:24:20 INFO - Using buildbot properties: 02:24:20 INFO - { 02:24:20 INFO - "project": "", 02:24:20 INFO - "product": "firefox", 02:24:20 INFO - "script_repo_revision": "production", 02:24:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:24:20 INFO - "repository": "", 02:24:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:24:20 INFO - "buildid": "20160529191945", 02:24:20 INFO - "pgo_build": "False", 02:24:20 INFO - "basedir": "/builds/slave/test", 02:24:20 INFO - "buildnumber": 1801, 02:24:20 INFO - "slavename": "talos-linux64-ix-060", 02:24:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:24:20 INFO - "platform": "ubuntu64_hw", 02:24:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:24:20 INFO - "branch": "fx-team", 02:24:20 INFO - "repo_path": "integration/fx-team", 02:24:20 INFO - "revision": "e0354aa795ba11ec139cbe286e7217ba4fd0ad3e", 02:24:20 INFO - "stage_platform": "linux64", 02:24:20 INFO - "builduid": "b6ab4b49b47e40b9aba09230e2d6b98b", 02:24:20 INFO - "slavebuilddir": "test" 02:24:20 INFO - } 02:24:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:24:20 INFO - Running post-action listener: _resource_record_post_action 02:24:20 INFO - ##### 02:24:20 INFO - ##### Finished read-buildbot-config step (success) 02:24:20 INFO - ##### 02:24:20 INFO - ##### 02:24:20 INFO - ##### Running download-and-extract step. 02:24:20 INFO - ##### 02:24:20 INFO - Running pre-action listener: _resource_record_pre_action 02:24:20 INFO - Running main action method: download_and_extract 02:24:20 INFO - mkdir: /builds/slave/test/build/tests 02:24: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')]} 02:24:20 INFO - https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:24:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:24:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:24:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:24:24 INFO - Downloaded 1361 bytes. 02:24:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:24:24 INFO - Using the following test package requirements: 02:24:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:24:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'jsshell-linux-x86_64.zip'], 02:24:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24: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')]} 02:24:24 INFO - https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:26 INFO - Downloaded 22837897 bytes. 02:24:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:24:27 INFO - Return code: 0 02:24:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:27 INFO - https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:31 INFO - Downloaded 22837897 bytes. 02:24:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:24:32 INFO - Return code: 0 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:24:35 INFO - Downloaded 10834034 bytes. 02:24:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:24:36 INFO - Return code: 0 02:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:36 INFO - https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:24:38 INFO - Downloaded 54847670 bytes. 02:24:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:24:38 INFO - mkdir: /builds/slave/test/properties 02:24:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:24:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:24:38 INFO - Contents: 02:24:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:24:38 INFO - Running post-action listener: _resource_record_post_action 02:24:38 INFO - Running post-action listener: set_extra_try_arguments 02:24:38 INFO - ##### 02:24:38 INFO - ##### Finished download-and-extract step (success) 02:24:38 INFO - ##### 02:24:38 INFO - ##### 02:24:38 INFO - ##### Running populate-webroot step. 02:24:38 INFO - ##### 02:24:38 INFO - Running pre-action listener: _resource_record_pre_action 02:24:38 INFO - Running main action method: populate_webroot 02:24:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:24:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:24:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:24:38 INFO - '--tppagecycles', 02:24:38 INFO - '7'], 02:24:38 INFO - 'tests': ['tsvgm']}}, 02:24:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:24:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:24:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:24:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:24:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:24:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['damp', 'tps']}, 02:24:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'tests': ['damp', 'tps']}, 02:24:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['dromaeo_dom']}, 02:24:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:24:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['a11yr', 02:24:38 INFO - 'ts_paint', 02:24:38 INFO - 'tpaint', 02:24:38 INFO - 'sessionrestore', 02:24:38 INFO - 'sessionrestore_no_auto_restore', 02:24:38 INFO - 'tabpaint']}, 02:24:38 INFO - 'other-e10s': {'tests': ['a11yr', 02:24:38 INFO - 'ts_paint', 02:24:38 INFO - 'tpaint', 02:24:38 INFO - 'sessionrestore', 02:24:38 INFO - 'sessionrestore_no_auto_restore', 02:24:38 INFO - 'tabpaint']}, 02:24:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:24:38 INFO - 'ts_paint', 02:24:38 INFO - 'tpaint', 02:24:38 INFO - 'sessionrestore', 02:24:38 INFO - 'sessionrestore_no_auto_restore', 02:24:38 INFO - 'tabpaint']}, 02:24:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:24:38 INFO - 'ts_paint', 02:24:38 INFO - 'tpaint', 02:24:38 INFO - 'sessionrestore', 02:24:38 INFO - 'sessionrestore_no_auto_restore', 02:24:38 INFO - 'tabpaint']}, 02:24:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['a11yr', 02:24:38 INFO - 'ts_paint', 02:24:38 INFO - 'tpaint', 02:24:38 INFO - 'sessionrestore', 02:24:38 INFO - 'sessionrestore_no_auto_restore', 02:24:38 INFO - 'tabpaint']}, 02:24:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['a11yr', 02:24:38 INFO - 'ts_paint', 02:24:38 INFO - 'tpaint', 02:24:38 INFO - 'sessionrestore', 02:24:38 INFO - 'sessionrestore_no_auto_restore', 02:24:38 INFO - 'tabpaint']}, 02:24:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['tsvgx', 02:24:38 INFO - 'tsvgr_opacity', 02:24:38 INFO - 'tart', 02:24:38 INFO - 'tscrollx', 02:24:38 INFO - 'cart']}, 02:24:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:24:38 INFO - 'tsvgr_opacity', 02:24:38 INFO - 'tart', 02:24:38 INFO - 'tscrollx', 02:24:38 INFO - 'cart']}, 02:24:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'talos_options': ['--disable-e10s'], 02:24:38 INFO - 'tests': ['tp5o']}, 02:24:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'tests': ['tp5o']}, 02:24:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'talos_options': ['--disable-e10s', 02:24:38 INFO - '--xperf_path', 02:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:38 INFO - 'tests': ['tp5n']}, 02:24:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:24:38 INFO - 'talos_options': ['--xperf_path', 02:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:24:38 INFO - 'tests': ['tp5n']}}, 02:24:38 INFO - 'talos.zip': {'path': '', 02:24:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:24:38 INFO - Running post-action listener: _resource_record_post_action 02:24:38 INFO - ##### 02:24:38 INFO - ##### Finished populate-webroot step (success) 02:24:38 INFO - ##### 02:24:38 INFO - ##### 02:24:38 INFO - ##### Running create-virtualenv step. 02:24:38 INFO - ##### 02:24:38 INFO - Running pre-action listener: _resource_record_pre_action 02:24:38 INFO - Running main action method: create_virtualenv 02:24:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:24:38 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 02:24:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:24:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:24:38 INFO - Using real prefix '/usr' 02:24:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:24:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:24:41 INFO - Installing pip.................done. 02:24:41 INFO - Return code: 0 02:24:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:24:41 INFO - Using env: {'DISPLAY': ':0', 02:24:41 INFO - 'HOME': '/home/cltbld', 02:24:41 INFO - 'LANG': 'en_US.UTF-8', 02:24:41 INFO - 'LANGUAGE': 'en_US:en', 02:24:41 INFO - 'LOGNAME': 'cltbld', 02:24:41 INFO - 'MAIL': '/var/mail/cltbld', 02:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:41 INFO - 'MOZ_NO_REMOTE': '1', 02:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:41 INFO - 'NO_EM_RESTART': '1', 02:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:41 INFO - 'PWD': '/builds/slave/test', 02:24:41 INFO - 'SHELL': '/bin/bash', 02:24:41 INFO - 'SHLVL': '1', 02:24:41 INFO - 'TERM': 'linux', 02:24:41 INFO - 'TMOUT': '86400', 02:24:41 INFO - 'USER': 'cltbld', 02:24:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:41 INFO - '_': '/tools/buildbot/bin/python'} 02:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:41 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 02:24:41 INFO - Cleaning up... 02:24:41 INFO - Return code: 0 02:24:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:24:41 INFO - Using env: {'DISPLAY': ':0', 02:24:41 INFO - 'HOME': '/home/cltbld', 02:24:41 INFO - 'LANG': 'en_US.UTF-8', 02:24:41 INFO - 'LANGUAGE': 'en_US:en', 02:24:41 INFO - 'LOGNAME': 'cltbld', 02:24:41 INFO - 'MAIL': '/var/mail/cltbld', 02:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:41 INFO - 'MOZ_NO_REMOTE': '1', 02:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:41 INFO - 'NO_EM_RESTART': '1', 02:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:41 INFO - 'PWD': '/builds/slave/test', 02:24:41 INFO - 'SHELL': '/bin/bash', 02:24:41 INFO - 'SHLVL': '1', 02:24:41 INFO - 'TERM': 'linux', 02:24:41 INFO - 'TMOUT': '86400', 02:24:41 INFO - 'USER': 'cltbld', 02:24:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:41 INFO - '_': '/tools/buildbot/bin/python'} 02:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:41 INFO - Downloading/unpacking psutil>=3.1.1 02:24:41 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 02:24:41 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 02:24:41 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 02:24:41 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 02:24:41 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 02:24:41 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 02:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:43 INFO - Installing collected packages: psutil 02:24:43 INFO - Running setup.py install for psutil 02:24:43 INFO - building 'psutil._psutil_linux' extension 02:24:43 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 02:24:44 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 02:24:44 INFO - building 'psutil._psutil_posix' extension 02:24:44 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 02:24:44 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 02:24:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:24:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:24:44 INFO - Successfully installed psutil 02:24:44 INFO - Cleaning up... 02:24:44 INFO - Return code: 0 02:24:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:24:44 INFO - Using env: {'DISPLAY': ':0', 02:24:44 INFO - 'HOME': '/home/cltbld', 02:24:44 INFO - 'LANG': 'en_US.UTF-8', 02:24:44 INFO - 'LANGUAGE': 'en_US:en', 02:24:44 INFO - 'LOGNAME': 'cltbld', 02:24:44 INFO - 'MAIL': '/var/mail/cltbld', 02:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:44 INFO - 'MOZ_NO_REMOTE': '1', 02:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:44 INFO - 'NO_EM_RESTART': '1', 02:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:44 INFO - 'PWD': '/builds/slave/test', 02:24:44 INFO - 'SHELL': '/bin/bash', 02:24:44 INFO - 'SHLVL': '1', 02:24:44 INFO - 'TERM': 'linux', 02:24:44 INFO - 'TMOUT': '86400', 02:24:44 INFO - 'USER': 'cltbld', 02:24:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:44 INFO - '_': '/tools/buildbot/bin/python'} 02:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:24:46 INFO - Installing collected packages: mozsystemmonitor 02:24:46 INFO - Running setup.py install for mozsystemmonitor 02:24:46 INFO - Successfully installed mozsystemmonitor 02:24:46 INFO - Cleaning up... 02:24:46 INFO - Return code: 0 02:24:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:24:46 INFO - Using env: {'DISPLAY': ':0', 02:24:46 INFO - 'HOME': '/home/cltbld', 02:24:46 INFO - 'LANG': 'en_US.UTF-8', 02:24:46 INFO - 'LANGUAGE': 'en_US:en', 02:24:46 INFO - 'LOGNAME': 'cltbld', 02:24:46 INFO - 'MAIL': '/var/mail/cltbld', 02:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:46 INFO - 'MOZ_NO_REMOTE': '1', 02:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:46 INFO - 'NO_EM_RESTART': '1', 02:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:46 INFO - 'PWD': '/builds/slave/test', 02:24:46 INFO - 'SHELL': '/bin/bash', 02:24:46 INFO - 'SHLVL': '1', 02:24:46 INFO - 'TERM': 'linux', 02:24:46 INFO - 'TMOUT': '86400', 02:24:46 INFO - 'USER': 'cltbld', 02:24:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:46 INFO - '_': '/tools/buildbot/bin/python'} 02:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:24:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:24:48 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 02:24:48 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 02:24:48 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 02:24:48 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 02:24:48 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 02:24:48 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 02:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:24:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:24:49 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 02:24:49 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 02:24:49 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 02:24:49 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 02:24:49 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 02:24:49 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 02:24:49 INFO - Downloading docopt-0.6.1.tar.gz 02:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:24:49 INFO - Installing collected packages: blobuploader, requests, docopt 02:24:49 INFO - Running setup.py install for blobuploader 02:24:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:24:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:24:49 INFO - Running setup.py install for requests 02:24:49 INFO - Running setup.py install for docopt 02:24:50 INFO - Successfully installed blobuploader requests docopt 02:24:50 INFO - Cleaning up... 02:24:50 INFO - Return code: 0 02:24:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:50 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')]} 02:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:50 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')]} 02:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:50 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 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:50 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 02:24:50 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 02:24:50 INFO - Using env: {'DISPLAY': ':0', 02:24:50 INFO - 'HOME': '/home/cltbld', 02:24:50 INFO - 'LANG': 'en_US.UTF-8', 02:24:50 INFO - 'LANGUAGE': 'en_US:en', 02:24:50 INFO - 'LOGNAME': 'cltbld', 02:24:50 INFO - 'MAIL': '/var/mail/cltbld', 02:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:50 INFO - 'MOZ_NO_REMOTE': '1', 02:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:50 INFO - 'NO_EM_RESTART': '1', 02:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:50 INFO - 'PWD': '/builds/slave/test', 02:24:50 INFO - 'SHELL': '/bin/bash', 02:24:50 INFO - 'SHLVL': '1', 02:24:50 INFO - 'TERM': 'linux', 02:24:50 INFO - 'TMOUT': '86400', 02:24:50 INFO - 'USER': 'cltbld', 02:24:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:50 INFO - '_': '/tools/buildbot/bin/python'} 02:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:50 INFO - Running setup.py (path:/tmp/pip-1PRnLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:50 INFO - Running setup.py (path:/tmp/pip-vFydq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:50 INFO - Running setup.py (path:/tmp/pip-oKc3k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:50 INFO - Running setup.py (path:/tmp/pip-GQmYlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:50 INFO - Running setup.py (path:/tmp/pip-pGZ7RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:50 INFO - Running setup.py (path:/tmp/pip-I98H1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:50 INFO - Running setup.py (path:/tmp/pip-jfGCDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:50 INFO - Running setup.py (path:/tmp/pip-cImAGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:50 INFO - Running setup.py (path:/tmp/pip-dk7zqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:50 INFO - Running setup.py (path:/tmp/pip-UgJ98i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:51 INFO - Running setup.py (path:/tmp/pip-NCcvcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:51 INFO - Running setup.py (path:/tmp/pip-6DxCG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:51 INFO - Running setup.py (path:/tmp/pip-6MMvUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:51 INFO - Running setup.py (path:/tmp/pip-UC7mUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:51 INFO - Running setup.py (path:/tmp/pip-Rr1NUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:51 INFO - Running setup.py (path:/tmp/pip-TM4QSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:51 INFO - Running setup.py (path:/tmp/pip-VEMfm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:24:51 INFO - Running setup.py install for manifestparser 02:24:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:24:51 INFO - Running setup.py install for mozcrash 02:24:51 INFO - Running setup.py install for mozdebug 02:24:51 INFO - Running setup.py install for mozdevice 02:24:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:24:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:24:51 INFO - Running setup.py install for mozfile 02:24:52 INFO - Running setup.py install for mozhttpd 02:24:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Running setup.py install for mozinfo 02:24:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Running setup.py install for mozInstall 02:24:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Running setup.py install for mozleak 02:24:52 INFO - Running setup.py install for mozlog 02:24:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Running setup.py install for moznetwork 02:24:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Running setup.py install for mozprocess 02:24:52 INFO - Running setup.py install for mozprofile 02:24:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:24:52 INFO - Running setup.py install for mozrunner 02:24:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:24:53 INFO - Running setup.py install for mozscreenshot 02:24:53 INFO - Running setup.py install for moztest 02:24:53 INFO - Running setup.py install for mozversion 02:24:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:24:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:24:53 INFO - Cleaning up... 02:24:53 INFO - Return code: 0 02:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:53 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 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:53 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 02:24:53 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 02:24:53 INFO - Using env: {'DISPLAY': ':0', 02:24:53 INFO - 'HOME': '/home/cltbld', 02:24:53 INFO - 'LANG': 'en_US.UTF-8', 02:24:53 INFO - 'LANGUAGE': 'en_US:en', 02:24:53 INFO - 'LOGNAME': 'cltbld', 02:24:53 INFO - 'MAIL': '/var/mail/cltbld', 02:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:53 INFO - 'MOZ_NO_REMOTE': '1', 02:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:53 INFO - 'NO_EM_RESTART': '1', 02:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:53 INFO - 'PWD': '/builds/slave/test', 02:24:53 INFO - 'SHELL': '/bin/bash', 02:24:53 INFO - 'SHLVL': '1', 02:24:53 INFO - 'TERM': 'linux', 02:24:53 INFO - 'TMOUT': '86400', 02:24:53 INFO - 'USER': 'cltbld', 02:24:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:53 INFO - '_': '/tools/buildbot/bin/python'} 02:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:24:53 INFO - Running setup.py (path:/tmp/pip-C0dTBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:24:53 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)) 02:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:24:53 INFO - Running setup.py (path:/tmp/pip-5JhfMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:24:53 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)) 02:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:24:53 INFO - Running setup.py (path:/tmp/pip-MjMySH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:24:53 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)) 02:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:24:53 INFO - Running setup.py (path:/tmp/pip-lID1Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:24:53 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)) 02:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:24:53 INFO - Running setup.py (path:/tmp/pip-gEpIGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:24:53 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)) 02:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:24:53 INFO - Running setup.py (path:/tmp/pip-9hyUIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:24:54 INFO - Running setup.py (path:/tmp/pip-epCpt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:24:54 INFO - Running setup.py (path:/tmp/pip-xnTeHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:24:54 INFO - Running setup.py (path:/tmp/pip-25Z7oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:24:54 INFO - Running setup.py (path:/tmp/pip-irPkGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:24:54 INFO - Running setup.py (path:/tmp/pip-N3zhMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:24:54 INFO - Running setup.py (path:/tmp/pip-m9qiwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:24:54 INFO - Running setup.py (path:/tmp/pip-pjpsSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:24:54 INFO - Running setup.py (path:/tmp/pip-_kMNgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:54 INFO - Running setup.py (path:/tmp/pip-BgWmzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:24:54 INFO - Running setup.py (path:/tmp/pip-270RHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:24:54 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)) 02:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:24:54 INFO - Running setup.py (path:/tmp/pip-aDymXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:24:54 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)) 02:24:54 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)) 02:24:54 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)) 02:24:54 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)) 02:24:54 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)) 02:24:54 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)) 02:24:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:56 INFO - Downloading blessings-1.6.tar.gz 02:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:24:56 INFO - Installing collected packages: blessings 02:24:56 INFO - Running setup.py install for blessings 02:24:56 INFO - Successfully installed blessings 02:24:56 INFO - Cleaning up... 02:24:56 INFO - Return code: 0 02:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:24:57 INFO - Reading from file tmpfile_stdout 02:24:57 INFO - Current package versions: 02:24:57 INFO - argparse == 1.2.1 02:24:57 INFO - blessings == 1.6 02:24:57 INFO - blobuploader == 1.2.4 02:24:57 INFO - docopt == 0.6.1 02:24:57 INFO - manifestparser == 1.1 02:24:57 INFO - mozInstall == 1.12 02:24:57 INFO - mozcrash == 0.17 02:24:57 INFO - mozdebug == 0.1 02:24:57 INFO - mozdevice == 0.48 02:24:57 INFO - mozfile == 1.2 02:24:57 INFO - mozhttpd == 0.7 02:24:57 INFO - mozinfo == 0.9 02:24:57 INFO - mozleak == 0.1 02:24:57 INFO - mozlog == 3.2 02:24:57 INFO - moznetwork == 0.27 02:24:57 INFO - mozprocess == 0.22 02:24:57 INFO - mozprofile == 0.28 02:24:57 INFO - mozrunner == 6.11 02:24:57 INFO - mozscreenshot == 0.1 02:24:57 INFO - mozsystemmonitor == 0.3 02:24:57 INFO - moztest == 0.7 02:24:57 INFO - mozversion == 1.4 02:24:57 INFO - psutil == 3.1.1 02:24:57 INFO - requests == 1.2.3 02:24:57 INFO - wsgiref == 0.1.2 02:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:57 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 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:57 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 02:24:57 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 02:24:57 INFO - Using env: {'DISPLAY': ':0', 02:24:57 INFO - 'HOME': '/home/cltbld', 02:24:57 INFO - 'LANG': 'en_US.UTF-8', 02:24:57 INFO - 'LANGUAGE': 'en_US:en', 02:24:57 INFO - 'LOGNAME': 'cltbld', 02:24:57 INFO - 'MAIL': '/var/mail/cltbld', 02:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:57 INFO - 'MOZ_NO_REMOTE': '1', 02:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:57 INFO - 'NO_EM_RESTART': '1', 02:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:57 INFO - 'PWD': '/builds/slave/test', 02:24:57 INFO - 'SHELL': '/bin/bash', 02:24:57 INFO - 'SHLVL': '1', 02:24:57 INFO - 'TERM': 'linux', 02:24:57 INFO - 'TMOUT': '86400', 02:24:57 INFO - 'USER': 'cltbld', 02:24:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:57 INFO - '_': '/tools/buildbot/bin/python'} 02:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 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)) 02:24:57 INFO - Cleaning up... 02:24:57 INFO - Return code: 0 02:24:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:24:57 INFO - Using env: {'DISPLAY': ':0', 02:24:57 INFO - 'HOME': '/home/cltbld', 02:24:57 INFO - 'LANG': 'en_US.UTF-8', 02:24:57 INFO - 'LANGUAGE': 'en_US:en', 02:24:57 INFO - 'LOGNAME': 'cltbld', 02:24:57 INFO - 'MAIL': '/var/mail/cltbld', 02:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:57 INFO - 'MOZ_NO_REMOTE': '1', 02:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:57 INFO - 'NO_EM_RESTART': '1', 02:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:57 INFO - 'PWD': '/builds/slave/test', 02:24:57 INFO - 'SHELL': '/bin/bash', 02:24:57 INFO - 'SHLVL': '1', 02:24:57 INFO - 'TERM': 'linux', 02:24:57 INFO - 'TMOUT': '86400', 02:24:57 INFO - 'USER': 'cltbld', 02:24:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:57 INFO - '_': '/tools/buildbot/bin/python'} 02:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:24:57 INFO - Downloading/unpacking jsonschema 02:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:24:59 INFO - Downloading/unpacking functools32 (from jsonschema) 02:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:24:59 INFO - warning: no files found matching '*.txt' 02:24:59 INFO - no previously-included directories found matching 'build' 02:24:59 INFO - no previously-included directories found matching 'dist' 02:24:59 INFO - no previously-included directories found matching '.git*' 02:24:59 INFO - Installing collected packages: jsonschema, functools32 02:24:59 INFO - Running setup.py install for functools32 02:24:59 INFO - warning: no files found matching '*.txt' 02:24:59 INFO - no previously-included directories found matching 'build' 02:24:59 INFO - no previously-included directories found matching 'dist' 02:24:59 INFO - no previously-included directories found matching '.git*' 02:24:59 INFO - Successfully installed jsonschema functools32 02:24:59 INFO - Cleaning up... 02:24:59 INFO - Return code: 0 02:24:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:24: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')]} 02:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24: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')]} 02:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f753c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcdf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdaa770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', '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 02:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:24:59 INFO - Using env: {'DISPLAY': ':0', 02:24:59 INFO - 'HOME': '/home/cltbld', 02:24:59 INFO - 'LANG': 'en_US.UTF-8', 02:24:59 INFO - 'LANGUAGE': 'en_US:en', 02:24:59 INFO - 'LOGNAME': 'cltbld', 02:24:59 INFO - 'MAIL': '/var/mail/cltbld', 02:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:59 INFO - 'MOZ_NO_REMOTE': '1', 02:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:59 INFO - 'NO_EM_RESTART': '1', 02:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:24:59 INFO - 'PWD': '/builds/slave/test', 02:24:59 INFO - 'SHELL': '/bin/bash', 02:24:59 INFO - 'SHLVL': '1', 02:24:59 INFO - 'TERM': 'linux', 02:24:59 INFO - 'TMOUT': '86400', 02:24:59 INFO - 'USER': 'cltbld', 02:24:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:59 INFO - '_': '/tools/buildbot/bin/python'} 02:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:00 INFO - Downloading/unpacking flake8 02:25:00 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 02:25:00 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 02:25:00 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 02:25:00 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 02:25:00 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 02:25:00 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 02:25:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:25:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:25:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:25:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:25:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:25:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:25:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:25:02 INFO - no previously-included directories found matching 'docs/_build' 02:25:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:25:02 INFO - Running setup.py install for pep8 02:25:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:25:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:25:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:25:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:25:02 INFO - no previously-included directories found matching 'docs/_build' 02:25:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:25:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:25:02 INFO - Cleaning up... 02:25:03 INFO - Return code: 0 02:25:03 INFO - Running post-action listener: _resource_record_post_action 02:25:03 INFO - Running post-action listener: _start_resource_monitoring 02:25:03 INFO - Starting resource monitoring. 02:25:03 INFO - ##### 02:25:03 INFO - ##### Finished create-virtualenv step (success) 02:25:03 INFO - ##### 02:25:03 INFO - ##### 02:25:03 INFO - ##### Running install step. 02:25:03 INFO - ##### 02:25:03 INFO - Running pre-action listener: _resource_record_pre_action 02:25:03 INFO - Running main action method: install 02:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:25:03 INFO - Reading from file tmpfile_stdout 02:25:03 INFO - Detecting whether we're running mozinstall >=1.0... 02:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:25:03 INFO - Reading from file tmpfile_stdout 02:25:03 INFO - Output received: 02:25:03 INFO - Usage: mozinstall [options] installer 02:25:03 INFO - Options: 02:25:03 INFO - -h, --help show this help message and exit 02:25:03 INFO - -d DEST, --destination=DEST 02:25:03 INFO - Directory to install application into. [default: 02:25:03 INFO - "/builds/slave/test"] 02:25:03 INFO - --app=APP Application being installed. [default: firefox] 02:25:03 INFO - mkdir: /builds/slave/test/build/application 02:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:25:19 INFO - Reading from file tmpfile_stdout 02:25:19 INFO - Output received: 02:25:19 INFO - /builds/slave/test/build/application/firefox/firefox 02:25:19 INFO - Running post-action listener: _resource_record_post_action 02:25:19 INFO - ##### 02:25:19 INFO - ##### Finished install step (success) 02:25:19 INFO - ##### 02:25:19 INFO - ##### 02:25:19 INFO - ##### Running run-tests step. 02:25:19 INFO - ##### 02:25:19 INFO - Running pre-action listener: _resource_record_pre_action 02:25:19 INFO - Running main action method: run_tests 02:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:25:19 INFO - Python 2.7.3 02:25:19 INFO - Return code: 0 02:25:19 INFO - grabbing minidump binary from tooltool 02:25:19 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')]} 02:25:19 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 0xe399c0>, '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 0xe3a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe3ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:25:19 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 02:25:19 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 02:25:19 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 02:25:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:25:19 INFO - Return code: 0 02:25:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:25:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:25:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:25:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:25:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:25:20 INFO - Return code: 0 02:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 02:25:20 INFO - Using env: {'DISPLAY': ':0', 02:25:20 INFO - 'HOME': '/home/cltbld', 02:25:20 INFO - 'LANG': 'en_US.UTF-8', 02:25:20 INFO - 'LANGUAGE': 'en_US:en', 02:25:20 INFO - 'LOGNAME': 'cltbld', 02:25:20 INFO - 'MAIL': '/var/mail/cltbld', 02:25:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:25:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:20 INFO - 'MOZ_NO_REMOTE': '1', 02:25:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:20 INFO - 'NO_EM_RESTART': '1', 02:25:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:20 INFO - 'PWD': '/builds/slave/test', 02:25:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:25:20 INFO - 'SHELL': '/bin/bash', 02:25:20 INFO - 'SHLVL': '1', 02:25:20 INFO - 'TERM': 'linux', 02:25:20 INFO - 'TMOUT': '86400', 02:25:20 INFO - 'USER': 'cltbld', 02:25:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367', 02:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:20 INFO - '_': '/tools/buildbot/bin/python'} 02:25:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:25:20 INFO - mozversion application_buildid: 20160529191945 02:25:20 INFO - mozversion application_changeset: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e 02:25:20 INFO - mozversion application_display_name: Nightly 02:25:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:25:20 INFO - mozversion application_name: Firefox 02:25:20 INFO - mozversion application_remotingname: firefox 02:25:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:25:20 INFO - mozversion application_vendor: Mozilla 02:25:20 INFO - mozversion application_version: 49.0a1 02:25:20 INFO - mozversion platform_buildid: 20160529191945 02:25:20 INFO - mozversion platform_changeset: e0354aa795ba11ec139cbe286e7217ba4fd0ad3e 02:25:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:25:20 INFO - mozversion platform_version: 49.0a1 02:25:20 INFO - using testdate: 1464600320 02:25:20 INFO - actual date: 1464600320 02:25:20 INFO - starting webserver on 'localhost:39365' 02:25:20 INFO - SUITE-START | Running 2 tests 02:25:20 INFO - TEST-START | dromaeo_css 02:25:20 INFO - operating with platform_type : linux_ 02:25:20 INFO - Initialising browser for dromaeo_css test... 02:25:20 INFO - TEST-INFO | started process 10489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEXCOd1/profile http://localhost:39365/getInfo.html) 02:25:24 INFO - PROCESS | 10489 | __metrics Screen width/height:1600/1200 02:25:24 INFO - PROCESS | 10489 | colorDepth:24 02:25:24 INFO - PROCESS | 10489 | Browser inner width/height: 1024/697 02:25:24 INFO - PROCESS | 10489 | __metrics 02:25:25 ERROR - PROCESS | 10489 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:25:26 INFO - TEST-INFO | 10489: exit 0 02:25:26 INFO - Browser initialized. 02:25:26 INFO - Running cycle 1/1 for dromaeo_css test... 02:25:26 INFO - TEST-INFO | started process 10573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEXCOd1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:38 INFO - PROCESS | 10573 | RSS: Main: 156917760 02:25:38 INFO - PROCESS | 10573 | 02:26:30 INFO - PROCESS | 10573 | 1464600390004 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] 02:28:41 INFO - PROCESS | 10573 | Cycle 1(1): loaded http://localhost:39365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39365/tests/dromaeo/cssquery-ext.html) 02:28:42 INFO - PROCESS | 10573 | RSS: Main: 273461248 02:28:42 INFO - PROCESS | 10573 | 02:31:45 INFO - PROCESS | 10573 | Cycle 1(1): loaded http://localhost:39365/tests/dromaeo/cssquery-ext.html (next: http://localhost:39365/tests/dromaeo/cssquery-jquery.html) 02:31:46 INFO - PROCESS | 10573 | RSS: Main: 235823104 02:31:46 INFO - PROCESS | 10573 | 02:34:48 INFO - PROCESS | 10573 | Cycle 1(1): loaded http://localhost:39365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39365/tests/dromaeo/cssquery-mootools.html) 02:34:49 INFO - PROCESS | 10573 | RSS: Main: 239095808 02:34:49 INFO - PROCESS | 10573 | 02:37:51 INFO - PROCESS | 10573 | Cycle 1(1): loaded http://localhost:39365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39365/tests/dromaeo/cssquery-prototype.html) 02:37:51 INFO - PROCESS | 10573 | RSS: Main: 237940736 02:37:51 INFO - PROCESS | 10573 | 02:40:54 INFO - PROCESS | 10573 | Cycle 1(1): loaded http://localhost:39365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39365/tests/dromaeo/cssquery-yui.html) 02:40:55 INFO - PROCESS | 10573 | RSS: Main: 218853376 02:40:55 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | Cycle 1(1): loaded http://localhost:39365/tests/dromaeo/cssquery-yui.html (next: http://localhost:39365/tests/dromaeo/cssquery-dojo.html) 02:43:58 INFO - PROCESS | 10573 | RSS: Main: 276070400 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | __start_tp_report 02:43:58 INFO - PROCESS | 10573 | _x_x_mozilla_page_load 02:43:58 INFO - PROCESS | 10573 | _x_x_mozilla_page_load_details 02:43:58 INFO - PROCESS | 10573 | |i|pagename|runs| 02:43:58 INFO - PROCESS | 10573 | |0;dojo.html;2648.3246772073117;2665.4669066186766;2687.7446642568957;2697.2312890826106;2708.864556772161;4640.883977900554;4646.163690535706;4715.599174070208;4732.195526760451;4779.9283010754825;4686.179918514264;4703.8118475261035;4714.717116972984;4715.174844402233;4780.259059845729;4075.3071977763702;4239.406483092362;4319.3952846601505;4346.630536404394;4438.600525952664;4357.651387888961;4382.539833317488;4398.164348773723;4404.911901761963;4441.844535441261;4238.067625122453;4275.486941567032;4276.807543660511;4281.486221653421;4302.333138363559;4298.763568003758;4308.18144552534;4359.651227901761;4372.803223854934;4377.846775362847;4343.804528796211;4352.7823608819745;4360.520342762294;4381.408509851161;4393.384926110347;4602;4624.3757092792375;4678.695884767513;4687.086018226447;4722.480527142012;5067.543921047087;5119.25770763241;5132.204508301219;5146.716930568818;5150.768215430315;4978.327925730016;5137.922931156036;5163.483651634844;5168.043911876277;5170.560502357304;4691.014886873761;4747.382840230748;4752.952470475251;4783.091212669582;4803.423589169322;5249.816256431007;5268.631195816256;5269.209618557171;5278.5249327560705;5280.102382594968;5046.520580544842;5049.419316778617;5056.367954005749;5057.039162559102;5058.671186372948;4953.157963146274;5043.420006699276;5100.030994111107;5101.897962040738;5140.871478213;5064.924026139611;5069.087564238473;5077.923831142536;5080.415752188545;5128.769205385766;4899.118158731462;5046.343975283263;5055.898882022412;5061.9746901266;5064.240363945438;4288.185244803477;4344.869653910388;4349.782510874507;4355.60799528044;4394.978025109854;3758.774473531597;3788.677962373174;3790.450384694204;3824.694024478035;3826.7512611680154;4311.48262208537;4416.050549131888;4427.601515863587;4479.507254202035;4482.282834746425;5040.193569028937;5101.05630458359;5103.795848166106;5180;5183.248428977777;4400.537943515885;4407.603315701603;4408.956778337145;4426.313921342133;4458.063806600585;4601.102784956968;4605.631549476034;4607.723536587815;4608.976955115203;4655.86032419028;4685.9765701171955;4698.882527936829;4781;4841.491643377535;4848.296996935495;5158.664686795346;5162.328897243335;5164.767585458589;5175.741212939262;5179.027815686985;4849.733264670336;4851.956829281721;4854.199057155671;4888.2911977762315;4912.312276281395;4885.975570122127;5002.599792016703;5045.369328833895;5073.695578265316;5086.847394578169;5148.279240906201;5165.61257905651;5167.534921857051;5174.97412512935;5222.791088356423;4854.781534831011;5016.272640467038;5017.247412888096;5024.899502010013;5033.521815427529;4891.26631005352;4922.581580565692;4934.55588996992;4949.505049495166;4953.628477864103;4875.390576177978;4896.559309662005;4916.827911023097;4938.703677779345;4950.702957822542;4915.18899381598;4926.4088309403105;4981.203007518924;5032.471590482946;5034.84895453137;4860.052289803596;4871.147549178809;4891.9755401222765;4943.4562198157455;4954.380702412199 02:43:58 INFO - PROCESS | 10573 | |1;ext.html;533.0432950698392;591.8372447576917;599.4574909706716;600.2586805295457;608.5587948737166;27228.183154505372;39839.60160398395;40710.79644601773;40799.796001020026;40827.59172408275;41860.16279674404;42495.57504424955;42562.57437425625;42594;42765.7861710691;7384.224656411053;7822.530648161129;7998.840168175611;9989.300748947577;10299;10155.136813370873;10296.227782916274;10297.588096476133;10298.12465940396;10298.536565854554;10280.537375818107;10349.275550711453;10359.844602330933;10361.222908281872;10365.689029329133;7488.588127652977;9991.150752186037;10277.126444252248;10284.691459256233;10626.628068017659;10140.847887281696;10223.744406389826;10225.539850706737;10227.539760710786;10256.897431025669;38115.42826857571;38641.806790965864;38676.613233867865;38756.41865372022;38757.61242387568;2924.5759364892183;3220.6874525929206;3352.916177095568;3737.2338670572467;3777.1312598102318;30033;30144.54783178254;30410;30547.694523054706;31588.842055789803;3404.489326601005;3511.841967111486;3526.559180102487;3537.239493508908;3578.8031658259047;240088;240726;240893;241656;244296;53560.73219633955;53878.46121538813;53947;54075.72962135243;54113.72943135259;33091.172720682174;34580.30839383198;34595.65404345975;36273.81863090667;36309.455358169645;12500.937495312648;13677.384517696728;13781.793273100911;13824.447022119204;13876.306184690726;9933.950330248446;10216.744581385376;10232.130268927076;10447.84328235077;10452.32059916103;18512.907435462737;18588.44234672962;18617.720734189;18634.347797827282;18646.81353186478;6793.966030169818;6964.164300283897;6976.651167441608;7001.544899581511;7054.118235220598;742.9925700742923;819.5451524403894;859.295377790206;862.5816479007676;949.1599934058409;28865.56701649477;29188.2846845422;29195.41609167847;29304.413911721647;29582.556261656093;919.8436265834824;958.7028021313415;992.6327258914248;1026.7741096958657;1026.8408396698524;15032.774508382165;15091.924540377448;15166.165860877538;15329.693406131815;15590.298436570381;397273;400286;401930;402048;402814;51771.482285176666;52186.478135218924;52245.7387713059;52308.47691523112;52317.47682523202;1114.2089116727213;1182.5506307603227;1202.3026644545967;1244.6577191272293;1262.0471543984233;28988.42023159567;29517;29830.850845745634;30202.848985754932;30376.088717338516;42054.789726051175;42402;42463.150736985706;42574.361384579875;42577;291079;291926;292093;292783;293702;25286.114985975404;25428.872855635604;26539.734602653727;26541.469170616867;27612.861935690195;43071.35392969046;43280;43435.34846977361;44089.779551103326;44630.3305450412;36545.45181822222;37419;37955.24089518249;37986;38201.4269785959;36808.631913681595;36814.81592592127;36989.63010369862;37090.25819483649;37319.44020839635;36308.45537316995;36651.45022824713;36951;37534.43698344582;37544.81227593844;31696.5245521322;33538.83230583832;33550.161245969044;34050.829745851115;34169.48745768766;25128.74871251264;25393.238202853943;25530;25698.852934435068;26012.349691257114 02:43:58 INFO - PROCESS | 10573 | |2;jquery.html;367.98896033119007;373.5629313702967;385.46997877917863;387.48464542158894;392.34086734286404;15603.687926241482;16355.509334719947;17002.40491582795;17017.404390846306;17221.7416738749;10965;15698.058116513017;16512.917435412837;16517.587060323498;17173.398931037416;4582.587567118959;4719.43366795985;4751.382320298374;4764.571188593026;4768.546988036131;3455.1534873955916;3619.60184379718;4686.414198225222;5175.353080864892;5432.864178395532;5482.342118945712;5495.038368285554;5507.284053073095;5510.972445137769;5514.6139770216105;5208.895822083556;5480.232767412545;5515.558755299567;5521.089020311644;5590.077637189859;3429.3484237994703;5054.9241761373605;5381.973090134564;5389.407165211824;5410.323709536308;12148.696282592917;12331.445084971198;12345.19756215852;12484.875151248552;12582.68543286416;1709.8546623537013;1726.0938007546013;1764.9911750441165;1768.5490199998917;1809.6561653285964;9005.954970225172;9160.496172710498;9172.082791720775;9183.724488265363;9360.906390936072;1679.160419790105;1686.6626674664994;1690.2309449200707;1697.2277613685744;1721.9668199080577;67493.3250667492;68215.31784682188;69120.6543967277;70646.64676676584;71988;9398.295127865438;9569.904300956901;9639.566219520138;9650.131488165958;9844.901550984541;13183.209007459584;13350.933245333712;13352.265625390502;13363.465461381631;13367.732645347232;6813.488988325896;6820.863582728318;6844.5208835382045;6902.309769023058;6921.584704917721;6402.135711678864;6511.38141876521;6635.734570617218;6643.767468138689;6644.734210631521;4179.811908464127;4224.957750422456;4297.355396690521;4437.979264769121;4458.754768487699;1544.4517196395118;1583.3903946980265;1703.872209584286;1712.8866236946085;1759.9736003959952;809.522381794744;815.2092470303796;842.9789255268545;853.9786505337293;951.9385884738605;16197.51407457778;16508.33966641321;16801.831981680025;16842.663146736995;17211.655766884844;848.5871024743856;848.7284069097952;852.2883392367319;873.7553485024204;931.4550987672152;9235.26117910579;9554.42673439582;9560.952195239119;9564.95217523922;9576.23390128788;354921;360969;362559;363204;366126;74631.62684186653;76909.61545192238;77790.2220977783;77791;78123;901.544719916438;902.697596305245;926.1988380051207;933.85992101184;936;14811.629709257355;14827.92586037063;14946.925265373604;14951.700965980837;15231.162286074372;31373.529397058606;31764.841175794896;32815;33490.33019339551;34109.488357674156;44815.327770082826;46356.30465543087;46716.7664161677;47423.76288118537;47469.762651186524;7419.629018548943;7426.480146389701;7456.17982021988;7632.19861914491;7725.381969442544;10922.617708380169;11323.490442930253;11331.716707082389;11366.090712743126;11606.071514279007;9444.669436569688;9532.285078618992;9632.75918102053;9929.255305852235;9995.600175992879;7608.543487390774;9739.805203896025;9828.213742900694;10084.092431681183;10279.434631095362;9657.372270802376;9736.9026309736;9777.755556111155;9828.508574571386;10169.44068076263;6650.6342151180215;6948.409385202112;6999.6850141742725;7015.438764898898;7107.786766397016;8904.421212621159;8959.955200223958;9404.482753448627;9631.855522167314;10454.0068693474 02:43:58 INFO - PROCESS | 10573 | |3;mootools.html;1272.885440310372;1442.7114577084585;1485.5543336998899;1593.4502596604175;1776.6446710657863;6941.930580694191;7526.435517336201;7679.116901556309;7718.536887786737;7901.920980790204;7774.455788094836;7884.4086693498075;7937.325327347168;7947.245011723877;7952.840943181133;2173.619616567102;2199.637059885117;2201.03154611971;2203.063697928382;2207.304699019812;2136.1455417832835;2172.478605134764;2176.945576360588;2180.4766855954535;2180.6401943679275;2151.3868547463976;2151.408362700254;2165.935021949344;2169.078141789741;2175.7824217578195;2096.8322534197227;2097.632914240002;2102.3062389411457;2102.463871712711;2104.968425473619;2052.271443637502;2120.639491286485;2122.991578999978;2123.140128248062;2123.893805309728;7343.889841652326;7483.176850546435;7785.026871641045;7819.061712594468;7857.410694197901;4580.770961451914;4748.833790817339;4756.476787553366;4764.547368000034;4786.353842231289;2975.7024297570288;3075.123589776903;3120.318024730817;3128.984355078233;3145.2608636970294;964.1081999150757;969.6024629901777;971.3394891473795;992.9851052234222;1007.37039350406;10630.946845265802;10846.240763146583;10851.294665846774;10872.402017889013;10902.236843420964;4343.218220720238;4354.085642015149;4466.6873318867365;4489.147062058199;4542.273236282179;8597.441166324168;8599.39804213699;8657.393982421296;8668.306535477146;8683.392162548687;4685.484596694361;4685.672002959828;4686.882827929329;4691.835785747482;4693.530646935279;3621.764585301947;3788.090858194069;4330.133973205371;4333.848315308949;4338.696291259645;3461.7922924624604;3530.1880567469625;3606.9278614427562;3630.528031355907;3655.6709896108946;1018.2770233134557;1066.99466502667;1078.568572570978;1082.2802836113897;1086.9619563315246;864.1142828600734;864.5547543015352;870.7126648206076;890.4657205676672;890.550272112592;5574.331080270394;5666.943330566724;5769.1923130761725;5811.302643682785;5821.796237131764;887.5650931043742;889.479654402169;916.0884919505135;936.8594710793299;937.044214900811;3651.1784848408897;3776.490173826553;3825.0819803247578;3830.9233815323537;3845.1540661054523;9036.909630903738;9418.481983490974;9489.145976861977;9523.666671666459;9546.37948533357;9240.214581760625;9482.099200575934;9488.146066854017;9503.90496095044;9505.049495050578;7353.77938661841;7443.7766866993;7508.849823003509;7528.887066694004;7535.7362492313605;5542.2795036644975;5818.185454036354;5848.9333153765265;5890.175375447355;5939.16851640762;9083.545822708706;9147.77130571741;9275.07249275067;9315.068493150631;9318.906810931803;9204;9259.120383563552;9271.30465215098;9317.487538185465;9345.112214339899;6111.96944015277;6790.626515541692;6959.478039146983;6970.546914450544;7157.785266442015;7418.480706350504;7451.068616422947;7451.478396512409;7462.552246865205;7468.887966680395;6728.6972086255255;6842.589444633139;6865;6982.231954485104;7027.964860175666;6748.595084294958;6749.763758268437;6851.931480685129;6858.451323893977;7031.402330801735;6278.372162783685;6508.869822603616;6515.446187074152;6680.064790929371;6761.492888033516;4891.119598472309;4928.876778080433;4935.728534930469;4950.9257361140335;4961.231009193581;4654.348391225163;4682.882927926829;4763.595094417014;4788.281757736228;4828.782704778364 02:43:58 INFO - PROCESS | 10573 | |4;prototype.html;305.12429327829136;310.5186960211672;319.3915590799527;320.59764994931356;323.27586206896547;4544.204764166274;4678.883027924295;4757.666963312565;4823.951760482394;4825.78283977221;4539.477960034597;4679.883002924928;4708.246680531116;4719.929201061978;4733.136452446263;3763.8306276217636;3779.79211143387;3781.392908014097;3787.7121778595274;3793.943090853639;3574.873914716869;3640.672339489445;3786.2995345861104;3789.9810500947456;3794.690831663072;3710.2579484103153;3727.4595183698348;3738.738288319819;3752.9437058444146;3754.085416437609;3722.4230244312175;3737.5141231639714;3739.569949455793;3786.5077539919907;3797.411401232813;3347.6484969078383;3352.664733526652;3358.529805827162;3358.6137594176494;3361.294128233074;4450.310201918708;4491.483479399878;4535.773211339453;4562.726236425825;4567.862964111082;4271.227440612142;4297.378599054574;4300.849470268557;4323.1785960667685;4331.501877284121;4895.9510404895855;4900.525234756461;4900.803967841282;4917.4344950330815;4938.185199442088;3576.481410195533;3671.8531258749617;3675.1730860556427;3677.889663310105;3710.3692372296773;5178.378594568639;5182.870428239286;5194.883100133452;5204.475829222823;5209.759803284586;3725;3725.981370093132;3740.1023754299317;3756.69946404287;3766.6798322142376;3827.138893748884;3846.8653597123966;3854.0557563396587;3854.2869569129803;3862.594427585063;4088.3850878903263;4249.851255206053;4260.936085958713;4271.9786401067795;4289.1421715657;4713.67004309695;4947.134251505972;4953.157963146202;4961.305417241589;5009.497150854729;1290.9870901290867;1324.8741369569875;1337.822716009905;1341.6377578054066;1346.2124657075524;857.6783706110209;872.389327470773;874.8862647855738;889.5329951775241;893.7810236491971;3943.4479172915817;3966.345552983783;3980.8805735827973;4006.198760247962;4022.557518672944;4482.260427029569;4528.954710452919;4530.275155975029;4539.273716205391;4553.59017688403;3941;3955.892350141965;3977.5226972763453;3978.264021156095;3982;2307.8384513083925;2405.615101583738;2419.512000119949;2446.47400808827;2449.9755002449747;4320.913581728348;4327.891802704895;4335.6965012449455;4339.1972485090355;4349.891252718644;4573.63410927125;4586.243269860435;4611.76941152941;4674.919660750933;4677.836275730333;4086.7752273625238;4263.424437700933;4267.4238977737605;4289.978550107229;4302.311630139163;4494;4506.211413002646;4519.977400112978;4520.570545798144;4535.915577407394;4445.711028783118;4458.643308535375;4465.732056076646;4501.617362524091;4559.612432943237;4099.487564054493;4276.2089013532595;4310.870673879788;4316.244657185043;4325.199838029975;3397.5243465915287;3458.8962331130106;3477.435154180578;3481.947770783491;3490.9476357854146;4454.681262459359;4486.698857331337;4488.438945131858;4557.931631025471;4813.422389313305;4753.191957367325;4935.84106172043;4959.181735013826;4967.155583550877;4988.376452943382;4875.878103047452;4912.778924948315;4930.753462326941;4940.184869496493;4967.975160124176;4745.881352966204;4880;4886.65793394459;4890.6087512998165;4909.4845041270155;4918.803247870045;4928.753562321941;4994.550490455877;4995.675281106716;4999.850064472312;4857.489963553776;4862.31927530139;4886.780094895667;4931.753412329441;4932.605391568738 02:43:58 INFO - PROCESS | 10573 | |5;yui.html;593.4154857465397;699.7166147710179;738.1806195123415;753.1338960195774;767.2787579675108;12276.693082672939;13359;13377.464901403957;13395;13410.19538827671;12472;12536.498540058386;12590.622281331574;12617.747645047093;12719.491220351174;625.9405356491148;714.0574441736909;727.0330460487539;773.0684525147212;810.3962547901822;799.4683535448919;800.8518424091533;803.5339503088225;803.7628899474669;804.7183485779989;856.0497847389393;856.5888373580685;857.2541888556933;857.5626430520417;857.7812657772259;648.623798197047;812.7561731480532;834.1325021977136;834.9039860416069;846.6401779243797;613.7146227004464;618.1315252070802;618.2766163588612;618.3569088148321;618.6226401894841;12651.493940242472;12701.809472857914;12701.936490317581;12717.173383730027;12719.872801272053;11757.882421175764;12003.93998030013;12328.445219965033;12560.995120390347;12606.495740170381;10404.16766658673;10463.476826158738;10479;10524.947375263151;10553.261271710984;3916.1776027034357;3930.6473743295496;3967.7619342839234;3989.780562069085;4013.237484877864;45987;46108.53891461076;46731.29903051457;46800.29799553009;46812.297815532795;9605.567749451291;9716.125548700651;9798.216142708709;9799.412035277906;9892.703218903445;17833.554161146076;17854.19656115478;17922.193501292473;17934;18294.79841027815;6751.729930802713;6775.593464392152;6843.418309443753;6875.278095799869;6903.6203008835;3535.9292814143573;3560.964390356115;3615.5119058927235;3807.2195199983935;3816.065064059323;2921.517949538345;3043.6651968283472;3057.4649436348996;3058.5106382978615;3058.923526911845;437.97372157670003;532.6351449257271;536.5519790974502;548.6954740119193;552.5358698693117;452.72383845854;558.5782734035859;580.5703779203443;584.4564554963924;622.4926684751913;7655.464117511832;8023.277904988579;8037.35701143907;8202.343812494986;8388.161183881562;540.6134613751187;565.0253313035064;582.1558739827267;608.5375114912698;609.6464050850497;3669.834857431422;3727.6645101940953;3748.962510374916;3800.35393983018;3868.226354729009;58119.4188058114;62225.68887155535;62292;62657;62802.37197628056;52821.623026963876;53026;53038;53088.469115308355;54745.1788223177;41466.378004329956;42074.57925420706;47123.5287647126;47359.99999999931;49835.50164498381;8369.330453563822;8388.874166887623;8419.831603367777;8462.83074338522;8505.617247224014;30410.239744006576;30909.536356955112;31713.524297136024;31768.841155794074;32282.83858580692;38772.224555509296;42197;42520.57479425166;42561.87190640518;43410.78294608507;10548.789024219626;10608.52261648243;10657.413842238751;10692.091172250135;10734.51694673726;11645.47595358194;11926.224795388272;11993.400329983291;12228.938855305667;12390.380480976095;10917.56329746833;11258.268212566485;11634.94182529082;11644.767104658029;11654.242474239147;10302;10591;10653.414062226651;10799.892001079888;11125.554977800797;10408.583656653649;10415.68752937413;10665.36007839532;10698.197635177237;10724.981126792942;9526.190273826802;9570.904290957002;9607.423554586747;9763.609455621696;10000.649977250761;9284.3036772241;9319.720408387759;9322.580483878106;9476.478793666414;9698.272629552954 02:43:58 INFO - PROCESS | 10573 | __end_tp_report 02:43:58 INFO - PROCESS | 10573 | __start_cc_report 02:43:58 INFO - PROCESS | 10573 | _x_x_mozilla_cycle_collect,1068 02:43:58 INFO - PROCESS | 10573 | __end_cc_report 02:43:58 INFO - PROCESS | 10573 | __startTimestamp1464601438369__endTimestamp 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | ------- Summary: start ------- 02:43:58 INFO - PROCESS | 10573 | Number of tests: 6 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | [#0] dojo.html Cycles:165 Average:4708.62 Median:4854.20 stddev:499.72 (10.3%) stddev-sans-first:474.39 02:43:58 INFO - PROCESS | 10573 | Values: 2648.3 2665.5 2687.7 2697.2 2708.9 4640.9 4646.2 4715.6 4732.2 4779.9 4686.2 4703.8 4714.7 4715.2 4780.3 4075.3 4239.4 4319.4 4346.6 4438.6 4357.7 4382.5 4398.2 4404.9 4441.8 4238.1 4275.5 4276.8 4281.5 4302.3 4298.8 4308.2 4359.7 4372.8 4377.8 4343.8 4352.8 4360.5 4381.4 4393.4 4602.0 4624.4 4678.7 4687.1 4722.5 5067.5 5119.3 5132.2 5146.7 5150.8 4978.3 5137.9 5163.5 5168.0 5170.6 4691.0 4747.4 4753.0 4783.1 4803.4 5249.8 5268.6 5269.2 5278.5 5280.1 5046.5 5049.4 5056.4 5057.0 5058.7 4953.2 5043.4 5100.0 5101.9 5140.9 5064.9 5069.1 5077.9 5080.4 5128.8 4899.1 5046.3 5055.9 5062.0 5064.2 4288.2 4344.9 4349.8 4355.6 4395.0 3758.8 3788.7 3790.5 3824.7 3826.8 4311.5 4416.1 4427.6 4479.5 4482.3 5040.2 5101.1 5103.8 5180.0 5183.2 4400.5 4407.6 4409.0 4426.3 4458.1 4601.1 4605.6 4607.7 4609.0 4655.9 4686.0 4698.9 4781.0 4841.5 4848.3 5158.7 5162.3 5164.8 5175.7 5179.0 4849.7 4852.0 4854.2 4888.3 4912.3 4886.0 5002.6 5045.4 5073.7 5086.8 5148.3 5165.6 5167.5 5175.0 5222.8 4854.8 5016.3 5017.2 5024.9 5033.5 4891.3 4922.6 4934.6 4949.5 4953.6 4875.4 4896.6 4916.8 4938.7 4950.7 4915.2 4926.4 4981.2 5032.5 5034.8 4860.1 4871.1 4892.0 4943.5 4954.4 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | [#1] ext.html Cycles:180 Average:46989.14 Median:34374.90 stddev:83739.90 (243.6%) stddev-sans-first:83902.17 02:43:58 INFO - PROCESS | 10573 | Values: 533.0 591.8 599.5 600.3 608.6 27228.2 39839.6 40710.8 40799.8 40827.6 41860.2 42495.6 42562.6 42594.0 42765.8 7384.2 7822.5 7998.8 9989.3 10299.0 10155.1 10296.2 10297.6 10298.1 10298.5 10280.5 10349.3 10359.8 10361.2 10365.7 7488.6 9991.2 10277.1 10284.7 10626.6 10140.8 10223.7 10225.5 10227.5 10256.9 38115.4 38641.8 38676.6 38756.4 38757.6 2924.6 3220.7 3352.9 3737.2 3777.1 30033.0 30144.5 30410.0 30547.7 31588.8 3404.5 3511.8 3526.6 3537.2 3578.8 240088.0 240726.0 240893.0 241656.0 244296.0 53560.7 53878.5 53947.0 54075.7 54113.7 33091.2 34580.3 34595.7 36273.8 36309.5 12500.9 13677.4 13781.8 13824.4 13876.3 9934.0 10216.7 10232.1 10447.8 10452.3 18512.9 18588.4 18617.7 18634.3 18646.8 6794.0 6964.2 6976.7 7001.5 7054.1 743.0 819.5 859.3 862.6 949.2 28865.6 29188.3 29195.4 29304.4 29582.6 919.8 958.7 992.6 1026.8 1026.8 15032.8 15091.9 15166.2 15329.7 15590.3 397273.0 400286.0 401930.0 402048.0 402814.0 51771.5 52186.5 52245.7 52308.5 52317.5 1114.2 1182.6 1202.3 1244.7 1262.0 28988.4 29517.0 29830.9 30202.8 30376.1 42054.8 42402.0 42463.2 42574.4 42577.0 291079.0 291926.0 292093.0 292783.0 293702.0 25286.1 25428.9 26539.7 26541.5 27612.9 43071.4 43280.0 43435.3 44089.8 44630.3 36545.5 37419.0 37955.2 37986.0 38201.4 36808.6 36814.8 36989.6 37090.3 37319.4 36308.5 36651.5 36951.0 37534.4 37544.8 31696.5 33538.8 33550.2 34050.8 34169.5 25128.7 25393.2 25530.0 25698.9 26012.3 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | [#2] jquery.html Cycles:180 Average:22786.80 Median:5295.43 stddev:59917.61 (1131.5%) stddev-sans-first:60062.05 02:43:58 INFO - PROCESS | 10573 | Values: 368.0 373.6 385.5 387.5 392.3 15603.7 16355.5 17002.4 17017.4 17221.7 10965.0 15698.1 16512.9 16517.6 17173.4 4582.6 4719.4 4751.4 4764.6 4768.5 3455.2 3619.6 4686.4 5175.4 5432.9 5482.3 5495.0 5507.3 5511.0 5514.6 5208.9 5480.2 5515.6 5521.1 5590.1 3429.3 5054.9 5382.0 5389.4 5410.3 12148.7 12331.4 12345.2 12484.9 12582.7 1709.9 1726.1 1765.0 1768.5 1809.7 9006.0 9160.5 9172.1 9183.7 9360.9 1679.2 1686.7 1690.2 1697.2 1722.0 67493.3 68215.3 69120.7 70646.6 71988.0 9398.3 9569.9 9639.6 9650.1 9844.9 13183.2 13350.9 13352.3 13363.5 13367.7 6813.5 6820.9 6844.5 6902.3 6921.6 6402.1 6511.4 6635.7 6643.8 6644.7 4179.8 4225.0 4297.4 4438.0 4458.8 1544.5 1583.4 1703.9 1712.9 1760.0 809.5 815.2 843.0 854.0 951.9 16197.5 16508.3 16801.8 16842.7 17211.7 848.6 848.7 852.3 873.8 931.5 9235.3 9554.4 9561.0 9565.0 9576.2 354921.0 360969.0 362559.0 363204.0 366126.0 74631.6 76909.6 77790.2 77791.0 78123.0 901.5 902.7 926.2 933.9 936.0 14811.6 14827.9 14946.9 14951.7 15231.2 31373.5 31764.8 32815.0 33490.3 34109.5 44815.3 46356.3 46716.8 47423.8 47469.8 7419.6 7426.5 7456.2 7632.2 7725.4 10922.6 11323.5 11331.7 11366.1 11606.1 9444.7 9532.3 9632.8 9929.3 9995.6 7608.5 9739.8 9828.2 10084.1 10279.4 9657.4 9736.9 9777.8 9828.5 10169.4 6650.6 6948.4 6999.7 7015.4 7107.8 8904.4 8960.0 9404.5 9631.9 10454.0 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | [#3] mootools.html Cycles:180 Average:5211.91 Median:5814.74 stddev:2875.79 (49.5%) stddev-sans-first:2868.62 02:43:58 INFO - PROCESS | 10573 | Values: 1272.9 1442.7 1485.6 1593.5 1776.6 6941.9 7526.4 7679.1 7718.5 7901.9 7774.5 7884.4 7937.3 7947.2 7952.8 2173.6 2199.6 2201.0 2203.1 2207.3 2136.1 2172.5 2176.9 2180.5 2180.6 2151.4 2151.4 2165.9 2169.1 2175.8 2096.8 2097.6 2102.3 2102.5 2105.0 2052.3 2120.6 2123.0 2123.1 2123.9 7343.9 7483.2 7785.0 7819.1 7857.4 4580.8 4748.8 4756.5 4764.5 4786.4 2975.7 3075.1 3120.3 3129.0 3145.3 964.1 969.6 971.3 993.0 1007.4 10630.9 10846.2 10851.3 10872.4 10902.2 4343.2 4354.1 4466.7 4489.1 4542.3 8597.4 8599.4 8657.4 8668.3 8683.4 4685.5 4685.7 4686.9 4691.8 4693.5 3621.8 3788.1 4330.1 4333.8 4338.7 3461.8 3530.2 3606.9 3630.5 3655.7 1018.3 1067.0 1078.6 1082.3 1087.0 864.1 864.6 870.7 890.5 890.6 5574.3 5666.9 5769.2 5811.3 5821.8 887.6 889.5 916.1 936.9 937.0 3651.2 3776.5 3825.1 3830.9 3845.2 9036.9 9418.5 9489.1 9523.7 9546.4 9240.2 9482.1 9488.1 9503.9 9505.0 7353.8 7443.8 7508.8 7528.9 7535.7 5542.3 5818.2 5848.9 5890.2 5939.2 9083.5 9147.8 9275.1 9315.1 9318.9 9204.0 9259.1 9271.3 9317.5 9345.1 6112.0 6790.6 6959.5 6970.5 7157.8 7418.5 7451.1 7451.5 7462.6 7468.9 6728.7 6842.6 6865.0 6982.2 7028.0 6748.6 6749.8 6851.9 6858.5 7031.4 6278.4 6508.9 6515.4 6680.1 6761.5 4891.1 4928.9 4935.7 4950.9 4961.2 4654.3 4682.9 4763.6 4788.3 4828.8 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | [#4] prototype.html Cycles:180 Average:3987.52 Median:4329.70 stddev:1117.06 (25.8%) stddev-sans-first:1085.46 02:43:58 INFO - PROCESS | 10573 | Values: 305.1 310.5 319.4 320.6 323.3 4544.2 4678.9 4757.7 4824.0 4825.8 4539.5 4679.9 4708.2 4719.9 4733.1 3763.8 3779.8 3781.4 3787.7 3793.9 3574.9 3640.7 3786.3 3790.0 3794.7 3710.3 3727.5 3738.7 3752.9 3754.1 3722.4 3737.5 3739.6 3786.5 3797.4 3347.6 3352.7 3358.5 3358.6 3361.3 4450.3 4491.5 4535.8 4562.7 4567.9 4271.2 4297.4 4300.8 4323.2 4331.5 4896.0 4900.5 4900.8 4917.4 4938.2 3576.5 3671.9 3675.2 3677.9 3710.4 5178.4 5182.9 5194.9 5204.5 5209.8 3725.0 3726.0 3740.1 3756.7 3766.7 3827.1 3846.9 3854.1 3854.3 3862.6 4088.4 4249.9 4260.9 4272.0 4289.1 4713.7 4947.1 4953.2 4961.3 5009.5 1291.0 1324.9 1337.8 1341.6 1346.2 857.7 872.4 874.9 889.5 893.8 3943.4 3966.3 3980.9 4006.2 4022.6 4482.3 4529.0 4530.3 4539.3 4553.6 3941.0 3955.9 3977.5 3978.3 3982.0 2307.8 2405.6 2419.5 2446.5 2450.0 4320.9 4327.9 4335.7 4339.2 4349.9 4573.6 4586.2 4611.8 4674.9 4677.8 4086.8 4263.4 4267.4 4290.0 4302.3 4494.0 4506.2 4520.0 4520.6 4535.9 4445.7 4458.6 4465.7 4501.6 4559.6 4099.5 4276.2 4310.9 4316.2 4325.2 3397.5 3458.9 3477.4 3481.9 3490.9 4454.7 4486.7 4488.4 4557.9 4813.4 4753.2 4935.8 4959.2 4967.2 4988.4 4875.9 4912.8 4930.8 4940.2 4968.0 4745.9 4880.0 4886.7 4890.6 4909.5 4918.8 4928.8 4994.6 4995.7 4999.9 4857.5 4862.3 4886.8 4931.8 4932.6 02:43:58 INFO - PROCESS | 10573 | 02:43:58 INFO - PROCESS | 10573 | [#5] yui.html Cycles:180 Average:13546.23 Median:46047.77 stddev:16068.14 (34.9%) stddev-sans-first:16083.77 02:43:58 INFO - PROCESS | 10573 | Values: 593.4 699.7 738.2 753.1 767.3 12276.7 13359.0 13377.5 13395.0 13410.2 12472.0 12536.5 12590.6 12617.7 12719.5 625.9 714.1 727.0 773.1 810.4 799.5 800.9 803.5 803.8 804.7 856.0 856.6 857.3 857.6 857.8 648.6 812.8 834.1 834.9 846.6 613.7 618.1 618.3 618.4 618.6 12651.5 12701.8 12701.9 12717.2 12719.9 11757.9 12003.9 12328.4 12561.0 12606.5 10404.2 10463.5 10479.0 10524.9 10553.3 3916.2 3930.6 3967.8 3989.8 4013.2 45987.0 46108.5 46731.3 46800.3 46812.3 9605.6 9716.1 9798.2 9799.4 9892.7 17833.6 17854.2 17922.2 17934.0 18294.8 6751.7 6775.6 6843.4 6875.3 6903.6 3535.9 3561.0 3615.5 3807.2 3816.1 2921.5 3043.7 3057.5 3058.5 3058.9 438.0 532.6 536.6 548.7 552.5 452.7 558.6 580.6 584.5 622.5 7655.5 8023.3 8037.4 8202.3 8388.2 540.6 565.0 582.2 608.5 609.6 3669.8 3727.7 3749.0 3800.4 3868.2 58119.4 62225.7 62292.0 62657.0 62802.4 52821.6 53026.0 53038.0 53088.5 54745.2 41466.4 42074.6 47123.5 47360.0 49835.5 8369.3 8388.9 8419.8 8462.8 8505.6 30410.2 30909.5 31713.5 31768.8 32282.8 38772.2 42197.0 42520.6 42561.9 43410.8 10548.8 10608.5 10657.4 10692.1 10734.5 11645.5 11926.2 11993.4 12228.9 12390.4 10917.6 11258.3 11634.9 11644.8 11654.2 10302.0 10591.0 10653.4 10799.9 11125.6 10408.6 10415.7 10665.4 10698.2 10725.0 9526.2 9570.9 9607.4 9763.6 10000.6 9284.3 9319.7 9322.6 9476.5 9698.3 02:43:58 INFO - PROCESS | 10573 | -------- Summary: end -------- 02:43:58 INFO - PROCESS | 10573 | 02:43:59 INFO - TEST-INFO | 10573: exit 0 02:43:59 INFO - TEST-OK | dromaeo_css | took 1118810ms 02:43:59 INFO - TEST-START | kraken 02:43:59 INFO - operating with platform_type : linux_ 02:43:59 INFO - Initialising browser for kraken test... 02:43:59 INFO - TEST-INFO | started process 10753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZCqBKI/profile http://localhost:39365/getInfo.html) 02:44:03 INFO - PROCESS | 10753 | __metrics Screen width/height:1600/1200 02:44:03 INFO - PROCESS | 10753 | colorDepth:24 02:44:03 INFO - PROCESS | 10753 | Browser inner width/height: 1024/697 02:44:03 INFO - PROCESS | 10753 | __metrics 02:44:04 ERROR - PROCESS | 10753 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:44:05 INFO - TEST-INFO | 10753: exit 0 02:44:05 INFO - Browser initialized. 02:44:05 INFO - Running cycle 1/1 for kraken test... 02:44:05 INFO - TEST-INFO | started process 10836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZCqBKI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:44:17 INFO - PROCESS | 10836 | RSS: Main: 157741056 02:44:17 INFO - PROCESS | 10836 | 02:44:19 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39365/tests/kraken/driver.html?testName=audio-beat-detection) 02:44:20 INFO - PROCESS | 10836 | RSS: Main: 214265856 02:44:20 INFO - PROCESS | 10836 | 02:44:23 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39365/tests/kraken/driver.html?testName=audio-dft) 02:44:24 INFO - PROCESS | 10836 | RSS: Main: 202919936 02:44:24 INFO - PROCESS | 10836 | 02:44:27 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39365/tests/kraken/driver.html?testName=audio-fft) 02:44:27 INFO - PROCESS | 10836 | RSS: Main: 270356480 02:44:27 INFO - PROCESS | 10836 | 02:44:30 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39365/tests/kraken/driver.html?testName=audio-oscillator) 02:44:30 INFO - PROCESS | 10836 | RSS: Main: 180727808 02:44:30 INFO - PROCESS | 10836 | 02:44:32 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:44:33 INFO - PROCESS | 10836 | RSS: Main: 185249792 02:44:33 INFO - PROCESS | 10836 | 02:44:36 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39365/tests/kraken/driver.html?testName=imaging-darkroom) 02:44:37 INFO - PROCESS | 10836 | RSS: Main: 220606464 02:44:37 INFO - PROCESS | 10836 | 02:44:40 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39365/tests/kraken/driver.html?testName=imaging-desaturate) 02:44:41 INFO - PROCESS | 10836 | RSS: Main: 216125440 02:44:41 INFO - PROCESS | 10836 | 02:44:44 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39365/tests/kraken/driver.html?testName=json-parse-financial) 02:44:44 INFO - PROCESS | 10836 | RSS: Main: 219095040 02:44:44 INFO - PROCESS | 10836 | 02:44:46 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:44:47 INFO - PROCESS | 10836 | RSS: Main: 208629760 02:44:47 INFO - PROCESS | 10836 | 02:44:49 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:44:49 INFO - PROCESS | 10836 | RSS: Main: 210931712 02:44:49 INFO - PROCESS | 10836 | 02:44:51 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:44:52 INFO - PROCESS | 10836 | RSS: Main: 218796032 02:44:52 INFO - PROCESS | 10836 | 02:44:55 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:44:56 INFO - PROCESS | 10836 | RSS: Main: 221351936 02:44:56 INFO - PROCESS | 10836 | 02:44:58 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:44:59 INFO - PROCESS | 10836 | RSS: Main: 222744576 02:44:59 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | Cycle 1(1): loaded http://localhost:39365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39365/tests/kraken/driver.html?testName=ai-astar) 02:45:01 INFO - PROCESS | 10836 | RSS: Main: 264527872 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | __start_tp_report 02:45:01 INFO - PROCESS | 10836 | _x_x_mozilla_page_load 02:45:01 INFO - PROCESS | 10836 | _x_x_mozilla_page_load_details 02:45:01 INFO - PROCESS | 10836 | |i|pagename|runs| 02:45:01 INFO - PROCESS | 10836 | |0;ai-astar;116;110;113;114;113;113;114;112;113;113 02:45:01 INFO - PROCESS | 10836 | |1;audio-beat-detection;168;131;131;184;130;134;152;133;169;129 02:45:01 INFO - PROCESS | 10836 | |2;audio-dft;162;162;160;161;162;162;161;162;161;161 02:45:01 INFO - PROCESS | 10836 | |3;audio-fft;75;77;76;128;76;76;76;75;106;74 02:45:01 INFO - PROCESS | 10836 | |4;audio-oscillator;85;86;112;84;84;84;116;84;85;142 02:45:01 INFO - PROCESS | 10836 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;118;117;117 02:45:01 INFO - PROCESS | 10836 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 02:45:01 INFO - PROCESS | 10836 | |7;imaging-desaturate;95;94;94;94;95;94;95;95;95;95 02:45:01 INFO - PROCESS | 10836 | |8;json-parse-financial;64;64;65;64;65;65;65;65;64;63 02:45:01 INFO - PROCESS | 10836 | |9;json-stringify-tinderbox;66;65;65;65;65;65;66;65;66;67 02:45:01 INFO - PROCESS | 10836 | |10;stanford-crypto-aes;82;83;83;82;83;85;85;84;113;84 02:45:01 INFO - PROCESS | 10836 | |11;stanford-crypto-ccm;142;139;132;133;131;139;132;139;147;133 02:45:01 INFO - PROCESS | 10836 | |12;stanford-crypto-pbkdf2;172;170;171;171;167;167;166;169;169;169 02:45:01 INFO - PROCESS | 10836 | |13;stanford-crypto-sha256-iterative;71;66;67;69;69;68;70;68;70;64 02:45:01 INFO - PROCESS | 10836 | __end_tp_report 02:45:01 INFO - PROCESS | 10836 | __start_cc_report 02:45:01 INFO - PROCESS | 10836 | _x_x_mozilla_cycle_collect,1889 02:45:01 INFO - PROCESS | 10836 | __end_cc_report 02:45:01 INFO - PROCESS | 10836 | __startTimestamp1464601501566__endTimestamp 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | ------- Summary: start ------- 02:45:01 INFO - PROCESS | 10836 | Number of tests: 14 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:1.52 (1.3%) stddev-sans-first:1.20 02:45:01 INFO - PROCESS | 10836 | Values: 116.0 110.0 113.0 114.0 113.0 113.0 114.0 112.0 113.0 113.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:143.00 stddev:20.55 (14.4%) stddev-sans-first:20.21 02:45:01 INFO - PROCESS | 10836 | Values: 168.0 131.0 131.0 184.0 130.0 134.0 152.0 133.0 169.0 129.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 02:45:01 INFO - PROCESS | 10836 | Values: 162.0 162.0 160.0 161.0 162.0 162.0 161.0 162.0 161.0 161.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:18.22 (24.0%) stddev-sans-first:19.04 02:45:01 INFO - PROCESS | 10836 | Values: 75.0 77.0 76.0 128.0 76.0 76.0 76.0 75.0 106.0 74.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:20.25 (24.1%) stddev-sans-first:21.07 02:45:01 INFO - PROCESS | 10836 | Values: 85.0 86.0 112.0 84.0 84.0 84.0 116.0 84.0 85.0 142.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 02:45:01 INFO - PROCESS | 10836 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 02:45:01 INFO - PROCESS | 10836 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:45:01 INFO - PROCESS | 10836 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 02:45:01 INFO - PROCESS | 10836 | Values: 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 64.0 63.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 02:45:01 INFO - PROCESS | 10836 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 67.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:83.50 stddev:9.41 (11.3%) stddev-sans-first:9.84 02:45:01 INFO - PROCESS | 10836 | Values: 82.0 83.0 83.0 82.0 83.0 85.0 85.0 84.0 113.0 84.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:139.00 stddev:5.31 (3.8%) stddev-sans-first:5.28 02:45:01 INFO - PROCESS | 10836 | Values: 142.0 139.0 132.0 133.0 131.0 139.0 132.0 139.0 147.0 133.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:1.97 (1.2%) stddev-sans-first:1.79 02:45:01 INFO - PROCESS | 10836 | Values: 172.0 170.0 171.0 171.0 167.0 167.0 166.0 169.0 169.0 169.0 02:45:01 INFO - PROCESS | 10836 | 02:45:01 INFO - PROCESS | 10836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:2.10 (3.0%) stddev-sans-first:1.96 02:45:01 INFO - PROCESS | 10836 | Values: 71.0 66.0 67.0 69.0 69.0 68.0 70.0 68.0 70.0 64.0 02:45:01 INFO - PROCESS | 10836 | -------- Summary: end -------- 02:45:01 INFO - PROCESS | 10836 | 02:45:02 INFO - TEST-INFO | 10836: exit 0 02:45:02 INFO - TEST-OK | kraken | took 63431ms 02:45:02 INFO - SUITE-END | took 1182s 02:45:02 INFO - Completed test suite (00:19:42) 02:45:02 INFO - javascript benchmark 02:45:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2648.3246772073117, 2665.4669066186766, 2687.7446642568957, 2697.2312890826106, 2708.864556772161, 4640.883977900554, 4646.163690535706, 4715.599174070208, 4732.195526760451, 4779.9283010754825, 4686.179918514264, 4703.8118475261035, 4714.717116972984, 4715.174844402233, 4780.259059845729, 4075.3071977763702, 4239.406483092362, 4319.3952846601505, 4346.630536404394, 4438.600525952664, 4357.651387888961, 4382.539833317488, 4398.164348773723, 4404.911901761963, 4441.844535441261, 4238.067625122453, 4275.486941567032, 4276.807543660511, 4281.486221653421, 4302.333138363559, 4298.763568003758, 4308.18144552534, 4359.651227901761, 4372.803223854934, 4377.846775362847, 4343.804528796211, 4352.7823608819745, 4360.520342762294, 4381.408509851161, 4393.384926110347, 4602.0, 4624.3757092792375, 4678.695884767513, 4687.086018226447, 4722.480527142012, 5067.543921047087, 5119.25770763241, 5132.204508301219, 5146.716930568818, 5150.768215430315, 4978.327925730016, 5137.922931156036, 5163.483651634844, 5168.043911876277, 5170.560502357304, 4691.014886873761, 4747.382840230748, 4752.952470475251, 4783.091212669582, 4803.423589169322, 5249.816256431007, 5268.631195816256, 5269.209618557171, 5278.5249327560705, 5280.102382594968, 5046.520580544842, 5049.419316778617, 5056.367954005749, 5057.039162559102, 5058.671186372948, 4953.157963146274, 5043.420006699276, 5100.030994111107, 5101.897962040738, 5140.871478213, 5064.924026139611, 5069.087564238473, 5077.923831142536, 5080.415752188545, 5128.769205385766, 4899.118158731462, 5046.343975283263, 5055.898882022412, 5061.9746901266, 5064.240363945438, 4288.185244803477, 4344.869653910388, 4349.782510874507, 4355.60799528044, 4394.978025109854, 3758.774473531597, 3788.677962373174, 3790.450384694204, 3824.694024478035, 3826.7512611680154, 4311.48262208537, 4416.050549131888, 4427.601515863587, 4479.507254202035, 4482.282834746425, 5040.193569028937, 5101.05630458359, 5103.795848166106, 5180.0, 5183.248428977777, 4400.537943515885, 4407.603315701603, 4408.956778337145, 4426.313921342133, 4458.063806600585, 4601.102784956968, 4605.631549476034, 4607.723536587815, 4608.976955115203, 4655.86032419028, 4685.9765701171955, 4698.882527936829, 4781.0, 4841.491643377535, 4848.296996935495, 5158.664686795346, 5162.328897243335, 5164.767585458589, 5175.741212939262, 5179.027815686985, 4849.733264670336, 4851.956829281721, 4854.199057155671, 4888.2911977762315, 4912.312276281395, 4885.975570122127, 5002.599792016703, 5045.369328833895, 5073.695578265316, 5086.847394578169, 5148.279240906201, 5165.61257905651, 5167.534921857051, 5174.97412512935, 5222.791088356423, 4854.781534831011, 5016.272640467038, 5017.247412888096, 5024.899502010013, 5033.521815427529, 4891.26631005352, 4922.581580565692, 4934.55588996992, 4949.505049495166, 4953.628477864103, 4875.390576177978, 4896.559309662005, 4916.827911023097, 4938.703677779345, 4950.702957822542, 4915.18899381598, 4926.4088309403105, 4981.203007518924, 5032.471590482946, 5034.84895453137, 4860.052289803596, 4871.147549178809, 4891.9755401222765, 4943.4562198157455, 4954.380702412199], "value": 4676.71334420384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.0432950698392, 591.8372447576917, 599.4574909706716, 600.2586805295457, 608.5587948737166, 27228.183154505372, 39839.60160398395, 40710.79644601773, 40799.796001020026, 40827.59172408275, 41860.16279674404, 42495.57504424955, 42562.57437425625, 42594.0, 42765.7861710691, 7384.224656411053, 7822.530648161129, 7998.840168175611, 9989.300748947577, 10299.0, 10155.136813370873, 10296.227782916274, 10297.588096476133, 10298.12465940396, 10298.536565854554, 10280.537375818107, 10349.275550711453, 10359.844602330933, 10361.222908281872, 10365.689029329133, 7488.588127652977, 9991.150752186037, 10277.126444252248, 10284.691459256233, 10626.628068017659, 10140.847887281696, 10223.744406389826, 10225.539850706737, 10227.539760710786, 10256.897431025669, 38115.42826857571, 38641.806790965864, 38676.613233867865, 38756.41865372022, 38757.61242387568, 2924.5759364892183, 3220.6874525929206, 3352.916177095568, 3737.2338670572467, 3777.1312598102318, 30033.0, 30144.54783178254, 30410.0, 30547.694523054706, 31588.842055789803, 3404.489326601005, 3511.841967111486, 3526.559180102487, 3537.239493508908, 3578.8031658259047, 240088.0, 240726.0, 240893.0, 241656.0, 244296.0, 53560.73219633955, 53878.46121538813, 53947.0, 54075.72962135243, 54113.72943135259, 33091.172720682174, 34580.30839383198, 34595.65404345975, 36273.81863090667, 36309.455358169645, 12500.937495312648, 13677.384517696728, 13781.793273100911, 13824.447022119204, 13876.306184690726, 9933.950330248446, 10216.744581385376, 10232.130268927076, 10447.84328235077, 10452.32059916103, 18512.907435462737, 18588.44234672962, 18617.720734189, 18634.347797827282, 18646.81353186478, 6793.966030169818, 6964.164300283897, 6976.651167441608, 7001.544899581511, 7054.118235220598, 742.9925700742923, 819.5451524403894, 859.295377790206, 862.5816479007676, 949.1599934058409, 28865.56701649477, 29188.2846845422, 29195.41609167847, 29304.413911721647, 29582.556261656093, 919.8436265834824, 958.7028021313415, 992.6327258914248, 1026.7741096958657, 1026.8408396698524, 15032.774508382165, 15091.924540377448, 15166.165860877538, 15329.693406131815, 15590.298436570381, 397273.0, 400286.0, 401930.0, 402048.0, 402814.0, 51771.482285176666, 52186.478135218924, 52245.7387713059, 52308.47691523112, 52317.47682523202, 1114.2089116727213, 1182.5506307603227, 1202.3026644545967, 1244.6577191272293, 1262.0471543984233, 28988.42023159567, 29517.0, 29830.850845745634, 30202.848985754932, 30376.088717338516, 42054.789726051175, 42402.0, 42463.150736985706, 42574.361384579875, 42577.0, 291079.0, 291926.0, 292093.0, 292783.0, 293702.0, 25286.114985975404, 25428.872855635604, 26539.734602653727, 26541.469170616867, 27612.861935690195, 43071.35392969046, 43280.0, 43435.34846977361, 44089.779551103326, 44630.3305450412, 36545.45181822222, 37419.0, 37955.24089518249, 37986.0, 38201.4269785959, 36808.631913681595, 36814.81592592127, 36989.63010369862, 37090.25819483649, 37319.44020839635, 36308.45537316995, 36651.45022824713, 36951.0, 37534.43698344582, 37544.81227593844, 31696.5245521322, 33538.83230583832, 33550.161245969044, 34050.829745851115, 34169.48745768766, 25128.74871251264, 25393.238202853943, 25530.0, 25698.852934435068, 26012.349691257114], "value": 18060.149731926755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.98896033119007, 373.5629313702967, 385.46997877917863, 387.48464542158894, 392.34086734286404, 15603.687926241482, 16355.509334719947, 17002.40491582795, 17017.404390846306, 17221.7416738749, 10965.0, 15698.058116513017, 16512.917435412837, 16517.587060323498, 17173.398931037416, 4582.587567118959, 4719.43366795985, 4751.382320298374, 4764.571188593026, 4768.546988036131, 3455.1534873955916, 3619.60184379718, 4686.414198225222, 5175.353080864892, 5432.864178395532, 5482.342118945712, 5495.038368285554, 5507.284053073095, 5510.972445137769, 5514.6139770216105, 5208.895822083556, 5480.232767412545, 5515.558755299567, 5521.089020311644, 5590.077637189859, 3429.3484237994703, 5054.9241761373605, 5381.973090134564, 5389.407165211824, 5410.323709536308, 12148.696282592917, 12331.445084971198, 12345.19756215852, 12484.875151248552, 12582.68543286416, 1709.8546623537013, 1726.0938007546013, 1764.9911750441165, 1768.5490199998917, 1809.6561653285964, 9005.954970225172, 9160.496172710498, 9172.082791720775, 9183.724488265363, 9360.906390936072, 1679.160419790105, 1686.6626674664994, 1690.2309449200707, 1697.2277613685744, 1721.9668199080577, 67493.3250667492, 68215.31784682188, 69120.6543967277, 70646.64676676584, 71988.0, 9398.295127865438, 9569.904300956901, 9639.566219520138, 9650.131488165958, 9844.901550984541, 13183.209007459584, 13350.933245333712, 13352.265625390502, 13363.465461381631, 13367.732645347232, 6813.488988325896, 6820.863582728318, 6844.5208835382045, 6902.309769023058, 6921.584704917721, 6402.135711678864, 6511.38141876521, 6635.734570617218, 6643.767468138689, 6644.734210631521, 4179.811908464127, 4224.957750422456, 4297.355396690521, 4437.979264769121, 4458.754768487699, 1544.4517196395118, 1583.3903946980265, 1703.872209584286, 1712.8866236946085, 1759.9736003959952, 809.522381794744, 815.2092470303796, 842.9789255268545, 853.9786505337293, 951.9385884738605, 16197.51407457778, 16508.33966641321, 16801.831981680025, 16842.663146736995, 17211.655766884844, 848.5871024743856, 848.7284069097952, 852.2883392367319, 873.7553485024204, 931.4550987672152, 9235.26117910579, 9554.42673439582, 9560.952195239119, 9564.95217523922, 9576.23390128788, 354921.0, 360969.0, 362559.0, 363204.0, 366126.0, 74631.62684186653, 76909.61545192238, 77790.2220977783, 77791.0, 78123.0, 901.544719916438, 902.697596305245, 926.1988380051207, 933.85992101184, 936.0, 14811.629709257355, 14827.92586037063, 14946.925265373604, 14951.700965980837, 15231.162286074372, 31373.529397058606, 31764.841175794896, 32815.0, 33490.33019339551, 34109.488357674156, 44815.327770082826, 46356.30465543087, 46716.7664161677, 47423.76288118537, 47469.762651186524, 7419.629018548943, 7426.480146389701, 7456.17982021988, 7632.19861914491, 7725.381969442544, 10922.617708380169, 11323.490442930253, 11331.716707082389, 11366.090712743126, 11606.071514279007, 9444.669436569688, 9532.285078618992, 9632.75918102053, 9929.255305852235, 9995.600175992879, 7608.543487390774, 9739.805203896025, 9828.213742900694, 10084.092431681183, 10279.434631095362, 9657.372270802376, 9736.9026309736, 9777.755556111155, 9828.508574571386, 10169.44068076263, 6650.6342151180215, 6948.409385202112, 6999.6850141742725, 7015.438764898898, 7107.786766397016, 8904.421212621159, 8959.955200223958, 9404.482753448627, 9631.855522167314, 10454.0068693474], "value": 7752.949867426311, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.885440310372, 1442.7114577084585, 1485.5543336998899, 1593.4502596604175, 1776.6446710657863, 6941.930580694191, 7526.435517336201, 7679.116901556309, 7718.536887786737, 7901.920980790204, 7774.455788094836, 7884.4086693498075, 7937.325327347168, 7947.245011723877, 7952.840943181133, 2173.619616567102, 2199.637059885117, 2201.03154611971, 2203.063697928382, 2207.304699019812, 2136.1455417832835, 2172.478605134764, 2176.945576360588, 2180.4766855954535, 2180.6401943679275, 2151.3868547463976, 2151.408362700254, 2165.935021949344, 2169.078141789741, 2175.7824217578195, 2096.8322534197227, 2097.632914240002, 2102.3062389411457, 2102.463871712711, 2104.968425473619, 2052.271443637502, 2120.639491286485, 2122.991578999978, 2123.140128248062, 2123.893805309728, 7343.889841652326, 7483.176850546435, 7785.026871641045, 7819.061712594468, 7857.410694197901, 4580.770961451914, 4748.833790817339, 4756.476787553366, 4764.547368000034, 4786.353842231289, 2975.7024297570288, 3075.123589776903, 3120.318024730817, 3128.984355078233, 3145.2608636970294, 964.1081999150757, 969.6024629901777, 971.3394891473795, 992.9851052234222, 1007.37039350406, 10630.946845265802, 10846.240763146583, 10851.294665846774, 10872.402017889013, 10902.236843420964, 4343.218220720238, 4354.085642015149, 4466.6873318867365, 4489.147062058199, 4542.273236282179, 8597.441166324168, 8599.39804213699, 8657.393982421296, 8668.306535477146, 8683.392162548687, 4685.484596694361, 4685.672002959828, 4686.882827929329, 4691.835785747482, 4693.530646935279, 3621.764585301947, 3788.090858194069, 4330.133973205371, 4333.848315308949, 4338.696291259645, 3461.7922924624604, 3530.1880567469625, 3606.9278614427562, 3630.528031355907, 3655.6709896108946, 1018.2770233134557, 1066.99466502667, 1078.568572570978, 1082.2802836113897, 1086.9619563315246, 864.1142828600734, 864.5547543015352, 870.7126648206076, 890.4657205676672, 890.550272112592, 5574.331080270394, 5666.943330566724, 5769.1923130761725, 5811.302643682785, 5821.796237131764, 887.5650931043742, 889.479654402169, 916.0884919505135, 936.8594710793299, 937.044214900811, 3651.1784848408897, 3776.490173826553, 3825.0819803247578, 3830.9233815323537, 3845.1540661054523, 9036.909630903738, 9418.481983490974, 9489.145976861977, 9523.666671666459, 9546.37948533357, 9240.214581760625, 9482.099200575934, 9488.146066854017, 9503.90496095044, 9505.049495050578, 7353.77938661841, 7443.7766866993, 7508.849823003509, 7528.887066694004, 7535.7362492313605, 5542.2795036644975, 5818.185454036354, 5848.9333153765265, 5890.175375447355, 5939.16851640762, 9083.545822708706, 9147.77130571741, 9275.07249275067, 9315.068493150631, 9318.906810931803, 9204.0, 9259.120383563552, 9271.30465215098, 9317.487538185465, 9345.112214339899, 6111.96944015277, 6790.626515541692, 6959.478039146983, 6970.546914450544, 7157.785266442015, 7418.480706350504, 7451.068616422947, 7451.478396512409, 7462.552246865205, 7468.887966680395, 6728.6972086255255, 6842.589444633139, 6865.0, 6982.231954485104, 7027.964860175666, 6748.595084294958, 6749.763758268437, 6851.931480685129, 6858.451323893977, 7031.402330801735, 6278.372162783685, 6508.869822603616, 6515.446187074152, 6680.064790929371, 6761.492888033516, 4891.119598472309, 4928.876778080433, 4935.728534930469, 4950.9257361140335, 4961.231009193581, 4654.348391225163, 4682.882927926829, 4763.595094417014, 4788.281757736228, 4828.782704778364], "value": 4206.309094040026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.12429327829136, 310.5186960211672, 319.3915590799527, 320.59764994931356, 323.27586206896547, 4544.204764166274, 4678.883027924295, 4757.666963312565, 4823.951760482394, 4825.78283977221, 4539.477960034597, 4679.883002924928, 4708.246680531116, 4719.929201061978, 4733.136452446263, 3763.8306276217636, 3779.79211143387, 3781.392908014097, 3787.7121778595274, 3793.943090853639, 3574.873914716869, 3640.672339489445, 3786.2995345861104, 3789.9810500947456, 3794.690831663072, 3710.2579484103153, 3727.4595183698348, 3738.738288319819, 3752.9437058444146, 3754.085416437609, 3722.4230244312175, 3737.5141231639714, 3739.569949455793, 3786.5077539919907, 3797.411401232813, 3347.6484969078383, 3352.664733526652, 3358.529805827162, 3358.6137594176494, 3361.294128233074, 4450.310201918708, 4491.483479399878, 4535.773211339453, 4562.726236425825, 4567.862964111082, 4271.227440612142, 4297.378599054574, 4300.849470268557, 4323.1785960667685, 4331.501877284121, 4895.9510404895855, 4900.525234756461, 4900.803967841282, 4917.4344950330815, 4938.185199442088, 3576.481410195533, 3671.8531258749617, 3675.1730860556427, 3677.889663310105, 3710.3692372296773, 5178.378594568639, 5182.870428239286, 5194.883100133452, 5204.475829222823, 5209.759803284586, 3725.0, 3725.981370093132, 3740.1023754299317, 3756.69946404287, 3766.6798322142376, 3827.138893748884, 3846.8653597123966, 3854.0557563396587, 3854.2869569129803, 3862.594427585063, 4088.3850878903263, 4249.851255206053, 4260.936085958713, 4271.9786401067795, 4289.1421715657, 4713.67004309695, 4947.134251505972, 4953.157963146202, 4961.305417241589, 5009.497150854729, 1290.9870901290867, 1324.8741369569875, 1337.822716009905, 1341.6377578054066, 1346.2124657075524, 857.6783706110209, 872.389327470773, 874.8862647855738, 889.5329951775241, 893.7810236491971, 3943.4479172915817, 3966.345552983783, 3980.8805735827973, 4006.198760247962, 4022.557518672944, 4482.260427029569, 4528.954710452919, 4530.275155975029, 4539.273716205391, 4553.59017688403, 3941.0, 3955.892350141965, 3977.5226972763453, 3978.264021156095, 3982.0, 2307.8384513083925, 2405.615101583738, 2419.512000119949, 2446.47400808827, 2449.9755002449747, 4320.913581728348, 4327.891802704895, 4335.6965012449455, 4339.1972485090355, 4349.891252718644, 4573.63410927125, 4586.243269860435, 4611.76941152941, 4674.919660750933, 4677.836275730333, 4086.7752273625238, 4263.424437700933, 4267.4238977737605, 4289.978550107229, 4302.311630139163, 4494.0, 4506.211413002646, 4519.977400112978, 4520.570545798144, 4535.915577407394, 4445.711028783118, 4458.643308535375, 4465.732056076646, 4501.617362524091, 4559.612432943237, 4099.487564054493, 4276.2089013532595, 4310.870673879788, 4316.244657185043, 4325.199838029975, 3397.5243465915287, 3458.8962331130106, 3477.435154180578, 3481.947770783491, 3490.9476357854146, 4454.681262459359, 4486.698857331337, 4488.438945131858, 4557.931631025471, 4813.422389313305, 4753.191957367325, 4935.84106172043, 4959.181735013826, 4967.155583550877, 4988.376452943382, 4875.878103047452, 4912.778924948315, 4930.753462326941, 4940.184869496493, 4967.975160124176, 4745.881352966204, 4880.0, 4886.65793394459, 4890.6087512998165, 4909.4845041270155, 4918.803247870045, 4928.753562321941, 4994.550490455877, 4995.675281106716, 4999.850064472312, 4857.489963553776, 4862.31927530139, 4886.780094895667, 4931.753412329441, 4932.605391568738], "value": 3646.2720576513993, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4154857465397, 699.7166147710179, 738.1806195123415, 753.1338960195774, 767.2787579675108, 12276.693082672939, 13359.0, 13377.464901403957, 13395.0, 13410.19538827671, 12472.0, 12536.498540058386, 12590.622281331574, 12617.747645047093, 12719.491220351174, 625.9405356491148, 714.0574441736909, 727.0330460487539, 773.0684525147212, 810.3962547901822, 799.4683535448919, 800.8518424091533, 803.5339503088225, 803.7628899474669, 804.7183485779989, 856.0497847389393, 856.5888373580685, 857.2541888556933, 857.5626430520417, 857.7812657772259, 648.623798197047, 812.7561731480532, 834.1325021977136, 834.9039860416069, 846.6401779243797, 613.7146227004464, 618.1315252070802, 618.2766163588612, 618.3569088148321, 618.6226401894841, 12651.493940242472, 12701.809472857914, 12701.936490317581, 12717.173383730027, 12719.872801272053, 11757.882421175764, 12003.93998030013, 12328.445219965033, 12560.995120390347, 12606.495740170381, 10404.16766658673, 10463.476826158738, 10479.0, 10524.947375263151, 10553.261271710984, 3916.1776027034357, 3930.6473743295496, 3967.7619342839234, 3989.780562069085, 4013.237484877864, 45987.0, 46108.53891461076, 46731.29903051457, 46800.29799553009, 46812.297815532795, 9605.567749451291, 9716.125548700651, 9798.216142708709, 9799.412035277906, 9892.703218903445, 17833.554161146076, 17854.19656115478, 17922.193501292473, 17934.0, 18294.79841027815, 6751.729930802713, 6775.593464392152, 6843.418309443753, 6875.278095799869, 6903.6203008835, 3535.9292814143573, 3560.964390356115, 3615.5119058927235, 3807.2195199983935, 3816.065064059323, 2921.517949538345, 3043.6651968283472, 3057.4649436348996, 3058.5106382978615, 3058.923526911845, 437.97372157670003, 532.6351449257271, 536.5519790974502, 548.6954740119193, 552.5358698693117, 452.72383845854, 558.5782734035859, 580.5703779203443, 584.4564554963924, 622.4926684751913, 7655.464117511832, 8023.277904988579, 8037.35701143907, 8202.343812494986, 8388.161183881562, 540.6134613751187, 565.0253313035064, 582.1558739827267, 608.5375114912698, 609.6464050850497, 3669.834857431422, 3727.6645101940953, 3748.962510374916, 3800.35393983018, 3868.226354729009, 58119.4188058114, 62225.68887155535, 62292.0, 62657.0, 62802.37197628056, 52821.623026963876, 53026.0, 53038.0, 53088.469115308355, 54745.1788223177, 41466.378004329956, 42074.57925420706, 47123.5287647126, 47359.99999999931, 49835.50164498381, 8369.330453563822, 8388.874166887623, 8419.831603367777, 8462.83074338522, 8505.617247224014, 30410.239744006576, 30909.536356955112, 31713.524297136024, 31768.841155794074, 32282.83858580692, 38772.224555509296, 42197.0, 42520.57479425166, 42561.87190640518, 43410.78294608507, 10548.789024219626, 10608.52261648243, 10657.413842238751, 10692.091172250135, 10734.51694673726, 11645.47595358194, 11926.224795388272, 11993.400329983291, 12228.938855305667, 12390.380480976095, 10917.56329746833, 11258.268212566485, 11634.94182529082, 11644.767104658029, 11654.242474239147, 10302.0, 10591.0, 10653.414062226651, 10799.892001079888, 11125.554977800797, 10408.583656653649, 10415.68752937413, 10665.36007839532, 10698.197635177237, 10724.981126792942, 9526.190273826802, 9570.904290957002, 9607.423554586747, 9763.609455621696, 10000.649977250761, 9284.3036772241, 9319.720408387759, 9322.580483878106, 9476.478793666414, 9698.272629552954], "value": 6064.752479441707, "unit": "score"}], "name": "dromaeo_css", "value": 6272.74036182244, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 113.0, 114.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 131.0, 131.0, 184.0, 130.0, 134.0, 152.0, 133.0, 169.0, 129.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 128.0, 76.0, 76.0, 76.0, 75.0, 106.0, 74.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 84.0, 84.0, 84.0, 116.0, 84.0, 85.0, 142.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.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, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 63.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 67.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 85.0, 85.0, 84.0, 113.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 132.0, 133.0, 131.0, 139.0, 132.0, 139.0, 147.0, 133.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 171.0, 171.0, 167.0, 167.0, 166.0, 169.0, 169.0, 169.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 67.0, 69.0, 69.0, 68.0, 70.0, 68.0, 70.0, 64.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1548.6000000000001, "alertThreshold": 2.0}]} 02:45:02 INFO - Return code: 0 02:45:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:45:02 ERROR - # TBPL SUCCESS # 02:45:02 INFO - Running post-action listener: _resource_record_post_action 02:45:02 INFO - ##### 02:45:02 INFO - ##### Finished run-tests step (success) 02:45:02 INFO - ##### 02:45:02 INFO - Running post-run listener: _resource_record_post_run 02:45:02 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521076736; Read time: 16; Write time: 367180 02:45:02 INFO - TinderboxPrint: CPU usage
13.2% 02:45:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:45:02 INFO - TinderboxPrint: I/O write bytes / time
521,076,736 / 367,180 02:45:02 INFO - TinderboxPrint: CPU idle
8,307.2 (86.8%) 02:45:02 INFO - TinderboxPrint: CPU user
1,218.5 (12.7%) 02:45:02 INFO - TinderboxPrint: Swap in / out
0 / 0 02:45:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 168120320; Read time: 0; Write time: 162156 02:45:02 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284188672; Read time: 16; Write time: 169704 02:45:03 INFO - Running post-run listener: _upload_blobber_files 02:45:03 INFO - Blob upload gear active. 02:45:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:45:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:45:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:04 INFO - (blobuploader) - INFO - Done attempting. 02:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:05 INFO - (blobuploader) - INFO - Done attempting. 02:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:09 INFO - (blobuploader) - INFO - Done attempting. 02:45:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:45:09 INFO - Return code: 0 02:45:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:45:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:45:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b941fd7d5d23accad36d1d070dac38edb5a562dceb1959256e1968bb0766858e7213bc3bbb7fc7aa412d4671ef4d570600dc033b7c491d390236c2615206eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0eaee34feda94ba4a8a094076552deeb4916e2b233ffcf60fc0d1fbe2a6827e14e99048a3e782371b9ce7bdedc3cf2ca77c55b2010c23d0cb683f821c0d4ce30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ae9b4a12b34d7efae8573b59f751b943e3c415b4e2c3cbf9c957848a144a04742e210f797d565dd0555ad31fed0b9c056f9832d7d63d77340631c84bba98094"} 02:45:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:45:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:45:09 INFO - Contents: 02:45:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b941fd7d5d23accad36d1d070dac38edb5a562dceb1959256e1968bb0766858e7213bc3bbb7fc7aa412d4671ef4d570600dc033b7c491d390236c2615206eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0eaee34feda94ba4a8a094076552deeb4916e2b233ffcf60fc0d1fbe2a6827e14e99048a3e782371b9ce7bdedc3cf2ca77c55b2010c23d0cb683f821c0d4ce30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ae9b4a12b34d7efae8573b59f751b943e3c415b4e2c3cbf9c957848a144a04742e210f797d565dd0555ad31fed0b9c056f9832d7d63d77340631c84bba98094"} 02:45:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:45:09 INFO - Copying logs to upload dir... 02:45:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:45:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.075964 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-30 02:45:08.798716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 02:45:08.802320) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b941fd7d5d23accad36d1d070dac38edb5a562dceb1959256e1968bb0766858e7213bc3bbb7fc7aa412d4671ef4d570600dc033b7c491d390236c2615206eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0eaee34feda94ba4a8a094076552deeb4916e2b233ffcf60fc0d1fbe2a6827e14e99048a3e782371b9ce7bdedc3cf2ca77c55b2010c23d0cb683f821c0d4ce30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ae9b4a12b34d7efae8573b59f751b943e3c415b4e2c3cbf9c957848a144a04742e210f797d565dd0555ad31fed0b9c056f9832d7d63d77340631c84bba98094"} build_url:https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/Am1Kx4hcTCKrN7AP3ERaNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b941fd7d5d23accad36d1d070dac38edb5a562dceb1959256e1968bb0766858e7213bc3bbb7fc7aa412d4671ef4d570600dc033b7c491d390236c2615206eac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0eaee34feda94ba4a8a094076552deeb4916e2b233ffcf60fc0d1fbe2a6827e14e99048a3e782371b9ce7bdedc3cf2ca77c55b2010c23d0cb683f821c0d4ce30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3ae9b4a12b34d7efae8573b59f751b943e3c415b4e2c3cbf9c957848a144a04742e210f797d565dd0555ad31fed0b9c056f9832d7d63d77340631c84bba98094"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 02:45:08.834989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:45:08.835605) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464600005.248754-486042367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 02:45:08.916600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 02:45:08.917017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 02:45:08.917343) ========= ========= Total master_lag: 0.20 =========