builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1464706486.9 results: success (0) buildid: 20160531053004 builduid: ca5d78058aac4173aab7f23709994b6f revision: 8bf67bdad00282eed87c14a08c166a0ca90bf621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:46.897570) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:46.898051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:46.898335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:46.913839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:46.914223) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 07:54:47-- 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% 16.7M=0.001s 2016-05-31 07:54:47 (16.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094155 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.022284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.022621) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017841 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.073184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.073639) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8bf67bdad00282eed87c14a08c166a0ca90bf621 --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 8bf67bdad00282eed87c14a08c166a0ca90bf621 --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=a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 07:54:47,907 truncating revision to first 12 chars 2016-05-31 07:54:47,907 Setting DEBUG logging. 2016-05-31 07:54:47,908 attempt 1/10 2016-05-31 07:54:47,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8bf67bdad002?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 07:54:48,266 unpacking tar archive at: fx-team-8bf67bdad002/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.785612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.786040) ========= script_repo_revision: 8bf67bdad00282eed87c14a08c166a0ca90bf621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.786595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.786871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 07:54:47.795850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-31 07:54:47.796211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:54:48 INFO - MultiFileLogger online at 20160531 07:54:48 in /builds/slave/test 07:54:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:54:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:48 INFO - {'append_to_log': False, 07:54:48 INFO - 'base_work_dir': '/builds/slave/test', 07:54:48 INFO - 'blob_upload_branch': 'Fx-Team', 07:54:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:48 INFO - 'branch': 'Fx-Team', 07:54:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:48 INFO - 'config_files': ('talos/linux_config.py',), 07:54:48 INFO - 'default_actions': ('clobber', 07:54:48 INFO - 'read-buildbot-config', 07:54:48 INFO - 'download-and-extract', 07:54:48 INFO - 'populate-webroot', 07:54:48 INFO - 'create-virtualenv', 07:54:48 INFO - 'install', 07:54:48 INFO - 'run-tests'), 07:54:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:48 INFO - 'download_minidump_stackwalk': True, 07:54:48 INFO - 'download_symbols': 'ondemand', 07:54:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:48 INFO - 'installer_path': 'installer.exe', 07:54:48 INFO - 'log_level': 'info', 07:54:48 INFO - 'log_name': 'talos', 07:54:48 INFO - 'log_to_console': True, 07:54:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:54:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:54:48 INFO - 'opt_config_files': (), 07:54:48 INFO - 'pip_index': False, 07:54:48 INFO - 'sps_profile': False, 07:54:48 INFO - 'sps_profile_interval': 0, 07:54:48 INFO - 'suite': 'dromaeojs-e10s', 07:54:48 INFO - 'system_bits': '32', 07:54:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:48 INFO - 'title': 'talos-linux64-ix-064', 07:54:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:48 INFO - 'use_talos_json': True, 07:54:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:48 INFO - 'work_dir': 'build'} 07:54:48 INFO - ##### 07:54:48 INFO - ##### Running clobber step. 07:54:48 INFO - ##### 07:54:48 INFO - Running pre-action listener: _resource_record_pre_action 07:54:48 INFO - Running main action method: clobber 07:54:48 INFO - rmtree: /builds/slave/test/build 07:54:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:49 INFO - Running post-action listener: _resource_record_post_action 07:54:49 INFO - ##### 07:54:49 INFO - ##### Finished clobber step (success) 07:54:49 INFO - ##### 07:54:49 INFO - ##### 07:54:49 INFO - ##### Running read-buildbot-config step. 07:54:49 INFO - ##### 07:54:49 INFO - Running pre-action listener: _resource_record_pre_action 07:54:49 INFO - Running main action method: read_buildbot_config 07:54:49 INFO - Using buildbot properties: 07:54:49 INFO - { 07:54:49 INFO - "project": "", 07:54:49 INFO - "product": "firefox", 07:54:49 INFO - "script_repo_revision": "production", 07:54:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:54:49 INFO - "repository": "", 07:54:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:54:49 INFO - "buildid": "20160531053004", 07:54:49 INFO - "pgo_build": "True", 07:54:49 INFO - "basedir": "/builds/slave/test", 07:54:49 INFO - "buildnumber": 400, 07:54:49 INFO - "slavename": "talos-linux64-ix-064", 07:54:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:54:49 INFO - "platform": "ubuntu64_hw", 07:54:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:54:49 INFO - "branch": "fx-team", 07:54:49 INFO - "repo_path": "integration/fx-team", 07:54:49 INFO - "revision": "8bf67bdad00282eed87c14a08c166a0ca90bf621", 07:54:49 INFO - "stage_platform": "linux64-pgo", 07:54:49 INFO - "builduid": "ca5d78058aac4173aab7f23709994b6f", 07:54:49 INFO - "slavebuilddir": "test" 07:54:49 INFO - } 07:54:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:54:49 INFO - Running post-action listener: _resource_record_post_action 07:54:49 INFO - ##### 07:54:49 INFO - ##### Finished read-buildbot-config step (success) 07:54:49 INFO - ##### 07:54:49 INFO - ##### 07:54:49 INFO - ##### Running download-and-extract step. 07:54:49 INFO - ##### 07:54:49 INFO - Running pre-action listener: _resource_record_pre_action 07:54:49 INFO - Running main action method: download_and_extract 07:54:49 INFO - mkdir: /builds/slave/test/build/tests 07:54:49 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')]} 07:54:49 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:49 INFO - Downloaded 1361 bytes. 07:54:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:54:49 INFO - Using the following test package requirements: 07:54:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:54:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:54:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'jsshell-linux-x86_64.zip'], 07:54:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:54:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:54:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:54:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:54:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:54:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:54:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:54:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:54:49 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')]} 07:54:49 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:51 INFO - Downloaded 24410458 bytes. 07:54:51 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'] 07:54:51 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 07:54:52 INFO - Return code: 0 07:54:52 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 07:54:52 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')]} 07:54:52 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:54:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:54:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:54 INFO - Downloaded 24410458 bytes. 07:54:54 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'] 07:54:54 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 07:54:55 INFO - Return code: 0 07:54:55 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')]} 07:54:55 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:54:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:54:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:57 INFO - Downloaded 10834055 bytes. 07:54:57 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'] 07:54:57 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 07:54:57 INFO - Return code: 0 07:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:57 INFO - https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:54:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eId2XjGXQoyWU20DDBreZg/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 07:54:59 INFO - Downloaded 58938764 bytes. 07:54:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:59 INFO - mkdir: /builds/slave/test/properties 07:54:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:59 INFO - Contents: 07:54:59 INFO - build_url:https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:54:59 INFO - Running post-action listener: _resource_record_post_action 07:54:59 INFO - Running post-action listener: set_extra_try_arguments 07:54:59 INFO - ##### 07:54:59 INFO - ##### Finished download-and-extract step (success) 07:54:59 INFO - ##### 07:54:59 INFO - ##### 07:54:59 INFO - ##### Running populate-webroot step. 07:54:59 INFO - ##### 07:54:59 INFO - Running pre-action listener: _resource_record_pre_action 07:54:59 INFO - Running main action method: populate_webroot 07:54:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:59 INFO - '--tppagecycles', 07:54:59 INFO - '7'], 07:54:59 INFO - 'tests': ['tsvgm']}}, 07:54:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['damp', 'tps']}, 07:54:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'tests': ['damp', 'tps']}, 07:54:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['dromaeo_dom']}, 07:54:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['a11yr', 07:54:59 INFO - 'ts_paint', 07:54:59 INFO - 'tpaint', 07:54:59 INFO - 'sessionrestore', 07:54:59 INFO - 'sessionrestore_no_auto_restore', 07:54:59 INFO - 'tabpaint']}, 07:54:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:59 INFO - 'ts_paint', 07:54:59 INFO - 'tpaint', 07:54:59 INFO - 'sessionrestore', 07:54:59 INFO - 'sessionrestore_no_auto_restore', 07:54:59 INFO - 'tabpaint']}, 07:54:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:59 INFO - 'ts_paint', 07:54:59 INFO - 'tpaint', 07:54:59 INFO - 'sessionrestore', 07:54:59 INFO - 'sessionrestore_no_auto_restore', 07:54:59 INFO - 'tabpaint']}, 07:54:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:59 INFO - 'ts_paint', 07:54:59 INFO - 'tpaint', 07:54:59 INFO - 'sessionrestore', 07:54:59 INFO - 'sessionrestore_no_auto_restore', 07:54:59 INFO - 'tabpaint']}, 07:54:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['a11yr', 07:54:59 INFO - 'ts_paint', 07:54:59 INFO - 'tpaint', 07:54:59 INFO - 'sessionrestore', 07:54:59 INFO - 'sessionrestore_no_auto_restore', 07:54:59 INFO - 'tabpaint']}, 07:54:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['a11yr', 07:54:59 INFO - 'ts_paint', 07:54:59 INFO - 'tpaint', 07:54:59 INFO - 'sessionrestore', 07:54:59 INFO - 'sessionrestore_no_auto_restore', 07:54:59 INFO - 'tabpaint']}, 07:54:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['tsvgx', 07:54:59 INFO - 'tsvgr_opacity', 07:54:59 INFO - 'tart', 07:54:59 INFO - 'tscrollx', 07:54:59 INFO - 'cart']}, 07:54:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:59 INFO - 'tsvgr_opacity', 07:54:59 INFO - 'tart', 07:54:59 INFO - 'tscrollx', 07:54:59 INFO - 'cart']}, 07:54:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'talos_options': ['--disable-e10s'], 07:54:59 INFO - 'tests': ['tp5o']}, 07:54:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'tests': ['tp5o']}, 07:54:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'talos_options': ['--disable-e10s', 07:54:59 INFO - '--xperf_path', 07:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:59 INFO - 'tests': ['tp5n']}, 07:54:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:54:59 INFO - 'talos_options': ['--xperf_path', 07:54:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:59 INFO - 'tests': ['tp5n']}}, 07:54:59 INFO - 'talos.zip': {'path': '', 07:54:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:59 INFO - Running post-action listener: _resource_record_post_action 07:54:59 INFO - ##### 07:54:59 INFO - ##### Finished populate-webroot step (success) 07:54:59 INFO - ##### 07:54:59 INFO - ##### 07:54:59 INFO - ##### Running create-virtualenv step. 07:54:59 INFO - ##### 07:54:59 INFO - Running pre-action listener: _resource_record_pre_action 07:54:59 INFO - Running main action method: create_virtualenv 07:54:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:59 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 07:54:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:59 INFO - Using real prefix '/usr' 07:54:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:55:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:02 INFO - Installing pip.................done. 07:55:02 INFO - Return code: 0 07:55:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:02 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:02 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 07:55:02 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 07:55:02 INFO - Using env: {'DISPLAY': ':0', 07:55:02 INFO - 'HOME': '/home/cltbld', 07:55:02 INFO - 'LANG': 'en_US.UTF-8', 07:55:02 INFO - 'LANGUAGE': 'en_US:en', 07:55:02 INFO - 'LOGNAME': 'cltbld', 07:55:02 INFO - 'MAIL': '/var/mail/cltbld', 07:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:02 INFO - 'MOZ_NO_REMOTE': '1', 07:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:02 INFO - 'NO_EM_RESTART': '1', 07:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:02 INFO - 'PWD': '/builds/slave/test', 07:55:02 INFO - 'SHELL': '/bin/bash', 07:55:02 INFO - 'SHLVL': '1', 07:55:02 INFO - 'TERM': 'linux', 07:55:02 INFO - 'TMOUT': '86400', 07:55:02 INFO - 'USER': 'cltbld', 07:55:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:02 INFO - '_': '/tools/buildbot/bin/python'} 07:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:02 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 07:55:02 INFO - Cleaning up... 07:55:02 INFO - Return code: 0 07:55:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:02 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:02 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 07:55:02 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 07:55:02 INFO - Using env: {'DISPLAY': ':0', 07:55:02 INFO - 'HOME': '/home/cltbld', 07:55:02 INFO - 'LANG': 'en_US.UTF-8', 07:55:02 INFO - 'LANGUAGE': 'en_US:en', 07:55:02 INFO - 'LOGNAME': 'cltbld', 07:55:02 INFO - 'MAIL': '/var/mail/cltbld', 07:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:02 INFO - 'MOZ_NO_REMOTE': '1', 07:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:02 INFO - 'NO_EM_RESTART': '1', 07:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:02 INFO - 'PWD': '/builds/slave/test', 07:55:02 INFO - 'SHELL': '/bin/bash', 07:55:02 INFO - 'SHLVL': '1', 07:55:02 INFO - 'TERM': 'linux', 07:55:02 INFO - 'TMOUT': '86400', 07:55:02 INFO - 'USER': 'cltbld', 07:55:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:02 INFO - '_': '/tools/buildbot/bin/python'} 07:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:02 INFO - Downloading/unpacking psutil>=3.1.1 07:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:04 INFO - Installing collected packages: psutil 07:55:04 INFO - Running setup.py install for psutil 07:55:04 INFO - building 'psutil._psutil_linux' extension 07:55:04 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 07:55:05 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 07:55:05 INFO - building 'psutil._psutil_posix' extension 07:55:05 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 07:55:05 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 07:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:05 INFO - Successfully installed psutil 07:55:05 INFO - Cleaning up... 07:55:05 INFO - Return code: 0 07:55:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:55:05 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')]} 07:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:05 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')]} 07:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:05 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:05 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 07:55:05 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 07:55:05 INFO - Using env: {'DISPLAY': ':0', 07:55:05 INFO - 'HOME': '/home/cltbld', 07:55:05 INFO - 'LANG': 'en_US.UTF-8', 07:55:05 INFO - 'LANGUAGE': 'en_US:en', 07:55:05 INFO - 'LOGNAME': 'cltbld', 07:55:05 INFO - 'MAIL': '/var/mail/cltbld', 07:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:05 INFO - 'MOZ_NO_REMOTE': '1', 07:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:05 INFO - 'NO_EM_RESTART': '1', 07:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:05 INFO - 'PWD': '/builds/slave/test', 07:55:05 INFO - 'SHELL': '/bin/bash', 07:55:05 INFO - 'SHLVL': '1', 07:55:05 INFO - 'TERM': 'linux', 07:55:05 INFO - 'TMOUT': '86400', 07:55:05 INFO - 'USER': 'cltbld', 07:55:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:05 INFO - '_': '/tools/buildbot/bin/python'} 07:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:55:05 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 07:55:05 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 07:55:05 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 07:55:05 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 07:55:05 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 07:55:05 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 07:55:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:55:07 INFO - Installing collected packages: mozsystemmonitor 07:55:07 INFO - Running setup.py install for mozsystemmonitor 07:55:07 INFO - Successfully installed mozsystemmonitor 07:55:07 INFO - Cleaning up... 07:55:07 INFO - Return code: 0 07:55:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:55:07 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')]} 07:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:07 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')]} 07:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:07 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:07 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 07:55:07 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 07:55:07 INFO - Using env: {'DISPLAY': ':0', 07:55:07 INFO - 'HOME': '/home/cltbld', 07:55:07 INFO - 'LANG': 'en_US.UTF-8', 07:55:07 INFO - 'LANGUAGE': 'en_US:en', 07:55:07 INFO - 'LOGNAME': 'cltbld', 07:55:07 INFO - 'MAIL': '/var/mail/cltbld', 07:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:07 INFO - 'MOZ_NO_REMOTE': '1', 07:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:07 INFO - 'NO_EM_RESTART': '1', 07:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:07 INFO - 'PWD': '/builds/slave/test', 07:55:07 INFO - 'SHELL': '/bin/bash', 07:55:07 INFO - 'SHLVL': '1', 07:55:07 INFO - 'TERM': 'linux', 07:55:07 INFO - 'TMOUT': '86400', 07:55:07 INFO - 'USER': 'cltbld', 07:55:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:07 INFO - '_': '/tools/buildbot/bin/python'} 07:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:07 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 07:55:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:09 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 07:55:09 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 07:55:09 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 07:55:09 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 07:55:09 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 07:55:09 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 07:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:55:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 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 07:55:10 INFO - Downloading docopt-0.6.1.tar.gz 07:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:10 INFO - Running setup.py install for blobuploader 07:55:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:55:10 INFO - Running setup.py install for requests 07:55:11 INFO - Running setup.py install for docopt 07:55:11 INFO - Successfully installed blobuploader requests docopt 07:55:11 INFO - Cleaning up... 07:55:11 INFO - Return code: 0 07:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:11 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:11 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 07:55:11 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 07:55:11 INFO - Using env: {'DISPLAY': ':0', 07:55:11 INFO - 'HOME': '/home/cltbld', 07:55:11 INFO - 'LANG': 'en_US.UTF-8', 07:55:11 INFO - 'LANGUAGE': 'en_US:en', 07:55:11 INFO - 'LOGNAME': 'cltbld', 07:55:11 INFO - 'MAIL': '/var/mail/cltbld', 07:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:11 INFO - 'MOZ_NO_REMOTE': '1', 07:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:11 INFO - 'NO_EM_RESTART': '1', 07:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:11 INFO - 'PWD': '/builds/slave/test', 07:55:11 INFO - 'SHELL': '/bin/bash', 07:55:11 INFO - 'SHLVL': '1', 07:55:11 INFO - 'TERM': 'linux', 07:55:11 INFO - 'TMOUT': '86400', 07:55:11 INFO - 'USER': 'cltbld', 07:55:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:11 INFO - '_': '/tools/buildbot/bin/python'} 07:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:11 INFO - Running setup.py (path:/tmp/pip-n9Mbok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:11 INFO - Running setup.py (path:/tmp/pip-kP4HaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:11 INFO - Running setup.py (path:/tmp/pip-dKyuGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:11 INFO - Running setup.py (path:/tmp/pip-3CiVAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:11 INFO - Running setup.py (path:/tmp/pip-P_I0mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:11 INFO - Running setup.py (path:/tmp/pip-ixIR21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:11 INFO - Running setup.py (path:/tmp/pip-FUSr5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:12 INFO - Running setup.py (path:/tmp/pip-hDV0lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:12 INFO - Running setup.py (path:/tmp/pip-OcvHW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:12 INFO - Running setup.py (path:/tmp/pip-UMLyxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:12 INFO - Running setup.py (path:/tmp/pip-W_uCZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:12 INFO - Running setup.py (path:/tmp/pip-5vAGGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:12 INFO - Running setup.py (path:/tmp/pip-kNc_Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:12 INFO - Running setup.py (path:/tmp/pip-lkijDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:12 INFO - Running setup.py (path:/tmp/pip-wh50UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:12 INFO - Running setup.py (path:/tmp/pip-RqFMtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:12 INFO - Running setup.py (path:/tmp/pip-gYUHtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:12 INFO - Running setup.py install for manifestparser 07:55:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:55:12 INFO - Running setup.py install for mozcrash 07:55:12 INFO - Running setup.py install for mozdebug 07:55:13 INFO - Running setup.py install for mozdevice 07:55:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Running setup.py install for mozfile 07:55:13 INFO - Running setup.py install for mozhttpd 07:55:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Running setup.py install for mozinfo 07:55:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Running setup.py install for mozInstall 07:55:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Running setup.py install for mozleak 07:55:13 INFO - Running setup.py install for mozlog 07:55:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Running setup.py install for moznetwork 07:55:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:55:13 INFO - Running setup.py install for mozprocess 07:55:13 INFO - Running setup.py install for mozprofile 07:55:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Running setup.py install for mozrunner 07:55:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Running setup.py install for mozscreenshot 07:55:14 INFO - Running setup.py install for moztest 07:55:14 INFO - Running setup.py install for mozversion 07:55:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:55:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:55:14 INFO - Cleaning up... 07:55:14 INFO - Return code: 0 07:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:14 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')]} 07:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:14 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')]} 07:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:14 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:14 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 07:55:14 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 07:55:14 INFO - Using env: {'DISPLAY': ':0', 07:55:14 INFO - 'HOME': '/home/cltbld', 07:55:14 INFO - 'LANG': 'en_US.UTF-8', 07:55:14 INFO - 'LANGUAGE': 'en_US:en', 07:55:14 INFO - 'LOGNAME': 'cltbld', 07:55:14 INFO - 'MAIL': '/var/mail/cltbld', 07:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:14 INFO - 'MOZ_NO_REMOTE': '1', 07:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:14 INFO - 'NO_EM_RESTART': '1', 07:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:14 INFO - 'PWD': '/builds/slave/test', 07:55:14 INFO - 'SHELL': '/bin/bash', 07:55:14 INFO - 'SHLVL': '1', 07:55:14 INFO - 'TERM': 'linux', 07:55:14 INFO - 'TMOUT': '86400', 07:55:14 INFO - 'USER': 'cltbld', 07:55:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:14 INFO - '_': '/tools/buildbot/bin/python'} 07:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:14 INFO - Running setup.py (path:/tmp/pip-JFHoO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:14 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)) 07:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:14 INFO - Running setup.py (path:/tmp/pip-P4RCsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:14 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)) 07:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:14 INFO - Running setup.py (path:/tmp/pip-FnXvh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:14 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)) 07:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:14 INFO - Running setup.py (path:/tmp/pip-mhyAaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:15 INFO - Running setup.py (path:/tmp/pip-Q58QSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:15 INFO - Running setup.py (path:/tmp/pip-fY5rL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:15 INFO - Running setup.py (path:/tmp/pip-_vjtsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:15 INFO - Running setup.py (path:/tmp/pip-O2t5Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:15 INFO - Running setup.py (path:/tmp/pip-g5ND5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:15 INFO - Running setup.py (path:/tmp/pip-E6RjAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:15 INFO - Running setup.py (path:/tmp/pip-gwtzZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:15 INFO - Running setup.py (path:/tmp/pip-weoQ9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:15 INFO - Running setup.py (path:/tmp/pip-gskjsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:15 INFO - Running setup.py (path:/tmp/pip-7mFEho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:15 INFO - Running setup.py (path:/tmp/pip-pLFLOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:15 INFO - Running setup.py (path:/tmp/pip-Qi611n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:15 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)) 07:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:15 INFO - Running setup.py (path:/tmp/pip-ZC7xND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:15 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)) 07:55:15 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)) 07:55:15 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)) 07:55:15 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)) 07:55:15 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)) 07:55:15 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)) 07:55:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:55:16 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 07:55:16 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 07:55:16 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 07:55:16 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 07:55:16 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 07:55:16 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 07:55:17 INFO - Downloading blessings-1.6.tar.gz 07:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:55:17 INFO - Installing collected packages: blessings 07:55:17 INFO - Running setup.py install for blessings 07:55:18 INFO - Successfully installed blessings 07:55:18 INFO - Cleaning up... 07:55:18 INFO - Return code: 0 07:55:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:18 INFO - Reading from file tmpfile_stdout 07:55:18 INFO - Current package versions: 07:55:18 INFO - argparse == 1.2.1 07:55:18 INFO - blessings == 1.6 07:55:18 INFO - blobuploader == 1.2.4 07:55:18 INFO - docopt == 0.6.1 07:55:18 INFO - manifestparser == 1.1 07:55:18 INFO - mozInstall == 1.12 07:55:18 INFO - mozcrash == 0.17 07:55:18 INFO - mozdebug == 0.1 07:55:18 INFO - mozdevice == 0.48 07:55:18 INFO - mozfile == 1.2 07:55:18 INFO - mozhttpd == 0.7 07:55:18 INFO - mozinfo == 0.9 07:55:18 INFO - mozleak == 0.1 07:55:18 INFO - mozlog == 3.2 07:55:18 INFO - moznetwork == 0.27 07:55:18 INFO - mozprocess == 0.22 07:55:18 INFO - mozprofile == 0.28 07:55:18 INFO - mozrunner == 6.11 07:55:18 INFO - mozscreenshot == 0.1 07:55:18 INFO - mozsystemmonitor == 0.3 07:55:18 INFO - moztest == 0.7 07:55:18 INFO - mozversion == 1.4 07:55:18 INFO - psutil == 3.1.1 07:55:18 INFO - requests == 1.2.3 07:55:18 INFO - wsgiref == 0.1.2 07:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:18 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:18 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 07:55:18 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 07:55:18 INFO - Using env: {'DISPLAY': ':0', 07:55:18 INFO - 'HOME': '/home/cltbld', 07:55:18 INFO - 'LANG': 'en_US.UTF-8', 07:55:18 INFO - 'LANGUAGE': 'en_US:en', 07:55:18 INFO - 'LOGNAME': 'cltbld', 07:55:18 INFO - 'MAIL': '/var/mail/cltbld', 07:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:18 INFO - 'MOZ_NO_REMOTE': '1', 07:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:18 INFO - 'NO_EM_RESTART': '1', 07:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:18 INFO - 'PWD': '/builds/slave/test', 07:55:18 INFO - 'SHELL': '/bin/bash', 07:55:18 INFO - 'SHLVL': '1', 07:55:18 INFO - 'TERM': 'linux', 07:55:18 INFO - 'TMOUT': '86400', 07:55:18 INFO - 'USER': 'cltbld', 07:55:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:18 INFO - '_': '/tools/buildbot/bin/python'} 07:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 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)) 07:55:18 INFO - Cleaning up... 07:55:18 INFO - Return code: 0 07:55:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:18 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:18 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 07:55:18 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 07:55:18 INFO - Using env: {'DISPLAY': ':0', 07:55:18 INFO - 'HOME': '/home/cltbld', 07:55:18 INFO - 'LANG': 'en_US.UTF-8', 07:55:18 INFO - 'LANGUAGE': 'en_US:en', 07:55:18 INFO - 'LOGNAME': 'cltbld', 07:55:18 INFO - 'MAIL': '/var/mail/cltbld', 07:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:18 INFO - 'MOZ_NO_REMOTE': '1', 07:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:18 INFO - 'NO_EM_RESTART': '1', 07:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:18 INFO - 'PWD': '/builds/slave/test', 07:55:18 INFO - 'SHELL': '/bin/bash', 07:55:18 INFO - 'SHLVL': '1', 07:55:18 INFO - 'TERM': 'linux', 07:55:18 INFO - 'TMOUT': '86400', 07:55:18 INFO - 'USER': 'cltbld', 07:55:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:18 INFO - '_': '/tools/buildbot/bin/python'} 07:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:18 INFO - Downloading/unpacking jsonschema 07:55:18 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 07:55:18 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 07:55:18 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 07:55:18 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 07:55:18 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 07:55:18 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 07:55:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:55:20 INFO - Downloading/unpacking functools32 (from jsonschema) 07:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:55:20 INFO - warning: no files found matching '*.txt' 07:55:20 INFO - no previously-included directories found matching 'build' 07:55:20 INFO - no previously-included directories found matching 'dist' 07:55:20 INFO - no previously-included directories found matching '.git*' 07:55:20 INFO - Installing collected packages: jsonschema, functools32 07:55:20 INFO - Running setup.py install for functools32 07:55:21 INFO - warning: no files found matching '*.txt' 07:55:21 INFO - no previously-included directories found matching 'build' 07:55:21 INFO - no previously-included directories found matching 'dist' 07:55:21 INFO - no previously-included directories found matching '.git*' 07:55:21 INFO - Successfully installed jsonschema functools32 07:55:21 INFO - Cleaning up... 07:55:21 INFO - Return code: 0 07:55:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:21 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 0x7f484cd56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29768e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', '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 07:55:21 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 07:55:21 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 07:55:21 INFO - Using env: {'DISPLAY': ':0', 07:55:21 INFO - 'HOME': '/home/cltbld', 07:55:21 INFO - 'LANG': 'en_US.UTF-8', 07:55:21 INFO - 'LANGUAGE': 'en_US:en', 07:55:21 INFO - 'LOGNAME': 'cltbld', 07:55:21 INFO - 'MAIL': '/var/mail/cltbld', 07:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:21 INFO - 'MOZ_NO_REMOTE': '1', 07:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:21 INFO - 'NO_EM_RESTART': '1', 07:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:21 INFO - 'PWD': '/builds/slave/test', 07:55:21 INFO - 'SHELL': '/bin/bash', 07:55:21 INFO - 'SHLVL': '1', 07:55:21 INFO - 'TERM': 'linux', 07:55:21 INFO - 'TMOUT': '86400', 07:55:21 INFO - 'USER': 'cltbld', 07:55:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:21 INFO - '_': '/tools/buildbot/bin/python'} 07:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:21 INFO - Downloading/unpacking flake8 07:55:21 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 07:55:21 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 07:55:21 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 07:55:21 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 07:55:21 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 07:55:21 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 07:55:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:55:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:55:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 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 07:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:55:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:24 INFO - no previously-included directories found matching 'docs/_build' 07:55:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:55:24 INFO - Running setup.py install for pep8 07:55:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:55:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:55:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:55:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:55:24 INFO - no previously-included directories found matching 'docs/_build' 07:55:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:55:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:55:24 INFO - Cleaning up... 07:55:24 INFO - Return code: 0 07:55:24 INFO - Running post-action listener: _resource_record_post_action 07:55:24 INFO - Running post-action listener: _start_resource_monitoring 07:55:24 INFO - Starting resource monitoring. 07:55:24 INFO - ##### 07:55:24 INFO - ##### Finished create-virtualenv step (success) 07:55:24 INFO - ##### 07:55:24 INFO - ##### 07:55:24 INFO - ##### Running install step. 07:55:24 INFO - ##### 07:55:24 INFO - Running pre-action listener: _resource_record_pre_action 07:55:24 INFO - Running main action method: install 07:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:24 INFO - Reading from file tmpfile_stdout 07:55:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:24 INFO - Reading from file tmpfile_stdout 07:55:24 INFO - Output received: 07:55:24 INFO - Usage: mozinstall [options] installer 07:55:24 INFO - Options: 07:55:24 INFO - -h, --help show this help message and exit 07:55:24 INFO - -d DEST, --destination=DEST 07:55:24 INFO - Directory to install application into. [default: 07:55:24 INFO - "/builds/slave/test"] 07:55:24 INFO - --app=APP Application being installed. [default: firefox] 07:55:24 INFO - mkdir: /builds/slave/test/build/application 07:55:24 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'] 07:55:24 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 07:55:41 INFO - Reading from file tmpfile_stdout 07:55:41 INFO - Output received: 07:55:41 INFO - /builds/slave/test/build/application/firefox/firefox 07:55:41 INFO - Running post-action listener: _resource_record_post_action 07:55:41 INFO - ##### 07:55:41 INFO - ##### Finished install step (success) 07:55:41 INFO - ##### 07:55:41 INFO - ##### 07:55:41 INFO - ##### Running run-tests step. 07:55:41 INFO - ##### 07:55:41 INFO - Running pre-action listener: _resource_record_pre_action 07:55:41 INFO - Running main action method: run_tests 07:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:41 INFO - Python 2.7.3 07:55:41 INFO - Return code: 0 07:55:41 INFO - grabbing minidump binary from tooltool 07:55: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')]} 07:55:41 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 0x2a05b20>, '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 0x2a06a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a06eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:41 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 07:55:41 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 07:55:41 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 07:55:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:41 INFO - Return code: 0 07:55:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:55:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:55:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:55:42 INFO - Return code: 0 07:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:55:42 INFO - Using env: {'DISPLAY': ':0', 07:55:42 INFO - 'HOME': '/home/cltbld', 07:55:42 INFO - 'LANG': 'en_US.UTF-8', 07:55:42 INFO - 'LANGUAGE': 'en_US:en', 07:55:42 INFO - 'LOGNAME': 'cltbld', 07:55:42 INFO - 'MAIL': '/var/mail/cltbld', 07:55:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:42 INFO - 'MOZ_NO_REMOTE': '1', 07:55:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:42 INFO - 'NO_EM_RESTART': '1', 07:55:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:42 INFO - 'PWD': '/builds/slave/test', 07:55:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:42 INFO - 'SHELL': '/bin/bash', 07:55:42 INFO - 'SHLVL': '1', 07:55:42 INFO - 'TERM': 'linux', 07:55:42 INFO - 'TMOUT': '86400', 07:55:42 INFO - 'USER': 'cltbld', 07:55:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853', 07:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:42 INFO - '_': '/tools/buildbot/bin/python'} 07:55:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:55:42 INFO - mozversion application_buildid: 20160531053004 07:55:42 INFO - mozversion application_changeset: 8bf67bdad00282eed87c14a08c166a0ca90bf621 07:55:42 INFO - mozversion application_display_name: Nightly 07:55:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:42 INFO - mozversion application_name: Firefox 07:55:42 INFO - mozversion application_remotingname: firefox 07:55:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:55:42 INFO - mozversion application_vendor: Mozilla 07:55:42 INFO - mozversion application_version: 49.0a1 07:55:42 INFO - mozversion platform_buildid: 20160531053004 07:55:42 INFO - mozversion platform_changeset: 8bf67bdad00282eed87c14a08c166a0ca90bf621 07:55:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:55:42 INFO - mozversion platform_version: 49.0a1 07:55:42 INFO - using testdate: 1464706542 07:55:42 INFO - actual date: 1464706542 07:55:42 INFO - starting webserver on 'localhost:56781' 07:55:42 INFO - SUITE-START | Running 2 tests 07:55:42 INFO - TEST-START | dromaeo_css 07:55:42 INFO - operating with platform_type : linux_ 07:55:42 INFO - Initialising browser for dromaeo_css test... 07:55:42 INFO - TEST-INFO | started process 3598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc_ZjhP/profile http://localhost:56781/getInfo.html) 07:55:47 INFO - PROCESS | 3598 | __metrics Screen width/height:1600/1200 07:55:47 INFO - PROCESS | 3598 | colorDepth:24 07:55:47 INFO - PROCESS | 3598 | Browser inner width/height: 1024/697 07:55:47 INFO - PROCESS | 3598 | __metrics 07:55:48 ERROR - PROCESS | 3598 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:55:49 INFO - TEST-INFO | 3598: exit 0 07:55:49 INFO - Browser initialized. 07:55:49 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:49 INFO - TEST-INFO | started process 3716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc_ZjhP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:00 INFO - PROCESS | 3716 | RSS: Main: 166793216 07:56:00 INFO - PROCESS | 3716 | 07:56:50 INFO - PROCESS | 3716 | 1464706610516 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] 07:58:58 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:56781/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56781/tests/dromaeo/cssquery-ext.html) 07:58:59 INFO - PROCESS | 3716 | RSS: Main: 170201088 07:58:59 INFO - PROCESS | 3716 | 08:02:01 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:56781/tests/dromaeo/cssquery-ext.html (next: http://localhost:56781/tests/dromaeo/cssquery-jquery.html) 08:02:02 INFO - PROCESS | 3716 | RSS: Main: 170373120 08:02:02 INFO - PROCESS | 3716 | 08:05:04 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:56781/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56781/tests/dromaeo/cssquery-mootools.html) 08:05:04 INFO - PROCESS | 3716 | RSS: Main: 171208704 08:05:04 INFO - PROCESS | 3716 | 08:08:06 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:56781/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56781/tests/dromaeo/cssquery-prototype.html) 08:08:07 INFO - PROCESS | 3716 | RSS: Main: 169070592 08:08:07 INFO - PROCESS | 3716 | 08:11:09 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:56781/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56781/tests/dromaeo/cssquery-yui.html) 08:11:10 INFO - PROCESS | 3716 | RSS: Main: 170229760 08:11:10 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:56781/tests/dromaeo/cssquery-yui.html (next: http://localhost:56781/tests/dromaeo/cssquery-dojo.html) 08:14:13 INFO - PROCESS | 3716 | RSS: Main: 171933696 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | __start_tp_report 08:14:13 INFO - PROCESS | 3716 | _x_x_mozilla_page_load 08:14:13 INFO - PROCESS | 3716 | _x_x_mozilla_page_load_details 08:14:13 INFO - PROCESS | 3716 | |i|pagename|runs| 08:14:13 INFO - PROCESS | 3716 | |0;dojo.html;3143.7956532825365;3167.461531539638;3172.8096314221143;3196.2968147007664;3200.7759456838016;5362.9006053758985;5382.650127741694;5390.838274851751;5443.591730620199;5462.972685136579;5290.259363689077;5306.177542480912;5330.546903513206;5375.462453754622;5423.728813559316;4844.757762111898;4860.7326597037145;4955.1080805455;5018.673786203904;5070.974645126769;894.935036410792;4946.332245146895;4974.030064137494;4990.6756060856105;5017.297578339036;4908.288298196777;4944.777485013183;4954.950450495503;4961.528654777809;4981.854173540106;4831.830885919011;4980.178270585349;4982.975085124551;5000.62495312853;5038.269450929594;4870.829520966749;4903.681260718042;4909.116359055369;4917.827876024322;4918.04098200851;5245.318108645852;5421.756020979065;5431.728413579305;5436.755346009439;5438.211459338374;5680.091185410314;5728.169415434781;5882.941170588325;5883.17635531026;5883.676397798119;5753.280839895013;5767.221425107598;5795.855103622401;5814.302283725938;5860.794872179454;5331.786728530854;5396.838094857121;5399.082156033444;5402;5405.108157154025;5789.392113828072;5908.202392676933;5934.643921364732;5937.6734279614175;5984.311804142492;5660.688662123541;5690.3456102548735;5703.828885133453;5709.942900570941;5710.400407957105;5594.13290939905;5787.392323806024;5789.507891829242;5802.593818432669;5823.155642431823;5671.801486947937;5707.914381284284;5729.140628905614;5791.536677065825;5821.27234095738;5477.342718873681;5686.402927692616;5744.138379243063;5786.855328616734;5829.533637309005;4365.738055716667;4367.868963931087;4382.167388196232;4382.430284063052;4426.026274219731;3819.9809000955374;3881.107345310594;3882.9029274267805;3913.3151698452657;3920.6863450923856;5594;5606.719664016783;5633.492985631313;5640.915386269209;5649.209110724501;5611;5908.202392676933;5910.940890591125;5936.495397891142;5953.880922381528;5436.184572314184;5483.369412517532;5512.972435137799;5518.392976772552;5539.2522009529;4959.826406075842;4972.328735620645;4976.651634385558;4982.800687972513;5009.899802004013;5836.037053886146;5967.880642387215;6031.336552979169;6040.667763272974;6046.848828779316;5775.740091695968;5778.16216648592;5798.913016304843;5861.120831875252;5866.090755932837;6062.060380640832;6064.605800622945;6065.090236464565;6072.848178795565;6078.240219972504;5493.258410114583;5666.433356664301;5712.885742285214;5747;5748.597598168088;5853.970730146492;5854.795082172103;5878.764849405976;5891.3224979127945;5907.852303692442;5691.7438715257085;5694.487496125369;5702.600817942704;5733;5739.655620662774;5442.102053161184;5573.526250268773;5588.720563971867;5595.664260144405;5612.7754889803955;5407.7025763581805;5543.445655434424;5566.944330556643;5572.080606700011;5621.269234999424;5725.656460612377;5810.593258471867;5814.796482123105;5830.970845145747;5837.620554663933;5411.161270003156;5538.972305138448;5584.581156413204;5679.403662615366;5691.573132015198 08:14:13 INFO - PROCESS | 3716 | |1;ext.html;580.9390014048524;629.6411045703949;634.8254230086728;648.0894343447457;650.0282078292953;43202.567974320285;44548.33177502336;44984;48419.27371089436;48494;46158.53841461593;46939.530604693944;46971.530284697146;47044.29433558499;47067.293990590166;8658.523781192032;8885;8966;8976.910230897705;8978.910210897873;8788.384813063089;8865.556722163898;8893;8894.688685895995;8897;8882.378233523623;8924.419912705653;8972.237359824423;8983.236424903891;8990.325725570576;8868.290536757077;8915.465072095663;8923.330750193729;8929.776755581097;8930.464172149692;8743.169398907094;8832.33757468186;8840.823183536357;8841.557922103933;8866.689665861728;43172.784136079434;43522.56477435217;43610.56389436129;43631.56368436307;43691.78154109209;3616.3129005488872;3755.75587586806;3809.2317736024347;3916.902077448058;4369.344598310247;32791.344173116406;32960.835195824104;33494.665053349396;33602.83198584016;33615.32769344624;4360.738355698668;4378.474583050054;4401.251787196153;4477.194105061088;4537.97798593686;246415;247655;249404;250858;250867.74566127235;59459.405405945385;60265;60504;60658.69670651619;60989;33201.501977470354;63544;63784.68107659525;63997.36002640007;64085.359146407936;17940.461786146436;17991;18143.274269029356;18149.7277540837;18165.54586135357;13540;13677;13681.24753138567;13681.521146759816;13687.452501900012;20118.295859645135;20224.292149774687;20327.593448130956;20332.898335508522;20425.285115020903;7187.496875218684;7208.603526805971;7390.926090739132;7437.136702369518;7449.88825167623;1032.5147180825;1092.644890410604;1093.4423444043437;1186.6855283349746;1220.8229806677982;32399.352012959607;33263.66736332654;33363.499547506806;33404.33191336208;33473.46609418125;1141.08713029576;1157.5774842182543;1158.8667303260065;1183.828344889986;1219.646302572262;17015.23431445588;17554.824451755318;17567.82432175662;17612.20745066475;17712.46862594124;600403;602900.8259504443;603837;610712;619126;58394.708026460445;58530.414695853346;58664.7066764672;58798;58853;1368.288489985222;1418.3475601223347;1431.8854491640852;1432.6919712261913;1443.6751730860472;31215.375692486476;31628.683713162573;32058.83970580132;32520.51219231761;33005.50491742674;52865.20702189547;53292.4670753303;53635;53741;53878.461215387346;480421;487078;491321;491723;492377;28678;28768.424631506834;29046.7095329044;29051.273718157216;29068;49690.751546242034;50774;51061.48938510568;53471;57007.71496142493;43169.3524597125;44427.33358999682;45111;45744.313835293164;46794;44551.99516021852;44667;45418.77290613526;45602.54397455983;46004;38924.41613375858;43502.34746478868;44347.77826110978;45161;45427.54572454233;36937;41695.37456938209;42160;43074.353884692384;43101;33385.332293354484;33430.83284583561;33688.32623347568;33762.662373375955;34074.31851362909 08:14:13 INFO - PROCESS | 3716 | |2;jquery.html;386.59407621996894;390.61134171499344;390.8158280410354;390.8690588652802;409.4084048549845;17979.37072202473;19114.617707645837;19396.418107456782;19420.51448713781;20583;19160.520986975334;19376.612467750638;19790.40628781135;19881.105350259237;19979.800201997976;5376.38171610264;5429;5622.437756224385;5639.7180140993;5662.037453632893;5525.613207075507;5674.773009079632;5683.062294721366;5724.627899186539;5886.823395298148;5890.970545147268;5907.350191478934;5935.020721580934;5938.88122237555;5955.464008239258;5902.61632993854;5906.5570082243785;5906.940930590682;6332.335104813974;6348.714307856158;5680.375158732578;5681.062624666925;5688.033034384164;5708.257926469574;5712.485876271156;13255.138416002928;13870.791938120936;13941.093828901088;14022.859771402258;14084.647883802885;2237.944051398712;2252.650839119939;2350.7766762157567;2351.2123438648073;2442.426029882976;9671.661491847752;9977.80044399108;10285.897141028569;10401.947990260076;10532.894671053267;1959.8628096033283;1969.3796454116907;2061.865978711379;2086.968695469569;2100.789921007902;76476.61761691156;78279.6086019572;78850.60574697147;79138.20861791365;79244;10755.56977720898;10830.187735919837;11001.944990275157;11121.55513779456;11208.271462355084;15603.921980390252;15666.451674191349;15684.607884802743;15695.450659226872;15713.68572628564;8189.099199088096;8331.875021874677;8400.41197116196;8455.154484551618;8487.278581320534;8028.919710802934;8104.473209241381;8108.75673729789;8198.713045043394;8230.84768132462;4675.696079754805;4682.012492631706;4784.162771514971;4786.569208771158;4909.116359055333;1969.6257711034857;2018.268118543344;2026.6858636911302;2032.2175962254344;2036.6639504481595;1041.073444634261;1096;1106.3417266726285;1111.5387114347616;1125.2460851229696;17585.912070439565;18889.622207556047;19459.180994556067;19725.802741972682;19795.703064454046;998.6305067125065;1005.1456262177092;1039.9948000259951;1062.654637242899;1069.4438891776233;10422.947885260677;10912.61805836792;10940.945295273472;11005.449727513593;11066.336019838835;415042;417069;418082;535256;542009;81942.59028704818;96367.51816240874;97600;98638;99283.50358248307;444.2203932099145;456.5799464492675;459.44866160607404;461.803733413298;462.1035191728104;10442.843357349493;10929.398883061507;11188;11477.426128693698;11533.480993355151;40536.18927621372;40722.20449832476;42114;43100;44117.89705257266;55998;57341.139882900956;58488.4151158483;59155.112673310796;59897.10154347601;8204.712835050745;8265.669373225004;8353.791155221168;8457.957710211656;8556.358273129665;8950.462972221687;12412.758724127876;12859.485620575073;12978.415971281127;13045.739085218433;8447.8732819009;11286.49210785533;11294.887051129384;11486.10479270911;11512.481938312629;11146.554137834395;11153.888461115284;11215.887841121485;11453;11636.476358563716;11122;11354.432278386214;11699.2395494296;11801.055915526566;11867.109966752701;8302.833943320979;8305.46014509055;8311;8539.060703322753;8571.057183709912;10727.570897164025;11718.531258749554;11764.764704706029;11836.76326473483;11976.820347694616 08:14:13 INFO - PROCESS | 3716 | |3;mootools.html;1501.8573235542624;1534;1712.6403455274392;1826.4429349048544;1828.954276143097;8203.3437325014;8700.434471759347;8870.290376769859;9479.431234125948;9504.572294246758;8701.08638592948;9008.774780630487;9061.81876362474;9062.275017998561;9070.63717451301;2333.323336232495;2362.232274510782;2364.2552595932225;2372.478054827935;2376.4415362389823;2331.4287999440076;2333.7666233376613;2363.5627408929317;2374.347054560001;2378.2865140457793;2320.106758897828;2331.25399872041;2342.3792694935855;2378.6669866218745;2387.6896003519605;2246.8314876384256;2286.5084006938587;2308.1690591387087;2308.4690521180055;2311.202635090891;2280.3159052284414;2308.826837987141;2312.433453803812;2319.9188028419094;2320.6170981787986;8910.688125915562;8953.10468953106;8954.641814327419;8965.148310910454;9014.594343254505;5151.742412879378;5241.973790131063;5326.760295786699;5329.786808527654;5453.372862120827;3410.2326976430104;3476.235228249781;3535.3106144301873;3539.29214157167;3593.8562457501666;1088.2327958789035;1107.778444311133;1143.056977993159;1144.7596004838995;1156.8438260834764;12880.613581592566;12909.935450322782;12973.935130324287;12977.026722995719;12982;4584.839530616479;4674.135284972291;4735.786889589976;4773.904521909542;4780.545848144421;10892.564297428173;10930.508127134139;10935.398553079656;10960.835587466194;10998.34009959405;5360.91958620621;5389.218563308376;5393.379761327419;5397.298351214317;5405.702686352289;4448.755318457451;4794.616430685606;4940.728259945738;4965.652404331734;4969.875753106129;4033.4353190553347;4039.7374170678813;4063.5733248009124;4078.4290199372113;4105.861258629223;1226.3745489800267;1226.7975783995719;1237.7648246833073;1239.8698136695698;1258.6218091190133;1000.7898341348398;1005.3364779245809;1023.7133602591286;1031.8091153136543;1038.7351225437465;6196.969015154986;6226.017456309507;6244.625322480575;6265.467435268053;6291.307956124822;419.6915267278548;421.2922290551841;422.9894252643647;427.22458737391537;1051.3639248254697;4156.875293741132;4242.469691288589;4334.479862416467;4366.628836548865;4373.169097871458;11554.711132221762;11751.236169648946;11765.470553825098;11767.88232117685;11786.58746943853;11023.503942322615;11397.487113079931;11415.714607134889;11711.297322160697;11736.765264694659;8541.701040463555;8708.651653933772;8711.433756805787;8721.912780872237;8756.8686469703;6038.969805150946;6221.5333849962335;6268.937310626835;6350.4919606432295;6353.618782873043;10144.391336519833;10727.517261723086;10810.081143102925;10877.238593298393;10886.455677215949;10663.680089597325;10727.839082413613;10899.237053406185;10903.945480272549;10957.178211634318;7380.926190738239;8116.878246826421;8163.061247956323;8286.917130828855;8495.74512764618;9118.498482583256;9150.63397464094;9161.77095572616;9257.398269112486;9290.814183716422;7980.281774640311;8285.50286982783;8313.210245026712;8327.833443331221;8430.662773488992;7861.292483676497;8044.959775201087;8049.557274349967;8076.838463230585;8080.676772929017;7053.788386348418;7116.644167791694;7130.607816570138;7170.533915295489;7181.964090179516;5272.868178295574;5303.4696530346655;5340.813071542478;5380.973095134499;5421.186821976735;5254.894902102013;5358.410574836843;5402.162664786964;5430.728463576885;5560.499555040065 08:14:13 INFO - PROCESS | 3716 | |4;prototype.html;320.5944480232506;328.61059644321483;329.28873632952826;329.4481743080341;331.03008186014983;5506.779728810848;5530.695811730353;5532.75102620382;5543.833684989451;5621.859453513664;5498.835034948948;5510.256115424417;5515.696636684981;5518.227448157261;5537.418571050042;4087.915163266733;4157.461739156502;4271.722338048017;4280.208161490119;4309.159713855799;4236.385724070008;4269.829206831723;4274.465691788527;4280.737182531146;4286.228478873802;4249.936250956238;4259.531451540328;4266.06146647737;4280.208161490119;4285.57144285572;4032.45561849151;4168.603982621677;4209.768462734548;4224.9155016899485;4328.199283132631;3664.9083772905624;3677.6506231907924;3684.336819372512;3701;3703.8332575443396;5332.253484512172;5358.91961620576;5374.871277031828;5378.757955891994;5435.755391007414;4509.346144808985;4790.353302304214;4802.279658051285;4884.511548845123;4894.3147959285725;5693.686847223401;5717.428257174291;5757.65454072757;5763.3948435414095;5832.591718579701;3944.23087497938;3952.8616498422416;3982.9402558961638;3992.700547458923;3999.0402303447254;5868.941310586925;5937.406259374028;5960.019990005041;5983.2349456910315;5990.64056156632;4022.1955608878343;4033.1127152026506;4036.555978842325;4041.8383264669674;4061.837526498966;4090.284200264942;4098.200850834059;4109.321961876317;4113.424120623115;4123.9381409278885;4588;4734.526547345238;4778.3037021857435;4783.976080119647;4862.222044472938;5796.21751063601;5806.767729290781;5815.534757219412;5830.7959221427045;5848.771757930882;1449.4926775628446;1454.9563513094624;1456.6067161866238;1463.5536161470854;1465.758149905275;900.0594378874092;925.4632313258294;925.7222833150028;1009.7223263602568;1043.4209013997154;5537.148368590179;5546.639468434539;5567.47109024642;5678.744456499468;5681;5842.1236814477315;5849.327327357323;5873.970630146822;5877.588568800143;5921.171036054956;5308.256844041837;5531.2809334787025;5535.702683386349;5574.219609254707;5612.522935550524;3109.8134111953354;3148.5434611981136;3148.779585428998;3161.3835302116327;3176.1583180457196;5896.64620122794;6027.156198132265;6106.755729770759;6111.419415155553;6168.907466388007;5974.4622983930785;5985.9401405986255;5993.670348130895;5994.460498555151;5999.760009599567;6121.84695382619;6160.8767824643255;6163.599366041193;6165.075238714139;6167.105769663373;5784;5889.440503152194;5889.528837692888;5933.605602683279;5947.226860508106;5835.44563266489;5852.239208902815;5871.236739223874;5911.3201981772645;5945.762169513171;5895.263092113486;6095.75616975316;6126.571140020156;6196.380361963767;6207.534434917309;4221.543567469218;4247.97876010618;4253.8727237282765;4268.125034368009;4279.507856596531;5894.793682221101;5923.348431672426;5946.256717910262;5980.760769569342;5999.340072592098;5587.7485513152815;5743.167240750151;5813.680247586423;5922.7334769936315;5927.614705044159;5835.649861008353;5848.824535263949;5864.472197502075;5879.176915231786;5902.61632993854;5504.311961004874;5558.777648893999;5742.741576629145;5755.165501002415;5810.622309549865;5822.214001109796;5863;5901;5904.232449781673;5930.466258036798;5571.359293681278;5708.603380988306;5735.7705691773535;5779.479846813807;5812.854678632899 08:14:13 INFO - PROCESS | 3716 | |5;yui.html;693.6462404173872;733.6221845749436;792.5601291283342;805.6374631415861;849.8300339932011;15991;15998.440054598077;16039;16094.678106437894;16154;14785.482508112218;14846.480373186942;14847.703045939103;14883.18142502162;14892.702145957075;682.7371461987121;800.6197056398194;815.2458975447717;825.7233826668044;830.016430529821;813.7151996801102;819.5697258939075;819.9877001844977;821.0393839208141;822.2640736540792;869.0570730757105;872.2062922740275;872.9388942774009;873.2010210657241;874.2612492443875;856.447591303612;857.695518091075;862.482510493705;863.1066845814584;866.2117473099449;623.507429130986;625.1060982794602;626.0984182776787;627.4039662320813;629.4712441549075;14073.085249458854;14157.079789813732;14208.644783880382;14226.928865355607;14234.572962811133;13629.454821807116;13727.519536816164;13874.375653095634;14619.488317908928;14673.339699713431;11928.880711192864;11945.522179112824;12097;12270.631881043582;12663.556775512905;3854.8458061677497;4032.5564187939303;4033.7781422021776;4060.4518390017265;4069.165821006716;61174.999999999556;61211.38788612146;61699.38300616981;61730.69134654298;61971.38028619746;11192.664220073411;11287.435628218556;11495.770084598262;11566.30602163873;11845;21488.14047438116;21522.892385537973;21523.78476215218;21561.460963475725;21564.35306940794;8249.670013199524;8459.492430454193;8626.78433039179;8637.715172187502;8740.038595754462;4613.123506533748;4681.110588988081;4741.359916411309;4758;4760.166970780099;3326.7338612910908;3380.3746306932803;3400.387930172593;3402.9829850851083;3405;597.3936454498687;615.3969110271869;616.9198004259417;627.05314974389;633.4837107757163;665.892450394496;674.5379415100672;784.5802495664792;801.4309840013539;805.2240397058802;9666.420014799134;9933.850992235122;10162.593496260215;10166.237532185116;10173.643922462827;708.8617719544742;709.2056896276204;729.657061181244;739.5193124469031;758.9279018493235;4589.242774942164;4723.622110231173;4774.522547745267;4803.277459968553;4803.78382972767;69980.65009674919;70413.64793176002;70585.2941470589;70826.291737083;72088;58359.70820145872;63493.682531587045;63606;63743;64766.028509572396;28007.439851203268;39466.60533394687;56558.71720641453;59903.40096599065;61181;10003.149102505751;10028.849567256351;10062.295639305179;10088.499962815375;10316.638917637847;38196.42705359477;38740.80629596834;39074.413883791196;39102.60897391103;39207.80396098001;49038;52165.7391713039;53022;53102;54086.45913540814;10936.56253749841;11313.547458101913;11354.148438867283;11430.142739294752;11497.310161390344;12801.8079728806;12970;13066.085374023727;13184.538541151014;13250.602481925558;11862.34757088334;11886.553683531494;12038.337891416057;12129.75740485203;12710.618681439571;12128.151029428209;12147.149699520949;12184.329861857683;12541.372931353579;12682.556110536087;11252.66242012741;11479.36863472517;11626.70933226676;11764;12076.154669173073;9909.55407006672;9953.253505986935;10280.691579252634;10373.844392334271;10443.477826108512;9919.801603967735;10389.84415233757;10445.738856528647;10502.78994420092;10616.256862019585 08:14:13 INFO - PROCESS | 3716 | __end_tp_report 08:14:13 INFO - PROCESS | 3716 | __start_cc_report 08:14:13 INFO - PROCESS | 3716 | _x_x_mozilla_cycle_collect,352 08:14:13 INFO - PROCESS | 3716 | __end_cc_report 08:14:13 INFO - PROCESS | 3716 | __startTimestamp1464707653281__endTimestamp 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | ------- Summary: start ------- 08:14:13 INFO - PROCESS | 3716 | Number of tests: 6 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | [#0] dojo.html Cycles:165 Average:5361.51 Median:5594.13 stddev:708.46 (12.7%) stddev-sans-first:688.94 08:14:13 INFO - PROCESS | 3716 | Values: 3143.8 3167.5 3172.8 3196.3 3200.8 5362.9 5382.7 5390.8 5443.6 5463.0 5290.3 5306.2 5330.5 5375.5 5423.7 4844.8 4860.7 4955.1 5018.7 5071.0 894.9 4946.3 4974.0 4990.7 5017.3 4908.3 4944.8 4955.0 4961.5 4981.9 4831.8 4980.2 4983.0 5000.6 5038.3 4870.8 4903.7 4909.1 4917.8 4918.0 5245.3 5421.8 5431.7 5436.8 5438.2 5680.1 5728.2 5882.9 5883.2 5883.7 5753.3 5767.2 5795.9 5814.3 5860.8 5331.8 5396.8 5399.1 5402.0 5405.1 5789.4 5908.2 5934.6 5937.7 5984.3 5660.7 5690.3 5703.8 5709.9 5710.4 5594.1 5787.4 5789.5 5802.6 5823.2 5671.8 5707.9 5729.1 5791.5 5821.3 5477.3 5686.4 5744.1 5786.9 5829.5 4365.7 4367.9 4382.2 4382.4 4426.0 3820.0 3881.1 3882.9 3913.3 3920.7 5594.0 5606.7 5633.5 5640.9 5649.2 5611.0 5908.2 5910.9 5936.5 5953.9 5436.2 5483.4 5513.0 5518.4 5539.3 4959.8 4972.3 4976.7 4982.8 5009.9 5836.0 5967.9 6031.3 6040.7 6046.8 5775.7 5778.2 5798.9 5861.1 5866.1 6062.1 6064.6 6065.1 6072.8 6078.2 5493.3 5666.4 5712.9 5747.0 5748.6 5854.0 5854.8 5878.8 5891.3 5907.9 5691.7 5694.5 5702.6 5733.0 5739.7 5442.1 5573.5 5588.7 5595.7 5612.8 5407.7 5543.4 5566.9 5572.1 5621.3 5725.7 5810.6 5814.8 5831.0 5837.6 5411.2 5539.0 5584.6 5679.4 5691.6 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | [#1] ext.html Cycles:180 Average:62061.65 Median:44550.16 stddev:125968.88 (282.8%) stddev-sans-first:126237.68 08:14:13 INFO - PROCESS | 3716 | Values: 580.9 629.6 634.8 648.1 650.0 43202.6 44548.3 44984.0 48419.3 48494.0 46158.5 46939.5 46971.5 47044.3 47067.3 8658.5 8885.0 8966.0 8976.9 8978.9 8788.4 8865.6 8893.0 8894.7 8897.0 8882.4 8924.4 8972.2 8983.2 8990.3 8868.3 8915.5 8923.3 8929.8 8930.5 8743.2 8832.3 8840.8 8841.6 8866.7 43172.8 43522.6 43610.6 43631.6 43691.8 3616.3 3755.8 3809.2 3916.9 4369.3 32791.3 32960.8 33494.7 33602.8 33615.3 4360.7 4378.5 4401.3 4477.2 4538.0 246415.0 247655.0 249404.0 250858.0 250867.7 59459.4 60265.0 60504.0 60658.7 60989.0 33201.5 63544.0 63784.7 63997.4 64085.4 17940.5 17991.0 18143.3 18149.7 18165.5 13540.0 13677.0 13681.2 13681.5 13687.5 20118.3 20224.3 20327.6 20332.9 20425.3 7187.5 7208.6 7390.9 7437.1 7449.9 1032.5 1092.6 1093.4 1186.7 1220.8 32399.4 33263.7 33363.5 33404.3 33473.5 1141.1 1157.6 1158.9 1183.8 1219.6 17015.2 17554.8 17567.8 17612.2 17712.5 600403.0 602900.8 603837.0 610712.0 619126.0 58394.7 58530.4 58664.7 58798.0 58853.0 1368.3 1418.3 1431.9 1432.7 1443.7 31215.4 31628.7 32058.8 32520.5 33005.5 52865.2 53292.5 53635.0 53741.0 53878.5 480421.0 487078.0 491321.0 491723.0 492377.0 28678.0 28768.4 29046.7 29051.3 29068.0 49690.8 50774.0 51061.5 53471.0 57007.7 43169.4 44427.3 45111.0 45744.3 46794.0 44552.0 44667.0 45418.8 45602.5 46004.0 38924.4 43502.3 44347.8 45161.0 45427.5 36937.0 41695.4 42160.0 43074.4 43101.0 33385.3 33430.8 33688.3 33762.7 34074.3 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | [#2] jquery.html Cycles:180 Average:27870.27 Median:388.60 stddev:77639.28 (19979.1%) stddev-sans-first:77829.66 08:14:13 INFO - PROCESS | 3716 | Values: 386.6 390.6 390.8 390.9 409.4 17979.4 19114.6 19396.4 19420.5 20583.0 19160.5 19376.6 19790.4 19881.1 19979.8 5376.4 5429.0 5622.4 5639.7 5662.0 5525.6 5674.8 5683.1 5724.6 5886.8 5891.0 5907.4 5935.0 5938.9 5955.5 5902.6 5906.6 5906.9 6332.3 6348.7 5680.4 5681.1 5688.0 5708.3 5712.5 13255.1 13870.8 13941.1 14022.9 14084.6 2237.9 2252.7 2350.8 2351.2 2442.4 9671.7 9977.8 10285.9 10401.9 10532.9 1959.9 1969.4 2061.9 2087.0 2100.8 76476.6 78279.6 78850.6 79138.2 79244.0 10755.6 10830.2 11001.9 11121.6 11208.3 15603.9 15666.5 15684.6 15695.5 15713.7 8189.1 8331.9 8400.4 8455.2 8487.3 8028.9 8104.5 8108.8 8198.7 8230.8 4675.7 4682.0 4784.2 4786.6 4909.1 1969.6 2018.3 2026.7 2032.2 2036.7 1041.1 1096.0 1106.3 1111.5 1125.2 17585.9 18889.6 19459.2 19725.8 19795.7 998.6 1005.1 1040.0 1062.7 1069.4 10422.9 10912.6 10940.9 11005.4 11066.3 415042.0 417069.0 418082.0 535256.0 542009.0 81942.6 96367.5 97600.0 98638.0 99283.5 444.2 456.6 459.4 461.8 462.1 10442.8 10929.4 11188.0 11477.4 11533.5 40536.2 40722.2 42114.0 43100.0 44117.9 55998.0 57341.1 58488.4 59155.1 59897.1 8204.7 8265.7 8353.8 8458.0 8556.4 8950.5 12412.8 12859.5 12978.4 13045.7 8447.9 11286.5 11294.9 11486.1 11512.5 11146.6 11153.9 11215.9 11453.0 11636.5 11122.0 11354.4 11699.2 11801.1 11867.1 8302.8 8305.5 8311.0 8539.1 8571.1 10727.6 11718.5 11764.8 11836.8 11976.8 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | [#3] mootools.html Cycles:180 Average:6041.45 Median:2334.85 stddev:3523.27 (150.9%) stddev-sans-first:3516.64 08:14:13 INFO - PROCESS | 3716 | Values: 1501.9 1534.0 1712.6 1826.4 1829.0 8203.3 8700.4 8870.3 9479.4 9504.6 8701.1 9008.8 9061.8 9062.3 9070.6 2333.3 2362.2 2364.3 2372.5 2376.4 2331.4 2333.8 2363.6 2374.3 2378.3 2320.1 2331.3 2342.4 2378.7 2387.7 2246.8 2286.5 2308.2 2308.5 2311.2 2280.3 2308.8 2312.4 2319.9 2320.6 8910.7 8953.1 8954.6 8965.1 9014.6 5151.7 5242.0 5326.8 5329.8 5453.4 3410.2 3476.2 3535.3 3539.3 3593.9 1088.2 1107.8 1143.1 1144.8 1156.8 12880.6 12909.9 12973.9 12977.0 12982.0 4584.8 4674.1 4735.8 4773.9 4780.5 10892.6 10930.5 10935.4 10960.8 10998.3 5360.9 5389.2 5393.4 5397.3 5405.7 4448.8 4794.6 4940.7 4965.7 4969.9 4033.4 4039.7 4063.6 4078.4 4105.9 1226.4 1226.8 1237.8 1239.9 1258.6 1000.8 1005.3 1023.7 1031.8 1038.7 6197.0 6226.0 6244.6 6265.5 6291.3 419.7 421.3 423.0 427.2 1051.4 4156.9 4242.5 4334.5 4366.6 4373.2 11554.7 11751.2 11765.5 11767.9 11786.6 11023.5 11397.5 11415.7 11711.3 11736.8 8541.7 8708.7 8711.4 8721.9 8756.9 6039.0 6221.5 6268.9 6350.5 6353.6 10144.4 10727.5 10810.1 10877.2 10886.5 10663.7 10727.8 10899.2 10903.9 10957.2 7380.9 8116.9 8163.1 8286.9 8495.7 9118.5 9150.6 9161.8 9257.4 9290.8 7980.3 8285.5 8313.2 8327.8 8430.7 7861.3 8045.0 8049.6 8076.8 8080.7 7053.8 7116.6 7130.6 7170.5 7182.0 5272.9 5303.5 5340.8 5381.0 5421.2 5254.9 5358.4 5402.2 5430.7 5560.5 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | [#4] prototype.html Cycles:180 Average:4843.32 Median:5545.24 stddev:1451.04 (26.2%) stddev-sans-first:1414.85 08:14:13 INFO - PROCESS | 3716 | Values: 320.6 328.6 329.3 329.4 331.0 5506.8 5530.7 5532.8 5543.8 5621.9 5498.8 5510.3 5515.7 5518.2 5537.4 4087.9 4157.5 4271.7 4280.2 4309.2 4236.4 4269.8 4274.5 4280.7 4286.2 4249.9 4259.5 4266.1 4280.2 4285.6 4032.5 4168.6 4209.8 4224.9 4328.2 3664.9 3677.7 3684.3 3701.0 3703.8 5332.3 5358.9 5374.9 5378.8 5435.8 4509.3 4790.4 4802.3 4884.5 4894.3 5693.7 5717.4 5757.7 5763.4 5832.6 3944.2 3952.9 3982.9 3992.7 3999.0 5868.9 5937.4 5960.0 5983.2 5990.6 4022.2 4033.1 4036.6 4041.8 4061.8 4090.3 4098.2 4109.3 4113.4 4123.9 4588.0 4734.5 4778.3 4784.0 4862.2 5796.2 5806.8 5815.5 5830.8 5848.8 1449.5 1455.0 1456.6 1463.6 1465.8 900.1 925.5 925.7 1009.7 1043.4 5537.1 5546.6 5567.5 5678.7 5681.0 5842.1 5849.3 5874.0 5877.6 5921.2 5308.3 5531.3 5535.7 5574.2 5612.5 3109.8 3148.5 3148.8 3161.4 3176.2 5896.6 6027.2 6106.8 6111.4 6168.9 5974.5 5985.9 5993.7 5994.5 5999.8 6121.8 6160.9 6163.6 6165.1 6167.1 5784.0 5889.4 5889.5 5933.6 5947.2 5835.4 5852.2 5871.2 5911.3 5945.8 5895.3 6095.8 6126.6 6196.4 6207.5 4221.5 4248.0 4253.9 4268.1 4279.5 5894.8 5923.3 5946.3 5980.8 5999.3 5587.7 5743.2 5813.7 5922.7 5927.6 5835.6 5848.8 5864.5 5879.2 5902.6 5504.3 5558.8 5742.7 5755.2 5810.6 5822.2 5863.0 5901.0 5904.2 5930.5 5571.4 5708.6 5735.8 5779.5 5812.9 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - PROCESS | 3716 | [#5] yui.html Cycles:180 Average:15918.27 Median:4064.81 stddev:19323.38 (475.4%) stddev-sans-first:19343.77 08:14:13 INFO - PROCESS | 3716 | Values: 693.6 733.6 792.6 805.6 849.8 15991.0 15998.4 16039.0 16094.7 16154.0 14785.5 14846.5 14847.7 14883.2 14892.7 682.7 800.6 815.2 825.7 830.0 813.7 819.6 820.0 821.0 822.3 869.1 872.2 872.9 873.2 874.3 856.4 857.7 862.5 863.1 866.2 623.5 625.1 626.1 627.4 629.5 14073.1 14157.1 14208.6 14226.9 14234.6 13629.5 13727.5 13874.4 14619.5 14673.3 11928.9 11945.5 12097.0 12270.6 12663.6 3854.8 4032.6 4033.8 4060.5 4069.2 61175.0 61211.4 61699.4 61730.7 61971.4 11192.7 11287.4 11495.8 11566.3 11845.0 21488.1 21522.9 21523.8 21561.5 21564.4 8249.7 8459.5 8626.8 8637.7 8740.0 4613.1 4681.1 4741.4 4758.0 4760.2 3326.7 3380.4 3400.4 3403.0 3405.0 597.4 615.4 616.9 627.1 633.5 665.9 674.5 784.6 801.4 805.2 9666.4 9933.9 10162.6 10166.2 10173.6 708.9 709.2 729.7 739.5 758.9 4589.2 4723.6 4774.5 4803.3 4803.8 69980.7 70413.6 70585.3 70826.3 72088.0 58359.7 63493.7 63606.0 63743.0 64766.0 28007.4 39466.6 56558.7 59903.4 61181.0 10003.1 10028.8 10062.3 10088.5 10316.6 38196.4 38740.8 39074.4 39102.6 39207.8 49038.0 52165.7 53022.0 53102.0 54086.5 10936.6 11313.5 11354.1 11430.1 11497.3 12801.8 12970.0 13066.1 13184.5 13250.6 11862.3 11886.6 12038.3 12129.8 12710.6 12128.2 12147.1 12184.3 12541.4 12682.6 11252.7 11479.4 11626.7 11764.0 12076.2 9909.6 9953.3 10280.7 10373.8 10443.5 9919.8 10389.8 10445.7 10502.8 10616.3 08:14:13 INFO - PROCESS | 3716 | -------- Summary: end -------- 08:14:13 INFO - PROCESS | 3716 | 08:14:13 INFO - TEST-INFO | 3716: exit 0 08:14:14 INFO - TEST-OK | dromaeo_css | took 1111482ms 08:14:14 INFO - TEST-START | kraken 08:14:14 INFO - operating with platform_type : linux_ 08:14:14 INFO - Initialising browser for kraken test... 08:14:14 INFO - TEST-INFO | started process 3953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqak4Lj/profile http://localhost:56781/getInfo.html) 08:14:18 INFO - PROCESS | 3953 | __metrics Screen width/height:1600/1200 08:14:18 INFO - PROCESS | 3953 | colorDepth:24 08:14:18 INFO - PROCESS | 3953 | Browser inner width/height: 1024/697 08:14:18 INFO - PROCESS | 3953 | __metrics 08:14:19 ERROR - PROCESS | 3953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:14:20 INFO - TEST-INFO | 3953: exit 0 08:14:20 INFO - Browser initialized. 08:14:20 INFO - Running cycle 1/1 for kraken test... 08:14:20 INFO - TEST-INFO | started process 4076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqak4Lj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:32 INFO - PROCESS | 4076 | RSS: Main: 167161856 08:14:32 INFO - PROCESS | 4076 | 08:14:34 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56781/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:35 INFO - PROCESS | 4076 | RSS: Main: 172367872 08:14:35 INFO - PROCESS | 4076 | 08:14:38 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56781/tests/kraken/driver.html?testName=audio-dft) 08:14:39 INFO - PROCESS | 4076 | RSS: Main: 171401216 08:14:39 INFO - PROCESS | 4076 | 08:14:41 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56781/tests/kraken/driver.html?testName=audio-fft) 08:14:42 INFO - PROCESS | 4076 | RSS: Main: 166739968 08:14:42 INFO - PROCESS | 4076 | 08:14:44 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56781/tests/kraken/driver.html?testName=audio-oscillator) 08:14:45 INFO - PROCESS | 4076 | RSS: Main: 167354368 08:14:45 INFO - PROCESS | 4076 | 08:14:47 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56781/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:48 INFO - PROCESS | 4076 | RSS: Main: 167739392 08:14:48 INFO - PROCESS | 4076 | 08:14:51 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56781/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:52 INFO - PROCESS | 4076 | RSS: Main: 168202240 08:14:52 INFO - PROCESS | 4076 | 08:14:55 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56781/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:56 INFO - PROCESS | 4076 | RSS: Main: 168357888 08:14:56 INFO - PROCESS | 4076 | 08:14:59 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56781/tests/kraken/driver.html?testName=json-parse-financial) 08:14:59 INFO - PROCESS | 4076 | RSS: Main: 168075264 08:14:59 INFO - PROCESS | 4076 | 08:15:01 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56781/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:15:01 INFO - PROCESS | 4076 | RSS: Main: 168009728 08:15:01 INFO - PROCESS | 4076 | 08:15:03 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:15:04 INFO - PROCESS | 4076 | RSS: Main: 168136704 08:15:04 INFO - PROCESS | 4076 | 08:15:06 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:07 INFO - PROCESS | 4076 | RSS: Main: 168747008 08:15:07 INFO - PROCESS | 4076 | 08:15:09 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:10 INFO - PROCESS | 4076 | RSS: Main: 168771584 08:15:10 INFO - PROCESS | 4076 | 08:15:12 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:15:13 INFO - PROCESS | 4076 | RSS: Main: 168656896 08:15:13 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | Cycle 1(1): loaded http://localhost:56781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56781/tests/kraken/driver.html?testName=ai-astar) 08:15:15 INFO - PROCESS | 4076 | RSS: Main: 169631744 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | __start_tp_report 08:15:15 INFO - PROCESS | 4076 | _x_x_mozilla_page_load 08:15:15 INFO - PROCESS | 4076 | _x_x_mozilla_page_load_details 08:15:15 INFO - PROCESS | 4076 | |i|pagename|runs| 08:15:15 INFO - PROCESS | 4076 | |0;ai-astar;110;106;112;111;111;111;110;111;112;112 08:15:15 INFO - PROCESS | 4076 | |1;audio-beat-detection;160;124;161;186;125;156;153;125;182;126 08:15:15 INFO - PROCESS | 4076 | |2;audio-dft;162;161;161;162;164;164;171;167;161;163 08:15:15 INFO - PROCESS | 4076 | |3;audio-fft;75;77;77;152;77;75;74;76;188;84 08:15:15 INFO - PROCESS | 4076 | |4;audio-oscillator;82;84;149;84;83;83;144;83;84;145 08:15:15 INFO - PROCESS | 4076 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;118 08:15:15 INFO - PROCESS | 4076 | |6;imaging-darkroom;146;147;147;148;147;148;147;147;148;147 08:15:15 INFO - PROCESS | 4076 | |7;imaging-desaturate;98;97;95;95;96;95;96;97;96;95 08:15:15 INFO - PROCESS | 4076 | |8;json-parse-financial;56;56;56;55;58;55;61;55;57;58 08:15:15 INFO - PROCESS | 4076 | |9;json-stringify-tinderbox;63;64;62;64;64;63;62;63;64;63 08:15:15 INFO - PROCESS | 4076 | |10;stanford-crypto-aes;79;78;79;86;80;81;83;81;115;80 08:15:15 INFO - PROCESS | 4076 | |11;stanford-crypto-ccm;124;131;119;130;132;120;126;132;129;121 08:15:15 INFO - PROCESS | 4076 | |12;stanford-crypto-pbkdf2;163;160;164;162;165;163;162;166;156;159 08:15:15 INFO - PROCESS | 4076 | |13;stanford-crypto-sha256-iterative;63;63;65;64;63;65;63;63;64;63 08:15:15 INFO - PROCESS | 4076 | __end_tp_report 08:15:15 INFO - PROCESS | 4076 | __start_cc_report 08:15:15 INFO - PROCESS | 4076 | _x_x_mozilla_cycle_collect,907 08:15:15 INFO - PROCESS | 4076 | __end_cc_report 08:15:15 INFO - PROCESS | 4076 | __startTimestamp1464707715519__endTimestamp 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | ------- Summary: start ------- 08:15:15 INFO - PROCESS | 4076 | Number of tests: 14 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.87 08:15:15 INFO - PROCESS | 4076 | Values: 110.0 106.0 112.0 111.0 111.0 111.0 110.0 111.0 112.0 112.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:158.00 stddev:23.78 (15.0%) stddev-sans-first:24.93 08:15:15 INFO - PROCESS | 4076 | Values: 160.0 124.0 161.0 186.0 125.0 156.0 153.0 125.0 182.0 126.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.20 (2.0%) stddev-sans-first:3.35 08:15:15 INFO - PROCESS | 4076 | Values: 162.0 161.0 161.0 162.0 164.0 164.0 171.0 167.0 161.0 163.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.50 stddev:40.26 (52.6%) stddev-sans-first:42.02 08:15:15 INFO - PROCESS | 4076 | Values: 75.0 77.0 77.0 152.0 77.0 75.0 74.0 76.0 188.0 84.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.00 stddev:30.33 (36.5%) stddev-sans-first:31.28 08:15:15 INFO - PROCESS | 4076 | Values: 82.0 84.0 149.0 84.0 83.0 83.0 144.0 83.0 84.0 145.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:15:15 INFO - PROCESS | 4076 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 08:15:15 INFO - PROCESS | 4076 | Values: 146.0 147.0 147.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.05 (1.1%) stddev-sans-first:0.83 08:15:15 INFO - PROCESS | 4076 | Values: 98.0 97.0 95.0 95.0 96.0 95.0 96.0 97.0 96.0 95.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:1.89 (3.3%) stddev-sans-first:1.99 08:15:15 INFO - PROCESS | 4076 | Values: 56.0 56.0 56.0 55.0 58.0 55.0 61.0 55.0 57.0 58.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 08:15:15 INFO - PROCESS | 4076 | Values: 63.0 64.0 62.0 64.0 64.0 63.0 62.0 63.0 64.0 63.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:80.50 stddev:11.06 (13.7%) stddev-sans-first:11.57 08:15:15 INFO - PROCESS | 4076 | Values: 79.0 78.0 79.0 86.0 80.0 81.0 83.0 81.0 115.0 80.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:129.50 stddev:5.10 (3.9%) stddev-sans-first:5.34 08:15:15 INFO - PROCESS | 4076 | Values: 124.0 131.0 119.0 130.0 132.0 120.0 126.0 132.0 129.0 121.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.00 stddev:2.98 (1.8%) stddev-sans-first:3.14 08:15:15 INFO - PROCESS | 4076 | Values: 163.0 160.0 164.0 162.0 165.0 163.0 162.0 166.0 156.0 159.0 08:15:15 INFO - PROCESS | 4076 | 08:15:15 INFO - PROCESS | 4076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 08:15:15 INFO - PROCESS | 4076 | Values: 63.0 63.0 65.0 64.0 63.0 65.0 63.0 63.0 64.0 63.0 08:15:15 INFO - PROCESS | 4076 | -------- Summary: end -------- 08:15:15 INFO - PROCESS | 4076 | 08:15:16 INFO - TEST-INFO | 4076: exit 0 08:15:16 INFO - TEST-OK | kraken | took 62531ms 08:15:16 INFO - SUITE-END | took 1174s 08:15:16 INFO - Completed test suite (00:19:34) 08:15:16 INFO - javascript benchmark 08:15:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7218.130441675016, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.7956532825365, 3167.461531539638, 3172.8096314221143, 3196.2968147007664, 3200.7759456838016, 5362.9006053758985, 5382.650127741694, 5390.838274851751, 5443.591730620199, 5462.972685136579, 5290.259363689077, 5306.177542480912, 5330.546903513206, 5375.462453754622, 5423.728813559316, 4844.757762111898, 4860.7326597037145, 4955.1080805455, 5018.673786203904, 5070.974645126769, 894.935036410792, 4946.332245146895, 4974.030064137494, 4990.6756060856105, 5017.297578339036, 4908.288298196777, 4944.777485013183, 4954.950450495503, 4961.528654777809, 4981.854173540106, 4831.830885919011, 4980.178270585349, 4982.975085124551, 5000.62495312853, 5038.269450929594, 4870.829520966749, 4903.681260718042, 4909.116359055369, 4917.827876024322, 4918.04098200851, 5245.318108645852, 5421.756020979065, 5431.728413579305, 5436.755346009439, 5438.211459338374, 5680.091185410314, 5728.169415434781, 5882.941170588325, 5883.17635531026, 5883.676397798119, 5753.280839895013, 5767.221425107598, 5795.855103622401, 5814.302283725938, 5860.794872179454, 5331.786728530854, 5396.838094857121, 5399.082156033444, 5402.0, 5405.108157154025, 5789.392113828072, 5908.202392676933, 5934.643921364732, 5937.6734279614175, 5984.311804142492, 5660.688662123541, 5690.3456102548735, 5703.828885133453, 5709.942900570941, 5710.400407957105, 5594.13290939905, 5787.392323806024, 5789.507891829242, 5802.593818432669, 5823.155642431823, 5671.801486947937, 5707.914381284284, 5729.140628905614, 5791.536677065825, 5821.27234095738, 5477.342718873681, 5686.402927692616, 5744.138379243063, 5786.855328616734, 5829.533637309005, 4365.738055716667, 4367.868963931087, 4382.167388196232, 4382.430284063052, 4426.026274219731, 3819.9809000955374, 3881.107345310594, 3882.9029274267805, 3913.3151698452657, 3920.6863450923856, 5594.0, 5606.719664016783, 5633.492985631313, 5640.915386269209, 5649.209110724501, 5611.0, 5908.202392676933, 5910.940890591125, 5936.495397891142, 5953.880922381528, 5436.184572314184, 5483.369412517532, 5512.972435137799, 5518.392976772552, 5539.2522009529, 4959.826406075842, 4972.328735620645, 4976.651634385558, 4982.800687972513, 5009.899802004013, 5836.037053886146, 5967.880642387215, 6031.336552979169, 6040.667763272974, 6046.848828779316, 5775.740091695968, 5778.16216648592, 5798.913016304843, 5861.120831875252, 5866.090755932837, 6062.060380640832, 6064.605800622945, 6065.090236464565, 6072.848178795565, 6078.240219972504, 5493.258410114583, 5666.433356664301, 5712.885742285214, 5747.0, 5748.597598168088, 5853.970730146492, 5854.795082172103, 5878.764849405976, 5891.3224979127945, 5907.852303692442, 5691.7438715257085, 5694.487496125369, 5702.600817942704, 5733.0, 5739.655620662774, 5442.102053161184, 5573.526250268773, 5588.720563971867, 5595.664260144405, 5612.7754889803955, 5407.7025763581805, 5543.445655434424, 5566.944330556643, 5572.080606700011, 5621.269234999424, 5725.656460612377, 5810.593258471867, 5814.796482123105, 5830.970845145747, 5837.620554663933, 5411.161270003156, 5538.972305138448, 5584.581156413204, 5679.403662615366, 5691.573132015198], "value": 5315.632006569347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9390014048524, 629.6411045703949, 634.8254230086728, 648.0894343447457, 650.0282078292953, 43202.567974320285, 44548.33177502336, 44984.0, 48419.27371089436, 48494.0, 46158.53841461593, 46939.530604693944, 46971.530284697146, 47044.29433558499, 47067.293990590166, 8658.523781192032, 8885.0, 8966.0, 8976.910230897705, 8978.910210897873, 8788.384813063089, 8865.556722163898, 8893.0, 8894.688685895995, 8897.0, 8882.378233523623, 8924.419912705653, 8972.237359824423, 8983.236424903891, 8990.325725570576, 8868.290536757077, 8915.465072095663, 8923.330750193729, 8929.776755581097, 8930.464172149692, 8743.169398907094, 8832.33757468186, 8840.823183536357, 8841.557922103933, 8866.689665861728, 43172.784136079434, 43522.56477435217, 43610.56389436129, 43631.56368436307, 43691.78154109209, 3616.3129005488872, 3755.75587586806, 3809.2317736024347, 3916.902077448058, 4369.344598310247, 32791.344173116406, 32960.835195824104, 33494.665053349396, 33602.83198584016, 33615.32769344624, 4360.738355698668, 4378.474583050054, 4401.251787196153, 4477.194105061088, 4537.97798593686, 246415.0, 247655.0, 249404.0, 250858.0, 250867.74566127235, 59459.405405945385, 60265.0, 60504.0, 60658.69670651619, 60989.0, 33201.501977470354, 63544.0, 63784.68107659525, 63997.36002640007, 64085.359146407936, 17940.461786146436, 17991.0, 18143.274269029356, 18149.7277540837, 18165.54586135357, 13540.0, 13677.0, 13681.24753138567, 13681.521146759816, 13687.452501900012, 20118.295859645135, 20224.292149774687, 20327.593448130956, 20332.898335508522, 20425.285115020903, 7187.496875218684, 7208.603526805971, 7390.926090739132, 7437.136702369518, 7449.88825167623, 1032.5147180825, 1092.644890410604, 1093.4423444043437, 1186.6855283349746, 1220.8229806677982, 32399.352012959607, 33263.66736332654, 33363.499547506806, 33404.33191336208, 33473.46609418125, 1141.08713029576, 1157.5774842182543, 1158.8667303260065, 1183.828344889986, 1219.646302572262, 17015.23431445588, 17554.824451755318, 17567.82432175662, 17612.20745066475, 17712.46862594124, 600403.0, 602900.8259504443, 603837.0, 610712.0, 619126.0, 58394.708026460445, 58530.414695853346, 58664.7066764672, 58798.0, 58853.0, 1368.288489985222, 1418.3475601223347, 1431.8854491640852, 1432.6919712261913, 1443.6751730860472, 31215.375692486476, 31628.683713162573, 32058.83970580132, 32520.51219231761, 33005.50491742674, 52865.20702189547, 53292.4670753303, 53635.0, 53741.0, 53878.461215387346, 480421.0, 487078.0, 491321.0, 491723.0, 492377.0, 28678.0, 28768.424631506834, 29046.7095329044, 29051.273718157216, 29068.0, 49690.751546242034, 50774.0, 51061.48938510568, 53471.0, 57007.71496142493, 43169.3524597125, 44427.33358999682, 45111.0, 45744.313835293164, 46794.0, 44551.99516021852, 44667.0, 45418.77290613526, 45602.54397455983, 46004.0, 38924.41613375858, 43502.34746478868, 44347.77826110978, 45161.0, 45427.54572454233, 36937.0, 41695.37456938209, 42160.0, 43074.353884692384, 43101.0, 33385.332293354484, 33430.83284583561, 33688.32623347568, 33762.662373375955, 34074.31851362909], "value": 20949.396275893414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.59407621996894, 390.61134171499344, 390.8158280410354, 390.8690588652802, 409.4084048549845, 17979.37072202473, 19114.617707645837, 19396.418107456782, 19420.51448713781, 20583.0, 19160.520986975334, 19376.612467750638, 19790.40628781135, 19881.105350259237, 19979.800201997976, 5376.38171610264, 5429.0, 5622.437756224385, 5639.7180140993, 5662.037453632893, 5525.613207075507, 5674.773009079632, 5683.062294721366, 5724.627899186539, 5886.823395298148, 5890.970545147268, 5907.350191478934, 5935.020721580934, 5938.88122237555, 5955.464008239258, 5902.61632993854, 5906.5570082243785, 5906.940930590682, 6332.335104813974, 6348.714307856158, 5680.375158732578, 5681.062624666925, 5688.033034384164, 5708.257926469574, 5712.485876271156, 13255.138416002928, 13870.791938120936, 13941.093828901088, 14022.859771402258, 14084.647883802885, 2237.944051398712, 2252.650839119939, 2350.7766762157567, 2351.2123438648073, 2442.426029882976, 9671.661491847752, 9977.80044399108, 10285.897141028569, 10401.947990260076, 10532.894671053267, 1959.8628096033283, 1969.3796454116907, 2061.865978711379, 2086.968695469569, 2100.789921007902, 76476.61761691156, 78279.6086019572, 78850.60574697147, 79138.20861791365, 79244.0, 10755.56977720898, 10830.187735919837, 11001.944990275157, 11121.55513779456, 11208.271462355084, 15603.921980390252, 15666.451674191349, 15684.607884802743, 15695.450659226872, 15713.68572628564, 8189.099199088096, 8331.875021874677, 8400.41197116196, 8455.154484551618, 8487.278581320534, 8028.919710802934, 8104.473209241381, 8108.75673729789, 8198.713045043394, 8230.84768132462, 4675.696079754805, 4682.012492631706, 4784.162771514971, 4786.569208771158, 4909.116359055333, 1969.6257711034857, 2018.268118543344, 2026.6858636911302, 2032.2175962254344, 2036.6639504481595, 1041.073444634261, 1096.0, 1106.3417266726285, 1111.5387114347616, 1125.2460851229696, 17585.912070439565, 18889.622207556047, 19459.180994556067, 19725.802741972682, 19795.703064454046, 998.6305067125065, 1005.1456262177092, 1039.9948000259951, 1062.654637242899, 1069.4438891776233, 10422.947885260677, 10912.61805836792, 10940.945295273472, 11005.449727513593, 11066.336019838835, 415042.0, 417069.0, 418082.0, 535256.0, 542009.0, 81942.59028704818, 96367.51816240874, 97600.0, 98638.0, 99283.50358248307, 444.2203932099145, 456.5799464492675, 459.44866160607404, 461.803733413298, 462.1035191728104, 10442.843357349493, 10929.398883061507, 11188.0, 11477.426128693698, 11533.480993355151, 40536.18927621372, 40722.20449832476, 42114.0, 43100.0, 44117.89705257266, 55998.0, 57341.139882900956, 58488.4151158483, 59155.112673310796, 59897.10154347601, 8204.712835050745, 8265.669373225004, 8353.791155221168, 8457.957710211656, 8556.358273129665, 8950.462972221687, 12412.758724127876, 12859.485620575073, 12978.415971281127, 13045.739085218433, 8447.8732819009, 11286.49210785533, 11294.887051129384, 11486.10479270911, 11512.481938312629, 11146.554137834395, 11153.888461115284, 11215.887841121485, 11453.0, 11636.476358563716, 11122.0, 11354.432278386214, 11699.2395494296, 11801.055915526566, 11867.109966752701, 8302.833943320979, 8305.46014509055, 8311.0, 8539.060703322753, 8571.057183709912, 10727.570897164025, 11718.531258749554, 11764.764704706029, 11836.76326473483, 11976.820347694616], "value": 8806.908493124007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.8573235542624, 1534.0, 1712.6403455274392, 1826.4429349048544, 1828.954276143097, 8203.3437325014, 8700.434471759347, 8870.290376769859, 9479.431234125948, 9504.572294246758, 8701.08638592948, 9008.774780630487, 9061.81876362474, 9062.275017998561, 9070.63717451301, 2333.323336232495, 2362.232274510782, 2364.2552595932225, 2372.478054827935, 2376.4415362389823, 2331.4287999440076, 2333.7666233376613, 2363.5627408929317, 2374.347054560001, 2378.2865140457793, 2320.106758897828, 2331.25399872041, 2342.3792694935855, 2378.6669866218745, 2387.6896003519605, 2246.8314876384256, 2286.5084006938587, 2308.1690591387087, 2308.4690521180055, 2311.202635090891, 2280.3159052284414, 2308.826837987141, 2312.433453803812, 2319.9188028419094, 2320.6170981787986, 8910.688125915562, 8953.10468953106, 8954.641814327419, 8965.148310910454, 9014.594343254505, 5151.742412879378, 5241.973790131063, 5326.760295786699, 5329.786808527654, 5453.372862120827, 3410.2326976430104, 3476.235228249781, 3535.3106144301873, 3539.29214157167, 3593.8562457501666, 1088.2327958789035, 1107.778444311133, 1143.056977993159, 1144.7596004838995, 1156.8438260834764, 12880.613581592566, 12909.935450322782, 12973.935130324287, 12977.026722995719, 12982.0, 4584.839530616479, 4674.135284972291, 4735.786889589976, 4773.904521909542, 4780.545848144421, 10892.564297428173, 10930.508127134139, 10935.398553079656, 10960.835587466194, 10998.34009959405, 5360.91958620621, 5389.218563308376, 5393.379761327419, 5397.298351214317, 5405.702686352289, 4448.755318457451, 4794.616430685606, 4940.728259945738, 4965.652404331734, 4969.875753106129, 4033.4353190553347, 4039.7374170678813, 4063.5733248009124, 4078.4290199372113, 4105.861258629223, 1226.3745489800267, 1226.7975783995719, 1237.7648246833073, 1239.8698136695698, 1258.6218091190133, 1000.7898341348398, 1005.3364779245809, 1023.7133602591286, 1031.8091153136543, 1038.7351225437465, 6196.969015154986, 6226.017456309507, 6244.625322480575, 6265.467435268053, 6291.307956124822, 419.6915267278548, 421.2922290551841, 422.9894252643647, 427.22458737391537, 1051.3639248254697, 4156.875293741132, 4242.469691288589, 4334.479862416467, 4366.628836548865, 4373.169097871458, 11554.711132221762, 11751.236169648946, 11765.470553825098, 11767.88232117685, 11786.58746943853, 11023.503942322615, 11397.487113079931, 11415.714607134889, 11711.297322160697, 11736.765264694659, 8541.701040463555, 8708.651653933772, 8711.433756805787, 8721.912780872237, 8756.8686469703, 6038.969805150946, 6221.5333849962335, 6268.937310626835, 6350.4919606432295, 6353.618782873043, 10144.391336519833, 10727.517261723086, 10810.081143102925, 10877.238593298393, 10886.455677215949, 10663.680089597325, 10727.839082413613, 10899.237053406185, 10903.945480272549, 10957.178211634318, 7380.926190738239, 8116.878246826421, 8163.061247956323, 8286.917130828855, 8495.74512764618, 9118.498482583256, 9150.63397464094, 9161.77095572616, 9257.398269112486, 9290.814183716422, 7980.281774640311, 8285.50286982783, 8313.210245026712, 8327.833443331221, 8430.662773488992, 7861.292483676497, 8044.959775201087, 8049.557274349967, 8076.838463230585, 8080.676772929017, 7053.788386348418, 7116.644167791694, 7130.607816570138, 7170.533915295489, 7181.964090179516, 5272.868178295574, 5303.4696530346655, 5340.813071542478, 5380.973095134499, 5421.186821976735, 5254.894902102013, 5358.410574836843, 5402.162664786964, 5430.728463576885, 5560.499555040065], "value": 4730.682500046723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5944480232506, 328.61059644321483, 329.28873632952826, 329.4481743080341, 331.03008186014983, 5506.779728810848, 5530.695811730353, 5532.75102620382, 5543.833684989451, 5621.859453513664, 5498.835034948948, 5510.256115424417, 5515.696636684981, 5518.227448157261, 5537.418571050042, 4087.915163266733, 4157.461739156502, 4271.722338048017, 4280.208161490119, 4309.159713855799, 4236.385724070008, 4269.829206831723, 4274.465691788527, 4280.737182531146, 4286.228478873802, 4249.936250956238, 4259.531451540328, 4266.06146647737, 4280.208161490119, 4285.57144285572, 4032.45561849151, 4168.603982621677, 4209.768462734548, 4224.9155016899485, 4328.199283132631, 3664.9083772905624, 3677.6506231907924, 3684.336819372512, 3701.0, 3703.8332575443396, 5332.253484512172, 5358.91961620576, 5374.871277031828, 5378.757955891994, 5435.755391007414, 4509.346144808985, 4790.353302304214, 4802.279658051285, 4884.511548845123, 4894.3147959285725, 5693.686847223401, 5717.428257174291, 5757.65454072757, 5763.3948435414095, 5832.591718579701, 3944.23087497938, 3952.8616498422416, 3982.9402558961638, 3992.700547458923, 3999.0402303447254, 5868.941310586925, 5937.406259374028, 5960.019990005041, 5983.2349456910315, 5990.64056156632, 4022.1955608878343, 4033.1127152026506, 4036.555978842325, 4041.8383264669674, 4061.837526498966, 4090.284200264942, 4098.200850834059, 4109.321961876317, 4113.424120623115, 4123.9381409278885, 4588.0, 4734.526547345238, 4778.3037021857435, 4783.976080119647, 4862.222044472938, 5796.21751063601, 5806.767729290781, 5815.534757219412, 5830.7959221427045, 5848.771757930882, 1449.4926775628446, 1454.9563513094624, 1456.6067161866238, 1463.5536161470854, 1465.758149905275, 900.0594378874092, 925.4632313258294, 925.7222833150028, 1009.7223263602568, 1043.4209013997154, 5537.148368590179, 5546.639468434539, 5567.47109024642, 5678.744456499468, 5681.0, 5842.1236814477315, 5849.327327357323, 5873.970630146822, 5877.588568800143, 5921.171036054956, 5308.256844041837, 5531.2809334787025, 5535.702683386349, 5574.219609254707, 5612.522935550524, 3109.8134111953354, 3148.5434611981136, 3148.779585428998, 3161.3835302116327, 3176.1583180457196, 5896.64620122794, 6027.156198132265, 6106.755729770759, 6111.419415155553, 6168.907466388007, 5974.4622983930785, 5985.9401405986255, 5993.670348130895, 5994.460498555151, 5999.760009599567, 6121.84695382619, 6160.8767824643255, 6163.599366041193, 6165.075238714139, 6167.105769663373, 5784.0, 5889.440503152194, 5889.528837692888, 5933.605602683279, 5947.226860508106, 5835.44563266489, 5852.239208902815, 5871.236739223874, 5911.3201981772645, 5945.762169513171, 5895.263092113486, 6095.75616975316, 6126.571140020156, 6196.380361963767, 6207.534434917309, 4221.543567469218, 4247.97876010618, 4253.8727237282765, 4268.125034368009, 4279.507856596531, 5894.793682221101, 5923.348431672426, 5946.256717910262, 5980.760769569342, 5999.340072592098, 5587.7485513152815, 5743.167240750151, 5813.680247586423, 5922.7334769936315, 5927.614705044159, 5835.649861008353, 5848.824535263949, 5864.472197502075, 5879.176915231786, 5902.61632993854, 5504.311961004874, 5558.777648893999, 5742.741576629145, 5755.165501002415, 5810.622309549865, 5822.214001109796, 5863.0, 5901.0, 5904.232449781673, 5930.466258036798, 5571.359293681278, 5708.603380988306, 5735.7705691773535, 5779.479846813807, 5812.854678632899], "value": 4375.240929566295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.6462404173872, 733.6221845749436, 792.5601291283342, 805.6374631415861, 849.8300339932011, 15991.0, 15998.440054598077, 16039.0, 16094.678106437894, 16154.0, 14785.482508112218, 14846.480373186942, 14847.703045939103, 14883.18142502162, 14892.702145957075, 682.7371461987121, 800.6197056398194, 815.2458975447717, 825.7233826668044, 830.016430529821, 813.7151996801102, 819.5697258939075, 819.9877001844977, 821.0393839208141, 822.2640736540792, 869.0570730757105, 872.2062922740275, 872.9388942774009, 873.2010210657241, 874.2612492443875, 856.447591303612, 857.695518091075, 862.482510493705, 863.1066845814584, 866.2117473099449, 623.507429130986, 625.1060982794602, 626.0984182776787, 627.4039662320813, 629.4712441549075, 14073.085249458854, 14157.079789813732, 14208.644783880382, 14226.928865355607, 14234.572962811133, 13629.454821807116, 13727.519536816164, 13874.375653095634, 14619.488317908928, 14673.339699713431, 11928.880711192864, 11945.522179112824, 12097.0, 12270.631881043582, 12663.556775512905, 3854.8458061677497, 4032.5564187939303, 4033.7781422021776, 4060.4518390017265, 4069.165821006716, 61174.999999999556, 61211.38788612146, 61699.38300616981, 61730.69134654298, 61971.38028619746, 11192.664220073411, 11287.435628218556, 11495.770084598262, 11566.30602163873, 11845.0, 21488.14047438116, 21522.892385537973, 21523.78476215218, 21561.460963475725, 21564.35306940794, 8249.670013199524, 8459.492430454193, 8626.78433039179, 8637.715172187502, 8740.038595754462, 4613.123506533748, 4681.110588988081, 4741.359916411309, 4758.0, 4760.166970780099, 3326.7338612910908, 3380.3746306932803, 3400.387930172593, 3402.9829850851083, 3405.0, 597.3936454498687, 615.3969110271869, 616.9198004259417, 627.05314974389, 633.4837107757163, 665.892450394496, 674.5379415100672, 784.5802495664792, 801.4309840013539, 805.2240397058802, 9666.420014799134, 9933.850992235122, 10162.593496260215, 10166.237532185116, 10173.643922462827, 708.8617719544742, 709.2056896276204, 729.657061181244, 739.5193124469031, 758.9279018493235, 4589.242774942164, 4723.622110231173, 4774.522547745267, 4803.277459968553, 4803.78382972767, 69980.65009674919, 70413.64793176002, 70585.2941470589, 70826.291737083, 72088.0, 58359.70820145872, 63493.682531587045, 63606.0, 63743.0, 64766.028509572396, 28007.439851203268, 39466.60533394687, 56558.71720641453, 59903.40096599065, 61181.0, 10003.149102505751, 10028.849567256351, 10062.295639305179, 10088.499962815375, 10316.638917637847, 38196.42705359477, 38740.80629596834, 39074.413883791196, 39102.60897391103, 39207.80396098001, 49038.0, 52165.7391713039, 53022.0, 53102.0, 54086.45913540814, 10936.56253749841, 11313.547458101913, 11354.148438867283, 11430.142739294752, 11497.310161390344, 12801.8079728806, 12970.0, 13066.085374023727, 13184.538541151014, 13250.602481925558, 11862.34757088334, 11886.553683531494, 12038.337891416057, 12129.75740485203, 12710.618681439571, 12128.151029428209, 12147.149699520949, 12184.329861857683, 12541.372931353579, 12682.556110536087, 11252.66242012741, 11479.36863472517, 11626.70933226676, 11764.0, 12076.154669173073, 9909.55407006672, 9953.253505986935, 10280.691579252634, 10373.844392334271, 10443.477826108512, 9919.801603967735, 10389.84415233757, 10445.738856528647, 10502.78994420092, 10616.256862019585], "value": 6966.723016064848, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 112.0, 111.0, 111.0, 111.0, 110.0, 111.0, 112.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 161.0, 186.0, 125.0, 156.0, 153.0, 125.0, 182.0, 126.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 164.0, 164.0, 171.0, 167.0, 161.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 152.0, 77.0, 75.0, 74.0, 76.0, 188.0, 84.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 149.0, 84.0, 83.0, 83.0, 144.0, 83.0, 84.0, 145.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 58.0, 55.0, 61.0, 55.0, 57.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 64.0, 64.0, 63.0, 62.0, 63.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 86.0, 80.0, 81.0, 83.0, 81.0, 115.0, 80.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 131.0, 119.0, 130.0, 132.0, 120.0, 126.0, 132.0, 129.0, 121.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 164.0, 162.0, 165.0, 163.0, 162.0, 166.0, 156.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 64.0, 63.0, 65.0, 63.0, 63.0, 64.0, 63.0], "value": 63.6, "unit": "score"}]}]} 08:15:16 INFO - Return code: 0 08:15:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:15:16 ERROR - # TBPL SUCCESS # 08:15:16 INFO - Running post-action listener: _resource_record_post_action 08:15:16 INFO - ##### 08:15:16 INFO - ##### Finished run-tests step (success) 08:15:16 INFO - ##### 08:15:16 INFO - Running post-run listener: _resource_record_post_run 08:15:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545783808; Read time: 12; Write time: 567548 08:15:16 INFO - TinderboxPrint: CPU usage
13.4% 08:15:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:15:16 INFO - TinderboxPrint: I/O write bytes / time
545,783,808 / 567,548 08:15:16 INFO - TinderboxPrint: CPU idle
8,230.4 (86.5%) 08:15:16 INFO - TinderboxPrint: CPU user
1,221.1 (12.8%) 08:15:16 INFO - TinderboxPrint: Swap in / out
0 / 0 08:15:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254857216; Read time: 0; Write time: 292972 08:15:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290926592; Read time: 12; Write time: 274576 08:15:17 INFO - Running post-run listener: _upload_blobber_files 08:15:17 INFO - Blob upload gear active. 08:15:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:15:17 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 08:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:15:17 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:15:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:15:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:18 INFO - (blobuploader) - INFO - Done attempting. 08:15:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:23 INFO - (blobuploader) - INFO - Done attempting. 08:15:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:15:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:15:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:24 INFO - (blobuploader) - INFO - Done attempting. 08:15:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:24 INFO - Return code: 0 08:15:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de6218be4dd3de262cfac31f961076cd9cacfd857fc685c2e3c9a9f128787ea1f78727f5ac12dd1b83d250767e4a4d9de5360de773b647523e2e139691f6f697", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdf3a1933e27cfea7955b05e8fc5cc14cbdbebfd7bb65aa1c2af9b186cd5dd78c037870116c95e280c93eb5e3c2d3edd0ebb706d089ecf88d5aa0cb9453aa5b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b652c3cf3dd96c79d5fed3a679edc491c885271c7a2534f295d16bde018d8a3b8c0c03a5fe8ae0b95c8a03401c40212c59279c9427f8f0a54697072e525dcc5"} 08:15:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:24 INFO - Contents: 08:15:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de6218be4dd3de262cfac31f961076cd9cacfd857fc685c2e3c9a9f128787ea1f78727f5ac12dd1b83d250767e4a4d9de5360de773b647523e2e139691f6f697", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdf3a1933e27cfea7955b05e8fc5cc14cbdbebfd7bb65aa1c2af9b186cd5dd78c037870116c95e280c93eb5e3c2d3edd0ebb706d089ecf88d5aa0cb9453aa5b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b652c3cf3dd96c79d5fed3a679edc491c885271c7a2534f295d16bde018d8a3b8c0c03a5fe8ae0b95c8a03401c40212c59279c9427f8f0a54697072e525dcc5"} 08:15:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:24 INFO - Copying logs to upload dir... 08:15:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.459808 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-31 08:15:23.248055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 08:15:23.251936) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de6218be4dd3de262cfac31f961076cd9cacfd857fc685c2e3c9a9f128787ea1f78727f5ac12dd1b83d250767e4a4d9de5360de773b647523e2e139691f6f697", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdf3a1933e27cfea7955b05e8fc5cc14cbdbebfd7bb65aa1c2af9b186cd5dd78c037870116c95e280c93eb5e3c2d3edd0ebb706d089ecf88d5aa0cb9453aa5b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b652c3cf3dd96c79d5fed3a679edc491c885271c7a2534f295d16bde018d8a3b8c0c03a5fe8ae0b95c8a03401c40212c59279c9427f8f0a54697072e525dcc5"} build_url:https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011522 build_url: 'https://queue.taskcluster.net/v1/task/eId2XjGXQoyWU20DDBreZg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de6218be4dd3de262cfac31f961076cd9cacfd857fc685c2e3c9a9f128787ea1f78727f5ac12dd1b83d250767e4a4d9de5360de773b647523e2e139691f6f697", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdf3a1933e27cfea7955b05e8fc5cc14cbdbebfd7bb65aa1c2af9b186cd5dd78c037870116c95e280c93eb5e3c2d3edd0ebb706d089ecf88d5aa0cb9453aa5b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b652c3cf3dd96c79d5fed3a679edc491c885271c7a2534f295d16bde018d8a3b8c0c03a5fe8ae0b95c8a03401c40212c59279c9427f8f0a54697072e525dcc5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 08:15:23.277368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 08:15:23.277692) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1464706487.60680-245998853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 08:15:23.361510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 08:15:23.361907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 08:15:23.362209) ========= ========= Total master_lag: 0.15 =========