builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1464615606.63 results: success (0) buildid: 20160530031349 builduid: 3720730da72c495290e6cf1804e4c1bf revision: 640f046e0e79d18aa0d4c0efac7e9f5d365f09a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.630068) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.630510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.630788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.662591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.662859) ========= 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=00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 06:40:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-05-30 06:40:07 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.798869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.799286) ========= 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=00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015942 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:06.853180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 06:40:06.853836) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 640f046e0e79d18aa0d4c0efac7e9f5d365f09a0 --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 640f046e0e79d18aa0d4c0efac7e9f5d365f09a0 --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=00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 06:40:07,273 truncating revision to first 12 chars 2016-05-30 06:40:07,273 Setting DEBUG logging. 2016-05-30 06:40:07,273 attempt 1/10 2016-05-30 06:40:07,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/640f046e0e79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 06:40:08,489 unpacking tar archive at: fx-team-640f046e0e79/testing/mozharness/ program finished with exit code 0 elapsedTime=1.555748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 06:40:08.425362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:08.425708) ========= script_repo_revision: 640f046e0e79d18aa0d4c0efac7e9f5d365f09a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:08.426119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:08.426385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:40:08.435290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-30 06:40:08.435577) ========= /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=00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:40:08 INFO - MultiFileLogger online at 20160530 06:40:08 in /builds/slave/test 06:40:08 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 06:40:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:40:08 INFO - {'append_to_log': False, 06:40:08 INFO - 'base_work_dir': '/builds/slave/test', 06:40:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:40:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:40:08 INFO - 'branch': 'Fx-Team-Non-PGO', 06:40:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:40:08 INFO - 'config_files': ('talos/linux_config.py',), 06:40:08 INFO - 'default_actions': ('clobber', 06:40:08 INFO - 'read-buildbot-config', 06:40:08 INFO - 'download-and-extract', 06:40:08 INFO - 'populate-webroot', 06:40:08 INFO - 'create-virtualenv', 06:40:08 INFO - 'install', 06:40:08 INFO - 'run-tests'), 06:40:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:40:08 INFO - 'download_minidump_stackwalk': True, 06:40:08 INFO - 'download_symbols': 'ondemand', 06:40:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:40:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:40:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:40:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:40:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:40:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:40:08 INFO - 'installer_path': 'installer.exe', 06:40:08 INFO - 'log_level': 'info', 06:40:08 INFO - 'log_name': 'talos', 06:40:08 INFO - 'log_to_console': True, 06:40:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:40:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:40:08 INFO - 'opt_config_files': (), 06:40:08 INFO - 'pip_index': False, 06:40:08 INFO - 'sps_profile': False, 06:40:08 INFO - 'sps_profile_interval': 0, 06:40:08 INFO - 'suite': 'dromaeojs', 06:40:08 INFO - 'system_bits': '32', 06:40:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:40:08 INFO - 'title': 'talos-linux64-ix-016', 06:40:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:40:08 INFO - 'use_talos_json': True, 06:40:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:40:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:40:08 INFO - 'work_dir': 'build'} 06:40:08 INFO - ##### 06:40:08 INFO - ##### Running clobber step. 06:40:08 INFO - ##### 06:40:08 INFO - Running pre-action listener: _resource_record_pre_action 06:40:08 INFO - Running main action method: clobber 06:40:08 INFO - rmtree: /builds/slave/test/build 06:40:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:40:09 INFO - Running post-action listener: _resource_record_post_action 06:40:09 INFO - ##### 06:40:09 INFO - ##### Finished clobber step (success) 06:40:09 INFO - ##### 06:40:09 INFO - ##### 06:40:09 INFO - ##### Running read-buildbot-config step. 06:40:09 INFO - ##### 06:40:09 INFO - Running pre-action listener: _resource_record_pre_action 06:40:09 INFO - Running main action method: read_buildbot_config 06:40:09 INFO - Using buildbot properties: 06:40:09 INFO - { 06:40:09 INFO - "project": "", 06:40:09 INFO - "product": "firefox", 06:40:09 INFO - "script_repo_revision": "production", 06:40:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:40:09 INFO - "repository": "", 06:40:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:40:09 INFO - "buildid": "20160530031349", 06:40:09 INFO - "pgo_build": "False", 06:40:09 INFO - "basedir": "/builds/slave/test", 06:40:09 INFO - "buildnumber": 1738, 06:40:09 INFO - "slavename": "talos-linux64-ix-016", 06:40:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:40:09 INFO - "platform": "ubuntu64_hw", 06:40:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:40:09 INFO - "branch": "fx-team", 06:40:09 INFO - "repo_path": "integration/fx-team", 06:40:09 INFO - "revision": "640f046e0e79d18aa0d4c0efac7e9f5d365f09a0", 06:40:09 INFO - "stage_platform": "linux64", 06:40:09 INFO - "builduid": "3720730da72c495290e6cf1804e4c1bf", 06:40:09 INFO - "slavebuilddir": "test" 06:40:09 INFO - } 06:40:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:40:09 INFO - Running post-action listener: _resource_record_post_action 06:40:09 INFO - ##### 06:40:09 INFO - ##### Finished read-buildbot-config step (success) 06:40:09 INFO - ##### 06:40:09 INFO - ##### 06:40:09 INFO - ##### Running download-and-extract step. 06:40:09 INFO - ##### 06:40:09 INFO - Running pre-action listener: _resource_record_pre_action 06:40:09 INFO - Running main action method: download_and_extract 06:40:09 INFO - mkdir: /builds/slave/test/build/tests 06:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:09 INFO - https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:10 INFO - Downloaded 1361 bytes. 06:40:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:40:10 INFO - Using the following test package requirements: 06:40:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:40:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:40:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'jsshell-linux-x86_64.zip'], 06:40:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:40:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:40:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:40:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:40:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:40:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:40:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:40:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:10 INFO - https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:40:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:40:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:40:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:13 INFO - Downloaded 22837897 bytes. 06:40:13 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'] 06:40:13 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 06:40:15 INFO - Return code: 0 06:40:15 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 06:40:15 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')]} 06:40:15 INFO - https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:40:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:40:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:40:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:16 INFO - Downloaded 22837897 bytes. 06:40:16 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'] 06:40:16 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 06:40:17 INFO - Return code: 0 06:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:17 INFO - https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:40:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:40:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:19 INFO - Downloaded 10834034 bytes. 06:40:19 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'] 06:40:19 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 06:40:19 INFO - Return code: 0 06:40: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')]} 06:40:19 INFO - https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:40:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:40:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:40:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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 06:40:22 INFO - Downloaded 54850524 bytes. 06:40:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:40:22 INFO - mkdir: /builds/slave/test/properties 06:40:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:40:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:40:22 INFO - Contents: 06:40:22 INFO - build_url:https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:40:23 INFO - Running post-action listener: _resource_record_post_action 06:40:23 INFO - Running post-action listener: set_extra_try_arguments 06:40:23 INFO - ##### 06:40:23 INFO - ##### Finished download-and-extract step (success) 06:40:23 INFO - ##### 06:40:23 INFO - ##### 06:40:23 INFO - ##### Running populate-webroot step. 06:40:23 INFO - ##### 06:40:23 INFO - Running pre-action listener: _resource_record_pre_action 06:40:23 INFO - Running main action method: populate_webroot 06:40:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:40:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:40:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:40:23 INFO - '--tppagecycles', 06:40:23 INFO - '7'], 06:40:23 INFO - 'tests': ['tsvgm']}}, 06:40:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:40:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:40:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:40:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:40:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:40:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['damp', 'tps']}, 06:40:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'tests': ['damp', 'tps']}, 06:40:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['dromaeo_dom']}, 06:40:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:40:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['a11yr', 06:40:23 INFO - 'ts_paint', 06:40:23 INFO - 'tpaint', 06:40:23 INFO - 'sessionrestore', 06:40:23 INFO - 'sessionrestore_no_auto_restore', 06:40:23 INFO - 'tabpaint']}, 06:40:23 INFO - 'other-e10s': {'tests': ['a11yr', 06:40:23 INFO - 'ts_paint', 06:40:23 INFO - 'tpaint', 06:40:23 INFO - 'sessionrestore', 06:40:23 INFO - 'sessionrestore_no_auto_restore', 06:40:23 INFO - 'tabpaint']}, 06:40:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:40:23 INFO - 'ts_paint', 06:40:23 INFO - 'tpaint', 06:40:23 INFO - 'sessionrestore', 06:40:23 INFO - 'sessionrestore_no_auto_restore', 06:40:23 INFO - 'tabpaint']}, 06:40:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:40:23 INFO - 'ts_paint', 06:40:23 INFO - 'tpaint', 06:40:23 INFO - 'sessionrestore', 06:40:23 INFO - 'sessionrestore_no_auto_restore', 06:40:23 INFO - 'tabpaint']}, 06:40:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['a11yr', 06:40:23 INFO - 'ts_paint', 06:40:23 INFO - 'tpaint', 06:40:23 INFO - 'sessionrestore', 06:40:23 INFO - 'sessionrestore_no_auto_restore', 06:40:23 INFO - 'tabpaint']}, 06:40:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['a11yr', 06:40:23 INFO - 'ts_paint', 06:40:23 INFO - 'tpaint', 06:40:23 INFO - 'sessionrestore', 06:40:23 INFO - 'sessionrestore_no_auto_restore', 06:40:23 INFO - 'tabpaint']}, 06:40:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['tsvgx', 06:40:23 INFO - 'tsvgr_opacity', 06:40:23 INFO - 'tart', 06:40:23 INFO - 'tscrollx', 06:40:23 INFO - 'cart']}, 06:40:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:40:23 INFO - 'tsvgr_opacity', 06:40:23 INFO - 'tart', 06:40:23 INFO - 'tscrollx', 06:40:23 INFO - 'cart']}, 06:40:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'talos_options': ['--disable-e10s'], 06:40:23 INFO - 'tests': ['tp5o']}, 06:40:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'tests': ['tp5o']}, 06:40:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'talos_options': ['--disable-e10s', 06:40:23 INFO - '--xperf_path', 06:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:23 INFO - 'tests': ['tp5n']}, 06:40:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:40:23 INFO - 'talos_options': ['--xperf_path', 06:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:40:23 INFO - 'tests': ['tp5n']}}, 06:40:23 INFO - 'talos.zip': {'path': '', 06:40:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:40:23 INFO - Running post-action listener: _resource_record_post_action 06:40:23 INFO - ##### 06:40:23 INFO - ##### Finished populate-webroot step (success) 06:40:23 INFO - ##### 06:40:23 INFO - ##### 06:40:23 INFO - ##### Running create-virtualenv step. 06:40:23 INFO - ##### 06:40:23 INFO - Running pre-action listener: _resource_record_pre_action 06:40:23 INFO - Running main action method: create_virtualenv 06:40:23 INFO - Creating virtualenv /builds/slave/test/build/venv 06:40:23 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 06:40:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:40:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:40:23 INFO - Using real prefix '/usr' 06:40:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:40:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:40:25 INFO - Installing pip.................done. 06:40:25 INFO - Return code: 0 06:40:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:40:25 INFO - Using env: {'DISPLAY': ':0', 06:40:25 INFO - 'HOME': '/home/cltbld', 06:40:25 INFO - 'LANG': 'en_US.UTF-8', 06:40:25 INFO - 'LANGUAGE': 'en_US:en', 06:40:25 INFO - 'LOGNAME': 'cltbld', 06:40:25 INFO - 'MAIL': '/var/mail/cltbld', 06:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:25 INFO - 'MOZ_NO_REMOTE': '1', 06:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:25 INFO - 'NO_EM_RESTART': '1', 06:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:25 INFO - 'PWD': '/builds/slave/test', 06:40:25 INFO - 'SHELL': '/bin/bash', 06:40:25 INFO - 'SHLVL': '1', 06:40:25 INFO - 'TERM': 'linux', 06:40:25 INFO - 'TMOUT': '86400', 06:40:25 INFO - 'USER': 'cltbld', 06:40:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:25 INFO - '_': '/tools/buildbot/bin/python'} 06:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:25 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 06:40:25 INFO - Cleaning up... 06:40:25 INFO - Return code: 0 06:40:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:40:25 INFO - Using env: {'DISPLAY': ':0', 06:40:25 INFO - 'HOME': '/home/cltbld', 06:40:25 INFO - 'LANG': 'en_US.UTF-8', 06:40:25 INFO - 'LANGUAGE': 'en_US:en', 06:40:25 INFO - 'LOGNAME': 'cltbld', 06:40:25 INFO - 'MAIL': '/var/mail/cltbld', 06:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:25 INFO - 'MOZ_NO_REMOTE': '1', 06:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:25 INFO - 'NO_EM_RESTART': '1', 06:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:25 INFO - 'PWD': '/builds/slave/test', 06:40:25 INFO - 'SHELL': '/bin/bash', 06:40:25 INFO - 'SHLVL': '1', 06:40:25 INFO - 'TERM': 'linux', 06:40:25 INFO - 'TMOUT': '86400', 06:40:25 INFO - 'USER': 'cltbld', 06:40:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:25 INFO - '_': '/tools/buildbot/bin/python'} 06:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:26 INFO - Downloading/unpacking psutil>=3.1.1 06:40:26 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 06:40:26 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 06:40:26 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 06:40:26 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 06:40:26 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 06:40:26 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 06:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:40:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:28 INFO - Installing collected packages: psutil 06:40:28 INFO - Running setup.py install for psutil 06:40:28 INFO - building 'psutil._psutil_linux' extension 06:40:28 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 06:40:28 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 06:40:28 INFO - building 'psutil._psutil_posix' extension 06:40:28 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 06:40:28 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 06:40:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:40:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:40:28 INFO - Successfully installed psutil 06:40:28 INFO - Cleaning up... 06:40:28 INFO - Return code: 0 06:40:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:28 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 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:28 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 06:40:28 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 06:40:28 INFO - Using env: {'DISPLAY': ':0', 06:40:28 INFO - 'HOME': '/home/cltbld', 06:40:28 INFO - 'LANG': 'en_US.UTF-8', 06:40:28 INFO - 'LANGUAGE': 'en_US:en', 06:40:28 INFO - 'LOGNAME': 'cltbld', 06:40:28 INFO - 'MAIL': '/var/mail/cltbld', 06:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:28 INFO - 'MOZ_NO_REMOTE': '1', 06:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:28 INFO - 'NO_EM_RESTART': '1', 06:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:28 INFO - 'PWD': '/builds/slave/test', 06:40:28 INFO - 'SHELL': '/bin/bash', 06:40:28 INFO - 'SHLVL': '1', 06:40:28 INFO - 'TERM': 'linux', 06:40:28 INFO - 'TMOUT': '86400', 06:40:28 INFO - 'USER': 'cltbld', 06:40:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:28 INFO - '_': '/tools/buildbot/bin/python'} 06:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:40:28 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 06:40:28 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 06:40:28 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 06:40:28 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 06:40:28 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 06:40:28 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 06:40:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:40:30 INFO - Installing collected packages: mozsystemmonitor 06:40:30 INFO - Running setup.py install for mozsystemmonitor 06:40:30 INFO - Successfully installed mozsystemmonitor 06:40:30 INFO - Cleaning up... 06:40:30 INFO - Return code: 0 06:40:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:40:31 INFO - Using env: {'DISPLAY': ':0', 06:40:31 INFO - 'HOME': '/home/cltbld', 06:40:31 INFO - 'LANG': 'en_US.UTF-8', 06:40:31 INFO - 'LANGUAGE': 'en_US:en', 06:40:31 INFO - 'LOGNAME': 'cltbld', 06:40:31 INFO - 'MAIL': '/var/mail/cltbld', 06:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:31 INFO - 'MOZ_NO_REMOTE': '1', 06:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:31 INFO - 'NO_EM_RESTART': '1', 06:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:31 INFO - 'PWD': '/builds/slave/test', 06:40:31 INFO - 'SHELL': '/bin/bash', 06:40:31 INFO - 'SHLVL': '1', 06:40:31 INFO - 'TERM': 'linux', 06:40:31 INFO - 'TMOUT': '86400', 06:40:31 INFO - 'USER': 'cltbld', 06:40:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:31 INFO - '_': '/tools/buildbot/bin/python'} 06:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:31 INFO - Downloading/unpacking blobuploader==1.2.4 06:40:31 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 06:40:31 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 06:40:31 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 06:40:31 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 06:40:31 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 06:40:31 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 06:40:33 INFO - Downloading blobuploader-1.2.4.tar.gz 06:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:40:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:40:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:33 INFO - Downloading docopt-0.6.1.tar.gz 06:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:40:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:40:33 INFO - Running setup.py install for blobuploader 06:40:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:40:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:40:33 INFO - Running setup.py install for requests 06:40:34 INFO - Running setup.py install for docopt 06:40:34 INFO - Successfully installed blobuploader requests docopt 06:40:34 INFO - Cleaning up... 06:40:34 INFO - Return code: 0 06:40:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:34 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 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:34 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 06:40:34 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 06:40:34 INFO - Using env: {'DISPLAY': ':0', 06:40:34 INFO - 'HOME': '/home/cltbld', 06:40:34 INFO - 'LANG': 'en_US.UTF-8', 06:40:34 INFO - 'LANGUAGE': 'en_US:en', 06:40:34 INFO - 'LOGNAME': 'cltbld', 06:40:34 INFO - 'MAIL': '/var/mail/cltbld', 06:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:34 INFO - 'MOZ_NO_REMOTE': '1', 06:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:34 INFO - 'NO_EM_RESTART': '1', 06:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:34 INFO - 'PWD': '/builds/slave/test', 06:40:34 INFO - 'SHELL': '/bin/bash', 06:40:34 INFO - 'SHLVL': '1', 06:40:34 INFO - 'TERM': 'linux', 06:40:34 INFO - 'TMOUT': '86400', 06:40:34 INFO - 'USER': 'cltbld', 06:40:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:34 INFO - '_': '/tools/buildbot/bin/python'} 06:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:34 INFO - Running setup.py (path:/tmp/pip-k0l_T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:34 INFO - Running setup.py (path:/tmp/pip-FHbnQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:34 INFO - Running setup.py (path:/tmp/pip-q_yt4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:34 INFO - Running setup.py (path:/tmp/pip-gWNsGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:34 INFO - Running setup.py (path:/tmp/pip-_Ew2bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:35 INFO - Running setup.py (path:/tmp/pip-v334Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:35 INFO - Running setup.py (path:/tmp/pip-PH_v36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:35 INFO - Running setup.py (path:/tmp/pip-qtQODh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:35 INFO - Running setup.py (path:/tmp/pip-MXHNxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:35 INFO - Running setup.py (path:/tmp/pip-wZVEyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:35 INFO - Running setup.py (path:/tmp/pip-ez6a8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:35 INFO - Running setup.py (path:/tmp/pip-GdFAy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:35 INFO - Running setup.py (path:/tmp/pip-hqdItJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:35 INFO - Running setup.py (path:/tmp/pip-96xsrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:35 INFO - Running setup.py (path:/tmp/pip-4qjEHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:35 INFO - Running setup.py (path:/tmp/pip-B8ZLk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:35 INFO - Running setup.py (path:/tmp/pip-51KKQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:40:35 INFO - Running setup.py install for manifestparser 06:40:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:40:35 INFO - Running setup.py install for mozcrash 06:40:36 INFO - Running setup.py install for mozdebug 06:40:36 INFO - Running setup.py install for mozdevice 06:40:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Running setup.py install for mozfile 06:40:36 INFO - Running setup.py install for mozhttpd 06:40:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Running setup.py install for mozinfo 06:40:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Running setup.py install for mozInstall 06:40:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Running setup.py install for mozleak 06:40:36 INFO - Running setup.py install for mozlog 06:40:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:40:36 INFO - Running setup.py install for moznetwork 06:40:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:40:37 INFO - Running setup.py install for mozprocess 06:40:37 INFO - Running setup.py install for mozprofile 06:40:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:40:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:40:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:40:37 INFO - Running setup.py install for mozrunner 06:40:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:40:37 INFO - Running setup.py install for mozscreenshot 06:40:37 INFO - Running setup.py install for moztest 06:40:37 INFO - Running setup.py install for mozversion 06:40:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:40:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:40:37 INFO - Cleaning up... 06:40:37 INFO - Return code: 0 06:40:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40:37 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')]} 06:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:37 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')]} 06:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:37 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 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:37 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 06:40:37 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 06:40:37 INFO - Using env: {'DISPLAY': ':0', 06:40:37 INFO - 'HOME': '/home/cltbld', 06:40:37 INFO - 'LANG': 'en_US.UTF-8', 06:40:37 INFO - 'LANGUAGE': 'en_US:en', 06:40:37 INFO - 'LOGNAME': 'cltbld', 06:40:37 INFO - 'MAIL': '/var/mail/cltbld', 06:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:37 INFO - 'MOZ_NO_REMOTE': '1', 06:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:37 INFO - 'NO_EM_RESTART': '1', 06:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:37 INFO - 'PWD': '/builds/slave/test', 06:40:37 INFO - 'SHELL': '/bin/bash', 06:40:37 INFO - 'SHLVL': '1', 06:40:37 INFO - 'TERM': 'linux', 06:40:37 INFO - 'TMOUT': '86400', 06:40:37 INFO - 'USER': 'cltbld', 06:40:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:37 INFO - '_': '/tools/buildbot/bin/python'} 06:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:40:37 INFO - Running setup.py (path:/tmp/pip-CqAN7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:40:37 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)) 06:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:40:37 INFO - Running setup.py (path:/tmp/pip-QtV_KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:40:38 INFO - Running setup.py (path:/tmp/pip-pMkDDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:40:38 INFO - Running setup.py (path:/tmp/pip-MH4o11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:40:38 INFO - Running setup.py (path:/tmp/pip-qY4NLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:40:38 INFO - Running setup.py (path:/tmp/pip-zTJyED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:40:38 INFO - Running setup.py (path:/tmp/pip-68O3LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:40:38 INFO - Running setup.py (path:/tmp/pip-SF5_IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:40:38 INFO - Running setup.py (path:/tmp/pip-PMfF3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:40:38 INFO - Running setup.py (path:/tmp/pip-VSLMqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:40:38 INFO - Running setup.py (path:/tmp/pip-_tdrtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:40:38 INFO - Running setup.py (path:/tmp/pip-URzUAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:40:38 INFO - Running setup.py (path:/tmp/pip-YQetlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:40:38 INFO - Running setup.py (path:/tmp/pip-xZ69V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:38 INFO - Running setup.py (path:/tmp/pip-_NzCzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:40:38 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)) 06:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:40:39 INFO - Running setup.py (path:/tmp/pip-1MhrLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:40:39 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)) 06:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:40:39 INFO - Running setup.py (path:/tmp/pip-UhnI0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:40:39 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)) 06:40:39 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)) 06:40:39 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)) 06:40:39 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)) 06:40:39 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)) 06:40:39 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)) 06:40:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:40:39 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 06:40:39 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 06:40:39 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 06:40:39 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 06:40:39 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 06:40:39 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 06:40:40 INFO - Downloading blessings-1.6.tar.gz 06:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:40:41 INFO - Installing collected packages: blessings 06:40:41 INFO - Running setup.py install for blessings 06:40:41 INFO - Successfully installed blessings 06:40:41 INFO - Cleaning up... 06:40:41 INFO - Return code: 0 06:40:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:40:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:41 INFO - Reading from file tmpfile_stdout 06:40:41 INFO - Current package versions: 06:40:41 INFO - argparse == 1.2.1 06:40:41 INFO - blessings == 1.6 06:40:41 INFO - blobuploader == 1.2.4 06:40:41 INFO - docopt == 0.6.1 06:40:41 INFO - manifestparser == 1.1 06:40:41 INFO - mozInstall == 1.12 06:40:41 INFO - mozcrash == 0.17 06:40:41 INFO - mozdebug == 0.1 06:40:41 INFO - mozdevice == 0.48 06:40:41 INFO - mozfile == 1.2 06:40:41 INFO - mozhttpd == 0.7 06:40:41 INFO - mozinfo == 0.9 06:40:41 INFO - mozleak == 0.1 06:40:41 INFO - mozlog == 3.2 06:40:41 INFO - moznetwork == 0.27 06:40:41 INFO - mozprocess == 0.22 06:40:41 INFO - mozprofile == 0.28 06:40:41 INFO - mozrunner == 6.11 06:40:41 INFO - mozscreenshot == 0.1 06:40:41 INFO - mozsystemmonitor == 0.3 06:40:41 INFO - moztest == 0.7 06:40:41 INFO - mozversion == 1.4 06:40:41 INFO - psutil == 3.1.1 06:40:41 INFO - requests == 1.2.3 06:40:41 INFO - wsgiref == 0.1.2 06:40:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:40: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')]} 06:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40: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')]} 06:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:41 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 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40:41 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 06:40:41 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 06:40:41 INFO - Using env: {'DISPLAY': ':0', 06:40:41 INFO - 'HOME': '/home/cltbld', 06:40:41 INFO - 'LANG': 'en_US.UTF-8', 06:40:41 INFO - 'LANGUAGE': 'en_US:en', 06:40:41 INFO - 'LOGNAME': 'cltbld', 06:40:41 INFO - 'MAIL': '/var/mail/cltbld', 06:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:41 INFO - 'MOZ_NO_REMOTE': '1', 06:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:41 INFO - 'NO_EM_RESTART': '1', 06:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:41 INFO - 'PWD': '/builds/slave/test', 06:40:41 INFO - 'SHELL': '/bin/bash', 06:40:41 INFO - 'SHLVL': '1', 06:40:41 INFO - 'TERM': 'linux', 06:40:41 INFO - 'TMOUT': '86400', 06:40:41 INFO - 'USER': 'cltbld', 06:40:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:41 INFO - '_': '/tools/buildbot/bin/python'} 06:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 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)) 06:40:41 INFO - Cleaning up... 06:40:41 INFO - Return code: 0 06:40:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:40: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')]} 06:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40: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')]} 06:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40: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', 'jsonschema'] in /builds/slave/test/build 06:40: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 jsonschema 06:40:41 INFO - Using env: {'DISPLAY': ':0', 06:40:41 INFO - 'HOME': '/home/cltbld', 06:40:41 INFO - 'LANG': 'en_US.UTF-8', 06:40:41 INFO - 'LANGUAGE': 'en_US:en', 06:40:41 INFO - 'LOGNAME': 'cltbld', 06:40:41 INFO - 'MAIL': '/var/mail/cltbld', 06:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:41 INFO - 'MOZ_NO_REMOTE': '1', 06:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:41 INFO - 'NO_EM_RESTART': '1', 06:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:41 INFO - 'PWD': '/builds/slave/test', 06:40:41 INFO - 'SHELL': '/bin/bash', 06:40:41 INFO - 'SHLVL': '1', 06:40:41 INFO - 'TERM': 'linux', 06:40:41 INFO - 'TMOUT': '86400', 06:40:41 INFO - 'USER': 'cltbld', 06:40:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:41 INFO - '_': '/tools/buildbot/bin/python'} 06:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:41 INFO - Downloading/unpacking jsonschema 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:40:43 INFO - Downloading/unpacking functools32 (from jsonschema) 06:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:43 INFO - Downloading functools32-3.2.3-2.tar.gz 06:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:40:44 INFO - warning: no files found matching '*.txt' 06:40:44 INFO - no previously-included directories found matching 'build' 06:40:44 INFO - no previously-included directories found matching 'dist' 06:40:44 INFO - no previously-included directories found matching '.git*' 06:40:44 INFO - Installing collected packages: jsonschema, functools32 06:40:44 INFO - Running setup.py install for functools32 06:40:44 INFO - warning: no files found matching '*.txt' 06:40:44 INFO - no previously-included directories found matching 'build' 06:40:44 INFO - no previously-included directories found matching 'dist' 06:40:44 INFO - no previously-included directories found matching '.git*' 06:40:44 INFO - Successfully installed jsonschema functools32 06:40:44 INFO - Cleaning up... 06:40:44 INFO - Return code: 0 06:40:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:40: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')]} 06:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40: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')]} 06:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02fda33f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, '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': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', '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 06:40: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', 'flake8'] in /builds/slave/test/build 06:40: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 flake8 06:40:44 INFO - Using env: {'DISPLAY': ':0', 06:40:44 INFO - 'HOME': '/home/cltbld', 06:40:44 INFO - 'LANG': 'en_US.UTF-8', 06:40:44 INFO - 'LANGUAGE': 'en_US:en', 06:40:44 INFO - 'LOGNAME': 'cltbld', 06:40:44 INFO - 'MAIL': '/var/mail/cltbld', 06:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:44 INFO - 'MOZ_NO_REMOTE': '1', 06:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:44 INFO - 'NO_EM_RESTART': '1', 06:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:44 INFO - 'PWD': '/builds/slave/test', 06:40:44 INFO - 'SHELL': '/bin/bash', 06:40:44 INFO - 'SHLVL': '1', 06:40:44 INFO - 'TERM': 'linux', 06:40:44 INFO - 'TMOUT': '86400', 06:40:44 INFO - 'USER': 'cltbld', 06:40:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:44 INFO - '_': '/tools/buildbot/bin/python'} 06:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:44 INFO - Downloading/unpacking flake8 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:40:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:40:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:40:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:47 INFO - no previously-included directories found matching 'docs/_build' 06:40:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:40:47 INFO - Running setup.py install for pep8 06:40:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:47 INFO - no previously-included directories found matching 'docs/_build' 06:40:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:40:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:40:47 INFO - Cleaning up... 06:40:48 INFO - Return code: 0 06:40:48 INFO - Running post-action listener: _resource_record_post_action 06:40:48 INFO - Running post-action listener: _start_resource_monitoring 06:40:48 INFO - Starting resource monitoring. 06:40:48 INFO - ##### 06:40:48 INFO - ##### Finished create-virtualenv step (success) 06:40:48 INFO - ##### 06:40:48 INFO - ##### 06:40:48 INFO - ##### Running install step. 06:40:48 INFO - ##### 06:40:48 INFO - Running pre-action listener: _resource_record_pre_action 06:40:48 INFO - Running main action method: install 06:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:48 INFO - Reading from file tmpfile_stdout 06:40:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:40:48 INFO - Reading from file tmpfile_stdout 06:40:48 INFO - Output received: 06:40:48 INFO - Usage: mozinstall [options] installer 06:40:48 INFO - Options: 06:40:48 INFO - -h, --help show this help message and exit 06:40:48 INFO - -d DEST, --destination=DEST 06:40:48 INFO - Directory to install application into. [default: 06:40:48 INFO - "/builds/slave/test"] 06:40:48 INFO - --app=APP Application being installed. [default: firefox] 06:40:48 INFO - mkdir: /builds/slave/test/build/application 06:40:48 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'] 06:40:48 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 06:41:04 INFO - Reading from file tmpfile_stdout 06:41:04 INFO - Output received: 06:41:04 INFO - /builds/slave/test/build/application/firefox/firefox 06:41:04 INFO - Running post-action listener: _resource_record_post_action 06:41:04 INFO - ##### 06:41:04 INFO - ##### Finished install step (success) 06:41:04 INFO - ##### 06:41:04 INFO - ##### 06:41:04 INFO - ##### Running run-tests step. 06:41:04 INFO - ##### 06:41:04 INFO - Running pre-action listener: _resource_record_pre_action 06:41:04 INFO - Running main action method: run_tests 06:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:41:04 INFO - Python 2.7.3 06:41:04 INFO - Return code: 0 06:41:04 INFO - grabbing minidump binary from tooltool 06:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:04 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 0x1a739c0>, '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 0x1a748c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:41:04 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 06:41:04 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 06:41:04 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 06:41:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:41:04 INFO - Return code: 0 06:41:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:41:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:41:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:41:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:41:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:41:05 INFO - Return code: 0 06:41:05 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/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:41:05 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/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 06:41:05 INFO - Using env: {'DISPLAY': ':0', 06:41:05 INFO - 'HOME': '/home/cltbld', 06:41:05 INFO - 'LANG': 'en_US.UTF-8', 06:41:05 INFO - 'LANGUAGE': 'en_US:en', 06:41:05 INFO - 'LOGNAME': 'cltbld', 06:41:05 INFO - 'MAIL': '/var/mail/cltbld', 06:41:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:41:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:05 INFO - 'MOZ_NO_REMOTE': '1', 06:41:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:05 INFO - 'NO_EM_RESTART': '1', 06:41:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:05 INFO - 'PWD': '/builds/slave/test', 06:41:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:41:05 INFO - 'SHELL': '/bin/bash', 06:41:05 INFO - 'SHLVL': '1', 06:41:05 INFO - 'TERM': 'linux', 06:41:05 INFO - 'TMOUT': '86400', 06:41:05 INFO - 'USER': 'cltbld', 06:41:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178', 06:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:05 INFO - '_': '/tools/buildbot/bin/python'} 06:41:05 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/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:41:05 INFO - mozversion application_buildid: 20160530031349 06:41:05 INFO - mozversion application_changeset: 640f046e0e79d18aa0d4c0efac7e9f5d365f09a0 06:41:05 INFO - mozversion application_display_name: Nightly 06:41:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:41:05 INFO - mozversion application_name: Firefox 06:41:05 INFO - mozversion application_remotingname: firefox 06:41:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:41:05 INFO - mozversion application_vendor: Mozilla 06:41:05 INFO - mozversion application_version: 49.0a1 06:41:05 INFO - mozversion platform_buildid: 20160530031349 06:41:05 INFO - mozversion platform_changeset: 640f046e0e79d18aa0d4c0efac7e9f5d365f09a0 06:41:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:41:05 INFO - mozversion platform_version: 49.0a1 06:41:05 INFO - using testdate: 1464615665 06:41:05 INFO - actual date: 1464615665 06:41:05 INFO - starting webserver on 'localhost:58396' 06:41:05 INFO - SUITE-START | Running 2 tests 06:41:05 INFO - TEST-START | dromaeo_css 06:41:05 INFO - operating with platform_type : linux_ 06:41:05 INFO - Initialising browser for dromaeo_css test... 06:41:05 INFO - TEST-INFO | started process 20280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHzXaI/profile http://localhost:58396/getInfo.html) 06:41:09 INFO - PROCESS | 20280 | __metrics Screen width/height:1600/1200 06:41:09 INFO - PROCESS | 20280 | colorDepth:24 06:41:09 INFO - PROCESS | 20280 | Browser inner width/height: 1024/697 06:41:09 INFO - PROCESS | 20280 | __metrics 06:41:10 ERROR - PROCESS | 20280 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:41:11 INFO - TEST-INFO | 20280: exit 0 06:41:11 INFO - Browser initialized. 06:41:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:41:11 INFO - TEST-INFO | started process 20362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHzXaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:41:23 INFO - PROCESS | 20362 | RSS: Main: 157437952 06:41:23 INFO - PROCESS | 20362 | 06:42:15 INFO - PROCESS | 20362 | 1464615735204 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] 06:44:26 INFO - PROCESS | 20362 | Cycle 1(1): loaded http://localhost:58396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58396/tests/dromaeo/cssquery-ext.html) 06:44:28 INFO - PROCESS | 20362 | RSS: Main: 271835136 06:44:28 INFO - PROCESS | 20362 | 06:47:30 INFO - PROCESS | 20362 | Cycle 1(1): loaded http://localhost:58396/tests/dromaeo/cssquery-ext.html (next: http://localhost:58396/tests/dromaeo/cssquery-jquery.html) 06:47:31 INFO - PROCESS | 20362 | RSS: Main: 240058368 06:47:31 INFO - PROCESS | 20362 | 06:50:33 INFO - PROCESS | 20362 | Cycle 1(1): loaded http://localhost:58396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58396/tests/dromaeo/cssquery-mootools.html) 06:50:34 INFO - PROCESS | 20362 | RSS: Main: 245592064 06:50:34 INFO - PROCESS | 20362 | 06:53:36 INFO - PROCESS | 20362 | Cycle 1(1): loaded http://localhost:58396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58396/tests/dromaeo/cssquery-prototype.html) 06:53:37 INFO - PROCESS | 20362 | RSS: Main: 235302912 06:53:37 INFO - PROCESS | 20362 | 06:56:40 INFO - PROCESS | 20362 | Cycle 1(1): loaded http://localhost:58396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58396/tests/dromaeo/cssquery-yui.html) 06:56:40 INFO - PROCESS | 20362 | RSS: Main: 214249472 06:56:40 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | Cycle 1(1): loaded http://localhost:58396/tests/dromaeo/cssquery-yui.html (next: http://localhost:58396/tests/dromaeo/cssquery-dojo.html) 06:59:43 INFO - PROCESS | 20362 | RSS: Main: 290463744 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | __start_tp_report 06:59:43 INFO - PROCESS | 20362 | _x_x_mozilla_page_load 06:59:43 INFO - PROCESS | 20362 | _x_x_mozilla_page_load_details 06:59:43 INFO - PROCESS | 20362 | |i|pagename|runs| 06:59:43 INFO - PROCESS | 20362 | |0;dojo.html;2653.2836134243753;2666.9199924002287;2686.7044625091235;2696.7033626301104;2706.0528814914783;4627.282771170466;4664.043871006444;4696.859094227174;4706.152892479352;4738.905221895564;4715.952840471594;4717.764111794414;4718.622510199184;4754.7860346284415;4772.832950846721;4285.892852678677;4340.045190058198;4385.934210986838;4394.956050439487;4504.527024662412;4414.404055452521;4419.160359531678;4438.644908407319;4441.911161776762;4457.643388528926;4243.024104455962;4284.721493102938;4299.763513006784;4325.891852703676;4335.544767799367;4283.057727299989;4290.978545107255;4303.505096913864;4351.673624478177;4351.9782401088105;4318.244307246219;4329.7618630975285;4339.869803905888;4375.7155784873885;4384.16700826845;4577.313402989578;4617.630589552828;4620.445546534404;4673.088747694201;4684.8360307389075;5108.795648174106;5128.589712822965;5132.974335128338;5135.075686376451;5135.871603209912;5119.078565858144;5143.7685304161405;5155.9484405155845;5162.096633089194;5165.173572228463;4621.145088158702;4733.313669517935;4792.113459010095;4796.688215265996;4851.927221091686;5253.343332083489;5316.973415132899;5323.22813192085;5328.733563321896;5334.146536554133;4914.65597408178;4955.132851750929;4956.033573453215;4960.032793605213;4966.652334336634;4965.602751779849;5028.195488721787;5037.168867136955;5075.593952483792;5076.847694569169;5047.621428392885;5054.873628159326;5055.266986286968;5055.772490237948;5107.463716309734;5035.093683136997;5038.445770965191;5039;5043.646944713835;5045.974770126126;4235.110626768352;4260.062786187033;4267.957320426756;4293.141371725667;4322.308430651144;3788.1476667749534;3790.3935370340614;3795.772253664789;3834.328992426314;3846.2692088503654;4399.912001759947;4408.294672852328;4411.18393097278;4460.77696115193;4461.5092339842595;4932.260160975882;5042.09242336383;5080.491950804964;5140.742962851842;5149.201873709581;4385.693001489865;4399.780010999437;4405.735655860659;4425.557444255549;4447.666425018137;4576.199165146153;4599.793009314589;4607.792649330788;4611.377464042378;4656.650751193606;4720.079584481062;4765.95234047669;4806.158922188603;4827.324174615486;4832.95167048325;5069.949300506948;5082.949170508396;5089.1094058538865;5092.261622064706;5135.024345374367;4762.78567464458;4770.0936822003705;4771;4778.259369797687;4818.975905120452;4837.975810120927;4876.171050921281;4947;4973.328600638867;4987.2020476725;5013.974930125472;5039.974800125976;5074.5432911036705;5077.339945807022;5115.64190506661;4787.976060119817;4865.294532292868;4865.416150062015;4872.756362181947;4920.950790492049;4873.415190177201;4909;4925.039617274597;4931.6301277405055;4941.135301322326;4877.9024419512125;4891.6430277136715;4918.901621967612;4928.0390323886495;4940.530649588283;4861.927071094007;4920.2619607057795;4980.103581355391;5018.824341148043;5027.095122877917;4734.573888350065;4779.402574678165;4855.75721213945;4876.951230487792;4904.019196160853 06:59:43 INFO - PROCESS | 20362 | |1;ext.html;545.959946302294;590.3211306996953;593.9406059394058;594.9286085669718;608.6956521739129;27169.864150679245;40405.59594404055;41149.588504114916;41278.174436511326;41300.58699413005;41384.58615413845;41786.79106604463;41824.16351672965;41858.16283674325;41974;7412;7798.142204357516;7988.7203947861835;7996.600169991506;10004.349717268391;9980.800383992315;10164.186865050779;10166.796664066715;10185.185185185168;10192.235582331317;10170.44062576558;10233.130183934374;10238.283320167591;10243.334183278062;10247.436390998491;7508.9487471754;7674.693012279502;7731.22687731228;10111.292209545334;10149.238807089461;9931.50342482873;10029.648962286357;10258.589656413735;10266.589336426534;10270.845937310947;39235.60764392348;39716.801415993024;39793.80103099466;39835.60164398348;39907.20185596272;2960.866760995739;3040.1639549123947;3084.90745277642;3112.128603990886;3472.2534655049285;29991.400171996436;30062.398752025056;30450;30728.692713072807;32217;3508.8070156141403;3520.7887526748477;3582.247727977128;3588.4617307403837;3640.8179591020344;259060;260832;260990;261948;263120.9999999981;57947.420525795045;58900.41099588949;59392;59396.40603593995;59490.40509594849;34786.30427391438;61560.69219653873;62251.377486225465;62338.68830655818;62354.37645623486;12078.094142939315;12880;12886.677833054062;12892.226466412045;12903.54837580699;8986.236169925498;9479.383840050512;9837.852432213522;9857.408555486694;10101;19386.586979468797;19512;19535;19751.111199996034;19774.60450790976;7372;7702.499337543042;7710.498817576839;7735.535867847834;7831.373490120776;736.8415790605046;802.9237222463856;1008.1481148429565;1047.3454091193005;1062.1025233677685;27755.722442775314;28468.715312846605;28524.006639070547;28637.713622863506;28931.56602650962;888.6623083228332;922.5848368234322;938.648006997376;947.7772723409993;974.084360700953;14724.77912831287;15155.696886062216;15211.543653690407;15258.389664413522;15329.233538323038;395503;397972;403245;404853;406117;49597.50402496001;50232.497675023515;50252.24621630678;50331.49668503342;50396.49603503991;1092.3118435385657;1167.1129941244715;1195.9820602690793;1221.5907670930337;1234.2594443334108;28237.294067648472;29538;29538;29601.259968500097;30029.699703003564;41529.58470415257;41598.792006039774;42128.1574368517;42136.57863421326;42152.78923605362;282734;284896;285919;286295;286634;22991.65512517347;25234;25956.61065084063;25972.35069123287;27433.177004689893;40883;41061.1787764249;41519.792401037805;42034.579654203066;42218.57781422146;36293.27413451769;36349.45475817918;36683.63316366802;37123.25753484969;37313.626863732105;35472;36187.27625447529;36228.63771362253;36340;36443.08892277714;35295.11762205965;36073.63926360808;36655.633443665225;36667;36739.08152296214;30096.548551771302;34187.65812341845;34226.315473690884;34358.65641343554;34390.31219375548;25196.24411267665;25348.873255633604;25747.485050298514;25907.740922590532;26368.20895373142 06:59:43 INFO - PROCESS | 20362 | |2;jquery.html;367.72053239537945;373.9831707573159;374.75207558829095;393.70275442041253;395.3595175815178;15817.920910395445;16391.50825475236;17196.96818190908;17199.398021069264;17206.225719842605;13272;14005.159690418583;14646.560603181895;14648.926755366236;15002.924985375084;4703.129920964615;4854.271859221128;4898.951010489903;4900.828471003516;4905.362302900618;3471.444568868969;5246.265522826808;5496.890062198753;5507.5593952483905;5618.353889302742;5466.863328416782;5597.6641401515835;5611.046122159243;5627.465390787868;5644.209810626516;6059.6364218147055;6096.207493025922;6134.4478996890275;6147.2008638877105;6155.692215389235;3428.5371474850826;5150.201718733565;5404.621676482648;5444.3194600674915;5539.667619942776;12512.937435312857;12525.812112818316;12547;18130.093495325313;19170.137343819562;1752.0626464841375;1778.395345582495;1811.3841293960118;1839.0988415676222;2287.096596844254;9121.407108537924;9446.622135114587;9505.04949505044;11156.497957591928;13338.19970801755;1622.691688579178;1647.8105017922971;1648.4889684197938;1700.1159397113431;1787.436957358428;66776.66611666958;68757.3124268756;70068;70469.29530704679;70671;9449.59035445957;9575;9674.371165874196;9783.168430683472;9798.46108464027;13233.867661323457;13389.66525836862;13424.060315777802;13426.328683565978;13435.395407206699;6520.054592084121;6544.345565443417;6602.768903088465;6668;6726;6171.259448866164;6193.566450348432;6281.403266689657;6370.681465926685;6381.649009304533;4009.67922566194;4102.220578090153;4135.338345864708;4176.749395036308;4187.644050255702;1558.2598265823642;1645.8025036995637;1721.9827801722072;1724.741288806689;1747.6242607839376;817.6647574494428;822.2106777493553;895.2390468102061;949.9525023748785;964.8890377606525;15793.68412631764;15937.601559961095;15967.680646387007;16304.266308016167;16517.174141292886;777.1257335497565;802.4142376065505;810.6838333050115;822.43663090783;861.1818772166467;8946.50794206312;9113.270938324918;9467.66863159786;9845.950770246103;10042.799144017079;375072;378951;389593;391416;391887;75571.62214189004;78307.21692783;78935.60532197302;79076;79653;963.3689933093975;970.708787363788;992.3999122299621;1024.1960061351804;1027.6249169053392;15167.241637918281;15345;15346.386144554093;15601.297941592882;15694.450694225647;34492.65507344995;34911.301773964886;35094.649053509136;35464.75873344524;35981;48896.51103489062;49362.75318623528;49581.752091239316;49945.75027124841;50251.49748502468;6577.112089867806;6914.239433662193;7133.643317834191;7283.562986220843;7369.042024536776;10362.585496580052;11658.825117623412;11719.707007324543;11873.703157421134;11884.864442464657;9420.340576159877;9527.57125929321;9545.90454095478;9700.708978730649;9819.705408837746;8316.251537361666;9616.278779091735;9787.706368808947;10052.64815731446;10182;9103.317251206054;9369.953150234205;9514.19129374011;9718.9028109718;9738.415695058318;7075.257098004636;7191.640417979184;7208.783736487913;7228.855422891618;7395.038644976119;7818.765437036898;9337.253019758538;9429.52852357393;9447.338686291894;9688 06:59:43 INFO - PROCESS | 20362 | |3;mootools.html;1241.5468354050774;1405.8664426879445;1451.9564413067608;1548.5818828916192;1760.331074191807;6773.390394864461;7419.629018549072;7656.617169141548;7675.731349402772;7887.5267483951;7690.807729806757;7848.215178482149;7851.411144164196;7855.567943763105;7859.764207073783;1884.3687364732762;1925.0278609302352;1926.9132889020027;2203.1958335207655;2233.8436309458343;1960.8529360297964;2144.3888491779844;2187.814035806958;2193.9451513712124;2208.072609504004;2150.7419109706857;2166.631672615659;2175.9347219583437;2179.3788770200495;2179.662152366378;1829.2134382215643;2163.8485306028583;2169.5227050048966;2169.7287839020123;2173.652215645505;2139.679048142791;2217.013429024085;2221.1559607349263;2222.9666555001686;2224.7552769195377;7497.287757663068;7557.319841214262;7793.103793063757;7796;7803.7268695595385;4657.510961349078;4812.230043193107;4814.398200224972;4823.252395878644;4823.276508523714;2903.11455006223;2994.3861508390946;3058.29659178388;3060.556219348204;3073.400686866062;892.085612247445;917.2845180759018;942.4816351006988;942.6559305853314;956.3687965942514;10350.482475876252;10503.947480262626;10546.736331591695;10577.418241996687;10582.682519524427;4237.745735255833;4332.480102387671;4360.476742790822;4404.471463424409;4406.911861762746;8984.46093234408;9031.142041506046;9034.909650903539;9036.096390361043;9040.367174297737;4642.094791515689;4647.674662773641;4653.837115700934;4654.604358629486;4654.720716757005;3673.779573225615;4076.2255171517318;4254.361845723166;4366.803493842721;4371.912561748811;3621.5292012038267;3666.7433279670167;3696.390095634244;3718.2563487302646;3752.399616061417;1182.6629410617932;1183.207251141737;1186.1400484648734;1194.8625908020515;1213.8179273109104;745.683084689005;808.4058217210346;810.8864758933754;823.3701218567801;836.7991681996399;5067.746612669352;5343.305370301913;5343.839684809462;5448.782048718007;5468.835934921959;854.5769843927296;896.9461832289953;914.9588268527799;964.4020707161465;1007.2043085962155;3379.4086034943784;3598.3882739934274;3606.2246616977477;3661.139632186434;3693.3905905525826;9536.618535258513;9567.091126342986;9657.179139773058;9834.164096051916;9851.064148905842;9679.951600241953;9725;9766.07222313879;9766.07222313879;9776.853347199798;7013.473989450914;7315.817104572428;7412.0364352633815;7445.478816482794;7451.3293803557945;5327.573794096385;5363.436839131991;5366.919496207638;5406.4052954175795;5426.131818908955;8562.272206862486;8849.159329863653;9099;9100.408473449204;9106.95446522763;9038.457692538468;9172.633094676139;9195.126462986273;9266.721998340061;9276.16514513697;6215;6460.289368169404;6580.144581204413;6581.078648989241;6647.468202543688;7629.6566654499575;7647.158812530506;7670.693172273047;7691.50005249657;7707.576083315472;6713.093732346071;6734.09089772894;6774.93225067743;6889.931100688929;6997.05539752127;6689.364510371507;6696.933030669826;6749.3588109131515;6769.3907548320885;6827.146606674166;6377.489800816016;6387.712552935222;6447.6131432114225;6458.192725909262;6526.4452521536205;4724.078804633064;4756.476787553435;4805.5915247204375;4816.229403295456;4854.63590230727;4746.5490778376;4790.0659371423635;4830.686005409637;4840.249761287007;4853.538913803183 06:59:43 INFO - PROCESS | 20362 | |4;prototype.html;310.6272473032361;312.10581683476846;317.9268768183318;317.9968200317997;319.06513914231294;4768.809247630095;4784.928226076611;4790.832320868771;4800.879978000557;4833.540813622704;4719.457262414815;4748.287756836477;4749.620030397568;4757.238841785315;4768.761561921899;3547.7693949893173;3678.70570354371;3678.981605091971;3768.9623103768886;3815.3704638734575;3715.461258117571;3737.9813100934457;3767.4537192107127;3774.7735135891935;3785.867494637688;3546.592141903688;3733.1973625670475;3741.3452645787015;3751.4185301278344;3751.8311675974646;3608.170120872201;3738.4392341148773;3749.418840079792;3765;3766.773993560395;3313.2545177335146;3319.767616266838;3325.118843506473;3329.284203896174;3338.8163650999186;4577.473590537097;4591.4260717410325;4611.01726257709;4614.76926153691;4624.1445332613575;4133.648639865585;4262.808173632194;4268.378016353797;4273.166732487166;4282.314829627276;4958.7024778513405;4964.67729597575;4967.627427942883;4971.204607262856;4977.776000080005;3631.909202269964;3634.672879440863;3639.5996440391536;3641.908952276188;3643.981780091083;4991.5258050485145;5178.818741344073;5201.5838732901275;5220.451852555465;5243.082460569385;3668.3954392381174;3686.3364594372733;3696.5194524711615;3712.7215458840697;3720.3489389356755;3767.434884767307;3777.8488860445823;3782.829772660182;3787.867424640124;3795.4306853972125;4254.914901701949;4265.3815196796295;4269.1034882674985;4273.786310684453;4294.205571969195;4658.906821863544;4932.679375840559;4946.802127914915;4984.925226121611;5002.049200811686;1307.5488956310057;1319.0502837956656;1323.3251041968665;1334.9599512014654;1335.9398827052805;854.9059603443616;880.3749337969984;902.9548522573976;917.8714979902819;920.6547544670749;4390.890227744332;4404.11917616478;4410.5368936261875;4410.904820210374;4411.558844115562;5025.698458092526;5081.415637201769;5093.923591146136;5112.74436278192;5115.232715092691;4193.040724026811;4364.54172311909;4394.318880573516;4406.955930440655;4407.6914615976575;2737.6167336572894;2742.945141097167;2751.7523422892036;2754.986225068902;2760.9723902760716;4800.927986080212;4829;4855.611551075976;4861.6596838220985;4866.172750632401;4975.878154778564;5045.419776725724;5103.2855400244;5202.557782588522;5214.191800270964;4746.501617330199;4754;4756.9762151189025;4766.6901651392545;4803.495632958559;5013.523715247045;5027.195648696191;5056.721880296472;5057.46896575869;5066.113430149783;4850.417949846041;4924.778384972757;4937.802487900587;4937.876553086202;4959.305697202467;4762.499937506512;4766.285057241442;4770.522947705202;4775.140474714584;4784.449788274393;3755.962440375561;3758.3047136279874;3767.6985841132096;3768;3780.281746468162;4895.363602731622;5058.822941197041;5137.152369859081;5143.177091665316;5151.072806894795;4885.364902562644;4913.852584422473;4921.975390123026;4928.644622728778;4939.901201976012;4882.36529251195;4907.754612269301;4925.704457732548;4926.334944782552;4943.011397720398;4644.117617652635;4881.829135980366;4899.828506002415;4900.534449227318;4914.140025495595;4816;4866.537678920497;5065.164247899055;5074.792465277616;5079.796808127633;4881.463039065629;4903.436104847988;4911.901761964812;4939.16034274167;4960.355153829979 06:59:43 INFO - PROCESS | 20362 | |5;yui.html;716.3087620446269;736.9410447164228;750.4971668981782;753.7927070055738;753.939684825214;13287.202767833925;13693.520726774552;13708.588742337746;13728.72542549151;13746.106503077293;14323.570292891203;14399.992000559965;14417.134971901693;14421.278936053208;14485.855141448583;629.9937000630003;774.3147314626568;801.0507548554966;806.4395245304515;810.8702607582788;779.6140910249435;813.8168911994813;813.8738495533202;814.3281792521165;814.5560669435172;842.692417267699;847.3094428041157;848.1687945813106;848.9363297752662;848.995755021224;661.0909998751716;817.9795505112361;838.9664413423455;839.546644811804;840.2647683277132;622.1662971618008;622.7820262907991;622.7820262907991;622.919020527333;623.1307326279859;12203.267803931703;12213.755724885541;12228.449719762632;12236.204646697935;12241.387930603523;11366.204365694404;11624.94187529057;11662.533498660043;11717.941410292893;11832.70418239551;11006.119510439146;11049.17131215154;11086.390248536409;11117.444127793578;11134.16493762971;3898.961010389888;3918.9804050979847;3925.411188321746;4000.7799571023875;4085.836566537335;46429.30356044662;46436.76781616104;47646;47662.28506572404;47773.76113119482;9656.179224765974;9771.538810486389;9856.45789481571;9934.602615895428;10254.28220024591;16669.41657042022;16707.911511061116;16710.916445417693;16752;16752.24614892333;6418.261899881573;6472.061551075068;6598.670066496656;6684.699188536528;6790.694418751168;3606.441001644749;3675.0996005978172;3697.1681371691157;3758.6805121564425;3827.8086095695103;2784.763295119897;2875.6405449318836;2877.92805179868;2879.3665393613373;2882.293838009701;491.08167726351235;513.2839688634334;517.4204890522639;534.6791924845062;537.1057189779052;534.2707204665603;535.3950036458855;561.3684604819578;575.8445219790717;577.1371799160282;6845;6935.757248496278;7016.228214896358;7141.928580714126;7167.820804479826;518.613632843534;529.1110933631459;538.284082170712;556.1879655702719;556.6520924422236;3300.719438847677;3431.3995050865997;3441.6730410610953;3444.2422667013216;3469.1500582357485;54628.45371546234;55491.16763248554;56825;56933.29933554389;57324;48743.268850967266;48818.511814882106;49415.50584494181;49587.25619115716;51732;46711.29933051007;47760.52239477561;47823.022122235416;47869;48301.275480867815;7959.92040079615;7969.1632378601735;8137.6338064788415;8238.340932725487;8437.915620843958;30857.845710771304;31308.373832523677;31467.370652587277;32713.509297361034;33324;36906.8154659225;40814.79592602137;41612;41748;42517;10621.840672389766;10644;10727.517261723086;10756.139508839431;10948.233623646587;11269.830952535554;11324.150688698546;11547.249428787101;12261.080418968791;12321.199122057038;10420.635277765545;10660.84008739885;10700.250982431155;10712.678619641423;10998.945005274922;9923.156531694598;10144.54349554257;10375.68872933783;10545.050945414643;10739.677809665722;9649.324547281623;9920.950395247977;9971.45157016371;10121.69634910954;10217.591296348062;8602.18279263469;8608;8637.740867773977;8823.911760882309;9290.442573445614;8660.653573856975;8680.826383472422;8720.345974051845;8885.378023538291;9095.49974751395 06:59:43 INFO - PROCESS | 20362 | __end_tp_report 06:59:43 INFO - PROCESS | 20362 | __start_cc_report 06:59:43 INFO - PROCESS | 20362 | _x_x_mozilla_cycle_collect,1054 06:59:43 INFO - PROCESS | 20362 | __end_cc_report 06:59:43 INFO - PROCESS | 20362 | __startTimestamp1464616783783__endTimestamp 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | ------- Summary: start ------- 06:59:43 INFO - PROCESS | 20362 | Number of tests: 6 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | [#0] dojo.html Cycles:165 Average:4687.92 Median:4796.69 stddev:485.78 (10.1%) stddev-sans-first:460.30 06:59:43 INFO - PROCESS | 20362 | Values: 2653.3 2666.9 2686.7 2696.7 2706.1 4627.3 4664.0 4696.9 4706.2 4738.9 4716.0 4717.8 4718.6 4754.8 4772.8 4285.9 4340.0 4385.9 4395.0 4504.5 4414.4 4419.2 4438.6 4441.9 4457.6 4243.0 4284.7 4299.8 4325.9 4335.5 4283.1 4291.0 4303.5 4351.7 4352.0 4318.2 4329.8 4339.9 4375.7 4384.2 4577.3 4617.6 4620.4 4673.1 4684.8 5108.8 5128.6 5133.0 5135.1 5135.9 5119.1 5143.8 5155.9 5162.1 5165.2 4621.1 4733.3 4792.1 4796.7 4851.9 5253.3 5317.0 5323.2 5328.7 5334.1 4914.7 4955.1 4956.0 4960.0 4966.7 4965.6 5028.2 5037.2 5075.6 5076.8 5047.6 5054.9 5055.3 5055.8 5107.5 5035.1 5038.4 5039.0 5043.6 5046.0 4235.1 4260.1 4268.0 4293.1 4322.3 3788.1 3790.4 3795.8 3834.3 3846.3 4399.9 4408.3 4411.2 4460.8 4461.5 4932.3 5042.1 5080.5 5140.7 5149.2 4385.7 4399.8 4405.7 4425.6 4447.7 4576.2 4599.8 4607.8 4611.4 4656.7 4720.1 4766.0 4806.2 4827.3 4833.0 5069.9 5082.9 5089.1 5092.3 5135.0 4762.8 4770.1 4771.0 4778.3 4819.0 4838.0 4876.2 4947.0 4973.3 4987.2 5014.0 5040.0 5074.5 5077.3 5115.6 4788.0 4865.3 4865.4 4872.8 4921.0 4873.4 4909.0 4925.0 4931.6 4941.1 4877.9 4891.6 4918.9 4928.0 4940.5 4861.9 4920.3 4980.1 5018.8 5027.1 4734.6 4779.4 4855.8 4877.0 4904.0 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | [#1] ext.html Cycles:180 Average:47831.98 Median:19527.12 stddev:84656.19 (433.5%) stddev-sans-first:84819.22 06:59:43 INFO - PROCESS | 20362 | Values: 546.0 590.3 593.9 594.9 608.7 27169.9 40405.6 41149.6 41278.2 41300.6 41384.6 41786.8 41824.2 41858.2 41974.0 7412.0 7798.1 7988.7 7996.6 10004.3 9980.8 10164.2 10166.8 10185.2 10192.2 10170.4 10233.1 10238.3 10243.3 10247.4 7508.9 7674.7 7731.2 10111.3 10149.2 9931.5 10029.6 10258.6 10266.6 10270.8 39235.6 39716.8 39793.8 39835.6 39907.2 2960.9 3040.2 3084.9 3112.1 3472.3 29991.4 30062.4 30450.0 30728.7 32217.0 3508.8 3520.8 3582.2 3588.5 3640.8 259060.0 260832.0 260990.0 261948.0 263121.0 57947.4 58900.4 59392.0 59396.4 59490.4 34786.3 61560.7 62251.4 62338.7 62354.4 12078.1 12880.0 12886.7 12892.2 12903.5 8986.2 9479.4 9837.9 9857.4 10101.0 19386.6 19512.0 19535.0 19751.1 19774.6 7372.0 7702.5 7710.5 7735.5 7831.4 736.8 802.9 1008.1 1047.3 1062.1 27755.7 28468.7 28524.0 28637.7 28931.6 888.7 922.6 938.6 947.8 974.1 14724.8 15155.7 15211.5 15258.4 15329.2 395503.0 397972.0 403245.0 404853.0 406117.0 49597.5 50232.5 50252.2 50331.5 50396.5 1092.3 1167.1 1196.0 1221.6 1234.3 28237.3 29538.0 29538.0 29601.3 30029.7 41529.6 41598.8 42128.2 42136.6 42152.8 282734.0 284896.0 285919.0 286295.0 286634.0 22991.7 25234.0 25956.6 25972.4 27433.2 40883.0 41061.2 41519.8 42034.6 42218.6 36293.3 36349.5 36683.6 37123.3 37313.6 35472.0 36187.3 36228.6 36340.0 36443.1 35295.1 36073.6 36655.6 36667.0 36739.1 30096.5 34187.7 34226.3 34358.7 34390.3 25196.2 25348.9 25747.5 25907.7 26368.2 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | [#2] jquery.html Cycles:180 Average:23723.24 Median:5325.44 stddev:63750.75 (1197.1%) stddev-sans-first:63905.47 06:59:43 INFO - PROCESS | 20362 | Values: 367.7 374.0 374.8 393.7 395.4 15817.9 16391.5 17197.0 17199.4 17206.2 13272.0 14005.2 14646.6 14648.9 15002.9 4703.1 4854.3 4899.0 4900.8 4905.4 3471.4 5246.3 5496.9 5507.6 5618.4 5466.9 5597.7 5611.0 5627.5 5644.2 6059.6 6096.2 6134.4 6147.2 6155.7 3428.5 5150.2 5404.6 5444.3 5539.7 12512.9 12525.8 12547.0 18130.1 19170.1 1752.1 1778.4 1811.4 1839.1 2287.1 9121.4 9446.6 9505.0 11156.5 13338.2 1622.7 1647.8 1648.5 1700.1 1787.4 66776.7 68757.3 70068.0 70469.3 70671.0 9449.6 9575.0 9674.4 9783.2 9798.5 13233.9 13389.7 13424.1 13426.3 13435.4 6520.1 6544.3 6602.8 6668.0 6726.0 6171.3 6193.6 6281.4 6370.7 6381.6 4009.7 4102.2 4135.3 4176.7 4187.6 1558.3 1645.8 1722.0 1724.7 1747.6 817.7 822.2 895.2 950.0 964.9 15793.7 15937.6 15967.7 16304.3 16517.2 777.1 802.4 810.7 822.4 861.2 8946.5 9113.3 9467.7 9846.0 10042.8 375072.0 378951.0 389593.0 391416.0 391887.0 75571.6 78307.2 78935.6 79076.0 79653.0 963.4 970.7 992.4 1024.2 1027.6 15167.2 15345.0 15346.4 15601.3 15694.5 34492.7 34911.3 35094.6 35464.8 35981.0 48896.5 49362.8 49581.8 49945.8 50251.5 6577.1 6914.2 7133.6 7283.6 7369.0 10362.6 11658.8 11719.7 11873.7 11884.9 9420.3 9527.6 9545.9 9700.7 9819.7 8316.3 9616.3 9787.7 10052.6 10182.0 9103.3 9370.0 9514.2 9718.9 9738.4 7075.3 7191.6 7208.8 7228.9 7395.0 7818.8 9337.3 9429.5 9447.3 9688.0 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | [#3] mootools.html Cycles:180 Average:5170.32 Median:5365.18 stddev:2877.12 (53.6%) stddev-sans-first:2870.04 06:59:43 INFO - PROCESS | 20362 | Values: 1241.5 1405.9 1452.0 1548.6 1760.3 6773.4 7419.6 7656.6 7675.7 7887.5 7690.8 7848.2 7851.4 7855.6 7859.8 1884.4 1925.0 1926.9 2203.2 2233.8 1960.9 2144.4 2187.8 2193.9 2208.1 2150.7 2166.6 2175.9 2179.4 2179.7 1829.2 2163.8 2169.5 2169.7 2173.7 2139.7 2217.0 2221.2 2223.0 2224.8 7497.3 7557.3 7793.1 7796.0 7803.7 4657.5 4812.2 4814.4 4823.3 4823.3 2903.1 2994.4 3058.3 3060.6 3073.4 892.1 917.3 942.5 942.7 956.4 10350.5 10503.9 10546.7 10577.4 10582.7 4237.7 4332.5 4360.5 4404.5 4406.9 8984.5 9031.1 9034.9 9036.1 9040.4 4642.1 4647.7 4653.8 4654.6 4654.7 3673.8 4076.2 4254.4 4366.8 4371.9 3621.5 3666.7 3696.4 3718.3 3752.4 1182.7 1183.2 1186.1 1194.9 1213.8 745.7 808.4 810.9 823.4 836.8 5067.7 5343.3 5343.8 5448.8 5468.8 854.6 896.9 915.0 964.4 1007.2 3379.4 3598.4 3606.2 3661.1 3693.4 9536.6 9567.1 9657.2 9834.2 9851.1 9680.0 9725.0 9766.1 9766.1 9776.9 7013.5 7315.8 7412.0 7445.5 7451.3 5327.6 5363.4 5366.9 5406.4 5426.1 8562.3 8849.2 9099.0 9100.4 9107.0 9038.5 9172.6 9195.1 9266.7 9276.2 6215.0 6460.3 6580.1 6581.1 6647.5 7629.7 7647.2 7670.7 7691.5 7707.6 6713.1 6734.1 6774.9 6889.9 6997.1 6689.4 6696.9 6749.4 6769.4 6827.1 6377.5 6387.7 6447.6 6458.2 6526.4 4724.1 4756.5 4805.6 4816.2 4854.6 4746.5 4790.1 4830.7 4840.2 4853.5 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | [#4] prototype.html Cycles:180 Average:4140.04 Median:4751.81 stddev:1171.53 (24.7%) stddev-sans-first:1139.01 06:59:43 INFO - PROCESS | 20362 | Values: 310.6 312.1 317.9 318.0 319.1 4768.8 4784.9 4790.8 4800.9 4833.5 4719.5 4748.3 4749.6 4757.2 4768.8 3547.8 3678.7 3679.0 3769.0 3815.4 3715.5 3738.0 3767.5 3774.8 3785.9 3546.6 3733.2 3741.3 3751.4 3751.8 3608.2 3738.4 3749.4 3765.0 3766.8 3313.3 3319.8 3325.1 3329.3 3338.8 4577.5 4591.4 4611.0 4614.8 4624.1 4133.6 4262.8 4268.4 4273.2 4282.3 4958.7 4964.7 4967.6 4971.2 4977.8 3631.9 3634.7 3639.6 3641.9 3644.0 4991.5 5178.8 5201.6 5220.5 5243.1 3668.4 3686.3 3696.5 3712.7 3720.3 3767.4 3777.8 3782.8 3787.9 3795.4 4254.9 4265.4 4269.1 4273.8 4294.2 4658.9 4932.7 4946.8 4984.9 5002.0 1307.5 1319.1 1323.3 1335.0 1335.9 854.9 880.4 903.0 917.9 920.7 4390.9 4404.1 4410.5 4410.9 4411.6 5025.7 5081.4 5093.9 5112.7 5115.2 4193.0 4364.5 4394.3 4407.0 4407.7 2737.6 2742.9 2751.8 2755.0 2761.0 4800.9 4829.0 4855.6 4861.7 4866.2 4975.9 5045.4 5103.3 5202.6 5214.2 4746.5 4754.0 4757.0 4766.7 4803.5 5013.5 5027.2 5056.7 5057.5 5066.1 4850.4 4924.8 4937.8 4937.9 4959.3 4762.5 4766.3 4770.5 4775.1 4784.4 3756.0 3758.3 3767.7 3768.0 3780.3 4895.4 5058.8 5137.2 5143.2 5151.1 4885.4 4913.9 4922.0 4928.6 4939.9 4882.4 4907.8 4925.7 4926.3 4943.0 4644.1 4881.8 4899.8 4900.5 4914.1 4816.0 4866.5 5065.2 5074.8 5079.8 4881.5 4903.4 4911.9 4939.2 4960.4 06:59:43 INFO - PROCESS | 20362 | 06:59:43 INFO - PROCESS | 20362 | [#5] yui.html Cycles:180 Average:13223.88 Median:48085.14 stddev:15537.02 (32.3%) stddev-sans-first:15552.22 06:59:43 INFO - PROCESS | 20362 | Values: 716.3 736.9 750.5 753.8 753.9 13287.2 13693.5 13708.6 13728.7 13746.1 14323.6 14400.0 14417.1 14421.3 14485.9 630.0 774.3 801.1 806.4 810.9 779.6 813.8 813.9 814.3 814.6 842.7 847.3 848.2 848.9 849.0 661.1 818.0 839.0 839.5 840.3 622.2 622.8 622.8 622.9 623.1 12203.3 12213.8 12228.4 12236.2 12241.4 11366.2 11624.9 11662.5 11717.9 11832.7 11006.1 11049.2 11086.4 11117.4 11134.2 3899.0 3919.0 3925.4 4000.8 4085.8 46429.3 46436.8 47646.0 47662.3 47773.8 9656.2 9771.5 9856.5 9934.6 10254.3 16669.4 16707.9 16710.9 16752.0 16752.2 6418.3 6472.1 6598.7 6684.7 6790.7 3606.4 3675.1 3697.2 3758.7 3827.8 2784.8 2875.6 2877.9 2879.4 2882.3 491.1 513.3 517.4 534.7 537.1 534.3 535.4 561.4 575.8 577.1 6845.0 6935.8 7016.2 7141.9 7167.8 518.6 529.1 538.3 556.2 556.7 3300.7 3431.4 3441.7 3444.2 3469.2 54628.5 55491.2 56825.0 56933.3 57324.0 48743.3 48818.5 49415.5 49587.3 51732.0 46711.3 47760.5 47823.0 47869.0 48301.3 7959.9 7969.2 8137.6 8238.3 8437.9 30857.8 31308.4 31467.4 32713.5 33324.0 36906.8 40814.8 41612.0 41748.0 42517.0 10621.8 10644.0 10727.5 10756.1 10948.2 11269.8 11324.2 11547.2 12261.1 12321.2 10420.6 10660.8 10700.3 10712.7 10998.9 9923.2 10144.5 10375.7 10545.1 10739.7 9649.3 9921.0 9971.5 10121.7 10217.6 8602.2 8608.0 8637.7 8823.9 9290.4 8660.7 8680.8 8720.3 8885.4 9095.5 06:59:43 INFO - PROCESS | 20362 | -------- Summary: end -------- 06:59:43 INFO - PROCESS | 20362 | 06:59:44 INFO - TEST-INFO | 20362: exit 0 06:59:44 INFO - TEST-OK | dromaeo_css | took 1119096ms 06:59:44 INFO - TEST-START | kraken 06:59:44 INFO - operating with platform_type : linux_ 06:59:44 INFO - Initialising browser for kraken test... 06:59:44 INFO - TEST-INFO | started process 20541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuQrCj_/profile http://localhost:58396/getInfo.html) 06:59:48 INFO - PROCESS | 20541 | __metrics Screen width/height:1600/1200 06:59:48 INFO - PROCESS | 20541 | colorDepth:24 06:59:48 INFO - PROCESS | 20541 | Browser inner width/height: 1024/697 06:59:48 INFO - PROCESS | 20541 | __metrics 06:59:49 ERROR - PROCESS | 20541 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:59:50 INFO - TEST-INFO | 20541: exit 0 06:59:50 INFO - Browser initialized. 06:59:50 INFO - Running cycle 1/1 for kraken test... 06:59:50 INFO - TEST-INFO | started process 20622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuQrCj_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:02 INFO - PROCESS | 20622 | RSS: Main: 157028352 07:00:02 INFO - PROCESS | 20622 | 07:00:05 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58396/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:06 INFO - PROCESS | 20622 | RSS: Main: 214994944 07:00:06 INFO - PROCESS | 20622 | 07:00:08 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58396/tests/kraken/driver.html?testName=audio-dft) 07:00:09 INFO - PROCESS | 20622 | RSS: Main: 204054528 07:00:09 INFO - PROCESS | 20622 | 07:00:12 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58396/tests/kraken/driver.html?testName=audio-fft) 07:00:13 INFO - PROCESS | 20622 | RSS: Main: 270016512 07:00:13 INFO - PROCESS | 20622 | 07:00:15 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58396/tests/kraken/driver.html?testName=audio-oscillator) 07:00:16 INFO - PROCESS | 20622 | RSS: Main: 180285440 07:00:16 INFO - PROCESS | 20622 | 07:00:18 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:00:18 INFO - PROCESS | 20622 | RSS: Main: 184619008 07:00:18 INFO - PROCESS | 20622 | 07:00:22 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58396/tests/kraken/driver.html?testName=imaging-darkroom) 07:00:22 INFO - PROCESS | 20622 | RSS: Main: 220164096 07:00:22 INFO - PROCESS | 20622 | 07:00:26 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58396/tests/kraken/driver.html?testName=imaging-desaturate) 07:00:26 INFO - PROCESS | 20622 | RSS: Main: 220811264 07:00:26 INFO - PROCESS | 20622 | 07:00:29 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58396/tests/kraken/driver.html?testName=json-parse-financial) 07:00:30 INFO - PROCESS | 20622 | RSS: Main: 221519872 07:00:30 INFO - PROCESS | 20622 | 07:00:32 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:00:32 INFO - PROCESS | 20622 | RSS: Main: 205836288 07:00:32 INFO - PROCESS | 20622 | 07:00:34 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:00:35 INFO - PROCESS | 20622 | RSS: Main: 210821120 07:00:35 INFO - PROCESS | 20622 | 07:00:37 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:00:38 INFO - PROCESS | 20622 | RSS: Main: 219324416 07:00:38 INFO - PROCESS | 20622 | 07:00:40 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:00:41 INFO - PROCESS | 20622 | RSS: Main: 223621120 07:00:41 INFO - PROCESS | 20622 | 07:00:44 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:00:44 INFO - PROCESS | 20622 | RSS: Main: 224161792 07:00:44 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | Cycle 1(1): loaded http://localhost:58396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58396/tests/kraken/driver.html?testName=ai-astar) 07:00:46 INFO - PROCESS | 20622 | RSS: Main: 266010624 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | __start_tp_report 07:00:46 INFO - PROCESS | 20622 | _x_x_mozilla_page_load 07:00:46 INFO - PROCESS | 20622 | _x_x_mozilla_page_load_details 07:00:46 INFO - PROCESS | 20622 | |i|pagename|runs| 07:00:46 INFO - PROCESS | 20622 | |0;ai-astar;114;108;114;114;114;114;114;114;113;112 07:00:46 INFO - PROCESS | 20622 | |1;audio-beat-detection;173;131;135;182;129;132;161;138;191;130 07:00:46 INFO - PROCESS | 20622 | |2;audio-dft;161;160;161;163;160;161;161;163;160;162 07:00:46 INFO - PROCESS | 20622 | |3;audio-fft;75;77;75;120;76;77;74;76;100;76 07:00:46 INFO - PROCESS | 20622 | |4;audio-oscillator;85;87;119;85;84;84;119;84;84;125 07:00:46 INFO - PROCESS | 20622 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;116;118 07:00:46 INFO - PROCESS | 20622 | |6;imaging-darkroom;146;146;146;146;145;147;146;146;146;147 07:00:46 INFO - PROCESS | 20622 | |7;imaging-desaturate;95;95;95;95;94;99;95;95;94;96 07:00:46 INFO - PROCESS | 20622 | |8;json-parse-financial;64;62;63;63;63;63;64;64;63;62 07:00:46 INFO - PROCESS | 20622 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;66;66;65 07:00:46 INFO - PROCESS | 20622 | |10;stanford-crypto-aes;89;90;86;87;85;86;84;85;110;85 07:00:46 INFO - PROCESS | 20622 | |11;stanford-crypto-ccm;140;133;130;129;144;128;130;133;141;135 07:00:46 INFO - PROCESS | 20622 | |12;stanford-crypto-pbkdf2;171;168;169;171;171;167;169;168;166;166 07:00:46 INFO - PROCESS | 20622 | |13;stanford-crypto-sha256-iterative;67;70;67;66;68;66;66;65;67;69 07:00:46 INFO - PROCESS | 20622 | __end_tp_report 07:00:46 INFO - PROCESS | 20622 | __start_cc_report 07:00:46 INFO - PROCESS | 20622 | _x_x_mozilla_cycle_collect,1854 07:00:46 INFO - PROCESS | 20622 | __end_cc_report 07:00:46 INFO - PROCESS | 20622 | __startTimestamp1464616846851__endTimestamp 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | ------- Summary: start ------- 07:00:46 INFO - PROCESS | 20622 | Number of tests: 14 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 07:00:46 INFO - PROCESS | 20622 | Values: 114.0 108.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 112.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:149.50 stddev:24.15 (16.2%) stddev-sans-first:24.17 07:00:46 INFO - PROCESS | 20622 | Values: 173.0 131.0 135.0 182.0 129.0 132.0 161.0 138.0 191.0 130.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 07:00:46 INFO - PROCESS | 20622 | Values: 161.0 160.0 161.0 163.0 160.0 161.0 161.0 163.0 160.0 162.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:15.22 (20.0%) stddev-sans-first:15.89 07:00:46 INFO - PROCESS | 20622 | Values: 75.0 77.0 75.0 120.0 76.0 77.0 74.0 76.0 100.0 76.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.00 stddev:17.63 (21.0%) stddev-sans-first:18.27 07:00:46 INFO - PROCESS | 20622 | Values: 85.0 87.0 119.0 85.0 84.0 84.0 119.0 84.0 84.0 125.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:00:46 INFO - PROCESS | 20622 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:00:46 INFO - PROCESS | 20622 | Values: 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 147.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 07:00:46 INFO - PROCESS | 20622 | Values: 95.0 95.0 95.0 95.0 94.0 99.0 95.0 95.0 94.0 96.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 07:00:46 INFO - PROCESS | 20622 | Values: 64.0 62.0 63.0 63.0 63.0 63.0 64.0 64.0 63.0 62.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 07:00:46 INFO - PROCESS | 20622 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 66.0 65.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:86.00 stddev:7.72 (9.0%) stddev-sans-first:8.19 07:00:46 INFO - PROCESS | 20622 | Values: 89.0 90.0 86.0 87.0 85.0 86.0 84.0 85.0 110.0 85.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:134.00 stddev:5.58 (4.2%) stddev-sans-first:5.52 07:00:46 INFO - PROCESS | 20622 | Values: 140.0 133.0 130.0 129.0 144.0 128.0 130.0 133.0 141.0 135.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:1.96 (1.2%) stddev-sans-first:1.87 07:00:46 INFO - PROCESS | 20622 | Values: 171.0 168.0 169.0 171.0 171.0 167.0 169.0 168.0 166.0 166.0 07:00:46 INFO - PROCESS | 20622 | 07:00:46 INFO - PROCESS | 20622 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.52 (2.3%) stddev-sans-first:1.62 07:00:46 INFO - PROCESS | 20622 | Values: 67.0 70.0 67.0 66.0 68.0 66.0 66.0 65.0 67.0 69.0 07:00:46 INFO - PROCESS | 20622 | -------- Summary: end -------- 07:00:46 INFO - PROCESS | 20622 | 07:00:47 INFO - TEST-INFO | 20622: exit 0 07:00:47 INFO - TEST-OK | kraken | took 63387ms 07:00:47 INFO - SUITE-END | took 1182s 07:00:48 INFO - Completed test suite (00:19:42) 07:00:48 INFO - javascript benchmark 07:00:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.2836134243753, 2666.9199924002287, 2686.7044625091235, 2696.7033626301104, 2706.0528814914783, 4627.282771170466, 4664.043871006444, 4696.859094227174, 4706.152892479352, 4738.905221895564, 4715.952840471594, 4717.764111794414, 4718.622510199184, 4754.7860346284415, 4772.832950846721, 4285.892852678677, 4340.045190058198, 4385.934210986838, 4394.956050439487, 4504.527024662412, 4414.404055452521, 4419.160359531678, 4438.644908407319, 4441.911161776762, 4457.643388528926, 4243.024104455962, 4284.721493102938, 4299.763513006784, 4325.891852703676, 4335.544767799367, 4283.057727299989, 4290.978545107255, 4303.505096913864, 4351.673624478177, 4351.9782401088105, 4318.244307246219, 4329.7618630975285, 4339.869803905888, 4375.7155784873885, 4384.16700826845, 4577.313402989578, 4617.630589552828, 4620.445546534404, 4673.088747694201, 4684.8360307389075, 5108.795648174106, 5128.589712822965, 5132.974335128338, 5135.075686376451, 5135.871603209912, 5119.078565858144, 5143.7685304161405, 5155.9484405155845, 5162.096633089194, 5165.173572228463, 4621.145088158702, 4733.313669517935, 4792.113459010095, 4796.688215265996, 4851.927221091686, 5253.343332083489, 5316.973415132899, 5323.22813192085, 5328.733563321896, 5334.146536554133, 4914.65597408178, 4955.132851750929, 4956.033573453215, 4960.032793605213, 4966.652334336634, 4965.602751779849, 5028.195488721787, 5037.168867136955, 5075.593952483792, 5076.847694569169, 5047.621428392885, 5054.873628159326, 5055.266986286968, 5055.772490237948, 5107.463716309734, 5035.093683136997, 5038.445770965191, 5039.0, 5043.646944713835, 5045.974770126126, 4235.110626768352, 4260.062786187033, 4267.957320426756, 4293.141371725667, 4322.308430651144, 3788.1476667749534, 3790.3935370340614, 3795.772253664789, 3834.328992426314, 3846.2692088503654, 4399.912001759947, 4408.294672852328, 4411.18393097278, 4460.77696115193, 4461.5092339842595, 4932.260160975882, 5042.09242336383, 5080.491950804964, 5140.742962851842, 5149.201873709581, 4385.693001489865, 4399.780010999437, 4405.735655860659, 4425.557444255549, 4447.666425018137, 4576.199165146153, 4599.793009314589, 4607.792649330788, 4611.377464042378, 4656.650751193606, 4720.079584481062, 4765.95234047669, 4806.158922188603, 4827.324174615486, 4832.95167048325, 5069.949300506948, 5082.949170508396, 5089.1094058538865, 5092.261622064706, 5135.024345374367, 4762.78567464458, 4770.0936822003705, 4771.0, 4778.259369797687, 4818.975905120452, 4837.975810120927, 4876.171050921281, 4947.0, 4973.328600638867, 4987.2020476725, 5013.974930125472, 5039.974800125976, 5074.5432911036705, 5077.339945807022, 5115.64190506661, 4787.976060119817, 4865.294532292868, 4865.416150062015, 4872.756362181947, 4920.950790492049, 4873.415190177201, 4909.0, 4925.039617274597, 4931.6301277405055, 4941.135301322326, 4877.9024419512125, 4891.6430277136715, 4918.901621967612, 4928.0390323886495, 4940.530649588283, 4861.927071094007, 4920.2619607057795, 4980.103581355391, 5018.824341148043, 5027.095122877917, 4734.573888350065, 4779.402574678165, 4855.75721213945, 4876.951230487792, 4904.019196160853], "value": 4657.472716662627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.959946302294, 590.3211306996953, 593.9406059394058, 594.9286085669718, 608.6956521739129, 27169.864150679245, 40405.59594404055, 41149.588504114916, 41278.174436511326, 41300.58699413005, 41384.58615413845, 41786.79106604463, 41824.16351672965, 41858.16283674325, 41974.0, 7412.0, 7798.142204357516, 7988.7203947861835, 7996.600169991506, 10004.349717268391, 9980.800383992315, 10164.186865050779, 10166.796664066715, 10185.185185185168, 10192.235582331317, 10170.44062576558, 10233.130183934374, 10238.283320167591, 10243.334183278062, 10247.436390998491, 7508.9487471754, 7674.693012279502, 7731.22687731228, 10111.292209545334, 10149.238807089461, 9931.50342482873, 10029.648962286357, 10258.589656413735, 10266.589336426534, 10270.845937310947, 39235.60764392348, 39716.801415993024, 39793.80103099466, 39835.60164398348, 39907.20185596272, 2960.866760995739, 3040.1639549123947, 3084.90745277642, 3112.128603990886, 3472.2534655049285, 29991.400171996436, 30062.398752025056, 30450.0, 30728.692713072807, 32217.0, 3508.8070156141403, 3520.7887526748477, 3582.247727977128, 3588.4617307403837, 3640.8179591020344, 259060.0, 260832.0, 260990.0, 261948.0, 263120.9999999981, 57947.420525795045, 58900.41099588949, 59392.0, 59396.40603593995, 59490.40509594849, 34786.30427391438, 61560.69219653873, 62251.377486225465, 62338.68830655818, 62354.37645623486, 12078.094142939315, 12880.0, 12886.677833054062, 12892.226466412045, 12903.54837580699, 8986.236169925498, 9479.383840050512, 9837.852432213522, 9857.408555486694, 10101.0, 19386.586979468797, 19512.0, 19535.0, 19751.111199996034, 19774.60450790976, 7372.0, 7702.499337543042, 7710.498817576839, 7735.535867847834, 7831.373490120776, 736.8415790605046, 802.9237222463856, 1008.1481148429565, 1047.3454091193005, 1062.1025233677685, 27755.722442775314, 28468.715312846605, 28524.006639070547, 28637.713622863506, 28931.56602650962, 888.6623083228332, 922.5848368234322, 938.648006997376, 947.7772723409993, 974.084360700953, 14724.77912831287, 15155.696886062216, 15211.543653690407, 15258.389664413522, 15329.233538323038, 395503.0, 397972.0, 403245.0, 404853.0, 406117.0, 49597.50402496001, 50232.497675023515, 50252.24621630678, 50331.49668503342, 50396.49603503991, 1092.3118435385657, 1167.1129941244715, 1195.9820602690793, 1221.5907670930337, 1234.2594443334108, 28237.294067648472, 29538.0, 29538.0, 29601.259968500097, 30029.699703003564, 41529.58470415257, 41598.792006039774, 42128.1574368517, 42136.57863421326, 42152.78923605362, 282734.0, 284896.0, 285919.0, 286295.0, 286634.0, 22991.65512517347, 25234.0, 25956.61065084063, 25972.35069123287, 27433.177004689893, 40883.0, 41061.1787764249, 41519.792401037805, 42034.579654203066, 42218.57781422146, 36293.27413451769, 36349.45475817918, 36683.63316366802, 37123.25753484969, 37313.626863732105, 35472.0, 36187.27625447529, 36228.63771362253, 36340.0, 36443.08892277714, 35295.11762205965, 36073.63926360808, 36655.633443665225, 36667.0, 36739.08152296214, 30096.548551771302, 34187.65812341845, 34226.315473690884, 34358.65641343554, 34390.31219375548, 25196.24411267665, 25348.873255633604, 25747.485050298514, 25907.740922590532, 26368.20895373142], "value": 18161.912546764066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.72053239537945, 373.9831707573159, 374.75207558829095, 393.70275442041253, 395.3595175815178, 15817.920910395445, 16391.50825475236, 17196.96818190908, 17199.398021069264, 17206.225719842605, 13272.0, 14005.159690418583, 14646.560603181895, 14648.926755366236, 15002.924985375084, 4703.129920964615, 4854.271859221128, 4898.951010489903, 4900.828471003516, 4905.362302900618, 3471.444568868969, 5246.265522826808, 5496.890062198753, 5507.5593952483905, 5618.353889302742, 5466.863328416782, 5597.6641401515835, 5611.046122159243, 5627.465390787868, 5644.209810626516, 6059.6364218147055, 6096.207493025922, 6134.4478996890275, 6147.2008638877105, 6155.692215389235, 3428.5371474850826, 5150.201718733565, 5404.621676482648, 5444.3194600674915, 5539.667619942776, 12512.937435312857, 12525.812112818316, 12547.0, 18130.093495325313, 19170.137343819562, 1752.0626464841375, 1778.395345582495, 1811.3841293960118, 1839.0988415676222, 2287.096596844254, 9121.407108537924, 9446.622135114587, 9505.04949505044, 11156.497957591928, 13338.19970801755, 1622.691688579178, 1647.8105017922971, 1648.4889684197938, 1700.1159397113431, 1787.436957358428, 66776.66611666958, 68757.3124268756, 70068.0, 70469.29530704679, 70671.0, 9449.59035445957, 9575.0, 9674.371165874196, 9783.168430683472, 9798.46108464027, 13233.867661323457, 13389.66525836862, 13424.060315777802, 13426.328683565978, 13435.395407206699, 6520.054592084121, 6544.345565443417, 6602.768903088465, 6668.0, 6726.0, 6171.259448866164, 6193.566450348432, 6281.403266689657, 6370.681465926685, 6381.649009304533, 4009.67922566194, 4102.220578090153, 4135.338345864708, 4176.749395036308, 4187.644050255702, 1558.2598265823642, 1645.8025036995637, 1721.9827801722072, 1724.741288806689, 1747.6242607839376, 817.6647574494428, 822.2106777493553, 895.2390468102061, 949.9525023748785, 964.8890377606525, 15793.68412631764, 15937.601559961095, 15967.680646387007, 16304.266308016167, 16517.174141292886, 777.1257335497565, 802.4142376065505, 810.6838333050115, 822.43663090783, 861.1818772166467, 8946.50794206312, 9113.270938324918, 9467.66863159786, 9845.950770246103, 10042.799144017079, 375072.0, 378951.0, 389593.0, 391416.0, 391887.0, 75571.62214189004, 78307.21692783, 78935.60532197302, 79076.0, 79653.0, 963.3689933093975, 970.708787363788, 992.3999122299621, 1024.1960061351804, 1027.6249169053392, 15167.241637918281, 15345.0, 15346.386144554093, 15601.297941592882, 15694.450694225647, 34492.65507344995, 34911.301773964886, 35094.649053509136, 35464.75873344524, 35981.0, 48896.51103489062, 49362.75318623528, 49581.752091239316, 49945.75027124841, 50251.49748502468, 6577.112089867806, 6914.239433662193, 7133.643317834191, 7283.562986220843, 7369.042024536776, 10362.585496580052, 11658.825117623412, 11719.707007324543, 11873.703157421134, 11884.864442464657, 9420.340576159877, 9527.57125929321, 9545.90454095478, 9700.708978730649, 9819.705408837746, 8316.251537361666, 9616.278779091735, 9787.706368808947, 10052.64815731446, 10182.0, 9103.317251206054, 9369.953150234205, 9514.19129374011, 9718.9028109718, 9738.415695058318, 7075.257098004636, 7191.640417979184, 7208.783736487913, 7228.855422891618, 7395.038644976119, 7818.765437036898, 9337.253019758538, 9429.52852357393, 9447.338686291894, 9688.0], "value": 7903.293733499464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.5468354050774, 1405.8664426879445, 1451.9564413067608, 1548.5818828916192, 1760.331074191807, 6773.390394864461, 7419.629018549072, 7656.617169141548, 7675.731349402772, 7887.5267483951, 7690.807729806757, 7848.215178482149, 7851.411144164196, 7855.567943763105, 7859.764207073783, 1884.3687364732762, 1925.0278609302352, 1926.9132889020027, 2203.1958335207655, 2233.8436309458343, 1960.8529360297964, 2144.3888491779844, 2187.814035806958, 2193.9451513712124, 2208.072609504004, 2150.7419109706857, 2166.631672615659, 2175.9347219583437, 2179.3788770200495, 2179.662152366378, 1829.2134382215643, 2163.8485306028583, 2169.5227050048966, 2169.7287839020123, 2173.652215645505, 2139.679048142791, 2217.013429024085, 2221.1559607349263, 2222.9666555001686, 2224.7552769195377, 7497.287757663068, 7557.319841214262, 7793.103793063757, 7796.0, 7803.7268695595385, 4657.510961349078, 4812.230043193107, 4814.398200224972, 4823.252395878644, 4823.276508523714, 2903.11455006223, 2994.3861508390946, 3058.29659178388, 3060.556219348204, 3073.400686866062, 892.085612247445, 917.2845180759018, 942.4816351006988, 942.6559305853314, 956.3687965942514, 10350.482475876252, 10503.947480262626, 10546.736331591695, 10577.418241996687, 10582.682519524427, 4237.745735255833, 4332.480102387671, 4360.476742790822, 4404.471463424409, 4406.911861762746, 8984.46093234408, 9031.142041506046, 9034.909650903539, 9036.096390361043, 9040.367174297737, 4642.094791515689, 4647.674662773641, 4653.837115700934, 4654.604358629486, 4654.720716757005, 3673.779573225615, 4076.2255171517318, 4254.361845723166, 4366.803493842721, 4371.912561748811, 3621.5292012038267, 3666.7433279670167, 3696.390095634244, 3718.2563487302646, 3752.399616061417, 1182.6629410617932, 1183.207251141737, 1186.1400484648734, 1194.8625908020515, 1213.8179273109104, 745.683084689005, 808.4058217210346, 810.8864758933754, 823.3701218567801, 836.7991681996399, 5067.746612669352, 5343.305370301913, 5343.839684809462, 5448.782048718007, 5468.835934921959, 854.5769843927296, 896.9461832289953, 914.9588268527799, 964.4020707161465, 1007.2043085962155, 3379.4086034943784, 3598.3882739934274, 3606.2246616977477, 3661.139632186434, 3693.3905905525826, 9536.618535258513, 9567.091126342986, 9657.179139773058, 9834.164096051916, 9851.064148905842, 9679.951600241953, 9725.0, 9766.07222313879, 9766.07222313879, 9776.853347199798, 7013.473989450914, 7315.817104572428, 7412.0364352633815, 7445.478816482794, 7451.3293803557945, 5327.573794096385, 5363.436839131991, 5366.919496207638, 5406.4052954175795, 5426.131818908955, 8562.272206862486, 8849.159329863653, 9099.0, 9100.408473449204, 9106.95446522763, 9038.457692538468, 9172.633094676139, 9195.126462986273, 9266.721998340061, 9276.16514513697, 6215.0, 6460.289368169404, 6580.144581204413, 6581.078648989241, 6647.468202543688, 7629.6566654499575, 7647.158812530506, 7670.693172273047, 7691.50005249657, 7707.576083315472, 6713.093732346071, 6734.09089772894, 6774.93225067743, 6889.931100688929, 6997.05539752127, 6689.364510371507, 6696.933030669826, 6749.3588109131515, 6769.3907548320885, 6827.146606674166, 6377.489800816016, 6387.712552935222, 6447.6131432114225, 6458.192725909262, 6526.4452521536205, 4724.078804633064, 4756.476787553435, 4805.5915247204375, 4816.229403295456, 4854.63590230727, 4746.5490778376, 4790.0659371423635, 4830.686005409637, 4840.249761287007, 4853.538913803183], "value": 4166.473139201338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.6272473032361, 312.10581683476846, 317.9268768183318, 317.9968200317997, 319.06513914231294, 4768.809247630095, 4784.928226076611, 4790.832320868771, 4800.879978000557, 4833.540813622704, 4719.457262414815, 4748.287756836477, 4749.620030397568, 4757.238841785315, 4768.761561921899, 3547.7693949893173, 3678.70570354371, 3678.981605091971, 3768.9623103768886, 3815.3704638734575, 3715.461258117571, 3737.9813100934457, 3767.4537192107127, 3774.7735135891935, 3785.867494637688, 3546.592141903688, 3733.1973625670475, 3741.3452645787015, 3751.4185301278344, 3751.8311675974646, 3608.170120872201, 3738.4392341148773, 3749.418840079792, 3765.0, 3766.773993560395, 3313.2545177335146, 3319.767616266838, 3325.118843506473, 3329.284203896174, 3338.8163650999186, 4577.473590537097, 4591.4260717410325, 4611.01726257709, 4614.76926153691, 4624.1445332613575, 4133.648639865585, 4262.808173632194, 4268.378016353797, 4273.166732487166, 4282.314829627276, 4958.7024778513405, 4964.67729597575, 4967.627427942883, 4971.204607262856, 4977.776000080005, 3631.909202269964, 3634.672879440863, 3639.5996440391536, 3641.908952276188, 3643.981780091083, 4991.5258050485145, 5178.818741344073, 5201.5838732901275, 5220.451852555465, 5243.082460569385, 3668.3954392381174, 3686.3364594372733, 3696.5194524711615, 3712.7215458840697, 3720.3489389356755, 3767.434884767307, 3777.8488860445823, 3782.829772660182, 3787.867424640124, 3795.4306853972125, 4254.914901701949, 4265.3815196796295, 4269.1034882674985, 4273.786310684453, 4294.205571969195, 4658.906821863544, 4932.679375840559, 4946.802127914915, 4984.925226121611, 5002.049200811686, 1307.5488956310057, 1319.0502837956656, 1323.3251041968665, 1334.9599512014654, 1335.9398827052805, 854.9059603443616, 880.3749337969984, 902.9548522573976, 917.8714979902819, 920.6547544670749, 4390.890227744332, 4404.11917616478, 4410.5368936261875, 4410.904820210374, 4411.558844115562, 5025.698458092526, 5081.415637201769, 5093.923591146136, 5112.74436278192, 5115.232715092691, 4193.040724026811, 4364.54172311909, 4394.318880573516, 4406.955930440655, 4407.6914615976575, 2737.6167336572894, 2742.945141097167, 2751.7523422892036, 2754.986225068902, 2760.9723902760716, 4800.927986080212, 4829.0, 4855.611551075976, 4861.6596838220985, 4866.172750632401, 4975.878154778564, 5045.419776725724, 5103.2855400244, 5202.557782588522, 5214.191800270964, 4746.501617330199, 4754.0, 4756.9762151189025, 4766.6901651392545, 4803.495632958559, 5013.523715247045, 5027.195648696191, 5056.721880296472, 5057.46896575869, 5066.113430149783, 4850.417949846041, 4924.778384972757, 4937.802487900587, 4937.876553086202, 4959.305697202467, 4762.499937506512, 4766.285057241442, 4770.522947705202, 4775.140474714584, 4784.449788274393, 3755.962440375561, 3758.3047136279874, 3767.6985841132096, 3768.0, 3780.281746468162, 4895.363602731622, 5058.822941197041, 5137.152369859081, 5143.177091665316, 5151.072806894795, 4885.364902562644, 4913.852584422473, 4921.975390123026, 4928.644622728778, 4939.901201976012, 4882.36529251195, 4907.754612269301, 4925.704457732548, 4926.334944782552, 4943.011397720398, 4644.117617652635, 4881.829135980366, 4899.828506002415, 4900.534449227318, 4914.140025495595, 4816.0, 4866.537678920497, 5065.164247899055, 5074.792465277616, 5079.796808127633, 4881.463039065629, 4903.436104847988, 4911.901761964812, 4939.16034274167, 4960.355153829979], "value": 3777.079815073031, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3087620446269, 736.9410447164228, 750.4971668981782, 753.7927070055738, 753.939684825214, 13287.202767833925, 13693.520726774552, 13708.588742337746, 13728.72542549151, 13746.106503077293, 14323.570292891203, 14399.992000559965, 14417.134971901693, 14421.278936053208, 14485.855141448583, 629.9937000630003, 774.3147314626568, 801.0507548554966, 806.4395245304515, 810.8702607582788, 779.6140910249435, 813.8168911994813, 813.8738495533202, 814.3281792521165, 814.5560669435172, 842.692417267699, 847.3094428041157, 848.1687945813106, 848.9363297752662, 848.995755021224, 661.0909998751716, 817.9795505112361, 838.9664413423455, 839.546644811804, 840.2647683277132, 622.1662971618008, 622.7820262907991, 622.7820262907991, 622.919020527333, 623.1307326279859, 12203.267803931703, 12213.755724885541, 12228.449719762632, 12236.204646697935, 12241.387930603523, 11366.204365694404, 11624.94187529057, 11662.533498660043, 11717.941410292893, 11832.70418239551, 11006.119510439146, 11049.17131215154, 11086.390248536409, 11117.444127793578, 11134.16493762971, 3898.961010389888, 3918.9804050979847, 3925.411188321746, 4000.7799571023875, 4085.836566537335, 46429.30356044662, 46436.76781616104, 47646.0, 47662.28506572404, 47773.76113119482, 9656.179224765974, 9771.538810486389, 9856.45789481571, 9934.602615895428, 10254.28220024591, 16669.41657042022, 16707.911511061116, 16710.916445417693, 16752.0, 16752.24614892333, 6418.261899881573, 6472.061551075068, 6598.670066496656, 6684.699188536528, 6790.694418751168, 3606.441001644749, 3675.0996005978172, 3697.1681371691157, 3758.6805121564425, 3827.8086095695103, 2784.763295119897, 2875.6405449318836, 2877.92805179868, 2879.3665393613373, 2882.293838009701, 491.08167726351235, 513.2839688634334, 517.4204890522639, 534.6791924845062, 537.1057189779052, 534.2707204665603, 535.3950036458855, 561.3684604819578, 575.8445219790717, 577.1371799160282, 6845.0, 6935.757248496278, 7016.228214896358, 7141.928580714126, 7167.820804479826, 518.613632843534, 529.1110933631459, 538.284082170712, 556.1879655702719, 556.6520924422236, 3300.719438847677, 3431.3995050865997, 3441.6730410610953, 3444.2422667013216, 3469.1500582357485, 54628.45371546234, 55491.16763248554, 56825.0, 56933.29933554389, 57324.0, 48743.268850967266, 48818.511814882106, 49415.50584494181, 49587.25619115716, 51732.0, 46711.29933051007, 47760.52239477561, 47823.022122235416, 47869.0, 48301.275480867815, 7959.92040079615, 7969.1632378601735, 8137.6338064788415, 8238.340932725487, 8437.915620843958, 30857.845710771304, 31308.373832523677, 31467.370652587277, 32713.509297361034, 33324.0, 36906.8154659225, 40814.79592602137, 41612.0, 41748.0, 42517.0, 10621.840672389766, 10644.0, 10727.517261723086, 10756.139508839431, 10948.233623646587, 11269.830952535554, 11324.150688698546, 11547.249428787101, 12261.080418968791, 12321.199122057038, 10420.635277765545, 10660.84008739885, 10700.250982431155, 10712.678619641423, 10998.945005274922, 9923.156531694598, 10144.54349554257, 10375.68872933783, 10545.050945414643, 10739.677809665722, 9649.324547281623, 9920.950395247977, 9971.45157016371, 10121.69634910954, 10217.591296348062, 8602.18279263469, 8608.0, 8637.740867773977, 8823.911760882309, 9290.442573445614, 8660.653573856975, 8680.826383472422, 8720.345974051845, 8885.378023538291, 9095.49974751395], "value": 5946.374069311062, "unit": "score"}], "name": "dromaeo_css", "value": 6300.736194501341, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 131.0, 135.0, 182.0, 129.0, 132.0, 161.0, 138.0, 191.0, 130.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 163.0, 160.0, 161.0, 161.0, 163.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 120.0, 76.0, 77.0, 74.0, 76.0, 100.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 119.0, 85.0, 84.0, 84.0, 119.0, 84.0, 84.0, 125.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 99.0, 95.0, 95.0, 94.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 86.0, 87.0, 85.0, 86.0, 84.0, 85.0, 110.0, 85.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 130.0, 129.0, 144.0, 128.0, 130.0, 133.0, 141.0, 135.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 169.0, 171.0, 171.0, 167.0, 169.0, 168.0, 166.0, 166.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 66.0, 68.0, 66.0, 66.0, 65.0, 67.0, 69.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1547.9999999999998, "alertThreshold": 2.0}]} 07:00:48 INFO - Return code: 0 07:00:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:00:48 ERROR - # TBPL SUCCESS # 07:00:48 INFO - Running post-action listener: _resource_record_post_action 07:00:48 INFO - ##### 07:00:48 INFO - ##### Finished run-tests step (success) 07:00:48 INFO - ##### 07:00:48 INFO - Running post-run listener: _resource_record_post_run 07:00:48 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 414969856; Read time: 0; Write time: 234476 07:00:48 INFO - TinderboxPrint: CPU usage
13.1% 07:00:48 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:00:48 INFO - TinderboxPrint: I/O write bytes / time
414,969,856 / 234,476 07:00:48 INFO - TinderboxPrint: CPU idle
8,318.8 (86.9%) 07:00:48 INFO - TinderboxPrint: CPU user
1,210.8 (12.7%) 07:00:48 INFO - TinderboxPrint: Swap in / out
0 / 0 07:00:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105373696; Read time: 0; Write time: 55072 07:00:48 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284565504; Read time: 0; Write time: 146464 07:00:48 INFO - Running post-run listener: _upload_blobber_files 07:00:48 INFO - Blob upload gear active. 07:00:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:00:48 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 07:00:48 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'] 07:00:48 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 07:00:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:49 INFO - (blobuploader) - INFO - Done attempting. 07:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:53 INFO - (blobuploader) - INFO - Done attempting. 07:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:54 INFO - (blobuploader) - INFO - Done attempting. 07:00:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:00:54 INFO - Return code: 0 07:00:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:00:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:00:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a142cb8a68ceb2e159c2aa8955d77af42fb6303c33557f1ac767ffcd4701be034ea467fa43ffef037772f781798b40307c1b612e463d03a1f8233c7b762f3f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cf2e44c2b714503d01d0a4545a0ea7f4d010a8d555f1083be905f08bbdf4403448ef7567f58c1df8b5f15f6553c1618429344153de7a51cabc629c25c8b3ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30d09d875d3e4ba5482499b9cfcb771c53b018aa663d1a8a48563238f289734b87dd33bac662938166dddffbb476ab76f15c450a40de69fe8d389a7c1cefd3d"} 07:00:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:00:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:00:54 INFO - Contents: 07:00:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a142cb8a68ceb2e159c2aa8955d77af42fb6303c33557f1ac767ffcd4701be034ea467fa43ffef037772f781798b40307c1b612e463d03a1f8233c7b762f3f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cf2e44c2b714503d01d0a4545a0ea7f4d010a8d555f1083be905f08bbdf4403448ef7567f58c1df8b5f15f6553c1618429344153de7a51cabc629c25c8b3ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30d09d875d3e4ba5482499b9cfcb771c53b018aa663d1a8a48563238f289734b87dd33bac662938166dddffbb476ab76f15c450a40de69fe8d389a7c1cefd3d"} 07:00:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:00:54 INFO - Copying logs to upload dir... 07:00:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:00:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.670514 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-30 07:00:54.128817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 07:00:54.131917) ========= 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=00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178 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/a142cb8a68ceb2e159c2aa8955d77af42fb6303c33557f1ac767ffcd4701be034ea467fa43ffef037772f781798b40307c1b612e463d03a1f8233c7b762f3f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cf2e44c2b714503d01d0a4545a0ea7f4d010a8d555f1083be905f08bbdf4403448ef7567f58c1df8b5f15f6553c1618429344153de7a51cabc629c25c8b3ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30d09d875d3e4ba5482499b9cfcb771c53b018aa663d1a8a48563238f289734b87dd33bac662938166dddffbb476ab76f15c450a40de69fe8d389a7c1cefd3d"} build_url:https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/PSYgrs_KQ_mKPPFbVlaqrw/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/a142cb8a68ceb2e159c2aa8955d77af42fb6303c33557f1ac767ffcd4701be034ea467fa43ffef037772f781798b40307c1b612e463d03a1f8233c7b762f3f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cf2e44c2b714503d01d0a4545a0ea7f4d010a8d555f1083be905f08bbdf4403448ef7567f58c1df8b5f15f6553c1618429344153de7a51cabc629c25c8b3ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d30d09d875d3e4ba5482499b9cfcb771c53b018aa663d1a8a48563238f289734b87dd33bac662938166dddffbb476ab76f15c450a40de69fe8d389a7c1cefd3d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 07:00:54.158255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:00:54.158797) ========= 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=00204705a9daa57ed339a427000001b9-1464615601.461881-1251449178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:00:54.243075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 07:00:54.243653) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 07:00:54.244192) ========= ========= Total master_lag: 0.19 =========