builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1464795519.17 results: success (0) buildid: 20160601075442 builduid: 6ec167071a674293aaa469b2f4523092 revision: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.173456) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.173953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.174287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.189570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.189877) ========= 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=ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 08:38:39-- 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% 66.8M=0s 2016-06-01 08:38:39 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.311885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.312200) ========= 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=ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014761 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:39.362198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 08:38:39.362562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 --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 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 --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=ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 08:38:39,437 truncating revision to first 12 chars 2016-06-01 08:38:39,437 Setting DEBUG logging. 2016-06-01 08:38:39,437 attempt 1/10 2016-06-01 08:38:39,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5d2cb7fff024?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 08:38:40,451 unpacking tar archive at: fx-team-5d2cb7fff024/testing/mozharness/ program finished with exit code 0 elapsedTime=1.379857 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 08:38:40.755785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:40.756123) ========= script_repo_revision: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:40.756520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:40.756791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 08:38:40.765967) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-01 08:38:40.766259) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:38:40 INFO - MultiFileLogger online at 20160601 08:38:40 in /builds/slave/test 08:38:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:38:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:40 INFO - {'append_to_log': False, 08:38:40 INFO - 'base_work_dir': '/builds/slave/test', 08:38:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:38:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:40 INFO - 'branch': 'Fx-Team-Non-PGO', 08:38:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:40 INFO - 'config_files': ('talos/linux_config.py',), 08:38:40 INFO - 'default_actions': ('clobber', 08:38:40 INFO - 'read-buildbot-config', 08:38:40 INFO - 'download-and-extract', 08:38:40 INFO - 'populate-webroot', 08:38:40 INFO - 'create-virtualenv', 08:38:40 INFO - 'install', 08:38:40 INFO - 'run-tests'), 08:38:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:40 INFO - 'download_minidump_stackwalk': True, 08:38:40 INFO - 'download_symbols': 'ondemand', 08:38:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:40 INFO - 'installer_path': 'installer.exe', 08:38:40 INFO - 'log_level': 'info', 08:38:40 INFO - 'log_name': 'talos', 08:38:40 INFO - 'log_to_console': True, 08:38:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:38:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:38:40 INFO - 'opt_config_files': (), 08:38:40 INFO - 'pip_index': False, 08:38:40 INFO - 'sps_profile': False, 08:38:40 INFO - 'sps_profile_interval': 0, 08:38:40 INFO - 'suite': 'dromaeojs', 08:38:40 INFO - 'system_bits': '32', 08:38:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:40 INFO - 'title': 'talos-linux64-ix-035', 08:38:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:40 INFO - 'use_talos_json': True, 08:38:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:40 INFO - 'work_dir': 'build'} 08:38:40 INFO - ##### 08:38:40 INFO - ##### Running clobber step. 08:38:40 INFO - ##### 08:38:40 INFO - Running pre-action listener: _resource_record_pre_action 08:38:40 INFO - Running main action method: clobber 08:38:40 INFO - rmtree: /builds/slave/test/build 08:38:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:41 INFO - Running post-action listener: _resource_record_post_action 08:38:41 INFO - ##### 08:38:41 INFO - ##### Finished clobber step (success) 08:38:41 INFO - ##### 08:38:41 INFO - ##### 08:38:41 INFO - ##### Running read-buildbot-config step. 08:38:41 INFO - ##### 08:38:41 INFO - Running pre-action listener: _resource_record_pre_action 08:38:41 INFO - Running main action method: read_buildbot_config 08:38:41 INFO - Using buildbot properties: 08:38:41 INFO - { 08:38:41 INFO - "project": "", 08:38:41 INFO - "product": "firefox", 08:38:41 INFO - "script_repo_revision": "production", 08:38:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:38:41 INFO - "repository": "", 08:38:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:38:41 INFO - "buildid": "20160601075442", 08:38:41 INFO - "pgo_build": "False", 08:38:41 INFO - "basedir": "/builds/slave/test", 08:38:41 INFO - "buildnumber": 1807, 08:38:41 INFO - "slavename": "talos-linux64-ix-035", 08:38:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:38:41 INFO - "platform": "ubuntu64_hw", 08:38:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:38:41 INFO - "branch": "fx-team", 08:38:41 INFO - "repo_path": "integration/fx-team", 08:38:41 INFO - "revision": "5d2cb7fff024a1d3ed59ad2432882d158ce5ee91", 08:38:41 INFO - "stage_platform": "linux64", 08:38:41 INFO - "builduid": "6ec167071a674293aaa469b2f4523092", 08:38:41 INFO - "slavebuilddir": "test" 08:38:41 INFO - } 08:38:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:38:41 INFO - Running post-action listener: _resource_record_post_action 08:38:41 INFO - ##### 08:38:41 INFO - ##### Finished read-buildbot-config step (success) 08:38:41 INFO - ##### 08:38:41 INFO - ##### 08:38:41 INFO - ##### Running download-and-extract step. 08:38:41 INFO - ##### 08:38:41 INFO - Running pre-action listener: _resource_record_pre_action 08:38:41 INFO - Running main action method: download_and_extract 08:38:41 INFO - mkdir: /builds/slave/test/build/tests 08:38: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')]} 08:38:41 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:42 INFO - Downloaded 1361 bytes. 08:38:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:38:42 INFO - Using the following test package requirements: 08:38:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:38:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:38:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'jsshell-linux-x86_64.zip'], 08:38:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:38:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:38:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:38:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:38:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:38:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:42 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:45 INFO - Downloaded 22849784 bytes. 08:38:45 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'] 08:38:45 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 08:38:46 INFO - Return code: 0 08:38:46 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 08:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:46 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:47 INFO - Downloaded 22849784 bytes. 08:38:47 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'] 08:38:47 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 08:38:49 INFO - Return code: 0 08:38: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')]} 08:38:49 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:38:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:38:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:38:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:50 INFO - Downloaded 10834055 bytes. 08:38:50 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'] 08:38:50 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 08:38:50 INFO - Return code: 0 08:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:50 INFO - https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PV9H3gPZTfuauS7JsYEK4g/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 08:38:52 INFO - Downloaded 55062799 bytes. 08:38:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:38:52 INFO - mkdir: /builds/slave/test/properties 08:38:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:52 INFO - Contents: 08:38:52 INFO - build_url:https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:38:53 INFO - Running post-action listener: _resource_record_post_action 08:38:53 INFO - Running post-action listener: set_extra_try_arguments 08:38:53 INFO - ##### 08:38:53 INFO - ##### Finished download-and-extract step (success) 08:38:53 INFO - ##### 08:38:53 INFO - ##### 08:38:53 INFO - ##### Running populate-webroot step. 08:38:53 INFO - ##### 08:38:53 INFO - Running pre-action listener: _resource_record_pre_action 08:38:53 INFO - Running main action method: populate_webroot 08:38:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:53 INFO - '--tppagecycles', 08:38:53 INFO - '7'], 08:38:53 INFO - 'tests': ['tsvgm']}}, 08:38:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['damp', 'tps']}, 08:38:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'tests': ['damp', 'tps']}, 08:38:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['dromaeo_dom']}, 08:38:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['a11yr', 08:38:53 INFO - 'ts_paint', 08:38:53 INFO - 'tpaint', 08:38:53 INFO - 'sessionrestore', 08:38:53 INFO - 'sessionrestore_no_auto_restore', 08:38:53 INFO - 'tabpaint']}, 08:38:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:53 INFO - 'ts_paint', 08:38:53 INFO - 'tpaint', 08:38:53 INFO - 'sessionrestore', 08:38:53 INFO - 'sessionrestore_no_auto_restore', 08:38:53 INFO - 'tabpaint']}, 08:38:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:38:53 INFO - 'ts_paint', 08:38:53 INFO - 'tpaint', 08:38:53 INFO - 'sessionrestore', 08:38:53 INFO - 'sessionrestore_no_auto_restore', 08:38:53 INFO - 'tabpaint']}, 08:38:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:38:53 INFO - 'ts_paint', 08:38:53 INFO - 'tpaint', 08:38:53 INFO - 'sessionrestore', 08:38:53 INFO - 'sessionrestore_no_auto_restore', 08:38:53 INFO - 'tabpaint']}, 08:38:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['a11yr', 08:38:53 INFO - 'ts_paint', 08:38:53 INFO - 'tpaint', 08:38:53 INFO - 'sessionrestore', 08:38:53 INFO - 'sessionrestore_no_auto_restore', 08:38:53 INFO - 'tabpaint']}, 08:38:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['a11yr', 08:38:53 INFO - 'ts_paint', 08:38:53 INFO - 'tpaint', 08:38:53 INFO - 'sessionrestore', 08:38:53 INFO - 'sessionrestore_no_auto_restore', 08:38:53 INFO - 'tabpaint']}, 08:38:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['tsvgx', 08:38:53 INFO - 'tsvgr_opacity', 08:38:53 INFO - 'tart', 08:38:53 INFO - 'tscrollx', 08:38:53 INFO - 'cart']}, 08:38:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:53 INFO - 'tsvgr_opacity', 08:38:53 INFO - 'tart', 08:38:53 INFO - 'tscrollx', 08:38:53 INFO - 'cart']}, 08:38:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'talos_options': ['--disable-e10s'], 08:38:53 INFO - 'tests': ['tp5o']}, 08:38:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'tests': ['tp5o']}, 08:38:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'talos_options': ['--disable-e10s', 08:38:53 INFO - '--xperf_path', 08:38:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:53 INFO - 'tests': ['tp5n']}, 08:38:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:53 INFO - 'talos_options': ['--xperf_path', 08:38:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:53 INFO - 'tests': ['tp5n']}}, 08:38:53 INFO - 'talos.zip': {'path': '', 08:38:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:53 INFO - Running post-action listener: _resource_record_post_action 08:38:53 INFO - ##### 08:38:53 INFO - ##### Finished populate-webroot step (success) 08:38:53 INFO - ##### 08:38:53 INFO - ##### 08:38:53 INFO - ##### Running create-virtualenv step. 08:38:53 INFO - ##### 08:38:53 INFO - Running pre-action listener: _resource_record_pre_action 08:38:53 INFO - Running main action method: create_virtualenv 08:38:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:53 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 08:38:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:53 INFO - Using real prefix '/usr' 08:38:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:56 INFO - Installing pip.................done. 08:38:56 INFO - Return code: 0 08:38:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:56 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')]} 08:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:56 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')]} 08:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:56 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:38:56 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 08:38:56 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 08:38:56 INFO - Using env: {'DISPLAY': ':0', 08:38:56 INFO - 'HOME': '/home/cltbld', 08:38:56 INFO - 'LANG': 'en_US.UTF-8', 08:38:56 INFO - 'LANGUAGE': 'en_US:en', 08:38:56 INFO - 'LOGNAME': 'cltbld', 08:38:56 INFO - 'MAIL': '/var/mail/cltbld', 08:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:56 INFO - 'MOZ_NO_REMOTE': '1', 08:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:56 INFO - 'NO_EM_RESTART': '1', 08:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:56 INFO - 'PWD': '/builds/slave/test', 08:38:56 INFO - 'SHELL': '/bin/bash', 08:38:56 INFO - 'SHLVL': '1', 08:38:56 INFO - 'TERM': 'linux', 08:38:56 INFO - 'TMOUT': '86400', 08:38:56 INFO - 'USER': 'cltbld', 08:38:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:56 INFO - '_': '/tools/buildbot/bin/python'} 08:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:56 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 08:38:56 INFO - Cleaning up... 08:38:56 INFO - Return code: 0 08:38:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:38:56 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')]} 08:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:56 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')]} 08:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:56 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:38:56 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 08:38:56 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 08:38:56 INFO - Using env: {'DISPLAY': ':0', 08:38:56 INFO - 'HOME': '/home/cltbld', 08:38:56 INFO - 'LANG': 'en_US.UTF-8', 08:38:56 INFO - 'LANGUAGE': 'en_US:en', 08:38:56 INFO - 'LOGNAME': 'cltbld', 08:38:56 INFO - 'MAIL': '/var/mail/cltbld', 08:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:56 INFO - 'MOZ_NO_REMOTE': '1', 08:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:56 INFO - 'NO_EM_RESTART': '1', 08:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:56 INFO - 'PWD': '/builds/slave/test', 08:38:56 INFO - 'SHELL': '/bin/bash', 08:38:56 INFO - 'SHLVL': '1', 08:38:56 INFO - 'TERM': 'linux', 08:38:56 INFO - 'TMOUT': '86400', 08:38:56 INFO - 'USER': 'cltbld', 08:38:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:56 INFO - '_': '/tools/buildbot/bin/python'} 08:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:56 INFO - Downloading/unpacking psutil>=3.1.1 08:38:56 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 08:38:56 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 08:38:56 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 08:38:56 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 08:38:56 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 08:38:56 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 08:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:58 INFO - Installing collected packages: psutil 08:38:58 INFO - Running setup.py install for psutil 08:38:58 INFO - building 'psutil._psutil_linux' extension 08:38:58 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 08:38:58 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 08:38:58 INFO - building 'psutil._psutil_posix' extension 08:38:58 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 08:38:58 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 08:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:59 INFO - Successfully installed psutil 08:38:59 INFO - Cleaning up... 08:38:59 INFO - Return code: 0 08:38:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:38:59 INFO - Using env: {'DISPLAY': ':0', 08:38:59 INFO - 'HOME': '/home/cltbld', 08:38:59 INFO - 'LANG': 'en_US.UTF-8', 08:38:59 INFO - 'LANGUAGE': 'en_US:en', 08:38:59 INFO - 'LOGNAME': 'cltbld', 08:38:59 INFO - 'MAIL': '/var/mail/cltbld', 08:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:59 INFO - 'MOZ_NO_REMOTE': '1', 08:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:59 INFO - 'NO_EM_RESTART': '1', 08:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:59 INFO - 'PWD': '/builds/slave/test', 08:38:59 INFO - 'SHELL': '/bin/bash', 08:38:59 INFO - 'SHLVL': '1', 08:38:59 INFO - 'TERM': 'linux', 08:38:59 INFO - 'TMOUT': '86400', 08:38:59 INFO - 'USER': 'cltbld', 08:38:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:59 INFO - '_': '/tools/buildbot/bin/python'} 08:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:01 INFO - Installing collected packages: mozsystemmonitor 08:39:01 INFO - Running setup.py install for mozsystemmonitor 08:39:01 INFO - Successfully installed mozsystemmonitor 08:39:01 INFO - Cleaning up... 08:39:01 INFO - Return code: 0 08:39:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:01 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:39:01 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 08:39:01 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 08:39:01 INFO - Using env: {'DISPLAY': ':0', 08:39:01 INFO - 'HOME': '/home/cltbld', 08:39:01 INFO - 'LANG': 'en_US.UTF-8', 08:39:01 INFO - 'LANGUAGE': 'en_US:en', 08:39:01 INFO - 'LOGNAME': 'cltbld', 08:39:01 INFO - 'MAIL': '/var/mail/cltbld', 08:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:01 INFO - 'MOZ_NO_REMOTE': '1', 08:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:01 INFO - 'NO_EM_RESTART': '1', 08:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:01 INFO - 'PWD': '/builds/slave/test', 08:39:01 INFO - 'SHELL': '/bin/bash', 08:39:01 INFO - 'SHLVL': '1', 08:39:01 INFO - 'TERM': 'linux', 08:39:01 INFO - 'TMOUT': '86400', 08:39:01 INFO - 'USER': 'cltbld', 08:39:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:01 INFO - '_': '/tools/buildbot/bin/python'} 08:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:01 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 08:39:01 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 08:39:01 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 08:39:01 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 08:39:01 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 08:39:01 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 08:39:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 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 08:39:03 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 08:39:04 INFO - Downloading docopt-0.6.1.tar.gz 08:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:04 INFO - Running setup.py install for blobuploader 08:39:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:04 INFO - Running setup.py install for requests 08:39:04 INFO - Running setup.py install for docopt 08:39:04 INFO - Successfully installed blobuploader requests docopt 08:39:04 INFO - Cleaning up... 08:39:04 INFO - Return code: 0 08:39:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:04 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:39:04 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 08:39:04 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 08:39:04 INFO - Using env: {'DISPLAY': ':0', 08:39:04 INFO - 'HOME': '/home/cltbld', 08:39:04 INFO - 'LANG': 'en_US.UTF-8', 08:39:04 INFO - 'LANGUAGE': 'en_US:en', 08:39:04 INFO - 'LOGNAME': 'cltbld', 08:39:04 INFO - 'MAIL': '/var/mail/cltbld', 08:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:04 INFO - 'MOZ_NO_REMOTE': '1', 08:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:04 INFO - 'NO_EM_RESTART': '1', 08:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:04 INFO - 'PWD': '/builds/slave/test', 08:39:04 INFO - 'SHELL': '/bin/bash', 08:39:04 INFO - 'SHLVL': '1', 08:39:04 INFO - 'TERM': 'linux', 08:39:04 INFO - 'TMOUT': '86400', 08:39:04 INFO - 'USER': 'cltbld', 08:39:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:04 INFO - '_': '/tools/buildbot/bin/python'} 08:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:05 INFO - Running setup.py (path:/tmp/pip-mgDZaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:05 INFO - Running setup.py (path:/tmp/pip-fCWWt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:05 INFO - Running setup.py (path:/tmp/pip-cwYAl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:05 INFO - Running setup.py (path:/tmp/pip-m4U4N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:05 INFO - Running setup.py (path:/tmp/pip-rhHcJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:05 INFO - Running setup.py (path:/tmp/pip-n_WPzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:05 INFO - Running setup.py (path:/tmp/pip-MuU3kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:05 INFO - Running setup.py (path:/tmp/pip-t1nXtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:05 INFO - Running setup.py (path:/tmp/pip-9GNYvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:05 INFO - Running setup.py (path:/tmp/pip-z5BPYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:05 INFO - Running setup.py (path:/tmp/pip-StUO37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:05 INFO - Running setup.py (path:/tmp/pip-LG4eYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:05 INFO - Running setup.py (path:/tmp/pip-AwLdCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:05 INFO - Running setup.py (path:/tmp/pip-p8Ayy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:06 INFO - Running setup.py (path:/tmp/pip-AFIjmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:06 INFO - Running setup.py (path:/tmp/pip-QPva4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:06 INFO - Running setup.py (path:/tmp/pip-OTyejD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:06 INFO - Running setup.py install for manifestparser 08:39:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:06 INFO - Running setup.py install for mozcrash 08:39:06 INFO - Running setup.py install for mozdebug 08:39:06 INFO - Running setup.py install for mozdevice 08:39:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:06 INFO - Running setup.py install for mozfile 08:39:06 INFO - Running setup.py install for mozhttpd 08:39:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:06 INFO - Running setup.py install for mozinfo 08:39:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:06 INFO - Running setup.py install for mozInstall 08:39:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Running setup.py install for mozleak 08:39:07 INFO - Running setup.py install for mozlog 08:39:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Running setup.py install for moznetwork 08:39:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Running setup.py install for mozprocess 08:39:07 INFO - Running setup.py install for mozprofile 08:39:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Running setup.py install for mozrunner 08:39:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:07 INFO - Running setup.py install for mozscreenshot 08:39:07 INFO - Running setup.py install for moztest 08:39:07 INFO - Running setup.py install for mozversion 08:39:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:08 INFO - Cleaning up... 08:39:08 INFO - Return code: 0 08:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:08 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')]} 08:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:08 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')]} 08:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:08 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:39:08 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 08:39:08 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 08:39:08 INFO - Using env: {'DISPLAY': ':0', 08:39:08 INFO - 'HOME': '/home/cltbld', 08:39:08 INFO - 'LANG': 'en_US.UTF-8', 08:39:08 INFO - 'LANGUAGE': 'en_US:en', 08:39:08 INFO - 'LOGNAME': 'cltbld', 08:39:08 INFO - 'MAIL': '/var/mail/cltbld', 08:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:08 INFO - 'MOZ_NO_REMOTE': '1', 08:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:08 INFO - 'NO_EM_RESTART': '1', 08:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:08 INFO - 'PWD': '/builds/slave/test', 08:39:08 INFO - 'SHELL': '/bin/bash', 08:39:08 INFO - 'SHLVL': '1', 08:39:08 INFO - 'TERM': 'linux', 08:39:08 INFO - 'TMOUT': '86400', 08:39:08 INFO - 'USER': 'cltbld', 08:39:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:08 INFO - '_': '/tools/buildbot/bin/python'} 08:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:08 INFO - Running setup.py (path:/tmp/pip-gOLljs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:08 INFO - Running setup.py (path:/tmp/pip-BC0rd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:08 INFO - Running setup.py (path:/tmp/pip-raEsmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:08 INFO - Running setup.py (path:/tmp/pip-gS8aFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:08 INFO - Running setup.py (path:/tmp/pip-4EGIWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:08 INFO - Running setup.py (path:/tmp/pip-UxS0i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:08 INFO - Running setup.py (path:/tmp/pip-H8zloM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:08 INFO - Running setup.py (path:/tmp/pip-VqcZyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:08 INFO - Running setup.py (path:/tmp/pip-XH9H9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:08 INFO - Running setup.py (path:/tmp/pip-jvD3Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:08 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)) 08:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:08 INFO - Running setup.py (path:/tmp/pip-Nyth7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:09 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)) 08:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:09 INFO - Running setup.py (path:/tmp/pip-avgMG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:09 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)) 08:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:09 INFO - Running setup.py (path:/tmp/pip-IRP4Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:09 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)) 08:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:09 INFO - Running setup.py (path:/tmp/pip-af20ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:09 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)) 08:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:09 INFO - Running setup.py (path:/tmp/pip-55h7ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:09 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)) 08:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:09 INFO - Running setup.py (path:/tmp/pip-ixW6aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:09 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)) 08:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:09 INFO - Running setup.py (path:/tmp/pip-l3wwEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:09 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)) 08:39:09 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)) 08:39:09 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)) 08:39:09 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)) 08:39:09 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)) 08:39:09 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)) 08:39:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:11 INFO - Downloading blessings-1.6.tar.gz 08:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:11 INFO - Installing collected packages: blessings 08:39:11 INFO - Running setup.py install for blessings 08:39:11 INFO - Successfully installed blessings 08:39:11 INFO - Cleaning up... 08:39:11 INFO - Return code: 0 08:39:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:11 INFO - Reading from file tmpfile_stdout 08:39:11 INFO - Current package versions: 08:39:11 INFO - argparse == 1.2.1 08:39:11 INFO - blessings == 1.6 08:39:11 INFO - blobuploader == 1.2.4 08:39:11 INFO - docopt == 0.6.1 08:39:11 INFO - manifestparser == 1.1 08:39:11 INFO - mozInstall == 1.12 08:39:11 INFO - mozcrash == 0.17 08:39:11 INFO - mozdebug == 0.1 08:39:11 INFO - mozdevice == 0.48 08:39:11 INFO - mozfile == 1.2 08:39:11 INFO - mozhttpd == 0.7 08:39:11 INFO - mozinfo == 0.9 08:39:11 INFO - mozleak == 0.1 08:39:11 INFO - mozlog == 3.2 08:39:11 INFO - moznetwork == 0.27 08:39:11 INFO - mozprocess == 0.22 08:39:11 INFO - mozprofile == 0.28 08:39:11 INFO - mozrunner == 6.11 08:39:11 INFO - mozscreenshot == 0.1 08:39:11 INFO - mozsystemmonitor == 0.3 08:39:11 INFO - moztest == 0.7 08:39:11 INFO - mozversion == 1.4 08:39:11 INFO - psutil == 3.1.1 08:39:11 INFO - requests == 1.2.3 08:39:11 INFO - wsgiref == 0.1.2 08:39:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:11 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:39:11 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 08:39:11 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 08:39:11 INFO - Using env: {'DISPLAY': ':0', 08:39:11 INFO - 'HOME': '/home/cltbld', 08:39:11 INFO - 'LANG': 'en_US.UTF-8', 08:39:11 INFO - 'LANGUAGE': 'en_US:en', 08:39:11 INFO - 'LOGNAME': 'cltbld', 08:39:11 INFO - 'MAIL': '/var/mail/cltbld', 08:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:11 INFO - 'MOZ_NO_REMOTE': '1', 08:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:11 INFO - 'NO_EM_RESTART': '1', 08:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:11 INFO - 'PWD': '/builds/slave/test', 08:39:11 INFO - 'SHELL': '/bin/bash', 08:39:11 INFO - 'SHLVL': '1', 08:39:11 INFO - 'TERM': 'linux', 08:39:11 INFO - 'TMOUT': '86400', 08:39:11 INFO - 'USER': 'cltbld', 08:39:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:11 INFO - '_': '/tools/buildbot/bin/python'} 08:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 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)) 08:39:12 INFO - Cleaning up... 08:39:12 INFO - Return code: 0 08:39:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39:12 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')]} 08:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:12 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')]} 08:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:12 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:39:12 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 08:39:12 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 08:39:12 INFO - Using env: {'DISPLAY': ':0', 08:39:12 INFO - 'HOME': '/home/cltbld', 08:39:12 INFO - 'LANG': 'en_US.UTF-8', 08:39:12 INFO - 'LANGUAGE': 'en_US:en', 08:39:12 INFO - 'LOGNAME': 'cltbld', 08:39:12 INFO - 'MAIL': '/var/mail/cltbld', 08:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:12 INFO - 'MOZ_NO_REMOTE': '1', 08:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:12 INFO - 'NO_EM_RESTART': '1', 08:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:12 INFO - 'PWD': '/builds/slave/test', 08:39:12 INFO - 'SHELL': '/bin/bash', 08:39:12 INFO - 'SHLVL': '1', 08:39:12 INFO - 'TERM': 'linux', 08:39:12 INFO - 'TMOUT': '86400', 08:39:12 INFO - 'USER': 'cltbld', 08:39:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:12 INFO - '_': '/tools/buildbot/bin/python'} 08:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:12 INFO - Downloading/unpacking jsonschema 08:39:12 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 08:39:12 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 08:39:12 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 08:39:12 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 08:39:12 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 08:39:12 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 08:39:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:14 INFO - warning: no files found matching '*.txt' 08:39:14 INFO - no previously-included directories found matching 'build' 08:39:14 INFO - no previously-included directories found matching 'dist' 08:39:14 INFO - no previously-included directories found matching '.git*' 08:39:14 INFO - Installing collected packages: jsonschema, functools32 08:39:14 INFO - Running setup.py install for functools32 08:39:14 INFO - warning: no files found matching '*.txt' 08:39:14 INFO - no previously-included directories found matching 'build' 08:39:14 INFO - no previously-included directories found matching 'dist' 08:39:14 INFO - no previously-included directories found matching '.git*' 08:39:14 INFO - Successfully installed jsonschema functools32 08:39:14 INFO - Cleaning up... 08:39:14 INFO - Return code: 0 08:39:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:14 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 0x7f6e98b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ca770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', '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 08:39:14 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 08:39:14 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 08:39:14 INFO - Using env: {'DISPLAY': ':0', 08:39:14 INFO - 'HOME': '/home/cltbld', 08:39:14 INFO - 'LANG': 'en_US.UTF-8', 08:39:14 INFO - 'LANGUAGE': 'en_US:en', 08:39:14 INFO - 'LOGNAME': 'cltbld', 08:39:14 INFO - 'MAIL': '/var/mail/cltbld', 08:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:14 INFO - 'MOZ_NO_REMOTE': '1', 08:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:14 INFO - 'NO_EM_RESTART': '1', 08:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:14 INFO - 'PWD': '/builds/slave/test', 08:39:14 INFO - 'SHELL': '/bin/bash', 08:39:14 INFO - 'SHLVL': '1', 08:39:14 INFO - 'TERM': 'linux', 08:39:14 INFO - 'TMOUT': '86400', 08:39:14 INFO - 'USER': 'cltbld', 08:39:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:14 INFO - '_': '/tools/buildbot/bin/python'} 08:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:14 INFO - Downloading/unpacking flake8 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 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 08:39:14 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 08:39:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:39:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:39:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:39:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:17 INFO - no previously-included directories found matching 'docs/_build' 08:39:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:39:17 INFO - Running setup.py install for pep8 08:39:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:17 INFO - no previously-included directories found matching 'docs/_build' 08:39:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:39:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:39:17 INFO - Cleaning up... 08:39:17 INFO - Return code: 0 08:39:17 INFO - Running post-action listener: _resource_record_post_action 08:39:17 INFO - Running post-action listener: _start_resource_monitoring 08:39:17 INFO - Starting resource monitoring. 08:39:17 INFO - ##### 08:39:17 INFO - ##### Finished create-virtualenv step (success) 08:39:17 INFO - ##### 08:39:17 INFO - ##### 08:39:17 INFO - ##### Running install step. 08:39:17 INFO - ##### 08:39:17 INFO - Running pre-action listener: _resource_record_pre_action 08:39:17 INFO - Running main action method: install 08:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:18 INFO - Reading from file tmpfile_stdout 08:39:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:18 INFO - Reading from file tmpfile_stdout 08:39:18 INFO - Output received: 08:39:18 INFO - Usage: mozinstall [options] installer 08:39:18 INFO - Options: 08:39:18 INFO - -h, --help show this help message and exit 08:39:18 INFO - -d DEST, --destination=DEST 08:39:18 INFO - Directory to install application into. [default: 08:39:18 INFO - "/builds/slave/test"] 08:39:18 INFO - --app=APP Application being installed. [default: firefox] 08:39:18 INFO - mkdir: /builds/slave/test/build/application 08:39:18 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'] 08:39:18 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 08:39:33 INFO - Reading from file tmpfile_stdout 08:39:33 INFO - Output received: 08:39:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:39:33 INFO - Running post-action listener: _resource_record_post_action 08:39:33 INFO - ##### 08:39:33 INFO - ##### Finished install step (success) 08:39:33 INFO - ##### 08:39:33 INFO - ##### 08:39:33 INFO - ##### Running run-tests step. 08:39:33 INFO - ##### 08:39:33 INFO - Running pre-action listener: _resource_record_pre_action 08:39:33 INFO - Running main action method: run_tests 08:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:33 INFO - Python 2.7.3 08:39:33 INFO - Return code: 0 08:39:33 INFO - grabbing minidump binary from tooltool 08:39:33 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')]} 08:39:33 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 0x18599c0>, '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 0x185a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:33 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 08:39:33 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 08:39:33 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 08:39:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:34 INFO - Return code: 0 08:39:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:39:34 INFO - Return code: 0 08:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:39:34 INFO - Using env: {'DISPLAY': ':0', 08:39:34 INFO - 'HOME': '/home/cltbld', 08:39:34 INFO - 'LANG': 'en_US.UTF-8', 08:39:34 INFO - 'LANGUAGE': 'en_US:en', 08:39:34 INFO - 'LOGNAME': 'cltbld', 08:39:34 INFO - 'MAIL': '/var/mail/cltbld', 08:39:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:34 INFO - 'MOZ_NO_REMOTE': '1', 08:39:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:34 INFO - 'NO_EM_RESTART': '1', 08:39:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:34 INFO - 'PWD': '/builds/slave/test', 08:39:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:34 INFO - 'SHELL': '/bin/bash', 08:39:34 INFO - 'SHLVL': '1', 08:39:34 INFO - 'TERM': 'linux', 08:39:34 INFO - 'TMOUT': '86400', 08:39:34 INFO - 'USER': 'cltbld', 08:39:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225', 08:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:34 INFO - '_': '/tools/buildbot/bin/python'} 08:39:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:39:35 INFO - mozversion application_buildid: 20160601075442 08:39:35 INFO - mozversion application_changeset: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 08:39:35 INFO - mozversion application_display_name: Nightly 08:39:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:35 INFO - mozversion application_name: Firefox 08:39:35 INFO - mozversion application_remotingname: firefox 08:39:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:39:35 INFO - mozversion application_vendor: Mozilla 08:39:35 INFO - mozversion application_version: 49.0a1 08:39:35 INFO - mozversion platform_buildid: 20160601075442 08:39:35 INFO - mozversion platform_changeset: 5d2cb7fff024a1d3ed59ad2432882d158ce5ee91 08:39:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:39:35 INFO - mozversion platform_version: 49.0a1 08:39:35 INFO - using testdate: 1464795575 08:39:35 INFO - actual date: 1464795575 08:39:35 INFO - starting webserver on 'localhost:48646' 08:39:35 INFO - SUITE-START | Running 2 tests 08:39:35 INFO - TEST-START | dromaeo_css 08:39:35 INFO - operating with platform_type : linux_ 08:39:35 INFO - Initialising browser for dromaeo_css test... 08:39:35 INFO - TEST-INFO | started process 24009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6poCXN/profile http://localhost:48646/getInfo.html) 08:39:39 INFO - PROCESS | 24009 | __metrics Screen width/height:1600/1200 08:39:39 INFO - PROCESS | 24009 | colorDepth:24 08:39:39 INFO - PROCESS | 24009 | Browser inner width/height: 1024/697 08:39:39 INFO - PROCESS | 24009 | __metrics 08:39:40 ERROR - PROCESS | 24009 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:39:41 INFO - TEST-INFO | 24009: exit 0 08:39:41 INFO - Browser initialized. 08:39:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:41 INFO - TEST-INFO | started process 24091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6poCXN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:53 INFO - PROCESS | 24091 | RSS: Main: 157589504 08:39:53 INFO - PROCESS | 24091 | 08:40:44 INFO - PROCESS | 24091 | 1464795644783 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] 08:42:56 INFO - PROCESS | 24091 | Cycle 1(1): loaded http://localhost:48646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48646/tests/dromaeo/cssquery-ext.html) 08:42:57 INFO - PROCESS | 24091 | RSS: Main: 242368512 08:42:57 INFO - PROCESS | 24091 | 08:45:59 INFO - PROCESS | 24091 | Cycle 1(1): loaded http://localhost:48646/tests/dromaeo/cssquery-ext.html (next: http://localhost:48646/tests/dromaeo/cssquery-jquery.html) 08:46:00 INFO - PROCESS | 24091 | RSS: Main: 242401280 08:46:00 INFO - PROCESS | 24091 | 08:49:02 INFO - PROCESS | 24091 | Cycle 1(1): loaded http://localhost:48646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48646/tests/dromaeo/cssquery-mootools.html) 08:49:02 INFO - PROCESS | 24091 | RSS: Main: 245194752 08:49:02 INFO - PROCESS | 24091 | 08:52:05 INFO - PROCESS | 24091 | Cycle 1(1): loaded http://localhost:48646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48646/tests/dromaeo/cssquery-prototype.html) 08:52:05 INFO - PROCESS | 24091 | RSS: Main: 227229696 08:52:05 INFO - PROCESS | 24091 | 08:55:08 INFO - PROCESS | 24091 | Cycle 1(1): loaded http://localhost:48646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48646/tests/dromaeo/cssquery-yui.html) 08:55:09 INFO - PROCESS | 24091 | RSS: Main: 212844544 08:55:09 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | Cycle 1(1): loaded http://localhost:48646/tests/dromaeo/cssquery-yui.html (next: http://localhost:48646/tests/dromaeo/cssquery-dojo.html) 08:58:12 INFO - PROCESS | 24091 | RSS: Main: 271695872 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | __start_tp_report 08:58:12 INFO - PROCESS | 24091 | _x_x_mozilla_page_load 08:58:12 INFO - PROCESS | 24091 | _x_x_mozilla_page_load_details 08:58:12 INFO - PROCESS | 24091 | |i|pagename|runs| 08:58:12 INFO - PROCESS | 24091 | |0;dojo.html;2617.2410001099674;2641.498115358083;2670.3724624713195;2687.556553168727;2694.975909154521;4496.707713998588;4542.545745425456;4551.4765801932745;4607.17070927233;4679.251319788835;4565.931511027337;4576.725396476214;4598.862034138972;4653.720776753397;4660.067986402716;4025.1547175093265;4154.833806647738;4245.10852720929;4275.7434553926705;4384.912301753963;4270.081932384537;4335.132973405316;4343.109662519192;4347.13057388522;4379.321205213197;4139.8965025874295;4153.376993450976;4177.5613560576;4178.39413285072;4233.23801715691;4186.392973018896;4197.244495990721;4225.366195070733;4251.213525497793;4259.595338442843;4248.851290204828;4253.064325848309;4263.381809637585;4271.1671224111315;4281.379200016011;4395.1429471252795;4462.620677242438;4506.774661266923;4522.8643140705835;4537.478190008158;4970.2793095001025;5023.799048038074;5027.572656324217;5035.59715222785;5046.44489106198;4824.758762061883;5054.9494505054845;5075.061113693979;5083.364579427572;5091.974540127313;4580.839670611546;4645.512221216791;4656.813727450898;4695.624350051988;4703.412073490814;5157.742112894341;5161.329027226437;5161.845144645667;5165.715885626251;5179.482051794866;4766.118268120339;4845.6123510119105;4951.950480495221;4956.132676781549;4959.603231741524;4965.155923493015;4965.453800081988;4991.176455884811;5000.174971129795;5031.547160755549;4922.310876477296;4929.87675308113;4932.334134891744;4936.481669424658;4997.525235102659;4771.5467030632035;4901.313816065754;4918.852434426973;4935.3090567320605;4975.776090075955;4341.717788343748;4354;4357.4988876279;4374;4394.1651086293505;3766.322062028806;3793.1275806564645;3800.4299355096405;3817.5609804872797;3818.4463252828186;4197.664186865105;4229.598188172119;4264.616184543406;4299.505556860939;4351.73889566627;4983.07813054586;5010.599152067826;5026.1204289249235;5052.317937078521;5059;4328.415663885336;4339.240632889232;4342.891427714269;4347.130573885172;4365.454318210223;4411.889702757457;4486.910261794811;4498.572635599613;4518.593326600556;4536.206163921301;4672.509386514367;4684.273937539687;4686.297055441711;4686.36734040907;4741.5021422750115;4991.625628077836;4993.051320249141;4994.600431965507;4996.075725990703;5024.522670346311;4609.976950115362;4613.953860461353;4633.073385322881;4662.720236785668;4676.859694209179;4863.4650188479945;4864.513548645107;4898.632602554894;4911.361523001987;4951.405831300267;4875.43932447773;4946.0355230729665;4977.800887964441;4985.700857948535;4992.650514463952;4761.119192949315;4803.375561177025;4806.2310030394965;4834.63740219492;4838.588719958843;4803.063402636592;4832.8791780205775;4833.492483289204;4849.539293767087;4888.437829649636;4577.908441831211;4693.366395536559;4778.474367819467;4786.114568804643;4821.276808478756;4782.163121453801;4810.158222311152;4819.807207711652;4830.203016502378;4877;4724.009987167844;4726;4726.480087190475;4730.692504987165;4773.140834649657 08:58:12 INFO - PROCESS | 24091 | |1;ext.html;542.7260324941088;579.7680927628945;590.769599856056;598.1685457214471;602.5781952633157;28443.431131377387;31209.68790312096;31223;31238.84380578094;31272.843635781846;44130;45264.54735452645;45362.09275814482;45391;45474.99999999992;7572.204918483576;7723.150453450116;7725.961370193141;7736.265054819812;7736.34241089508;7611.086669599656;7713.228677132298;7713.8842917356005;7718.729844455445;7722.189170137139;7689.615519224044;7696.345810606105;7748.922510774876;7759;7759.806004849867;7654.272844079804;7661.080670319569;7708.768736937901;7711.228877112272;7718.845623087563;7620.352270057052;7669;7679.500832445929;7687.884681729778;7690.846183076363;38970.41544376837;39367;39396;39398;39449.802750986346;3028.787984841062;3045.284358175849;3385.458326667746;3704.2961837251105;3764.0966168119726;27293.454130917467;29241.561376579368;29769.851150744107;29771.70228297711;29966;3258.9359125767887;3527.294541091792;3530.9117272068147;3588.982055089734;3589.964100358989;243156;245343;246523;248091.75954120295;248336;55155.72422137864;55437.72281138649;55465.722671386386;55565;55694.16458753122;32776.50835237473;33752.49371259433;33801.492977605354;35553.8222308892;35564.46653300203;14554;14583.489577864935;14663.413463461342;14668.853311466748;14673.119612823264;11107.55569777216;11160.553577856957;11164.553417863195;11166.609168679057;11168.66494005181;18573.90713046426;18640.34758783436;18693.906530467262;18769.155388007573;18818.529536761416;6947.4789390795895;7009.824754381181;7051.647417629098;7118.60847653384;7222.638868056576;822.576373167819;957.621739412928;979.5494072726483;998.1465846701111;999.6601155606983;27534.714953597144;27820;28057.765988800536;28195.295117622223;28384.148475545768;802.3300544045787;960.9279304052224;963.4267610771719;973.7955029443896;1002.1882275356984;15032.323545440482;15041.849581504264;15157.848421515864;15309.387624495119;15321.310541025681;375363;379162;379569;380236;380246;48106;48441;48635;48688.02623947572;48751;1091.1325496230515;1178.528588564581;1215.1918973882268;1231.8213858990396;1244.116677159209;27666.170014899584;28149.859250703616;28813.71186288194;28874;29104.126876193746;40383.79808100941;40666;40845.1830963385;40950.38574421446;40972.3854142194;238560;238810;238941;239148;239223;21830.126794928026;23885.402864928517;24835.875820620782;25012;26123.346916327242;41075;41291.38062928998;41296;42000.369994449495;42228.36657450079;34502;35271.823640882656;35475.29049418945;35558.46662300016;35613.64386356207;34884.82557587196;35214.82392588123;35582;35602.8219858899;35869.82065089658;34969.99210710457;35107.29785404226;35397.64602353943;35435;35599.64400355963;31317.217069573442;31746.841265793522;31977.520337195427;32276.83861580677;32446;23789.405264868517;25386.365340866625;25403.016639399804;25549.105781297567;25645 08:58:12 INFO - PROCESS | 24091 | |2;jquery.html;371.34272337961806;373.43984023964055;381.99999999999983;386.22754491017963;386.7176960818601;15761.842381576182;16620.25208865601;16816.831831681695;16991.57521061974;17138.571535711613;16327.428540001103;17021.148942552885;17420.56448588786;17434.47696569105;17436.476905692816;4890.926636100461;5084.745762711868;5174.275601415805;5181.844544663666;5183.352080989876;3636.981815090934;3806.143617686026;5050.696958182502;5787.421257874221;6124.5100391968535;6134.110553969672;6139.508839292846;6174.228221472316;6175.011998080308;6179;5875.618084824473;6038.27540695115;6051.152838602599;6109.266887973449;6122.448979591836;3330.983345083259;5050.772715227787;5291.973540132275;5330.413654498002;5342.545883599899;19717.901410493;20325.390238292875;20340.89829550843;20402.69395959062;20484.897575512026;1981.7621885373846;2220.411590928405;2278.362058623588;2345.976540234593;2506.7743903048813;12528.123031387806;12794.87205127946;12900.225986440844;13024.934875325564;13448.394822233024;1721.7847769028872;1751.5183324585714;1785.0360805165196;1785.3394244129754;1897.3264491105597;65156.3484365155;67610.32389676089;67764.32235677629;67792.66103669499;68715.65642171807;9010.59452324647;9455.52722363879;9707.854382184272;9819.06718861707;9865.130247502724;12992.740145197233;13226.669333266553;13228.801567976489;13246.933765331112;13248;7315.195328513859;7318.194998550155;7470.663820128108;7566.924330756732;7587.734429295058;6814.727410903607;6816.318368163144;7089.22018577956;7149.177844547839;7362.705491780376;6001.849953751192;6107.389261073946;6127.295361033449;6157.384261573897;6234.438900498886;1637.1814092953523;1708.2227586448137;1723.2331612432347;1762.409592786431;1769.9557511062326;858.4076986879033;881.2069137775925;933.0203286549096;959.6593209410559;975.3855071305175;16011.759823602655;16976.151192440328;17031.744523832152;17112.91443542774;17608.471745847644;900.8288425199191;922.1331947969022;949.2074118111454;956.2159029595665;962.2975228083538;9113.908860911439;9512.38169518979;9515.524223788783;9688.176504997155;9737.221022318197;406438;407673;408384;411474;412898;76709.6164519185;77591.61204194056;78244.60877695575;78405.2159478398;78444;938.7606160429184;950.2587981374539;956.4787190980932;959.9184069354183;966.7728083900278;15005.549833505012;15160.545183644508;15310;15336.079835209923;15569.688606227586;33141.33717325592;34537.65462345445;34894.476582851785;35020.82489587536;35363.29273414569;45396.31905521486;47545.762271188425;48476;49683;49904;7275.890861636974;7420.332170104716;7424.925750742424;7451.701931922662;7594.658240379306;6398.936010639834;7653.961730191313;9355.625774969198;10348.223883208639;10389.272750907667;5374.516293533601;9019.684311049083;9190.85114360705;9236.445813251226;9308.627654893728;8811.162939520735;8937.329700272376;9077.09229077087;9140.542972851197;9318.95340523293;8950.328725345755;9294.674686386215;9454.290928180277;9574.090461406155;9648.614055437703;7087.7164913402885;7269.236730143259;7361.1166660001145;7383.556986580822;7463.514871533333;9075;9289;9374.625014999596;9471.573779180091;9520.952395238257 08:58:12 INFO - PROCESS | 24091 | |3;mootools.html;1227.3863068465766;1397.5457976157747;1426.6076828872058;1507.773833924911;1721.2770636332732;6700.296468870765;7596.544207347556;7746.883796743039;7881.7241396551135;7975.800604984878;7749.186335434782;7836.373090152789;7843.294103530681;7849.45053846231;7850.214978502147;1890.4990177602947;2165.415337858777;2204.1293688992837;2205.7353117625826;2247.752747197815;2282.7032485776826;2309.2033248529315;2310.5263420998654;2312.6877871487386;2317.2584772872688;2174.4781252499442;2185.4208634711813;2192.331338941622;2198.087793565668;2205.040807248844;1848.833604975552;2109.156337465011;2170.0994087453687;2189.4854709143337;2192.473806286496;2186.5736181444627;2207.315732123047;2213.9335819925427;2214.2360885494477;2217.5786600545844;7861.921380786233;7894.802629934297;7920.405969552249;7920.405969552249;7923.405744569122;4469.374287599739;4623.953760462386;4626.30605409188;4628.8148474061;4648.2562789953445;2842.6020357150014;2851.244420228641;2995.4907665696664;3009.7893147479685;3025.3344264261827;928.7399528132133;930.8464103422928;930.9487978161198;940.431039221275;948.4972964328916;10760.73098172544;10788.08301294391;10832.350058996406;10834.295770774954;10849.186311026626;4279.358096285582;4401.339799030107;4435.733855968652;4443.044745379694;4471.7987690554;9336.206422454168;9370.39092458988;9390.906090939003;9401;9409.106134917172;4609.516000819933;4624.468186158568;4625.653076019312;4634.606058485067;4638.2115040443205;3633.818309084535;3913.25648126855;4070.3487442009136;4072.6131017553284;4073.6944729145434;3634.1823089804584;3736.1967177057063;3798.7340886137704;3807.5430948286385;3842.8270727817317;1197.5868325427714;1207.5169932027259;1214.8056310990376;1216.8904798568171;1235.092207227687;724.4675163754636;851.8253757979724;866.4324867211986;872.0407551693087;888.1340692824444;5091.41448733393;5130.48695130484;5144.845654630367;5262.97368513155;5318.282031925718;410.05948274614514;426.1583372838619;431.5533422907276;433.2980571474169;446.4196544492147;3463.4631632097066;3595.388783906742;3647.562292524861;3700.6854417374825;3720.2187540616774;9245.121713437213;9576.664816731382;9609.951950240204;9643.324967252365;9692.660756873476;9465;9465.810683786285;9476.241900647932;9476.763080922894;9547.52262386878;7029.332213439715;7326.084239470067;7328.9267107329315;7455.776326710099;7457.5898325591525;5425.186222066722;5511.944880551304;5714.5999780015;5775.33583637887;5850.5904586678525;8774;8943.821123577622;9047.366684332033;9124.133207345292;9205;8964.775880602776;9232.538373081454;9274.95362523183;9286.117818807203;9347.298952578447;6186.659733714689;6688.431483323972;6823.69293381809;6940.305969403221;7019.438444924496;7597.772066838003;7601.619919003917;7635.350995165473;7636.427267954815;7639.579823109782;6748.7300507979135;6864.48516361265;6875.965620171867;6966.12923384577;6969.686364113729;6796.388325050769;6796.864062718817;6851.3491218334175;6868.175818901764;6912.792616221522;6012.909806352821;6071.908921366271;6129.816105516842;6251.593646412968;6416.422521972858;4783.258594917794;4813.374261346143;4835.516448355136;4863.148948933993;4874.926876096933;4718.504557021463;4735.431748190102;4777.617790576676;4810.63920205993;4847.345608342828 08:58:12 INFO - PROCESS | 24091 | |4;prototype.html;303.8222639755743;307.6308429884138;312.6295340022075;315.75844478973573;316.69122605459665;4691.929621055682;4758.952410475894;4788.856334309972;4796.11271914696;4800.543948324912;4649.535046495349;4689.249720044793;4691.577758001779;4696.248600223965;4707.62339012879;3551.1122219445137;3652.1600031992657;3670.7063434925144;3751.4560388743616;3791.146991926822;3729.9813500932455;3762.454444105603;3768.1333293342545;3777.5655799583124;3802.8478860845535;3557.092941299965;3729.1982223821874;3748.269087527933;3771.6039815819354;3772.79249641271;3619.782813031213;3739.7943113128767;3753.7560058596378;3758.7932663703486;3775.546934367866;3318.96681033189;3319.1038419626566;3322.8670853165845;3326.567546218976;3341.18141055443;4455.17579247837;4460.1971645104195;4468.955310446887;4522.8643140705835;4534.752942940685;4002.2595819773146;4206.558311377292;4211.368294755811;4301.989032577342;4308.719933204332;4895.363602731658;4910;4925.75371231437;4935.950640493585;4969.701817890902;3541.645835416438;3541.8406171722336;3547.4324108142573;3558.1460449492192;3566.7681600695873;5010.448850626428;5150.356205474353;5201.427842937312;5209.270702101709;5216.686998780086;3601.9108916828177;3623.7463377563845;3624.401973674367;3626.202235508184;3643.1802844360336;3663.377225871608;3664.2151964507166;3673.4673472346362;3679.466477360821;3680.981595092061;4186.602272784081;4189.539150693421;4217.62041416274;4224.598663126998;4228.429162063082;4770.356001939763;4962.950370496249;4970.602351811846;4975.477574854661;4978.103941290602;1253.6113804720383;1254.1095821966323;1273;1273.2996851731511;1275.1329096214663;820.8522465956066;821.4619424276989;855.2388374346837;877.8902637170354;878.6529320918202;4359.869203923888;4381.452318460192;4395.516493185747;4401.965538098544;4410.338449232577;5048.7728052237;5068.949310506848;5074.847754567369;5097.541221290102;5140.974295128575;4188.895277618023;4330.653547716175;4347.891302717394;4388.363687265329;4395.340698895191;2697.770689491376;2700.9054683085997;2724.209979106037;2724.433450765778;2732.0847516082335;4782.378290822171;4789.970156416387;4798.95201047992;4833.293355720808;4844.249141383091;5018.473060328686;5122.718250496258;5195.766190521435;5204.375474942955;5212.853172302088;4766.165920963817;4772.141014617471;4772.49888761682;4786.928196077061;4787.234042553175;5070.290159377616;5073.463268365817;5088.160453525127;5100.38795344561;5114.079465696211;4820.180569303297;4904.705717656952;4935.235038569028;5002.149634562061;5002.799888004439;4709.481956984798;4740.407449068866;4753.595944344631;4786.2581299898575;4798.376211092535;3577.195131095483;3595.946060809142;3596.0470475323536;3598.85604575814;3603.8017909015257;4878.78045487961;5030.84907452777;5034.766482211881;5101.744912754421;5107.974460127675;4890.559849613552;4902.754862256944;4903.950960490492;4912.238603016538;4923.507649235048;4814.15752243349;4864.148773964472;4918.852434426973;4920;4921.188003979303;4697.741624210701;4803.639727020557;4860.1251774680895;4870.172070747911;4876.07435538674;4735.928961065656;4835.854924352275;4907.533784290486;4913.975430122827;4959.404871415453;4813.78337974785;4835.516448355136;4855.490173531728;4862.298195631501;4873.659743570546 08:58:12 INFO - PROCESS | 24091 | |5;yui.html;664.2062735031639;711.2425267090549;720.4488566246819;758.5410826449996;795.7175202803005;11068.557257709692;12215.694607634814;12399.256044637328;12411.379431028436;12437.62687119388;12216.511339546407;12486.12597118202;12648.177868438568;12748.80876786849;12757.553485628005;629.9401556852092;776.0183368039435;792.3977776889562;802.3821657323857;807.2532907060975;793.9285464308211;799.9160088190744;802.9076656184526;803.0764620686199;803.5901690138013;840.7477756673004;841.9031811341713;842.9957850210772;843.5065486690294;843.5782108945527;658.5653468710676;811.3955103447969;834.7913021744564;844;844.2823599940064;592.2862950145064;594.2215697436372;595.2262059322907;595.2886300870462;597.1758972617803;10984;10985.890141098567;10986.285891417032;10990.725231869188;10994.395308258043;11943.283402995849;12354.38228088592;12355.567555135616;12536.749265014649;12595.118341716083;9510.09654082861;9602.66390676323;9757.951210243904;9776.706698799047;11164.665060048212;4148.253314403406;4152.273352163359;4201.390798334224;4202.495700515958;4258.53156152823;41746.58253417457;41874.1625167498;42232.57767422317;42271.577284227074;42335.57664423347;9624.230061595055;9637.18083962857;9865.408075515492;9895.455749933679;9925.255605829592;16948.322067117424;16994.49016529506;16995.490135295713;17006;17042.914785425994;6385.904211436832;6447.645379504079;6614.669266536654;6615.735370585219;6686.3313668632745;3372.443546814748;3522.5244591979754;3613.33153366628;3641.016925430119;3715;2790.5116604594114;2849.430113977213;2861.9856900715363;2865.1547793400996;2867.139858042579;526.5629527492172;537.0842713174029;546.9371022332404;548.7256371814093;550.3176061683564;402.73620778389613;448.8698277499554;528.7435593737034;622.4864486798409;631.7788773929088;7856.803579910434;7993.160718124514;8130.665708238494;8243.546604936786;8318.70884519039;566.3713278261126;570.7146426786607;574.5288863132191;580.3413126101905;604.2597817673403;3671;3735.813209339522;3754.3617585010616;3765.7175711821724;3773.64150405711;51678.48321516737;51888;55322;56669;58624.706876466196;46233.53766462292;48158;49430.75284623626;50456.243156352684;50622;47496.5250347499;48228.035439291016;48968.265476017885;49081.263781043315;49683.503164967886;8506.78733031679;8548.615312311085;8710.69512567057;8791;8832.337574682053;30640.387192255585;31230.843845781535;31602.367952641278;32180.35639287248;32574.34851303008;38385.808070959465;40827.7958610205;40873.38689919713;41408;41656.3751543721;10874.456277186267;11131.554737810397;11250.659315505924;11828.23116497425;12290.877091228973;11882.940585297018;11985.995675718454;12524.37378131108;12663.430145643284;12880.806787898002;11328.433578320886;11658;12014;12050.879491204976;12175.269483830998;11575.363355015555;11580.594679186188;11697.532098715956;11882.76234475323;12004.2197257178;11118.555257789598;11335.433228338716;11780.469878855301;11797.88202117968;11811.468483918072;8604.354673399395;8703.47779133254;8898.822023559622;8948.642054318016;9374.906250937676;9767.609295628095;9838.9016109838;9864.013598640078;9866.408015519091;10023.097921187129 08:58:12 INFO - PROCESS | 24091 | __end_tp_report 08:58:12 INFO - PROCESS | 24091 | __start_cc_report 08:58:12 INFO - PROCESS | 24091 | _x_x_mozilla_cycle_collect,871 08:58:12 INFO - PROCESS | 24091 | __end_cc_report 08:58:12 INFO - PROCESS | 24091 | __startTimestamp1464796692623__endTimestamp 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | ------- Summary: start ------- 08:58:12 INFO - PROCESS | 24091 | Number of tests: 6 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | [#0] dojo.html Cycles:165 Average:4593.06 Median:4686.37 stddev:470.46 (10.0%) stddev-sans-first:445.64 08:58:12 INFO - PROCESS | 24091 | Values: 2617.2 2641.5 2670.4 2687.6 2695.0 4496.7 4542.5 4551.5 4607.2 4679.3 4565.9 4576.7 4598.9 4653.7 4660.1 4025.2 4154.8 4245.1 4275.7 4384.9 4270.1 4335.1 4343.1 4347.1 4379.3 4139.9 4153.4 4177.6 4178.4 4233.2 4186.4 4197.2 4225.4 4251.2 4259.6 4248.9 4253.1 4263.4 4271.2 4281.4 4395.1 4462.6 4506.8 4522.9 4537.5 4970.3 5023.8 5027.6 5035.6 5046.4 4824.8 5054.9 5075.1 5083.4 5092.0 4580.8 4645.5 4656.8 4695.6 4703.4 5157.7 5161.3 5161.8 5165.7 5179.5 4766.1 4845.6 4952.0 4956.1 4959.6 4965.2 4965.5 4991.2 5000.2 5031.5 4922.3 4929.9 4932.3 4936.5 4997.5 4771.5 4901.3 4918.9 4935.3 4975.8 4341.7 4354.0 4357.5 4374.0 4394.2 3766.3 3793.1 3800.4 3817.6 3818.4 4197.7 4229.6 4264.6 4299.5 4351.7 4983.1 5010.6 5026.1 5052.3 5059.0 4328.4 4339.2 4342.9 4347.1 4365.5 4411.9 4486.9 4498.6 4518.6 4536.2 4672.5 4684.3 4686.3 4686.4 4741.5 4991.6 4993.1 4994.6 4996.1 5024.5 4610.0 4614.0 4633.1 4662.7 4676.9 4863.5 4864.5 4898.6 4911.4 4951.4 4875.4 4946.0 4977.8 4985.7 4992.7 4761.1 4803.4 4806.2 4834.6 4838.6 4803.1 4832.9 4833.5 4849.5 4888.4 4577.9 4693.4 4778.5 4786.1 4821.3 4782.2 4810.2 4819.8 4830.2 4877.0 4724.0 4726.0 4726.5 4730.7 4773.1 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | [#1] ext.html Cycles:180 Average:44134.19 Median:35561.47 stddev:77581.09 (218.2%) stddev-sans-first:77729.68 08:58:12 INFO - PROCESS | 24091 | Values: 542.7 579.8 590.8 598.2 602.6 28443.4 31209.7 31223.0 31238.8 31272.8 44130.0 45264.5 45362.1 45391.0 45475.0 7572.2 7723.2 7726.0 7736.3 7736.3 7611.1 7713.2 7713.9 7718.7 7722.2 7689.6 7696.3 7748.9 7759.0 7759.8 7654.3 7661.1 7708.8 7711.2 7718.8 7620.4 7669.0 7679.5 7687.9 7690.8 38970.4 39367.0 39396.0 39398.0 39449.8 3028.8 3045.3 3385.5 3704.3 3764.1 27293.5 29241.6 29769.9 29771.7 29966.0 3258.9 3527.3 3530.9 3589.0 3590.0 243156.0 245343.0 246523.0 248091.8 248336.0 55155.7 55437.7 55465.7 55565.0 55694.2 32776.5 33752.5 33801.5 35553.8 35564.5 14554.0 14583.5 14663.4 14668.9 14673.1 11107.6 11160.6 11164.6 11166.6 11168.7 18573.9 18640.3 18693.9 18769.2 18818.5 6947.5 7009.8 7051.6 7118.6 7222.6 822.6 957.6 979.5 998.1 999.7 27534.7 27820.0 28057.8 28195.3 28384.1 802.3 960.9 963.4 973.8 1002.2 15032.3 15041.8 15157.8 15309.4 15321.3 375363.0 379162.0 379569.0 380236.0 380246.0 48106.0 48441.0 48635.0 48688.0 48751.0 1091.1 1178.5 1215.2 1231.8 1244.1 27666.2 28149.9 28813.7 28874.0 29104.1 40383.8 40666.0 40845.2 40950.4 40972.4 238560.0 238810.0 238941.0 239148.0 239223.0 21830.1 23885.4 24835.9 25012.0 26123.3 41075.0 41291.4 41296.0 42000.4 42228.4 34502.0 35271.8 35475.3 35558.5 35613.6 34884.8 35214.8 35582.0 35602.8 35869.8 34970.0 35107.3 35397.6 35435.0 35599.6 31317.2 31746.8 31977.5 32276.8 32446.0 23789.4 25386.4 25403.0 25549.1 25645.0 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | [#2] jquery.html Cycles:180 Average:24593.73 Median:6079.27 stddev:67436.07 (1109.3%) stddev-sans-first:67600.72 08:58:12 INFO - PROCESS | 24091 | Values: 371.3 373.4 382.0 386.2 386.7 15761.8 16620.3 16816.8 16991.6 17138.6 16327.4 17021.1 17420.6 17434.5 17436.5 4890.9 5084.7 5174.3 5181.8 5183.4 3637.0 3806.1 5050.7 5787.4 6124.5 6134.1 6139.5 6174.2 6175.0 6179.0 5875.6 6038.3 6051.2 6109.3 6122.4 3331.0 5050.8 5292.0 5330.4 5342.5 19717.9 20325.4 20340.9 20402.7 20484.9 1981.8 2220.4 2278.4 2346.0 2506.8 12528.1 12794.9 12900.2 13024.9 13448.4 1721.8 1751.5 1785.0 1785.3 1897.3 65156.3 67610.3 67764.3 67792.7 68715.7 9010.6 9455.5 9707.9 9819.1 9865.1 12992.7 13226.7 13228.8 13246.9 13248.0 7315.2 7318.2 7470.7 7566.9 7587.7 6814.7 6816.3 7089.2 7149.2 7362.7 6001.8 6107.4 6127.3 6157.4 6234.4 1637.2 1708.2 1723.2 1762.4 1770.0 858.4 881.2 933.0 959.7 975.4 16011.8 16976.2 17031.7 17112.9 17608.5 900.8 922.1 949.2 956.2 962.3 9113.9 9512.4 9515.5 9688.2 9737.2 406438.0 407673.0 408384.0 411474.0 412898.0 76709.6 77591.6 78244.6 78405.2 78444.0 938.8 950.3 956.5 959.9 966.8 15005.5 15160.5 15310.0 15336.1 15569.7 33141.3 34537.7 34894.5 35020.8 35363.3 45396.3 47545.8 48476.0 49683.0 49904.0 7275.9 7420.3 7424.9 7451.7 7594.7 6398.9 7654.0 9355.6 10348.2 10389.3 5374.5 9019.7 9190.9 9236.4 9308.6 8811.2 8937.3 9077.1 9140.5 9319.0 8950.3 9294.7 9454.3 9574.1 9648.6 7087.7 7269.2 7361.1 7383.6 7463.5 9075.0 9289.0 9374.6 9471.6 9521.0 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | [#3] mootools.html Cycles:180 Average:5182.42 Median:5110.95 stddev:2918.38 (57.1%) stddev-sans-first:2911.43 08:58:12 INFO - PROCESS | 24091 | Values: 1227.4 1397.5 1426.6 1507.8 1721.3 6700.3 7596.5 7746.9 7881.7 7975.8 7749.2 7836.4 7843.3 7849.5 7850.2 1890.5 2165.4 2204.1 2205.7 2247.8 2282.7 2309.2 2310.5 2312.7 2317.3 2174.5 2185.4 2192.3 2198.1 2205.0 1848.8 2109.2 2170.1 2189.5 2192.5 2186.6 2207.3 2213.9 2214.2 2217.6 7861.9 7894.8 7920.4 7920.4 7923.4 4469.4 4624.0 4626.3 4628.8 4648.3 2842.6 2851.2 2995.5 3009.8 3025.3 928.7 930.8 930.9 940.4 948.5 10760.7 10788.1 10832.4 10834.3 10849.2 4279.4 4401.3 4435.7 4443.0 4471.8 9336.2 9370.4 9390.9 9401.0 9409.1 4609.5 4624.5 4625.7 4634.6 4638.2 3633.8 3913.3 4070.3 4072.6 4073.7 3634.2 3736.2 3798.7 3807.5 3842.8 1197.6 1207.5 1214.8 1216.9 1235.1 724.5 851.8 866.4 872.0 888.1 5091.4 5130.5 5144.8 5263.0 5318.3 410.1 426.2 431.6 433.3 446.4 3463.5 3595.4 3647.6 3700.7 3720.2 9245.1 9576.7 9610.0 9643.3 9692.7 9465.0 9465.8 9476.2 9476.8 9547.5 7029.3 7326.1 7328.9 7455.8 7457.6 5425.2 5511.9 5714.6 5775.3 5850.6 8774.0 8943.8 9047.4 9124.1 9205.0 8964.8 9232.5 9275.0 9286.1 9347.3 6186.7 6688.4 6823.7 6940.3 7019.4 7597.8 7601.6 7635.4 7636.4 7639.6 6748.7 6864.5 6876.0 6966.1 6969.7 6796.4 6796.9 6851.3 6868.2 6912.8 6012.9 6071.9 6129.8 6251.6 6416.4 4783.3 4813.4 4835.5 4863.1 4874.9 4718.5 4735.4 4777.6 4810.6 4847.3 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | [#4] prototype.html Cycles:180 Average:4107.55 Median:4702.68 stddev:1177.41 (25.0%) stddev-sans-first:1145.57 08:58:12 INFO - PROCESS | 24091 | Values: 303.8 307.6 312.6 315.8 316.7 4691.9 4759.0 4788.9 4796.1 4800.5 4649.5 4689.2 4691.6 4696.2 4707.6 3551.1 3652.2 3670.7 3751.5 3791.1 3730.0 3762.5 3768.1 3777.6 3802.8 3557.1 3729.2 3748.3 3771.6 3772.8 3619.8 3739.8 3753.8 3758.8 3775.5 3319.0 3319.1 3322.9 3326.6 3341.2 4455.2 4460.2 4469.0 4522.9 4534.8 4002.3 4206.6 4211.4 4302.0 4308.7 4895.4 4910.0 4925.8 4936.0 4969.7 3541.6 3541.8 3547.4 3558.1 3566.8 5010.4 5150.4 5201.4 5209.3 5216.7 3601.9 3623.7 3624.4 3626.2 3643.2 3663.4 3664.2 3673.5 3679.5 3681.0 4186.6 4189.5 4217.6 4224.6 4228.4 4770.4 4963.0 4970.6 4975.5 4978.1 1253.6 1254.1 1273.0 1273.3 1275.1 820.9 821.5 855.2 877.9 878.7 4359.9 4381.5 4395.5 4402.0 4410.3 5048.8 5068.9 5074.8 5097.5 5141.0 4188.9 4330.7 4347.9 4388.4 4395.3 2697.8 2700.9 2724.2 2724.4 2732.1 4782.4 4790.0 4799.0 4833.3 4844.2 5018.5 5122.7 5195.8 5204.4 5212.9 4766.2 4772.1 4772.5 4786.9 4787.2 5070.3 5073.5 5088.2 5100.4 5114.1 4820.2 4904.7 4935.2 5002.1 5002.8 4709.5 4740.4 4753.6 4786.3 4798.4 3577.2 3595.9 3596.0 3598.9 3603.8 4878.8 5030.8 5034.8 5101.7 5108.0 4890.6 4902.8 4904.0 4912.2 4923.5 4814.2 4864.1 4918.9 4920.0 4921.2 4697.7 4803.6 4860.1 4870.2 4876.1 4735.9 4835.9 4907.5 4914.0 4959.4 4813.8 4835.5 4855.5 4862.3 4873.7 08:58:12 INFO - PROCESS | 24091 | 08:58:12 INFO - PROCESS | 24091 | [#5] yui.html Cycles:180 Average:13147.69 Median:47827.26 stddev:15105.58 (31.6%) stddev-sans-first:15118.87 08:58:12 INFO - PROCESS | 24091 | Values: 664.2 711.2 720.4 758.5 795.7 11068.6 12215.7 12399.3 12411.4 12437.6 12216.5 12486.1 12648.2 12748.8 12757.6 629.9 776.0 792.4 802.4 807.3 793.9 799.9 802.9 803.1 803.6 840.7 841.9 843.0 843.5 843.6 658.6 811.4 834.8 844.0 844.3 592.3 594.2 595.2 595.3 597.2 10984.0 10985.9 10986.3 10990.7 10994.4 11943.3 12354.4 12355.6 12536.7 12595.1 9510.1 9602.7 9758.0 9776.7 11164.7 4148.3 4152.3 4201.4 4202.5 4258.5 41746.6 41874.2 42232.6 42271.6 42335.6 9624.2 9637.2 9865.4 9895.5 9925.3 16948.3 16994.5 16995.5 17006.0 17042.9 6385.9 6447.6 6614.7 6615.7 6686.3 3372.4 3522.5 3613.3 3641.0 3715.0 2790.5 2849.4 2862.0 2865.2 2867.1 526.6 537.1 546.9 548.7 550.3 402.7 448.9 528.7 622.5 631.8 7856.8 7993.2 8130.7 8243.5 8318.7 566.4 570.7 574.5 580.3 604.3 3671.0 3735.8 3754.4 3765.7 3773.6 51678.5 51888.0 55322.0 56669.0 58624.7 46233.5 48158.0 49430.8 50456.2 50622.0 47496.5 48228.0 48968.3 49081.3 49683.5 8506.8 8548.6 8710.7 8791.0 8832.3 30640.4 31230.8 31602.4 32180.4 32574.3 38385.8 40827.8 40873.4 41408.0 41656.4 10874.5 11131.6 11250.7 11828.2 12290.9 11882.9 11986.0 12524.4 12663.4 12880.8 11328.4 11658.0 12014.0 12050.9 12175.3 11575.4 11580.6 11697.5 11882.8 12004.2 11118.6 11335.4 11780.5 11797.9 11811.5 8604.4 8703.5 8898.8 8948.6 9374.9 9767.6 9838.9 9864.0 9866.4 10023.1 08:58:12 INFO - PROCESS | 24091 | -------- Summary: end -------- 08:58:12 INFO - PROCESS | 24091 | 08:58:13 INFO - TEST-INFO | 24091: exit 0 08:58:13 INFO - TEST-OK | dromaeo_css | took 1118219ms 08:58:13 INFO - TEST-START | kraken 08:58:13 INFO - operating with platform_type : linux_ 08:58:13 INFO - Initialising browser for kraken test... 08:58:13 INFO - TEST-INFO | started process 24267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE4Xxf/profile http://localhost:48646/getInfo.html) 08:58:17 INFO - PROCESS | 24267 | __metrics Screen width/height:1600/1200 08:58:17 INFO - PROCESS | 24267 | colorDepth:24 08:58:17 INFO - PROCESS | 24267 | Browser inner width/height: 1024/697 08:58:17 INFO - PROCESS | 24267 | __metrics 08:58:18 ERROR - PROCESS | 24267 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:58:19 INFO - TEST-INFO | 24267: exit 0 08:58:19 INFO - Browser initialized. 08:58:19 INFO - Running cycle 1/1 for kraken test... 08:58:19 INFO - TEST-INFO | started process 24349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE4Xxf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:31 INFO - PROCESS | 24349 | RSS: Main: 157360128 08:58:31 INFO - PROCESS | 24349 | 08:58:34 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48646/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:35 INFO - PROCESS | 24349 | RSS: Main: 215482368 08:58:35 INFO - PROCESS | 24349 | 08:58:37 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48646/tests/kraken/driver.html?testName=audio-dft) 08:58:38 INFO - PROCESS | 24349 | RSS: Main: 202674176 08:58:38 INFO - PROCESS | 24349 | 08:58:41 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48646/tests/kraken/driver.html?testName=audio-fft) 08:58:42 INFO - PROCESS | 24349 | RSS: Main: 270331904 08:58:42 INFO - PROCESS | 24349 | 08:58:44 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48646/tests/kraken/driver.html?testName=audio-oscillator) 08:58:45 INFO - PROCESS | 24349 | RSS: Main: 180596736 08:58:45 INFO - PROCESS | 24349 | 08:58:47 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:48 INFO - PROCESS | 24349 | RSS: Main: 184152064 08:58:48 INFO - PROCESS | 24349 | 08:58:51 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48646/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:51 INFO - PROCESS | 24349 | RSS: Main: 220803072 08:58:51 INFO - PROCESS | 24349 | 08:58:55 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48646/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:55 INFO - PROCESS | 24349 | RSS: Main: 217063424 08:58:55 INFO - PROCESS | 24349 | 08:58:58 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48646/tests/kraken/driver.html?testName=json-parse-financial) 08:58:59 INFO - PROCESS | 24349 | RSS: Main: 219541504 08:58:59 INFO - PROCESS | 24349 | 08:59:01 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:01 INFO - PROCESS | 24349 | RSS: Main: 209575936 08:59:01 INFO - PROCESS | 24349 | 08:59:03 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:04 INFO - PROCESS | 24349 | RSS: Main: 212398080 08:59:04 INFO - PROCESS | 24349 | 08:59:06 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:07 INFO - PROCESS | 24349 | RSS: Main: 219836416 08:59:07 INFO - PROCESS | 24349 | 08:59:09 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:10 INFO - PROCESS | 24349 | RSS: Main: 224714752 08:59:10 INFO - PROCESS | 24349 | 08:59:13 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:14 INFO - PROCESS | 24349 | RSS: Main: 222429184 08:59:14 INFO - PROCESS | 24349 | 08:59:15 INFO - PROCESS | 24349 | Cycle 1(1): loaded http://localhost:48646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48646/tests/kraken/driver.html?testName=ai-astar) 08:59:16 INFO - PROCESS | 24349 | RSS: Main: 265478144 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | __start_tp_report 08:59:16 INFO - PROCESS | 24349 | _x_x_mozilla_page_load 08:59:16 INFO - PROCESS | 24349 | _x_x_mozilla_page_load_details 08:59:16 INFO - PROCESS | 24349 | |i|pagename|runs| 08:59:16 INFO - PROCESS | 24349 | |0;ai-astar;114;108;114;112;112;114;115;114;113;112 08:59:16 INFO - PROCESS | 24349 | |1;audio-beat-detection;163;129;131;186;132;131;157;130;162;142 08:59:16 INFO - PROCESS | 24349 | |2;audio-dft;162;161;162;161;163;160;162;161;163;161 08:59:16 INFO - PROCESS | 24349 | |3;audio-fft;76;76;76;109;76;78;74;75;108;74 08:59:16 INFO - PROCESS | 24349 | |4;audio-oscillator;86;85;128;86;86;84;122;85;84;126 08:59:16 INFO - PROCESS | 24349 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;116;116 08:59:16 INFO - PROCESS | 24349 | |6;imaging-darkroom;147;147;146;146;146;146;147;147;145;145 08:59:16 INFO - PROCESS | 24349 | |7;imaging-desaturate;95;94;94;95;95;94;94;95;95;95 08:59:16 INFO - PROCESS | 24349 | |8;json-parse-financial;66;65;65;66;64;65;64;65;64;65 08:59:16 INFO - PROCESS | 24349 | |9;json-stringify-tinderbox;65;64;65;64;65;65;65;66;65;65 08:59:16 INFO - PROCESS | 24349 | |10;stanford-crypto-aes;83;83;85;82;87;83;88;84;110;84 08:59:16 INFO - PROCESS | 24349 | |11;stanford-crypto-ccm;134;131;135;141;131;135;130;143;143;141 08:59:16 INFO - PROCESS | 24349 | |12;stanford-crypto-pbkdf2;170;168;170;167;166;167;165;168;168;166 08:59:16 INFO - PROCESS | 24349 | |13;stanford-crypto-sha256-iterative;71;66;66;66;66;66;66;67;66;65 08:59:16 INFO - PROCESS | 24349 | __end_tp_report 08:59:16 INFO - PROCESS | 24349 | __start_cc_report 08:59:16 INFO - PROCESS | 24349 | _x_x_mozilla_cycle_collect,1890 08:59:16 INFO - PROCESS | 24349 | __end_cc_report 08:59:16 INFO - PROCESS | 24349 | __startTimestamp1464796756086__endTimestamp 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | ------- Summary: start ------- 08:59:16 INFO - PROCESS | 24349 | Number of tests: 14 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:1.99 (1.7%) stddev-sans-first:2.06 08:59:16 INFO - PROCESS | 24349 | Values: 114.0 108.0 114.0 112.0 112.0 114.0 115.0 114.0 113.0 112.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:149.50 stddev:19.64 (13.1%) stddev-sans-first:19.88 08:59:16 INFO - PROCESS | 24349 | Values: 163.0 129.0 131.0 186.0 132.0 131.0 157.0 130.0 162.0 142.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:59:16 INFO - PROCESS | 24349 | Values: 162.0 161.0 162.0 161.0 163.0 160.0 162.0 161.0 163.0 161.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.91 (18.3%) stddev-sans-first:14.57 08:59:16 INFO - PROCESS | 24349 | Values: 76.0 76.0 76.0 109.0 76.0 78.0 74.0 75.0 108.0 74.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.00 stddev:19.48 (22.9%) stddev-sans-first:20.24 08:59:16 INFO - PROCESS | 24349 | Values: 86.0 85.0 128.0 86.0 86.0 84.0 122.0 85.0 84.0 126.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:59:16 INFO - PROCESS | 24349 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 08:59:16 INFO - PROCESS | 24349 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 145.0 145.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:59:16 INFO - PROCESS | 24349 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 08:59:16 INFO - PROCESS | 24349 | Values: 66.0 65.0 65.0 66.0 64.0 65.0 64.0 65.0 64.0 65.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:59:16 INFO - PROCESS | 24349 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:84.00 stddev:8.33 (9.9%) stddev-sans-first:8.72 08:59:16 INFO - PROCESS | 24349 | Values: 83.0 83.0 85.0 82.0 87.0 83.0 88.0 84.0 110.0 84.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:138.00 stddev:5.15 (3.7%) stddev-sans-first:5.39 08:59:16 INFO - PROCESS | 24349 | Values: 134.0 131.0 135.0 141.0 131.0 135.0 130.0 143.0 143.0 141.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:168.00 stddev:1.65 (1.0%) stddev-sans-first:1.48 08:59:16 INFO - PROCESS | 24349 | Values: 170.0 168.0 170.0 167.0 166.0 167.0 165.0 168.0 168.0 166.0 08:59:16 INFO - PROCESS | 24349 | 08:59:16 INFO - PROCESS | 24349 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:0.50 08:59:16 INFO - PROCESS | 24349 | Values: 71.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 65.0 08:59:16 INFO - PROCESS | 24349 | -------- Summary: end -------- 08:59:16 INFO - PROCESS | 24349 | 08:59:17 INFO - TEST-INFO | 24349: exit 0 08:59:17 INFO - TEST-OK | kraken | took 63680ms 08:59:17 INFO - SUITE-END | took 1181s 08:59:17 INFO - Completed test suite (00:19:42) 08:59:17 INFO - javascript benchmark 08:59:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.2410001099674, 2641.498115358083, 2670.3724624713195, 2687.556553168727, 2694.975909154521, 4496.707713998588, 4542.545745425456, 4551.4765801932745, 4607.17070927233, 4679.251319788835, 4565.931511027337, 4576.725396476214, 4598.862034138972, 4653.720776753397, 4660.067986402716, 4025.1547175093265, 4154.833806647738, 4245.10852720929, 4275.7434553926705, 4384.912301753963, 4270.081932384537, 4335.132973405316, 4343.109662519192, 4347.13057388522, 4379.321205213197, 4139.8965025874295, 4153.376993450976, 4177.5613560576, 4178.39413285072, 4233.23801715691, 4186.392973018896, 4197.244495990721, 4225.366195070733, 4251.213525497793, 4259.595338442843, 4248.851290204828, 4253.064325848309, 4263.381809637585, 4271.1671224111315, 4281.379200016011, 4395.1429471252795, 4462.620677242438, 4506.774661266923, 4522.8643140705835, 4537.478190008158, 4970.2793095001025, 5023.799048038074, 5027.572656324217, 5035.59715222785, 5046.44489106198, 4824.758762061883, 5054.9494505054845, 5075.061113693979, 5083.364579427572, 5091.974540127313, 4580.839670611546, 4645.512221216791, 4656.813727450898, 4695.624350051988, 4703.412073490814, 5157.742112894341, 5161.329027226437, 5161.845144645667, 5165.715885626251, 5179.482051794866, 4766.118268120339, 4845.6123510119105, 4951.950480495221, 4956.132676781549, 4959.603231741524, 4965.155923493015, 4965.453800081988, 4991.176455884811, 5000.174971129795, 5031.547160755549, 4922.310876477296, 4929.87675308113, 4932.334134891744, 4936.481669424658, 4997.525235102659, 4771.5467030632035, 4901.313816065754, 4918.852434426973, 4935.3090567320605, 4975.776090075955, 4341.717788343748, 4354.0, 4357.4988876279, 4374.0, 4394.1651086293505, 3766.322062028806, 3793.1275806564645, 3800.4299355096405, 3817.5609804872797, 3818.4463252828186, 4197.664186865105, 4229.598188172119, 4264.616184543406, 4299.505556860939, 4351.73889566627, 4983.07813054586, 5010.599152067826, 5026.1204289249235, 5052.317937078521, 5059.0, 4328.415663885336, 4339.240632889232, 4342.891427714269, 4347.130573885172, 4365.454318210223, 4411.889702757457, 4486.910261794811, 4498.572635599613, 4518.593326600556, 4536.206163921301, 4672.509386514367, 4684.273937539687, 4686.297055441711, 4686.36734040907, 4741.5021422750115, 4991.625628077836, 4993.051320249141, 4994.600431965507, 4996.075725990703, 5024.522670346311, 4609.976950115362, 4613.953860461353, 4633.073385322881, 4662.720236785668, 4676.859694209179, 4863.4650188479945, 4864.513548645107, 4898.632602554894, 4911.361523001987, 4951.405831300267, 4875.43932447773, 4946.0355230729665, 4977.800887964441, 4985.700857948535, 4992.650514463952, 4761.119192949315, 4803.375561177025, 4806.2310030394965, 4834.63740219492, 4838.588719958843, 4803.063402636592, 4832.8791780205775, 4833.492483289204, 4849.539293767087, 4888.437829649636, 4577.908441831211, 4693.366395536559, 4778.474367819467, 4786.114568804643, 4821.276808478756, 4782.163121453801, 4810.158222311152, 4819.807207711652, 4830.203016502378, 4877.0, 4724.009987167844, 4726.0, 4726.480087190475, 4730.692504987165, 4773.140834649657], "value": 4564.280300030422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.7260324941088, 579.7680927628945, 590.769599856056, 598.1685457214471, 602.5781952633157, 28443.431131377387, 31209.68790312096, 31223.0, 31238.84380578094, 31272.843635781846, 44130.0, 45264.54735452645, 45362.09275814482, 45391.0, 45474.99999999992, 7572.204918483576, 7723.150453450116, 7725.961370193141, 7736.265054819812, 7736.34241089508, 7611.086669599656, 7713.228677132298, 7713.8842917356005, 7718.729844455445, 7722.189170137139, 7689.615519224044, 7696.345810606105, 7748.922510774876, 7759.0, 7759.806004849867, 7654.272844079804, 7661.080670319569, 7708.768736937901, 7711.228877112272, 7718.845623087563, 7620.352270057052, 7669.0, 7679.500832445929, 7687.884681729778, 7690.846183076363, 38970.41544376837, 39367.0, 39396.0, 39398.0, 39449.802750986346, 3028.787984841062, 3045.284358175849, 3385.458326667746, 3704.2961837251105, 3764.0966168119726, 27293.454130917467, 29241.561376579368, 29769.851150744107, 29771.70228297711, 29966.0, 3258.9359125767887, 3527.294541091792, 3530.9117272068147, 3588.982055089734, 3589.964100358989, 243156.0, 245343.0, 246523.0, 248091.75954120295, 248336.0, 55155.72422137864, 55437.72281138649, 55465.722671386386, 55565.0, 55694.16458753122, 32776.50835237473, 33752.49371259433, 33801.492977605354, 35553.8222308892, 35564.46653300203, 14554.0, 14583.489577864935, 14663.413463461342, 14668.853311466748, 14673.119612823264, 11107.55569777216, 11160.553577856957, 11164.553417863195, 11166.609168679057, 11168.66494005181, 18573.90713046426, 18640.34758783436, 18693.906530467262, 18769.155388007573, 18818.529536761416, 6947.4789390795895, 7009.824754381181, 7051.647417629098, 7118.60847653384, 7222.638868056576, 822.576373167819, 957.621739412928, 979.5494072726483, 998.1465846701111, 999.6601155606983, 27534.714953597144, 27820.0, 28057.765988800536, 28195.295117622223, 28384.148475545768, 802.3300544045787, 960.9279304052224, 963.4267610771719, 973.7955029443896, 1002.1882275356984, 15032.323545440482, 15041.849581504264, 15157.848421515864, 15309.387624495119, 15321.310541025681, 375363.0, 379162.0, 379569.0, 380236.0, 380246.0, 48106.0, 48441.0, 48635.0, 48688.02623947572, 48751.0, 1091.1325496230515, 1178.528588564581, 1215.1918973882268, 1231.8213858990396, 1244.116677159209, 27666.170014899584, 28149.859250703616, 28813.71186288194, 28874.0, 29104.126876193746, 40383.79808100941, 40666.0, 40845.1830963385, 40950.38574421446, 40972.3854142194, 238560.0, 238810.0, 238941.0, 239148.0, 239223.0, 21830.126794928026, 23885.402864928517, 24835.875820620782, 25012.0, 26123.346916327242, 41075.0, 41291.38062928998, 41296.0, 42000.369994449495, 42228.36657450079, 34502.0, 35271.823640882656, 35475.29049418945, 35558.46662300016, 35613.64386356207, 34884.82557587196, 35214.82392588123, 35582.0, 35602.8219858899, 35869.82065089658, 34969.99210710457, 35107.29785404226, 35397.64602353943, 35435.0, 35599.64400355963, 31317.217069573442, 31746.841265793522, 31977.520337195427, 32276.83861580677, 32446.0, 23789.405264868517, 25386.365340866625, 25403.016639399804, 25549.105781297567, 25645.0], "value": 17111.29127891054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.34272337961806, 373.43984023964055, 381.99999999999983, 386.22754491017963, 386.7176960818601, 15761.842381576182, 16620.25208865601, 16816.831831681695, 16991.57521061974, 17138.571535711613, 16327.428540001103, 17021.148942552885, 17420.56448588786, 17434.47696569105, 17436.476905692816, 4890.926636100461, 5084.745762711868, 5174.275601415805, 5181.844544663666, 5183.352080989876, 3636.981815090934, 3806.143617686026, 5050.696958182502, 5787.421257874221, 6124.5100391968535, 6134.110553969672, 6139.508839292846, 6174.228221472316, 6175.011998080308, 6179.0, 5875.618084824473, 6038.27540695115, 6051.152838602599, 6109.266887973449, 6122.448979591836, 3330.983345083259, 5050.772715227787, 5291.973540132275, 5330.413654498002, 5342.545883599899, 19717.901410493, 20325.390238292875, 20340.89829550843, 20402.69395959062, 20484.897575512026, 1981.7621885373846, 2220.411590928405, 2278.362058623588, 2345.976540234593, 2506.7743903048813, 12528.123031387806, 12794.87205127946, 12900.225986440844, 13024.934875325564, 13448.394822233024, 1721.7847769028872, 1751.5183324585714, 1785.0360805165196, 1785.3394244129754, 1897.3264491105597, 65156.3484365155, 67610.32389676089, 67764.32235677629, 67792.66103669499, 68715.65642171807, 9010.59452324647, 9455.52722363879, 9707.854382184272, 9819.06718861707, 9865.130247502724, 12992.740145197233, 13226.669333266553, 13228.801567976489, 13246.933765331112, 13248.0, 7315.195328513859, 7318.194998550155, 7470.663820128108, 7566.924330756732, 7587.734429295058, 6814.727410903607, 6816.318368163144, 7089.22018577956, 7149.177844547839, 7362.705491780376, 6001.849953751192, 6107.389261073946, 6127.295361033449, 6157.384261573897, 6234.438900498886, 1637.1814092953523, 1708.2227586448137, 1723.2331612432347, 1762.409592786431, 1769.9557511062326, 858.4076986879033, 881.2069137775925, 933.0203286549096, 959.6593209410559, 975.3855071305175, 16011.759823602655, 16976.151192440328, 17031.744523832152, 17112.91443542774, 17608.471745847644, 900.8288425199191, 922.1331947969022, 949.2074118111454, 956.2159029595665, 962.2975228083538, 9113.908860911439, 9512.38169518979, 9515.524223788783, 9688.176504997155, 9737.221022318197, 406438.0, 407673.0, 408384.0, 411474.0, 412898.0, 76709.6164519185, 77591.61204194056, 78244.60877695575, 78405.2159478398, 78444.0, 938.7606160429184, 950.2587981374539, 956.4787190980932, 959.9184069354183, 966.7728083900278, 15005.549833505012, 15160.545183644508, 15310.0, 15336.079835209923, 15569.688606227586, 33141.33717325592, 34537.65462345445, 34894.476582851785, 35020.82489587536, 35363.29273414569, 45396.31905521486, 47545.762271188425, 48476.0, 49683.0, 49904.0, 7275.890861636974, 7420.332170104716, 7424.925750742424, 7451.701931922662, 7594.658240379306, 6398.936010639834, 7653.961730191313, 9355.625774969198, 10348.223883208639, 10389.272750907667, 5374.516293533601, 9019.684311049083, 9190.85114360705, 9236.445813251226, 9308.627654893728, 8811.162939520735, 8937.329700272376, 9077.09229077087, 9140.542972851197, 9318.95340523293, 8950.328725345755, 9294.674686386215, 9454.290928180277, 9574.090461406155, 9648.614055437703, 7087.7164913402885, 7269.236730143259, 7361.1166660001145, 7383.556986580822, 7463.514871533333, 9075.0, 9289.0, 9374.625014999596, 9471.573779180091, 9520.952395238257], "value": 8218.107937108296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.3863068465766, 1397.5457976157747, 1426.6076828872058, 1507.773833924911, 1721.2770636332732, 6700.296468870765, 7596.544207347556, 7746.883796743039, 7881.7241396551135, 7975.800604984878, 7749.186335434782, 7836.373090152789, 7843.294103530681, 7849.45053846231, 7850.214978502147, 1890.4990177602947, 2165.415337858777, 2204.1293688992837, 2205.7353117625826, 2247.752747197815, 2282.7032485776826, 2309.2033248529315, 2310.5263420998654, 2312.6877871487386, 2317.2584772872688, 2174.4781252499442, 2185.4208634711813, 2192.331338941622, 2198.087793565668, 2205.040807248844, 1848.833604975552, 2109.156337465011, 2170.0994087453687, 2189.4854709143337, 2192.473806286496, 2186.5736181444627, 2207.315732123047, 2213.9335819925427, 2214.2360885494477, 2217.5786600545844, 7861.921380786233, 7894.802629934297, 7920.405969552249, 7920.405969552249, 7923.405744569122, 4469.374287599739, 4623.953760462386, 4626.30605409188, 4628.8148474061, 4648.2562789953445, 2842.6020357150014, 2851.244420228641, 2995.4907665696664, 3009.7893147479685, 3025.3344264261827, 928.7399528132133, 930.8464103422928, 930.9487978161198, 940.431039221275, 948.4972964328916, 10760.73098172544, 10788.08301294391, 10832.350058996406, 10834.295770774954, 10849.186311026626, 4279.358096285582, 4401.339799030107, 4435.733855968652, 4443.044745379694, 4471.7987690554, 9336.206422454168, 9370.39092458988, 9390.906090939003, 9401.0, 9409.106134917172, 4609.516000819933, 4624.468186158568, 4625.653076019312, 4634.606058485067, 4638.2115040443205, 3633.818309084535, 3913.25648126855, 4070.3487442009136, 4072.6131017553284, 4073.6944729145434, 3634.1823089804584, 3736.1967177057063, 3798.7340886137704, 3807.5430948286385, 3842.8270727817317, 1197.5868325427714, 1207.5169932027259, 1214.8056310990376, 1216.8904798568171, 1235.092207227687, 724.4675163754636, 851.8253757979724, 866.4324867211986, 872.0407551693087, 888.1340692824444, 5091.41448733393, 5130.48695130484, 5144.845654630367, 5262.97368513155, 5318.282031925718, 410.05948274614514, 426.1583372838619, 431.5533422907276, 433.2980571474169, 446.4196544492147, 3463.4631632097066, 3595.388783906742, 3647.562292524861, 3700.6854417374825, 3720.2187540616774, 9245.121713437213, 9576.664816731382, 9609.951950240204, 9643.324967252365, 9692.660756873476, 9465.0, 9465.810683786285, 9476.241900647932, 9476.763080922894, 9547.52262386878, 7029.332213439715, 7326.084239470067, 7328.9267107329315, 7455.776326710099, 7457.5898325591525, 5425.186222066722, 5511.944880551304, 5714.5999780015, 5775.33583637887, 5850.5904586678525, 8774.0, 8943.821123577622, 9047.366684332033, 9124.133207345292, 9205.0, 8964.775880602776, 9232.538373081454, 9274.95362523183, 9286.117818807203, 9347.298952578447, 6186.659733714689, 6688.431483323972, 6823.69293381809, 6940.305969403221, 7019.438444924496, 7597.772066838003, 7601.619919003917, 7635.350995165473, 7636.427267954815, 7639.579823109782, 6748.7300507979135, 6864.48516361265, 6875.965620171867, 6966.12923384577, 6969.686364113729, 6796.388325050769, 6796.864062718817, 6851.3491218334175, 6868.175818901764, 6912.792616221522, 6012.909806352821, 6071.908921366271, 6129.816105516842, 6251.593646412968, 6416.422521972858, 4783.258594917794, 4813.374261346143, 4835.516448355136, 4863.148948933993, 4874.926876096933, 4718.504557021463, 4735.431748190102, 4777.617790576676, 4810.63920205993, 4847.345608342828], "value": 4104.299991716966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8222639755743, 307.6308429884138, 312.6295340022075, 315.75844478973573, 316.69122605459665, 4691.929621055682, 4758.952410475894, 4788.856334309972, 4796.11271914696, 4800.543948324912, 4649.535046495349, 4689.249720044793, 4691.577758001779, 4696.248600223965, 4707.62339012879, 3551.1122219445137, 3652.1600031992657, 3670.7063434925144, 3751.4560388743616, 3791.146991926822, 3729.9813500932455, 3762.454444105603, 3768.1333293342545, 3777.5655799583124, 3802.8478860845535, 3557.092941299965, 3729.1982223821874, 3748.269087527933, 3771.6039815819354, 3772.79249641271, 3619.782813031213, 3739.7943113128767, 3753.7560058596378, 3758.7932663703486, 3775.546934367866, 3318.96681033189, 3319.1038419626566, 3322.8670853165845, 3326.567546218976, 3341.18141055443, 4455.17579247837, 4460.1971645104195, 4468.955310446887, 4522.8643140705835, 4534.752942940685, 4002.2595819773146, 4206.558311377292, 4211.368294755811, 4301.989032577342, 4308.719933204332, 4895.363602731658, 4910.0, 4925.75371231437, 4935.950640493585, 4969.701817890902, 3541.645835416438, 3541.8406171722336, 3547.4324108142573, 3558.1460449492192, 3566.7681600695873, 5010.448850626428, 5150.356205474353, 5201.427842937312, 5209.270702101709, 5216.686998780086, 3601.9108916828177, 3623.7463377563845, 3624.401973674367, 3626.202235508184, 3643.1802844360336, 3663.377225871608, 3664.2151964507166, 3673.4673472346362, 3679.466477360821, 3680.981595092061, 4186.602272784081, 4189.539150693421, 4217.62041416274, 4224.598663126998, 4228.429162063082, 4770.356001939763, 4962.950370496249, 4970.602351811846, 4975.477574854661, 4978.103941290602, 1253.6113804720383, 1254.1095821966323, 1273.0, 1273.2996851731511, 1275.1329096214663, 820.8522465956066, 821.4619424276989, 855.2388374346837, 877.8902637170354, 878.6529320918202, 4359.869203923888, 4381.452318460192, 4395.516493185747, 4401.965538098544, 4410.338449232577, 5048.7728052237, 5068.949310506848, 5074.847754567369, 5097.541221290102, 5140.974295128575, 4188.895277618023, 4330.653547716175, 4347.891302717394, 4388.363687265329, 4395.340698895191, 2697.770689491376, 2700.9054683085997, 2724.209979106037, 2724.433450765778, 2732.0847516082335, 4782.378290822171, 4789.970156416387, 4798.95201047992, 4833.293355720808, 4844.249141383091, 5018.473060328686, 5122.718250496258, 5195.766190521435, 5204.375474942955, 5212.853172302088, 4766.165920963817, 4772.141014617471, 4772.49888761682, 4786.928196077061, 4787.234042553175, 5070.290159377616, 5073.463268365817, 5088.160453525127, 5100.38795344561, 5114.079465696211, 4820.180569303297, 4904.705717656952, 4935.235038569028, 5002.149634562061, 5002.799888004439, 4709.481956984798, 4740.407449068866, 4753.595944344631, 4786.2581299898575, 4798.376211092535, 3577.195131095483, 3595.946060809142, 3596.0470475323536, 3598.85604575814, 3603.8017909015257, 4878.78045487961, 5030.84907452777, 5034.766482211881, 5101.744912754421, 5107.974460127675, 4890.559849613552, 4902.754862256944, 4903.950960490492, 4912.238603016538, 4923.507649235048, 4814.15752243349, 4864.148773964472, 4918.852434426973, 4920.0, 4921.188003979303, 4697.741624210701, 4803.639727020557, 4860.1251774680895, 4870.172070747911, 4876.07435538674, 4735.928961065656, 4835.854924352275, 4907.533784290486, 4913.975430122827, 4959.404871415453, 4813.78337974785, 4835.516448355136, 4855.490173531728, 4862.298195631501, 4873.659743570546], "value": 3738.642348711743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.2062735031639, 711.2425267090549, 720.4488566246819, 758.5410826449996, 795.7175202803005, 11068.557257709692, 12215.694607634814, 12399.256044637328, 12411.379431028436, 12437.62687119388, 12216.511339546407, 12486.12597118202, 12648.177868438568, 12748.80876786849, 12757.553485628005, 629.9401556852092, 776.0183368039435, 792.3977776889562, 802.3821657323857, 807.2532907060975, 793.9285464308211, 799.9160088190744, 802.9076656184526, 803.0764620686199, 803.5901690138013, 840.7477756673004, 841.9031811341713, 842.9957850210772, 843.5065486690294, 843.5782108945527, 658.5653468710676, 811.3955103447969, 834.7913021744564, 844.0, 844.2823599940064, 592.2862950145064, 594.2215697436372, 595.2262059322907, 595.2886300870462, 597.1758972617803, 10984.0, 10985.890141098567, 10986.285891417032, 10990.725231869188, 10994.395308258043, 11943.283402995849, 12354.38228088592, 12355.567555135616, 12536.749265014649, 12595.118341716083, 9510.09654082861, 9602.66390676323, 9757.951210243904, 9776.706698799047, 11164.665060048212, 4148.253314403406, 4152.273352163359, 4201.390798334224, 4202.495700515958, 4258.53156152823, 41746.58253417457, 41874.1625167498, 42232.57767422317, 42271.577284227074, 42335.57664423347, 9624.230061595055, 9637.18083962857, 9865.408075515492, 9895.455749933679, 9925.255605829592, 16948.322067117424, 16994.49016529506, 16995.490135295713, 17006.0, 17042.914785425994, 6385.904211436832, 6447.645379504079, 6614.669266536654, 6615.735370585219, 6686.3313668632745, 3372.443546814748, 3522.5244591979754, 3613.33153366628, 3641.016925430119, 3715.0, 2790.5116604594114, 2849.430113977213, 2861.9856900715363, 2865.1547793400996, 2867.139858042579, 526.5629527492172, 537.0842713174029, 546.9371022332404, 548.7256371814093, 550.3176061683564, 402.73620778389613, 448.8698277499554, 528.7435593737034, 622.4864486798409, 631.7788773929088, 7856.803579910434, 7993.160718124514, 8130.665708238494, 8243.546604936786, 8318.70884519039, 566.3713278261126, 570.7146426786607, 574.5288863132191, 580.3413126101905, 604.2597817673403, 3671.0, 3735.813209339522, 3754.3617585010616, 3765.7175711821724, 3773.64150405711, 51678.48321516737, 51888.0, 55322.0, 56669.0, 58624.706876466196, 46233.53766462292, 48158.0, 49430.75284623626, 50456.243156352684, 50622.0, 47496.5250347499, 48228.035439291016, 48968.265476017885, 49081.263781043315, 49683.503164967886, 8506.78733031679, 8548.615312311085, 8710.69512567057, 8791.0, 8832.337574682053, 30640.387192255585, 31230.843845781535, 31602.367952641278, 32180.35639287248, 32574.34851303008, 38385.808070959465, 40827.7958610205, 40873.38689919713, 41408.0, 41656.3751543721, 10874.456277186267, 11131.554737810397, 11250.659315505924, 11828.23116497425, 12290.877091228973, 11882.940585297018, 11985.995675718454, 12524.37378131108, 12663.430145643284, 12880.806787898002, 11328.433578320886, 11658.0, 12014.0, 12050.879491204976, 12175.269483830998, 11575.363355015555, 11580.594679186188, 11697.532098715956, 11882.76234475323, 12004.2197257178, 11118.555257789598, 11335.433228338716, 11780.469878855301, 11797.88202117968, 11811.468483918072, 8604.354673399395, 8703.47779133254, 8898.822023559622, 8948.642054318016, 9374.906250937676, 9767.609295628095, 9838.9016109838, 9864.013598640078, 9866.408015519091, 10023.097921187129], "value": 6005.808383484722, "unit": "score"}], "name": "dromaeo_css", "value": 6242.141431980402, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 112.0, 112.0, 114.0, 115.0, 114.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 131.0, 186.0, 132.0, 131.0, 157.0, 130.0, 162.0, 142.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 163.0, 160.0, 162.0, 161.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 109.0, 76.0, 78.0, 74.0, 75.0, 108.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 128.0, 86.0, 86.0, 84.0, 122.0, 85.0, 84.0, 126.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 85.0, 82.0, 87.0, 83.0, 88.0, 84.0, 110.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 135.0, 141.0, 131.0, 135.0, 130.0, 143.0, 143.0, 141.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 170.0, 167.0, 166.0, 167.0, 165.0, 168.0, 168.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1544.6000000000004, "alertThreshold": 2.0}]} 08:59:17 INFO - Return code: 0 08:59:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:59:17 ERROR - # TBPL SUCCESS # 08:59:17 INFO - Running post-action listener: _resource_record_post_action 08:59:17 INFO - ##### 08:59:17 INFO - ##### Finished run-tests step (success) 08:59:17 INFO - ##### 08:59:17 INFO - Running post-run listener: _resource_record_post_run 08:59:17 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522932224; Read time: 16; Write time: 359988 08:59:17 INFO - TinderboxPrint: CPU usage
13.1% 08:59:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:59:17 INFO - TinderboxPrint: I/O write bytes / time
522,932,224 / 359,988 08:59:17 INFO - TinderboxPrint: CPU idle
8,317.3 (86.9%) 08:59:17 INFO - TinderboxPrint: CPU user
1,210.9 (12.7%) 08:59:17 INFO - TinderboxPrint: Swap in / out
0 / 0 08:59:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237137920; Read time: 0; Write time: 192324 08:59:17 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285794304; Read time: 16; Write time: 167664 08:59:18 INFO - Running post-run listener: _upload_blobber_files 08:59:18 INFO - Blob upload gear active. 08:59:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:18 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:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:59:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:19 INFO - (blobuploader) - INFO - Done attempting. 08:59:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:59:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:24 INFO - (blobuploader) - INFO - Done attempting. 08:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:59:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:25 INFO - (blobuploader) - INFO - Done attempting. 08:59:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:25 INFO - Return code: 0 08:59:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2c4bc8328c7873f1ff8f0a65c4a67802b6ed32770363f09164733889435c070108b06d7a1b8945afb0e35677ed5768fbc78295f00713f53be67248e5d669286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fb2f5bda713a0e5103f36325b92bee8945302369e357e30982191533a9ff090e879eac95235e28c986931f98a18cc2ed135dc3b0fa918a7849062f6ac8a428c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ff65bd4fbdeeb3f7d005196212d36a550fea072d67ec4f53e6617a368e77c27d48f589a32fb149d5d6d6551eecae173b5e524aa3735bec033a01b982d03dd4c"} 08:59:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:25 INFO - Contents: 08:59:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2c4bc8328c7873f1ff8f0a65c4a67802b6ed32770363f09164733889435c070108b06d7a1b8945afb0e35677ed5768fbc78295f00713f53be67248e5d669286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fb2f5bda713a0e5103f36325b92bee8945302369e357e30982191533a9ff090e879eac95235e28c986931f98a18cc2ed135dc3b0fa918a7849062f6ac8a428c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ff65bd4fbdeeb3f7d005196212d36a550fea072d67ec4f53e6617a368e77c27d48f589a32fb149d5d6d6551eecae173b5e524aa3735bec033a01b982d03dd4c"} 08:59:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:25 INFO - Copying logs to upload dir... 08:59:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.275187 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-01 08:59:25.052288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:59:25.055992) ========= 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=ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2c4bc8328c7873f1ff8f0a65c4a67802b6ed32770363f09164733889435c070108b06d7a1b8945afb0e35677ed5768fbc78295f00713f53be67248e5d669286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fb2f5bda713a0e5103f36325b92bee8945302369e357e30982191533a9ff090e879eac95235e28c986931f98a18cc2ed135dc3b0fa918a7849062f6ac8a428c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ff65bd4fbdeeb3f7d005196212d36a550fea072d67ec4f53e6617a368e77c27d48f589a32fb149d5d6d6551eecae173b5e524aa3735bec033a01b982d03dd4c"} build_url:https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/PV9H3gPZTfuauS7JsYEK4g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2c4bc8328c7873f1ff8f0a65c4a67802b6ed32770363f09164733889435c070108b06d7a1b8945afb0e35677ed5768fbc78295f00713f53be67248e5d669286", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fb2f5bda713a0e5103f36325b92bee8945302369e357e30982191533a9ff090e879eac95235e28c986931f98a18cc2ed135dc3b0fa918a7849062f6ac8a428c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ff65bd4fbdeeb3f7d005196212d36a550fea072d67ec4f53e6617a368e77c27d48f589a32fb149d5d6d6551eecae173b5e524aa3735bec033a01b982d03dd4c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:59:25.084961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:59:25.085298) ========= 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=ed14279e38b05397cf4aa391000001a4-1464795518.548703-1648283225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:59:25.170522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:59:25.170911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:59:25.171245) ========= ========= Total master_lag: 0.17 =========