builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1464075723.41 results: success (0) buildid: 20160524000618 builduid: ed1d46c3532145ebbf1522783cdba228 revision: 00f9eb3e72e805caebd204b780dc904877cab590 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.413736) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.414381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.414735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.431747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.432054) ========= 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=0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 00:42:03-- 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% 227M=0s 2016-05-24 00:42:03 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.535515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.535955) ========= 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=0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013837 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.586714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:03.587106) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 00f9eb3e72e805caebd204b780dc904877cab590 --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 00f9eb3e72e805caebd204b780dc904877cab590 --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=0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 00:42:03,829 truncating revision to first 12 chars 2016-05-24 00:42:03,829 Setting DEBUG logging. 2016-05-24 00:42:03,829 attempt 1/10 2016-05-24 00:42:03,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/00f9eb3e72e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 00:42:04,394 unpacking tar archive at: fx-team-00f9eb3e72e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:04.490785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:04.491607) ========= script_repo_revision: 00f9eb3e72e805caebd204b780dc904877cab590 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:04.492640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:04.493300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 00:42:04.505067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 00:42:04.505381) ========= /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=0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:42:04 INFO - MultiFileLogger online at 20160524 00:42:04 in /builds/slave/test 00:42:04 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 00:42:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:42:04 INFO - {'append_to_log': False, 00:42:04 INFO - 'base_work_dir': '/builds/slave/test', 00:42:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:42:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:42:04 INFO - 'branch': 'Fx-Team-Non-PGO', 00:42:04 INFO - 'buildbot_json_path': 'buildprops.json', 00:42:04 INFO - 'config_files': ('talos/linux_config.py',), 00:42:04 INFO - 'default_actions': ('clobber', 00:42:04 INFO - 'read-buildbot-config', 00:42:04 INFO - 'download-and-extract', 00:42:04 INFO - 'populate-webroot', 00:42:04 INFO - 'create-virtualenv', 00:42:04 INFO - 'install', 00:42:04 INFO - 'run-tests'), 00:42:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:42:04 INFO - 'download_minidump_stackwalk': True, 00:42:04 INFO - 'download_symbols': 'ondemand', 00:42:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:42:04 INFO - 'tooltool.py': '/tools/tooltool.py', 00:42:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:42:04 INFO - '/tools/misc-python/virtualenv.py')}, 00:42:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:42:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:42:04 INFO - 'installer_path': 'installer.exe', 00:42:04 INFO - 'log_level': 'info', 00:42:04 INFO - 'log_name': 'talos', 00:42:04 INFO - 'log_to_console': True, 00:42:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:42:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:42:04 INFO - 'opt_config_files': (), 00:42:04 INFO - 'pip_index': False, 00:42:04 INFO - 'sps_profile': False, 00:42:04 INFO - 'sps_profile_interval': 0, 00:42:04 INFO - 'suite': 'dromaeojs', 00:42:04 INFO - 'system_bits': '32', 00:42:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:42:04 INFO - 'title': 'talos-linux64-ix-017', 00:42:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:42:04 INFO - 'use_talos_json': True, 00:42:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:42:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:42:04 INFO - 'work_dir': 'build'} 00:42:04 INFO - ##### 00:42:04 INFO - ##### Running clobber step. 00:42:04 INFO - ##### 00:42:04 INFO - Running pre-action listener: _resource_record_pre_action 00:42:04 INFO - Running main action method: clobber 00:42:04 INFO - rmtree: /builds/slave/test/build 00:42:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:42:05 INFO - Running post-action listener: _resource_record_post_action 00:42:05 INFO - ##### 00:42:05 INFO - ##### Finished clobber step (success) 00:42:05 INFO - ##### 00:42:05 INFO - ##### 00:42:05 INFO - ##### Running read-buildbot-config step. 00:42:05 INFO - ##### 00:42:05 INFO - Running pre-action listener: _resource_record_pre_action 00:42:05 INFO - Running main action method: read_buildbot_config 00:42:05 INFO - Using buildbot properties: 00:42:05 INFO - { 00:42:05 INFO - "project": "", 00:42:05 INFO - "product": "firefox", 00:42:05 INFO - "script_repo_revision": "production", 00:42:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:42:05 INFO - "repository": "", 00:42:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:42:05 INFO - "buildid": "20160524000618", 00:42:05 INFO - "pgo_build": "False", 00:42:05 INFO - "basedir": "/builds/slave/test", 00:42:05 INFO - "buildnumber": 1769, 00:42:05 INFO - "slavename": "talos-linux64-ix-017", 00:42:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:42:05 INFO - "platform": "ubuntu64_hw", 00:42:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:42:05 INFO - "branch": "fx-team", 00:42:05 INFO - "repo_path": "integration/fx-team", 00:42:05 INFO - "revision": "00f9eb3e72e805caebd204b780dc904877cab590", 00:42:05 INFO - "stage_platform": "linux64", 00:42:05 INFO - "builduid": "ed1d46c3532145ebbf1522783cdba228", 00:42:05 INFO - "slavebuilddir": "test" 00:42:05 INFO - } 00:42:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:42:05 INFO - Running post-action listener: _resource_record_post_action 00:42:05 INFO - ##### 00:42:05 INFO - ##### Finished read-buildbot-config step (success) 00:42:05 INFO - ##### 00:42:05 INFO - ##### 00:42:05 INFO - ##### Running download-and-extract step. 00:42:05 INFO - ##### 00:42:05 INFO - Running pre-action listener: _resource_record_pre_action 00:42:05 INFO - Running main action method: download_and_extract 00:42:05 INFO - mkdir: /builds/slave/test/build/tests 00:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:05 INFO - https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:06 INFO - Downloaded 1361 bytes. 00:42:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:42:06 INFO - Using the following test package requirements: 00:42:06 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:42:06 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:42:06 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:42:06 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'jsshell-linux-x86_64.zip'], 00:42:06 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:42:06 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:42:06 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:42:06 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:42:06 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:42:06 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:42:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:42:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:42:06 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')]} 00:42:06 INFO - https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:07 INFO - Downloaded 22814444 bytes. 00:42:07 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'] 00:42:07 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 00:42:08 INFO - Return code: 0 00:42:08 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 00:42: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')]} 00:42:08 INFO - https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:42:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:42:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:42:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:10 INFO - Downloaded 22814444 bytes. 00:42:10 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'] 00:42:10 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 00:42:11 INFO - Return code: 0 00:42: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')]} 00:42:11 INFO - https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:12 INFO - Downloaded 10840359 bytes. 00:42:12 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'] 00:42:12 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 00:42:12 INFO - Return code: 0 00:42: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')]} 00:42:12 INFO - https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:42:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:42:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:42:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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 00:42:13 INFO - Downloaded 54816214 bytes. 00:42:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:42:13 INFO - mkdir: /builds/slave/test/properties 00:42:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:42:13 INFO - Writing to file /builds/slave/test/properties/build_url 00:42:13 INFO - Contents: 00:42:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:42:14 INFO - Running post-action listener: _resource_record_post_action 00:42:14 INFO - Running post-action listener: set_extra_try_arguments 00:42:14 INFO - ##### 00:42:14 INFO - ##### Finished download-and-extract step (success) 00:42:14 INFO - ##### 00:42:14 INFO - ##### 00:42:14 INFO - ##### Running populate-webroot step. 00:42:14 INFO - ##### 00:42:14 INFO - Running pre-action listener: _resource_record_pre_action 00:42:14 INFO - Running main action method: populate_webroot 00:42:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:42:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:42:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:42:14 INFO - '--tppagecycles', 00:42:14 INFO - '7'], 00:42:14 INFO - 'tests': ['tsvgm']}}, 00:42:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:42:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:42:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:42:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:42:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:42:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:42:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['damp', 'tps']}, 00:42:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'tests': ['damp', 'tps']}, 00:42:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['dromaeo_dom']}, 00:42:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:42:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['a11yr', 00:42:14 INFO - 'ts_paint', 00:42:14 INFO - 'tpaint', 00:42:14 INFO - 'sessionrestore', 00:42:14 INFO - 'sessionrestore_no_auto_restore', 00:42:14 INFO - 'tabpaint']}, 00:42:14 INFO - 'other-e10s': {'tests': ['a11yr', 00:42:14 INFO - 'ts_paint', 00:42:14 INFO - 'tpaint', 00:42:14 INFO - 'sessionrestore', 00:42:14 INFO - 'sessionrestore_no_auto_restore', 00:42:14 INFO - 'tabpaint']}, 00:42:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:42:14 INFO - 'ts_paint', 00:42:14 INFO - 'tpaint', 00:42:14 INFO - 'sessionrestore', 00:42:14 INFO - 'sessionrestore_no_auto_restore', 00:42:14 INFO - 'tabpaint']}, 00:42:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:42:14 INFO - 'ts_paint', 00:42:14 INFO - 'tpaint', 00:42:14 INFO - 'sessionrestore', 00:42:14 INFO - 'sessionrestore_no_auto_restore', 00:42:14 INFO - 'tabpaint']}, 00:42:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['a11yr', 00:42:14 INFO - 'ts_paint', 00:42:14 INFO - 'tpaint', 00:42:14 INFO - 'sessionrestore', 00:42:14 INFO - 'sessionrestore_no_auto_restore', 00:42:14 INFO - 'tabpaint']}, 00:42:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['a11yr', 00:42:14 INFO - 'ts_paint', 00:42:14 INFO - 'tpaint', 00:42:14 INFO - 'sessionrestore', 00:42:14 INFO - 'sessionrestore_no_auto_restore', 00:42:14 INFO - 'tabpaint']}, 00:42:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['tsvgx', 00:42:14 INFO - 'tsvgr_opacity', 00:42:14 INFO - 'tart', 00:42:14 INFO - 'tscrollx', 00:42:14 INFO - 'cart']}, 00:42:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:42:14 INFO - 'tsvgr_opacity', 00:42:14 INFO - 'tart', 00:42:14 INFO - 'tscrollx', 00:42:14 INFO - 'cart']}, 00:42:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'talos_options': ['--disable-e10s'], 00:42:14 INFO - 'tests': ['tp5o']}, 00:42:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'tests': ['tp5o']}, 00:42:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'talos_options': ['--disable-e10s', 00:42:14 INFO - '--xperf_path', 00:42:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:42:14 INFO - 'tests': ['tp5n']}, 00:42:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:42:14 INFO - 'talos_options': ['--xperf_path', 00:42:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:42:14 INFO - 'tests': ['tp5n']}}, 00:42:14 INFO - 'talos.zip': {'path': '', 00:42:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:42:14 INFO - Running post-action listener: _resource_record_post_action 00:42:14 INFO - ##### 00:42:14 INFO - ##### Finished populate-webroot step (success) 00:42:14 INFO - ##### 00:42:14 INFO - ##### 00:42:14 INFO - ##### Running create-virtualenv step. 00:42:14 INFO - ##### 00:42:14 INFO - Running pre-action listener: _resource_record_pre_action 00:42:14 INFO - Running main action method: create_virtualenv 00:42:14 INFO - Creating virtualenv /builds/slave/test/build/venv 00:42:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:42:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:42:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:42:14 INFO - Using real prefix '/usr' 00:42:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:42:15 INFO - Installing distribute.............................................................................................................................................................................................done. 00:42:17 INFO - Installing pip.................done. 00:42:17 INFO - Return code: 0 00:42:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:42:17 INFO - Using env: {'DISPLAY': ':0', 00:42:17 INFO - 'HOME': '/home/cltbld', 00:42:17 INFO - 'LANG': 'en_US.UTF-8', 00:42:17 INFO - 'LANGUAGE': 'en_US:en', 00:42:17 INFO - 'LOGNAME': 'cltbld', 00:42:17 INFO - 'MAIL': '/var/mail/cltbld', 00:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:17 INFO - 'MOZ_NO_REMOTE': '1', 00:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:17 INFO - 'NO_EM_RESTART': '1', 00:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:17 INFO - 'PWD': '/builds/slave/test', 00:42:17 INFO - 'SHELL': '/bin/bash', 00:42:17 INFO - 'SHLVL': '1', 00:42:17 INFO - 'TERM': 'linux', 00:42:17 INFO - 'TMOUT': '86400', 00:42:17 INFO - 'USER': 'cltbld', 00:42:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:17 INFO - '_': '/tools/buildbot/bin/python'} 00:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:42:17 INFO - Cleaning up... 00:42:17 INFO - Return code: 0 00:42:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:42:17 INFO - Using env: {'DISPLAY': ':0', 00:42:17 INFO - 'HOME': '/home/cltbld', 00:42:17 INFO - 'LANG': 'en_US.UTF-8', 00:42:17 INFO - 'LANGUAGE': 'en_US:en', 00:42:17 INFO - 'LOGNAME': 'cltbld', 00:42:17 INFO - 'MAIL': '/var/mail/cltbld', 00:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:17 INFO - 'MOZ_NO_REMOTE': '1', 00:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:17 INFO - 'NO_EM_RESTART': '1', 00:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:17 INFO - 'PWD': '/builds/slave/test', 00:42:17 INFO - 'SHELL': '/bin/bash', 00:42:17 INFO - 'SHLVL': '1', 00:42:17 INFO - 'TERM': 'linux', 00:42:17 INFO - 'TMOUT': '86400', 00:42:17 INFO - 'USER': 'cltbld', 00:42:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:17 INFO - '_': '/tools/buildbot/bin/python'} 00:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:17 INFO - Downloading/unpacking psutil>=3.1.1 00:42: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 00:42: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 00:42: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 00:42: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 00:42: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 00:42: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 00:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:42:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:42:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:42:19 INFO - Installing collected packages: psutil 00:42:19 INFO - Running setup.py install for psutil 00:42:19 INFO - building 'psutil._psutil_linux' extension 00:42:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:42:20 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 00:42:20 INFO - building 'psutil._psutil_posix' extension 00:42:20 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 00:42:20 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 00:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:42:20 INFO - Successfully installed psutil 00:42:20 INFO - Cleaning up... 00:42:20 INFO - Return code: 0 00:42:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:42:20 INFO - Using env: {'DISPLAY': ':0', 00:42:20 INFO - 'HOME': '/home/cltbld', 00:42:20 INFO - 'LANG': 'en_US.UTF-8', 00:42:20 INFO - 'LANGUAGE': 'en_US:en', 00:42:20 INFO - 'LOGNAME': 'cltbld', 00:42:20 INFO - 'MAIL': '/var/mail/cltbld', 00:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:20 INFO - 'MOZ_NO_REMOTE': '1', 00:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:20 INFO - 'NO_EM_RESTART': '1', 00:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:20 INFO - 'PWD': '/builds/slave/test', 00:42:20 INFO - 'SHELL': '/bin/bash', 00:42:20 INFO - 'SHLVL': '1', 00:42:20 INFO - 'TERM': 'linux', 00:42:20 INFO - 'TMOUT': '86400', 00:42:20 INFO - 'USER': 'cltbld', 00:42:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:20 INFO - '_': '/tools/buildbot/bin/python'} 00:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:42:22 INFO - Installing collected packages: mozsystemmonitor 00:42:22 INFO - Running setup.py install for mozsystemmonitor 00:42:22 INFO - Successfully installed mozsystemmonitor 00:42:22 INFO - Cleaning up... 00:42:22 INFO - Return code: 0 00:42:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:42:22 INFO - Using env: {'DISPLAY': ':0', 00:42:22 INFO - 'HOME': '/home/cltbld', 00:42:22 INFO - 'LANG': 'en_US.UTF-8', 00:42:22 INFO - 'LANGUAGE': 'en_US:en', 00:42:22 INFO - 'LOGNAME': 'cltbld', 00:42:22 INFO - 'MAIL': '/var/mail/cltbld', 00:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:22 INFO - 'MOZ_NO_REMOTE': '1', 00:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:22 INFO - 'NO_EM_RESTART': '1', 00:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:22 INFO - 'PWD': '/builds/slave/test', 00:42:22 INFO - 'SHELL': '/bin/bash', 00:42:22 INFO - 'SHLVL': '1', 00:42:22 INFO - 'TERM': 'linux', 00:42:22 INFO - 'TMOUT': '86400', 00:42:22 INFO - 'USER': 'cltbld', 00:42:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:22 INFO - '_': '/tools/buildbot/bin/python'} 00:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:22 INFO - Downloading/unpacking blobuploader==1.2.4 00:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:24 INFO - Downloading blobuploader-1.2.4.tar.gz 00:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:42:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:42:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:25 INFO - Downloading docopt-0.6.1.tar.gz 00:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:42:25 INFO - Installing collected packages: blobuploader, requests, docopt 00:42:25 INFO - Running setup.py install for blobuploader 00:42:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:42:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:42:25 INFO - Running setup.py install for requests 00:42:25 INFO - Running setup.py install for docopt 00:42:26 INFO - Successfully installed blobuploader requests docopt 00:42:26 INFO - Cleaning up... 00:42:26 INFO - Return code: 0 00:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:26 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')]} 00:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:26 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')]} 00:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:26 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 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:26 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 00:42:26 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 00:42:26 INFO - Using env: {'DISPLAY': ':0', 00:42:26 INFO - 'HOME': '/home/cltbld', 00:42:26 INFO - 'LANG': 'en_US.UTF-8', 00:42:26 INFO - 'LANGUAGE': 'en_US:en', 00:42:26 INFO - 'LOGNAME': 'cltbld', 00:42:26 INFO - 'MAIL': '/var/mail/cltbld', 00:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:26 INFO - 'MOZ_NO_REMOTE': '1', 00:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:26 INFO - 'NO_EM_RESTART': '1', 00:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:26 INFO - 'PWD': '/builds/slave/test', 00:42:26 INFO - 'SHELL': '/bin/bash', 00:42:26 INFO - 'SHLVL': '1', 00:42:26 INFO - 'TERM': 'linux', 00:42:26 INFO - 'TMOUT': '86400', 00:42:26 INFO - 'USER': 'cltbld', 00:42:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:26 INFO - '_': '/tools/buildbot/bin/python'} 00:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:42:26 INFO - Running setup.py (path:/tmp/pip-2Ojls4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:42:26 INFO - Running setup.py (path:/tmp/pip-CL0APB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:42:26 INFO - Running setup.py (path:/tmp/pip-TpojD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:42:26 INFO - Running setup.py (path:/tmp/pip-pfG5jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:42:26 INFO - Running setup.py (path:/tmp/pip-iYZS6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:42:26 INFO - Running setup.py (path:/tmp/pip-NFCG3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:42:26 INFO - Running setup.py (path:/tmp/pip-P4aQEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:42:26 INFO - Running setup.py (path:/tmp/pip-5h6Pv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:42:26 INFO - Running setup.py (path:/tmp/pip-JZXywM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:42:26 INFO - Running setup.py (path:/tmp/pip-Bjn5oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:42:27 INFO - Running setup.py (path:/tmp/pip-DguF7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:42:27 INFO - Running setup.py (path:/tmp/pip-giDSRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:42:27 INFO - Running setup.py (path:/tmp/pip-fjfEtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:42:27 INFO - Running setup.py (path:/tmp/pip-uZ18cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:27 INFO - Running setup.py (path:/tmp/pip-7VghqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:42:27 INFO - Running setup.py (path:/tmp/pip-Sf9spI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:42:27 INFO - Running setup.py (path:/tmp/pip-IFKZtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:42:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:42:27 INFO - Running setup.py install for manifestparser 00:42:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:42:27 INFO - Running setup.py install for mozcrash 00:42:27 INFO - Running setup.py install for mozdebug 00:42:27 INFO - Running setup.py install for mozdevice 00:42:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:42:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:42:27 INFO - Running setup.py install for mozfile 00:42:28 INFO - Running setup.py install for mozhttpd 00:42:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Running setup.py install for mozinfo 00:42:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Running setup.py install for mozInstall 00:42:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Running setup.py install for mozleak 00:42:28 INFO - Running setup.py install for mozlog 00:42:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Running setup.py install for moznetwork 00:42:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Running setup.py install for mozprocess 00:42:28 INFO - Running setup.py install for mozprofile 00:42:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:42:28 INFO - Running setup.py install for mozrunner 00:42:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:42:29 INFO - Running setup.py install for mozscreenshot 00:42:29 INFO - Running setup.py install for moztest 00:42:29 INFO - Running setup.py install for mozversion 00:42:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:42:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:42:29 INFO - Cleaning up... 00:42:29 INFO - Return code: 0 00:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42:29 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')]} 00:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:29 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')]} 00:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:29 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 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:29 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 00:42:29 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 00:42:29 INFO - Using env: {'DISPLAY': ':0', 00:42:29 INFO - 'HOME': '/home/cltbld', 00:42:29 INFO - 'LANG': 'en_US.UTF-8', 00:42:29 INFO - 'LANGUAGE': 'en_US:en', 00:42:29 INFO - 'LOGNAME': 'cltbld', 00:42:29 INFO - 'MAIL': '/var/mail/cltbld', 00:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:29 INFO - 'MOZ_NO_REMOTE': '1', 00:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:29 INFO - 'NO_EM_RESTART': '1', 00:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:29 INFO - 'PWD': '/builds/slave/test', 00:42:29 INFO - 'SHELL': '/bin/bash', 00:42:29 INFO - 'SHLVL': '1', 00:42:29 INFO - 'TERM': 'linux', 00:42:29 INFO - 'TMOUT': '86400', 00:42:29 INFO - 'USER': 'cltbld', 00:42:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:29 INFO - '_': '/tools/buildbot/bin/python'} 00:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:42:29 INFO - Running setup.py (path:/tmp/pip-u8N1yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:42:29 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)) 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:42:29 INFO - Running setup.py (path:/tmp/pip-BXC7b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:42:29 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)) 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:42:29 INFO - Running setup.py (path:/tmp/pip-ejyxCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:42:29 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)) 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:42:29 INFO - Running setup.py (path:/tmp/pip-CKtr_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:42:29 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)) 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:42:29 INFO - Running setup.py (path:/tmp/pip-VbtIXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:42:29 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)) 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:42:29 INFO - Running setup.py (path:/tmp/pip-3ev93r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:42:29 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)) 00:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:42:29 INFO - Running setup.py (path:/tmp/pip-BDmkNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:42:30 INFO - Running setup.py (path:/tmp/pip-bBnCM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:42:30 INFO - Running setup.py (path:/tmp/pip-TBvrTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:42:30 INFO - Running setup.py (path:/tmp/pip-fzCA1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:42:30 INFO - Running setup.py (path:/tmp/pip-RSKwC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:42:30 INFO - Running setup.py (path:/tmp/pip-pFBaGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:42:30 INFO - Running setup.py (path:/tmp/pip-VKGM5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:42:30 INFO - Running setup.py (path:/tmp/pip-vfuYNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:30 INFO - Running setup.py (path:/tmp/pip-8Gzr0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:42:30 INFO - Running setup.py (path:/tmp/pip-PEz5vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:42:30 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)) 00:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:42:30 INFO - Running setup.py (path:/tmp/pip-xUneru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:42:30 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)) 00:42:30 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)) 00:42:30 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)) 00:42:30 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)) 00:42:30 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)) 00:42:30 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)) 00:42:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:42:30 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 00:42:30 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 00:42:30 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 00:42:30 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 00:42:30 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 00:42:30 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 00:42:32 INFO - Downloading blessings-1.6.tar.gz 00:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:42:32 INFO - Installing collected packages: blessings 00:42:32 INFO - Running setup.py install for blessings 00:42:32 INFO - Successfully installed blessings 00:42:32 INFO - Cleaning up... 00:42:32 INFO - Return code: 0 00:42:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:42:33 INFO - Reading from file tmpfile_stdout 00:42:33 INFO - Current package versions: 00:42:33 INFO - argparse == 1.2.1 00:42:33 INFO - blessings == 1.6 00:42:33 INFO - blobuploader == 1.2.4 00:42:33 INFO - docopt == 0.6.1 00:42:33 INFO - manifestparser == 1.1 00:42:33 INFO - mozInstall == 1.12 00:42:33 INFO - mozcrash == 0.17 00:42:33 INFO - mozdebug == 0.1 00:42:33 INFO - mozdevice == 0.48 00:42:33 INFO - mozfile == 1.2 00:42:33 INFO - mozhttpd == 0.7 00:42:33 INFO - mozinfo == 0.9 00:42:33 INFO - mozleak == 0.1 00:42:33 INFO - mozlog == 3.2 00:42:33 INFO - moznetwork == 0.27 00:42:33 INFO - mozprocess == 0.22 00:42:33 INFO - mozprofile == 0.28 00:42:33 INFO - mozrunner == 6.11 00:42:33 INFO - mozscreenshot == 0.1 00:42:33 INFO - mozsystemmonitor == 0.3 00:42:33 INFO - moztest == 0.7 00:42:33 INFO - mozversion == 1.4 00:42:33 INFO - psutil == 3.1.1 00:42:33 INFO - requests == 1.2.3 00:42:33 INFO - wsgiref == 0.1.2 00:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:42: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')]} 00:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42: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')]} 00:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:33 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 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:33 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 00:42:33 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 00:42:33 INFO - Using env: {'DISPLAY': ':0', 00:42:33 INFO - 'HOME': '/home/cltbld', 00:42:33 INFO - 'LANG': 'en_US.UTF-8', 00:42:33 INFO - 'LANGUAGE': 'en_US:en', 00:42:33 INFO - 'LOGNAME': 'cltbld', 00:42:33 INFO - 'MAIL': '/var/mail/cltbld', 00:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:33 INFO - 'MOZ_NO_REMOTE': '1', 00:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:33 INFO - 'NO_EM_RESTART': '1', 00:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:33 INFO - 'PWD': '/builds/slave/test', 00:42:33 INFO - 'SHELL': '/bin/bash', 00:42:33 INFO - 'SHLVL': '1', 00:42:33 INFO - 'TERM': 'linux', 00:42:33 INFO - 'TMOUT': '86400', 00:42:33 INFO - 'USER': 'cltbld', 00:42:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:33 INFO - '_': '/tools/buildbot/bin/python'} 00:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 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)) 00:42:33 INFO - Cleaning up... 00:42:33 INFO - Return code: 0 00:42:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:42: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')]} 00:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42: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')]} 00:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:33 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 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:33 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 00:42:33 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 00:42:33 INFO - Using env: {'DISPLAY': ':0', 00:42:33 INFO - 'HOME': '/home/cltbld', 00:42:33 INFO - 'LANG': 'en_US.UTF-8', 00:42:33 INFO - 'LANGUAGE': 'en_US:en', 00:42:33 INFO - 'LOGNAME': 'cltbld', 00:42:33 INFO - 'MAIL': '/var/mail/cltbld', 00:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:33 INFO - 'MOZ_NO_REMOTE': '1', 00:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:33 INFO - 'NO_EM_RESTART': '1', 00:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:33 INFO - 'PWD': '/builds/slave/test', 00:42:33 INFO - 'SHELL': '/bin/bash', 00:42:33 INFO - 'SHLVL': '1', 00:42:33 INFO - 'TERM': 'linux', 00:42:33 INFO - 'TMOUT': '86400', 00:42:33 INFO - 'USER': 'cltbld', 00:42:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:33 INFO - '_': '/tools/buildbot/bin/python'} 00:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:33 INFO - Downloading/unpacking jsonschema 00:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:42:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:42:35 INFO - Downloading/unpacking functools32 (from jsonschema) 00:42:35 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 00:42:35 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 00:42:35 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 00:42:35 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 00:42:35 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 00:42:35 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 00:42:35 INFO - Downloading functools32-3.2.3-2.tar.gz 00:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:42:35 INFO - warning: no files found matching '*.txt' 00:42:35 INFO - no previously-included directories found matching 'build' 00:42:35 INFO - no previously-included directories found matching 'dist' 00:42:35 INFO - no previously-included directories found matching '.git*' 00:42:35 INFO - Installing collected packages: jsonschema, functools32 00:42:35 INFO - Running setup.py install for functools32 00:42:35 INFO - warning: no files found matching '*.txt' 00:42:35 INFO - no previously-included directories found matching 'build' 00:42:35 INFO - no previously-included directories found matching 'dist' 00:42:35 INFO - no previously-included directories found matching '.git*' 00:42:35 INFO - Successfully installed jsonschema functools32 00:42:35 INFO - Cleaning up... 00:42:36 INFO - Return code: 0 00:42:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:42:36 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 0x7f44ea7a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, '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': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', '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 00:42:36 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 00:42:36 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 00:42:36 INFO - Using env: {'DISPLAY': ':0', 00:42:36 INFO - 'HOME': '/home/cltbld', 00:42:36 INFO - 'LANG': 'en_US.UTF-8', 00:42:36 INFO - 'LANGUAGE': 'en_US:en', 00:42:36 INFO - 'LOGNAME': 'cltbld', 00:42:36 INFO - 'MAIL': '/var/mail/cltbld', 00:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:36 INFO - 'MOZ_NO_REMOTE': '1', 00:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:36 INFO - 'NO_EM_RESTART': '1', 00:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:36 INFO - 'PWD': '/builds/slave/test', 00:42:36 INFO - 'SHELL': '/bin/bash', 00:42:36 INFO - 'SHLVL': '1', 00:42:36 INFO - 'TERM': 'linux', 00:42:36 INFO - 'TMOUT': '86400', 00:42:36 INFO - 'USER': 'cltbld', 00:42:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:36 INFO - '_': '/tools/buildbot/bin/python'} 00:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:42:36 INFO - Downloading/unpacking flake8 00:42:36 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 00:42:36 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 00:42:36 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 00:42:36 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 00:42:36 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 00:42:36 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 00:42:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:42:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:42:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 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 00:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:42:38 INFO - no previously-included directories found matching 'docs/_build' 00:42:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:42:38 INFO - Running setup.py install for pep8 00:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:42:38 INFO - no previously-included directories found matching 'docs/_build' 00:42:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:42:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:42:39 INFO - Cleaning up... 00:42:39 INFO - Return code: 0 00:42:39 INFO - Running post-action listener: _resource_record_post_action 00:42:39 INFO - Running post-action listener: _start_resource_monitoring 00:42:39 INFO - Starting resource monitoring. 00:42:39 INFO - ##### 00:42:39 INFO - ##### Finished create-virtualenv step (success) 00:42:39 INFO - ##### 00:42:39 INFO - ##### 00:42:39 INFO - ##### Running install step. 00:42:39 INFO - ##### 00:42:39 INFO - Running pre-action listener: _resource_record_pre_action 00:42:39 INFO - Running main action method: install 00:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:42:39 INFO - Reading from file tmpfile_stdout 00:42:39 INFO - Detecting whether we're running mozinstall >=1.0... 00:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:42:39 INFO - Reading from file tmpfile_stdout 00:42:39 INFO - Output received: 00:42:39 INFO - Usage: mozinstall [options] installer 00:42:39 INFO - Options: 00:42:39 INFO - -h, --help show this help message and exit 00:42:39 INFO - -d DEST, --destination=DEST 00:42:39 INFO - Directory to install application into. [default: 00:42:39 INFO - "/builds/slave/test"] 00:42:39 INFO - --app=APP Application being installed. [default: firefox] 00:42:39 INFO - mkdir: /builds/slave/test/build/application 00:42:39 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'] 00:42:39 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 00:42:55 INFO - Reading from file tmpfile_stdout 00:42:55 INFO - Output received: 00:42:55 INFO - /builds/slave/test/build/application/firefox/firefox 00:42:55 INFO - Running post-action listener: _resource_record_post_action 00:42:55 INFO - ##### 00:42:55 INFO - ##### Finished install step (success) 00:42:55 INFO - ##### 00:42:55 INFO - ##### 00:42:55 INFO - ##### Running run-tests step. 00:42:55 INFO - ##### 00:42:55 INFO - Running pre-action listener: _resource_record_pre_action 00:42:55 INFO - Running main action method: run_tests 00:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:42:55 INFO - Python 2.7.3 00:42:55 INFO - Return code: 0 00:42:55 INFO - grabbing minidump binary from tooltool 00:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:42:55 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 0x16369c0>, '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 0x16378c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1637d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:42:55 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 00:42:55 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 00:42:55 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 00:42:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:42:55 INFO - Return code: 0 00:42:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:42:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:42:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:42:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:42:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:42:56 INFO - Return code: 0 00:42:56 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/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 00:42:56 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/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 00:42:56 INFO - Using env: {'DISPLAY': ':0', 00:42:56 INFO - 'HOME': '/home/cltbld', 00:42:56 INFO - 'LANG': 'en_US.UTF-8', 00:42:56 INFO - 'LANGUAGE': 'en_US:en', 00:42:56 INFO - 'LOGNAME': 'cltbld', 00:42:56 INFO - 'MAIL': '/var/mail/cltbld', 00:42:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:42:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:42:56 INFO - 'MOZ_NO_REMOTE': '1', 00:42:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:42:56 INFO - 'NO_EM_RESTART': '1', 00:42:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:42:56 INFO - 'PWD': '/builds/slave/test', 00:42:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:42:56 INFO - 'SHELL': '/bin/bash', 00:42:56 INFO - 'SHLVL': '1', 00:42:56 INFO - 'TERM': 'linux', 00:42:56 INFO - 'TMOUT': '86400', 00:42:56 INFO - 'USER': 'cltbld', 00:42:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783', 00:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:42:56 INFO - '_': '/tools/buildbot/bin/python'} 00:42:56 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/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 00:42:56 INFO - mozversion application_buildid: 20160524000618 00:42:56 INFO - mozversion application_changeset: 00f9eb3e72e805caebd204b780dc904877cab590 00:42:56 INFO - mozversion application_display_name: Nightly 00:42:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:42:56 INFO - mozversion application_name: Firefox 00:42:56 INFO - mozversion application_remotingname: firefox 00:42:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:42:56 INFO - mozversion application_vendor: Mozilla 00:42:56 INFO - mozversion application_version: 49.0a1 00:42:56 INFO - mozversion platform_buildid: 20160524000618 00:42:56 INFO - mozversion platform_changeset: 00f9eb3e72e805caebd204b780dc904877cab590 00:42:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:42:56 INFO - mozversion platform_version: 49.0a1 00:42:56 INFO - using testdate: 1464075776 00:42:56 INFO - actual date: 1464075776 00:42:56 INFO - starting webserver on 'localhost:60565' 00:42:56 INFO - SUITE-START | Running 2 tests 00:42:56 INFO - TEST-START | dromaeo_css 00:42:56 INFO - operating with platform_type : linux_ 00:42:56 INFO - Initialising browser for dromaeo_css test... 00:42:56 INFO - TEST-INFO | started process 24965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy5G6q7/profile http://localhost:60565/getInfo.html) 00:43:00 INFO - PROCESS | 24965 | __metrics Screen width/height:1600/1200 00:43:00 INFO - PROCESS | 24965 | colorDepth:24 00:43:00 INFO - PROCESS | 24965 | Browser inner width/height: 1024/697 00:43:00 INFO - PROCESS | 24965 | __metrics 00:43:01 ERROR - PROCESS | 24965 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:43:01 INFO - TEST-INFO | 24965: exit 0 00:43:01 INFO - Browser initialized. 00:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 00:43:01 INFO - TEST-INFO | started process 25048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy5G6q7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:13 INFO - PROCESS | 25048 | RSS: Main: 154533888 00:43:13 INFO - PROCESS | 25048 | 00:44:05 INFO - PROCESS | 25048 | 1464075845655 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] 00:46:17 INFO - PROCESS | 25048 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60565/tests/dromaeo/cssquery-ext.html) 00:46:18 INFO - PROCESS | 25048 | RSS: Main: 238702592 00:46:18 INFO - PROCESS | 25048 | 00:49:20 INFO - PROCESS | 25048 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-ext.html (next: http://localhost:60565/tests/dromaeo/cssquery-jquery.html) 00:49:21 INFO - PROCESS | 25048 | RSS: Main: 238567424 00:49:21 INFO - PROCESS | 25048 | 00:52:23 INFO - PROCESS | 25048 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60565/tests/dromaeo/cssquery-mootools.html) 00:52:24 INFO - PROCESS | 25048 | RSS: Main: 238473216 00:52:24 INFO - PROCESS | 25048 | 00:55:26 INFO - PROCESS | 25048 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60565/tests/dromaeo/cssquery-prototype.html) 00:55:26 INFO - PROCESS | 25048 | RSS: Main: 236785664 00:55:26 INFO - PROCESS | 25048 | 00:58:29 INFO - PROCESS | 25048 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60565/tests/dromaeo/cssquery-yui.html) 00:58:30 INFO - PROCESS | 25048 | RSS: Main: 222703616 00:58:30 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | Cycle 1(1): loaded http://localhost:60565/tests/dromaeo/cssquery-yui.html (next: http://localhost:60565/tests/dromaeo/cssquery-dojo.html) 01:01:33 INFO - PROCESS | 25048 | RSS: Main: 277299200 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | __start_tp_report 01:01:33 INFO - PROCESS | 25048 | _x_x_mozilla_page_load 01:01:33 INFO - PROCESS | 25048 | _x_x_mozilla_page_load_details 01:01:33 INFO - PROCESS | 25048 | |i|pagename|runs| 01:01:33 INFO - PROCESS | 25048 | |0;dojo.html;2663.1477927063343;2669.3460102274944;2713.5793951937444;2725.591161325801;2731.877065532051;4596.0578081493295;4643.257078867382;4698.483166851648;4742.52574742526;4794.041191761648;4712.222483290261;4758.785854636541;4758.8096476141;4761.928571071437;4767.1657459944545;4358.585934336233;4361.302191649337;4432;4461;4522.932156017662;4432.268675668527;4460.643148548124;4474.843380481684;4481.596656300932;4505.279155335147;4280.0797828466875;4322.956770432287;4339.349097635349;4381.978090109561;4430.025394413224;4343.413639158704;4352.36890650857;4383.364412160219;4395.516493185747;4405.427294451701;4378.868633940987;4378.890527736832;4379.627731642814;4407.0524837160165;4422.137683151786;4475.216837053503;4589.908201835945;4648.861029047871;4652.5114862939245;4713.293006049086;5042.369703787027;5101.4133374662015;5109.923351149736;5111.591072714174;5114.079465696173;4957.628177886637;5058.721770302632;5142.717150556718;5149.382074151088;5151.819686310999;4654;4733.692309999908;4736.95263047372;4759.190937540627;4787.54518320766;5244.554212891947;5268.947310526923;5272.130098533776;5272.815451459181;5275.815346462856;4946.876328091755;4954.157793175169;5024.171011783088;5032.194848824171;5032.471590482946;5063.8480845574695;5067.391912970467;5081.034603425412;5092;5138.38339399267;5027.824026159067;5041.974790126026;5043.4956504349275;5045.672031317952;5087.389513258433;4894.608431325485;4953.25701144824;4982.202847544376;5012.448630650625;5019.52314530119;4241.893952651209;4250.893727656771;4262.936055959163;4298.075913678574;4302.978485107555;3727.552693676722;3737.9439308410397;3747.5315585551807;3780;3790.374588192917;4310.331898555729;4350.2387082260475;4396.406485124531;4405.933910991338;4454.042380888124;5108.872278193075;5146.30524879144;5146.6911985281;5149.922751158736;5190;4451.06527629195;4454.554544545519;4458.866234012985;4478.798454069574;4506.59440650343;4455.420795296655;4526.411566496335;4559.202139625552;4573.748443835621;4577.473590537064;4838.346823178826;4855.732934688626;4857.708537487762;4893.217085266411;4913.1893237615395;5121.974390128025;5133.56364708989;5135.820246291362;5138.486151384981;5139.8458046258675;4697.788599512962;4724.338592596971;4761.6428767843245;4767.4517430495935;4872.196087645641;4942.431620363561;4956.479569645279;4958.2810492477665;4980.252962055576;5028.723420211923;5044.47033061538;5051.318072060225;5056.494350565061;5057.31726216956;5107.719075450886;4852.660313778002;4917.311576379381;4969.130402179532;4971.9005619886675;4979.3526841510375;4942.5304596063315;4973.726445045412;4990.226514890198;4993.4756850530175;5037.042961837239;4742.66801323904;4895.779689914034;4902.411710594752;4903.705777653352;4959.950400496094;4941.135301322182;4965.255211718271;4989.426215985208;4997.275395067622;5010.674306170087;4896.951030489649;4900.92648610264;4901.50984901507;4903.068417000758;4955.950440495693 01:01:33 INFO - PROCESS | 25048 | |1;ext.html;587.2571197435245;590.1030433740714;599.3077994915874;603.8037637767727;603.86714922717;42321.36517952229;44252.999999999956;44264.55735442645;44271.55728442719;44315.55684443154;38297.23405531888;38550.228995420075;38660.42009369854;38691.22617547648;38780.76459677942;7510;7589.08930928288;7752.457327987043;7763.378929685611;9885.308028438012;9656.565454554562;10098.444585547792;10105.343152695088;10106.039926207035;10107;10153.796924061515;10226.233032522554;10230.07929286364;10232.13026892715;10235.539400726986;7496.512726672749;9899.059589339002;10063.446510441923;10190.133838623726;10207.693769186937;9946.403215807075;10030.849537256947;10039.949800251024;10040.397576145455;10042.246831487668;37263.81368093169;37523.4371484428;37568.43647345292;37626.81186594077;37701.43447848284;3041.8022828516077;3270.2314955985325;3356.2784001439563;3496.7027802636553;3581.301646178996;29005.56491652627;29016.70983290161;29085.41829163405;29297.853510732522;29834.55248171279;3484;3524.3479956207925;3548.3967725486727;3587.121155316964;3588.802615856127;246127;246785;247001;247318;248270;31012.53481197784;51411.401201916255;51687;51762;51864;31715.84142079321;33837.830810845786;34100.31799363999;34128.31743365119;34151.31697366088;11414.828777568344;11547.422628868522;11556.537738490535;11557.479913403917;11563.248388854698;7884.408669349822;8929.866052009225;9278.62885484573;9301.767455813659;9463.337566370288;7913.0504339478475;7958.204179581995;7987.440879138405;8040.517568945882;8049.315808156372;3140.9214769630944;3147.7324427423923;3183.5861338025907;3189.202699325169;3199.776015678927;882.8896387951506;913.2693844924034;990.0347161517607;1001.3791449301334;1004.884438289606;26855.597166042524;27849.164525063876;28193.57709634357;28199.71800282012;28212.43575128486;979.808937257228;997.7854761226371;999.9050090241416;1011.5650270383659;1051.5951358726793;14853.851461485247;14933.925330373278;15061;15212.391504339923;15252.847471525365;120593;120632;120647;120713;120946.3952680231;48825;49129.26306105412;49215.75392123016;49295.260571091465;49360.50639493559;1109.4064675398622;1185.7095011722183;1240.6030070377392;1246.246021157205;1259.9370031498388;27521.724782751917;28310.57534137031;28393.858030709715;28575.571366429103;29082.41835163327;40411.595884040784;40653.390199146445;40878.59121408748;40916.18167636571;40925.795371022956;282111;283495;283704;283994;284396;21894;23841.52316953686;24494.877525612257;24646.260612181664;25764.227073187834;40127.79936100301;40417.59582404138;40506;41006.17987640171;41439;35116.64883351134;35641.28717425689;35820;36157.27685446329;36323.091922702144;35451.64548354483;36021;36091.639083608825;36135.819320903225;36208;33599.66400336063;34101;34627.30745385129;34833.79329822143;35195.120121997155;30702;31570.36859262756;31631;31860.681393185772;32223;24179.87910060509;24372.756272437757;24671.506569868143;25019.74980250247;25051.624225636264 01:01:33 INFO - PROCESS | 25048 | |2;jquery.html;366.5839272425796;369.0865108855582;370.8831718008827;381.47166174847825;384.34277385670504;16662.250198741072;17303.39438119666;17362.39231626893;17697.82302176978;17747;13770.724585508284;16321;17056;17187.570310742238;17221.7416738749;4954.1330267203275;5127.256547800566;5155.845324640267;5168.948310516885;5175.353080864892;3738.7943663098517;3912.256671232471;5070.2141168119;5570.192322113291;5913.408659134074;5929.347771745104;5934.792282270121;5952.613080149798;5955.315138759055;5960.463558279754;5715.228444160048;5952.3154837193415;5953.3451320354725;5958.106284057404;5965.224520812289;3390.4066788312193;4929.778159982773;5234;5244.423113457517;5253.50091741284;19936.80063199364;20459.2839250627;20524.281650142173;20850.895745521175;20935.895320523454;1916.8179022992792;1934.7001214811726;1968.2028778344793;2221.6445368741083;2511.748825117492;12259.203151795105;13248.668783280398;13331;13380.330983450789;13760;1746.362577659158;1801.306496998665;1810.6469238498498;1848.2514581594476;1848.473185142228;65309;67205.66397168032;67304.32695673029;67759.3224067758;69059;9507.382020168667;9510.90489095114;9965;10000.399976001463;10170.135538479311;13916.930415347859;13990.930045349709;14000.929995349958;14003.299835008209;14006.299685015709;6724;6826.488013398915;6830.692618832065;6913.792586222421;6926.757563485254;6229.781957631461;6263.123162757218;6426.325235850169;6434.356564343529;6442.162518872517;6194.628322300677;6293.118963345135;6297.748090076438;6302.558820882494;6369.681515924185;1650.4553497345846;1693.1618848669987;1758.2000189913558;1765.9646807063787;1774.5803357314096;862.3833958719546;890.8619164029586;921.3412410126791;1004.3923426327113;1024.6669832304383;16432.178391080397;17356.09083000869;17547.385841495485;17637.470875873743;17755.378561750276;878.1350369885657;883.3772190605607;887.1572006593761;894.3247847874812;925.2366797392178;8702.173293537104;9789.608415663293;9995.600175992879;10061.647842325483;10262.948685256526;397311;398255;400451;403361;414058;65709.34290657128;67697;67790.66104669445;67824.6608766953;68253.65873170702;905.1401168889581;919.2645883293338;932.0353434195575;942.0767647705287;943.8065196634674;15209.239538022834;15301.46444874424;15320.846791531942;15556.766648500055;15776.526704198892;31946.36107277795;32263.838680806446;32613;32689.18277043093;33174.838880639065;41251.38122928098;42982.78508607437;43915;44451;45532;7065.929340706527;7202.603856787927;7307.26927307265;7381;7419.258074192538;10566.207534435101;10794.244402892036;10861.945690271497;10909.181811364339;10940.945295273472;8971.102889710977;9103.499307537884;9121.86175051074;9160.633574656938;9284.442933424016;9113.544322783968;9276.768080798034;9318.580663870007;9372.000959693105;9529.904700952902;8991.100889911218;9005.14451127142;9102.908970910472;9450.952745236229;9451.338406311766;7056.50604457683;7132.965719970472;7197.784066478014;7229.385502232369;7339.669714862737;8558.914410856061;8868.379213454997;8929.821403572023;9015.774605634911;9140.628905664204 01:01:33 INFO - PROCESS | 25048 | |3;mootools.html;1292.4313302147061;1423.8220222472191;1465.6335916020994;1542.2288855572215;1735.3405705831783;6762.222344430385;7542.585157816318;7760.844783104335;7769.339606133485;7960.562169080698;7700.114486834016;7879;7952.125266220725;7978.242067003625;7980.640871160797;1848.4639454558162;2160.8919554022314;2201.7137772089645;2215.534737705084;2232.1071571371417;2234.1398561553838;2258.8192944564394;2259.1189436119926;2260.4235919840416;2261.977380226193;2183.094015983365;2183.814375778061;2213.3691897809126;2222.6666000100035;2237.451824303048;1755.6400937807718;2081.115525901486;2150.5483848391855;2152.806247437738;2153.91384344626;2207.172310383606;2234.910603575855;2236.4297104238476;2236.563870045342;2240.2271216430304;7852.3325517331095;7884.566348850811;7887.566183859885;7889.368850491946;7904.920950790476;4353.499347575038;4502.2571275739465;4508.752018638974;4510.864674059783;4518.006038671487;2778.4165325281715;2838.7161283871656;2993.266649670823;2996.4306781711407;3001.069668402802;936.9109934556207;956.8803899512561;962.6245764151986;977.4575110813496;981.9950900245453;11143.275687080395;11148.386838723867;11166.776664466664;11179.217454778169;11190.664280071529;4119.196756632487;4183.3515805050265;4286.314189729628;4291.206126866539;4293.484781826201;9274.675386361445;9345.439273643604;9367;9372.297077719199;9396.06039396055;4477.574630410171;4483.103379324149;4487.753173575419;4488.753118578509;4489.034857505652;3419.230673098583;3866.6133386661672;4000.3999400089638;4007.2987227235117;4058.573849745734;3616.0598244456633;3654.8720794772057;3721.8511259549855;3751.756135851161;3792.6965842732516;1153.5270539078938;1158.7972104881612;1159.5245949160972;1171.6777886081395;1186.211169572242;718.8562287542512;766.3907193780957;792.5482474989201;815.5799763121997;833.1876420489974;4767.237242041257;4777.211760059621;4802.447718512346;4864.36763220779;4941.135301322254;801.4750338528273;813.8209593889335;850.6724910909345;869.6738722978882;878.5036454403241;3139.8744050238192;3192.393445245396;3193.5848339716154;3311.718503927145;3354.6477619849566;9226.90773092274;9889.505524723734;9889.604415823287;9892.307538472382;9907.45508997012;9635.084666956627;9643.180329671915;9666.323357364918;9743.561539730728;9746.75633109178;7235.819104522429;7514.812129696692;7520.699172033167;7526.473146879666;7543.358814500719;4781.102550319598;4977.477364876636;5031.295618613471;5263.973680131575;5275;8920.643174272956;9123.49820759838;9147.451152930846;9163.404378715362;9168.954155229181;8970.551472426483;9140.954295228481;9215.539223038955;9306.953465232631;9342.579583918876;6501.1548498694865;6527.934720652733;6530.281669016499;6575.901361479678;6595.208574971034;7358.852822943618;7387.667554959932;7401.111866576045;7427.851442971219;7475.925240747523;6600.438962688226;6828.351306625863;6859.965700171467;6924.723011079501;6972.372486476242;6029.186059882035;6200.937990620217;6246.750129994749;6249.687515624291;6309.747610095545;5432.565394768488;5843.590948633555;5896.380880007538;5909.704514774158;5913.467787898938;4171.916561668689;4299.731579184086;4325.567443255649;4360.454943132108;4362.585554372329;4330.415393921906;4348.760818155032;4364.018095928391;4419.337099435111;4448.154850578379 01:01:33 INFO - PROCESS | 25048 | |4;prototype.html;279.3560842258594;293.27122101577584;297.09830663934963;303.7372672638169;305.42884805413877;4756.643251756115;4758.833440829571;4770.928436073453;4787.162246606843;4799.904001919964;4697.919478519934;4699.4256923930525;4704.741239231841;4713.151632706112;4733.739644319561;3546.414841551141;3609.9892030231445;3658.762180458275;3748.512693349861;3809.733318667694;3752.6810221131236;3771.622837716234;3776.3013842439236;3789.4505296732095;3801.771893686374;3545.468179773042;3743.681787048104;3747.7001839852746;3755.2864955658474;3758.361078616642;3613.313470440621;3715.770537677372;3719.1074142205675;3723.03201167697;3733.831977561016;3266.9019929402157;3275.885344012972;3284.850302394143;3296.76922615417;3312.96687033129;4516.9159401743345;4522.3216517522305;4524.457065152203;4545.545445455428;4548.204064288736;4003.2393845169327;4208.389783481409;4215.831366745327;4235.767032813194;4254.91490170198;4920.261960705887;4938.049470459185;4955.315192834453;4968.453470118284;4977.058947010669;3525.294941011782;3534.5581802274714;3536.8938931832085;3541.3979623464074;3545.2023294758733;5014.924776128361;5188.299579556749;5197.22041693749;5214.374275086976;5221.39953905302;3644.85420583179;3654.8903532894055;3655.9451608225368;3663.19409729859;3670.908227294339;3647.3981793004386;3660.103274697663;3664.9083772905356;3694.371956767356;3704.2961837250837;4161.313383291784;4196.160767846443;4197.160567886435;4202;4202.768847713344;4830.154722923475;4895.143349913751;4921.581665558396;4950.8267210647455;5010.073136469765;1251.7684228417772;1257.8930790882878;1278.5461161287794;1279.9104062715521;1281.7052078022107;799.7800604833717;817.9918200818034;900.0954041188694;943.8112377524523;945.191860958884;4370.366296886998;4387.473503179639;4402.559744025636;4404.867853964322;4452.688311818141;5049.166887463527;5079.161938280216;5083.949160508421;5087.033463641897;5102.642815002989;4192.930802645306;4335.197988372098;4375.431193944767;4376.934345984812;4408.382826404306;2649.205238428464;2673;2676.5182267191703;2701.122135306033;2710.6340644012807;4761.4524329701835;4765.475797662254;4773.856784296477;4789.09007288621;4816.157172494799;5015.3577225621175;5058.962912602908;5162.45794191612;5170.276161337416;5174.24973378858;4713.646476514206;4751.311059896296;4761.428628564456;4767.189577771787;4782.3543821584335;5038.035166285078;5038.622103342191;5055.7219352935945;5058.494150584912;5066.417362003417;4704.341392205026;4932.975335123301;4953.554180123806;4975.527324904128;4986.8753281168265;4755.809767609257;4773.641976851681;4841.491643377535;4842.58837998774;4865.343178670834;3676.926461470809;3699.9085269844923;3733.290674771785;3736.0858530346372;3755.267722794029;4736.5069256488205;4977.680914557717;4978.800847966186;4988.530677314752;4989.453269486471;4872.660018494942;4918.901621967469;4926.261060840902;4932.260160975882;4939.53074457926;4872.3909511311085;4894.804207831647;4906.141425250496;4950.306957025947;4956.7769450375545;4662.32396302541;4811.821103829584;4830.95169048305;4840.249761287007;4864.878378040577;4944.1100601892;4944.5549900507685;4969.4782047884455;4995.225740010304;4997.200447928314;4867.659263851497;4870.829520966749;4884.682495637772;4896.338994235875;4897.436794768647 01:01:33 INFO - PROCESS | 25048 | |5;yui.html;719.6869361827605;727.0766127018686;730.9853802923942;752.6876346316279;781.0549235425135;11829.7634047319;11963.1625786195;12064.457099430525;12100.334481603508;12121.57574484891;12364.752704945919;12390.07074469414;12424.192427492208;12424.627261182157;12435.502579896816;628.4218518962565;783.1072577261926;803.8633432316491;804.9959750201241;806.9193080691942;794.1224946434194;795.2882170457437;795.5624406576388;799.1489064146695;799.9280064794167;510.57877251267666;857.3012994409536;857.7126662568047;858.4162769316862;859.3640705877668;820.3314298846421;838.7609531283616;842.6629348260744;844.7888027993001;845.0873057098319;616.7532986805269;616.8519555306694;617.0836308082494;617.3425302053299;617.4473845907933;11720.179587428884;11766.882331176665;11780.705482362924;11786.410679466078;11859.584914528037;11621.24461909973;11834;11891.108166887432;12207.267563946103;12302.569410070604;10537.315074520131;10553.102986246178;10596.576136954513;10790;10910.127189824794;4092.4270602115726;4132.876013719593;4152.6055024772595;4187.937180942288;4297.269464191064;44058;44059.77970110161;44215;44933.77533112346;46024.07951840978;9753.658621948198;9875.358101723365;9891.109800118023;9899.30704850668;9946.303758736818;16661.583460413585;16745.246463909152;16798;16804.915975420045;16841.41055063067;6413.3266007069515;6416.390442907917;6439.613623182624;6448.677566121675;6783.219929708048;3828;3841.4621952926614;3864.806759662006;3885.6206046853526;3895.7857317847793;2692.5018871508832;2798.2164993801766;2802.355458244615;2825.6044153818484;2837.120492647286;479.79608666316676;503.40598094248406;522.2531779555196;538.4534697282262;544.4337888595816;599.0355527600559;599.2240049136379;608.4493533352323;609.1776102261999;615.7321565119188;8314.422529016025;8362.58187090643;8383.916160838435;8431.988161420668;8614.956925215334;461.0916494505818;520.2560338715673;579.3684883477031;582.9826951968757;607.2348840461051;3829.9042523937123;3893.7274390792372;3935.2129574085297;4033.576474470197;4065.10567675111;60422.69788651117;60722.69638651867;61050.38949610447;61111.38888611146;61546;54688.45311546913;54706;55113.44886551083;55271.447285527436;55859;49967.50032499701;50377;50395.496045039814;50514.49485505098;51572;7507.849843003219;7813.609319533887;7840.098388685146;7853.882191767014;7915;32765.50851737178;33351;33469.497957531144;33508.664913350556;34408.48387274243;36486.817565912;37023.81488092542;37451.250974980896;39710.60289397069;40144.397834033094;10746.892531074589;10852.674419767103;10874.836877446687;10921.781564368826;10990.780184396428;11632.069434445393;11741.354225517678;11861.525538978343;12153.270803751802;12850.100492965403;11228.775424491629;11273.887261127284;11500.079993600659;11572.074234061087;11823.172377933806;10991.945040274748;11666.70833229176;11760.235584686969;11904;12151.513939442324;10796.352218866894;11041.116710663287;11271.436428178395;11768.235064720766;11795.587154449553;9049.140331668481;9283.164515193665;9525.714228573153;9669.854952175863;9880.160186384237;9650.517474126125;9737.902620973982;9940.801183976424;9962.302638815214;9966.651167209113 01:01:33 INFO - PROCESS | 25048 | __end_tp_report 01:01:33 INFO - PROCESS | 25048 | __start_cc_report 01:01:33 INFO - PROCESS | 25048 | _x_x_mozilla_cycle_collect,950 01:01:33 INFO - PROCESS | 25048 | __end_cc_report 01:01:33 INFO - PROCESS | 25048 | __startTimestamp1464076893449__endTimestamp 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | ------- Summary: start ------- 01:01:33 INFO - PROCESS | 25048 | Number of tests: 6 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | [#0] dojo.html Cycles:165 Average:4701.60 Median:4855.73 stddev:486.33 (10.0%) stddev-sans-first:460.78 01:01:33 INFO - PROCESS | 25048 | Values: 2663.1 2669.3 2713.6 2725.6 2731.9 4596.1 4643.3 4698.5 4742.5 4794.0 4712.2 4758.8 4758.8 4761.9 4767.2 4358.6 4361.3 4432.0 4461.0 4522.9 4432.3 4460.6 4474.8 4481.6 4505.3 4280.1 4323.0 4339.3 4382.0 4430.0 4343.4 4352.4 4383.4 4395.5 4405.4 4378.9 4378.9 4379.6 4407.1 4422.1 4475.2 4589.9 4648.9 4652.5 4713.3 5042.4 5101.4 5109.9 5111.6 5114.1 4957.6 5058.7 5142.7 5149.4 5151.8 4654.0 4733.7 4737.0 4759.2 4787.5 5244.6 5268.9 5272.1 5272.8 5275.8 4946.9 4954.2 5024.2 5032.2 5032.5 5063.8 5067.4 5081.0 5092.0 5138.4 5027.8 5042.0 5043.5 5045.7 5087.4 4894.6 4953.3 4982.2 5012.4 5019.5 4241.9 4250.9 4262.9 4298.1 4303.0 3727.6 3737.9 3747.5 3780.0 3790.4 4310.3 4350.2 4396.4 4405.9 4454.0 5108.9 5146.3 5146.7 5149.9 5190.0 4451.1 4454.6 4458.9 4478.8 4506.6 4455.4 4526.4 4559.2 4573.7 4577.5 4838.3 4855.7 4857.7 4893.2 4913.2 5122.0 5133.6 5135.8 5138.5 5139.8 4697.8 4724.3 4761.6 4767.5 4872.2 4942.4 4956.5 4958.3 4980.3 5028.7 5044.5 5051.3 5056.5 5057.3 5107.7 4852.7 4917.3 4969.1 4971.9 4979.4 4942.5 4973.7 4990.2 4993.5 5037.0 4742.7 4895.8 4902.4 4903.7 4960.0 4941.1 4965.3 4989.4 4997.3 5010.7 4897.0 4900.9 4901.5 4903.1 4956.0 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | [#1] ext.html Cycles:180 Average:37793.61 Median:33718.75 stddev:59800.10 (177.3%) stddev-sans-first:59902.60 01:01:33 INFO - PROCESS | 25048 | Values: 587.3 590.1 599.3 603.8 603.9 42321.4 44253.0 44264.6 44271.6 44315.6 38297.2 38550.2 38660.4 38691.2 38780.8 7510.0 7589.1 7752.5 7763.4 9885.3 9656.6 10098.4 10105.3 10106.0 10107.0 10153.8 10226.2 10230.1 10232.1 10235.5 7496.5 9899.1 10063.4 10190.1 10207.7 9946.4 10030.8 10039.9 10040.4 10042.2 37263.8 37523.4 37568.4 37626.8 37701.4 3041.8 3270.2 3356.3 3496.7 3581.3 29005.6 29016.7 29085.4 29297.9 29834.6 3484.0 3524.3 3548.4 3587.1 3588.8 246127.0 246785.0 247001.0 247318.0 248270.0 31012.5 51411.4 51687.0 51762.0 51864.0 31715.8 33837.8 34100.3 34128.3 34151.3 11414.8 11547.4 11556.5 11557.5 11563.2 7884.4 8929.9 9278.6 9301.8 9463.3 7913.1 7958.2 7987.4 8040.5 8049.3 3140.9 3147.7 3183.6 3189.2 3199.8 882.9 913.3 990.0 1001.4 1004.9 26855.6 27849.2 28193.6 28199.7 28212.4 979.8 997.8 999.9 1011.6 1051.6 14853.9 14933.9 15061.0 15212.4 15252.8 120593.0 120632.0 120647.0 120713.0 120946.4 48825.0 49129.3 49215.8 49295.3 49360.5 1109.4 1185.7 1240.6 1246.2 1259.9 27521.7 28310.6 28393.9 28575.6 29082.4 40411.6 40653.4 40878.6 40916.2 40925.8 282111.0 283495.0 283704.0 283994.0 284396.0 21894.0 23841.5 24494.9 24646.3 25764.2 40127.8 40417.6 40506.0 41006.2 41439.0 35116.6 35641.3 35820.0 36157.3 36323.1 35451.6 36021.0 36091.6 36135.8 36208.0 33599.7 34101.0 34627.3 34833.8 35195.1 30702.0 31570.4 31631.0 31860.7 32223.0 24179.9 24372.8 24671.5 25019.7 25051.6 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | [#2] jquery.html Cycles:180 Average:24003.68 Median:5204.68 stddev:66103.49 (1270.1%) stddev-sans-first:66265.10 01:01:33 INFO - PROCESS | 25048 | Values: 366.6 369.1 370.9 381.5 384.3 16662.3 17303.4 17362.4 17697.8 17747.0 13770.7 16321.0 17056.0 17187.6 17221.7 4954.1 5127.3 5155.8 5168.9 5175.4 3738.8 3912.3 5070.2 5570.2 5913.4 5929.3 5934.8 5952.6 5955.3 5960.5 5715.2 5952.3 5953.3 5958.1 5965.2 3390.4 4929.8 5234.0 5244.4 5253.5 19936.8 20459.3 20524.3 20850.9 20935.9 1916.8 1934.7 1968.2 2221.6 2511.7 12259.2 13248.7 13331.0 13380.3 13760.0 1746.4 1801.3 1810.6 1848.3 1848.5 65309.0 67205.7 67304.3 67759.3 69059.0 9507.4 9510.9 9965.0 10000.4 10170.1 13916.9 13990.9 14000.9 14003.3 14006.3 6724.0 6826.5 6830.7 6913.8 6926.8 6229.8 6263.1 6426.3 6434.4 6442.2 6194.6 6293.1 6297.7 6302.6 6369.7 1650.5 1693.2 1758.2 1766.0 1774.6 862.4 890.9 921.3 1004.4 1024.7 16432.2 17356.1 17547.4 17637.5 17755.4 878.1 883.4 887.2 894.3 925.2 8702.2 9789.6 9995.6 10061.6 10262.9 397311.0 398255.0 400451.0 403361.0 414058.0 65709.3 67697.0 67790.7 67824.7 68253.7 905.1 919.3 932.0 942.1 943.8 15209.2 15301.5 15320.8 15556.8 15776.5 31946.4 32263.8 32613.0 32689.2 33174.8 41251.4 42982.8 43915.0 44451.0 45532.0 7065.9 7202.6 7307.3 7381.0 7419.3 10566.2 10794.2 10861.9 10909.2 10940.9 8971.1 9103.5 9121.9 9160.6 9284.4 9113.5 9276.8 9318.6 9372.0 9529.9 8991.1 9005.1 9102.9 9451.0 9451.3 7056.5 7133.0 7197.8 7229.4 7339.7 8558.9 8868.4 8929.8 9015.8 9140.6 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | [#3] mootools.html Cycles:180 Average:5097.97 Median:4959.31 stddev:2942.15 (59.3%) stddev-sans-first:2936.51 01:01:33 INFO - PROCESS | 25048 | Values: 1292.4 1423.8 1465.6 1542.2 1735.3 6762.2 7542.6 7760.8 7769.3 7960.6 7700.1 7879.0 7952.1 7978.2 7980.6 1848.5 2160.9 2201.7 2215.5 2232.1 2234.1 2258.8 2259.1 2260.4 2262.0 2183.1 2183.8 2213.4 2222.7 2237.5 1755.6 2081.1 2150.5 2152.8 2153.9 2207.2 2234.9 2236.4 2236.6 2240.2 7852.3 7884.6 7887.6 7889.4 7904.9 4353.5 4502.3 4508.8 4510.9 4518.0 2778.4 2838.7 2993.3 2996.4 3001.1 936.9 956.9 962.6 977.5 982.0 11143.3 11148.4 11166.8 11179.2 11190.7 4119.2 4183.4 4286.3 4291.2 4293.5 9274.7 9345.4 9367.0 9372.3 9396.1 4477.6 4483.1 4487.8 4488.8 4489.0 3419.2 3866.6 4000.4 4007.3 4058.6 3616.1 3654.9 3721.9 3751.8 3792.7 1153.5 1158.8 1159.5 1171.7 1186.2 718.9 766.4 792.5 815.6 833.2 4767.2 4777.2 4802.4 4864.4 4941.1 801.5 813.8 850.7 869.7 878.5 3139.9 3192.4 3193.6 3311.7 3354.6 9226.9 9889.5 9889.6 9892.3 9907.5 9635.1 9643.2 9666.3 9743.6 9746.8 7235.8 7514.8 7520.7 7526.5 7543.4 4781.1 4977.5 5031.3 5264.0 5275.0 8920.6 9123.5 9147.5 9163.4 9169.0 8970.6 9141.0 9215.5 9307.0 9342.6 6501.2 6527.9 6530.3 6575.9 6595.2 7358.9 7387.7 7401.1 7427.9 7475.9 6600.4 6828.4 6860.0 6924.7 6972.4 6029.2 6200.9 6246.8 6249.7 6309.7 5432.6 5843.6 5896.4 5909.7 5913.5 4171.9 4299.7 4325.6 4360.5 4362.6 4330.4 4348.8 4364.0 4419.3 4448.2 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | [#4] prototype.html Cycles:180 Average:4110.50 Median:4713.40 stddev:1177.07 (25.0%) stddev-sans-first:1144.70 01:01:33 INFO - PROCESS | 25048 | Values: 279.4 293.3 297.1 303.7 305.4 4756.6 4758.8 4770.9 4787.2 4799.9 4697.9 4699.4 4704.7 4713.2 4733.7 3546.4 3610.0 3658.8 3748.5 3809.7 3752.7 3771.6 3776.3 3789.5 3801.8 3545.5 3743.7 3747.7 3755.3 3758.4 3613.3 3715.8 3719.1 3723.0 3733.8 3266.9 3275.9 3284.9 3296.8 3313.0 4516.9 4522.3 4524.5 4545.5 4548.2 4003.2 4208.4 4215.8 4235.8 4254.9 4920.3 4938.0 4955.3 4968.5 4977.1 3525.3 3534.6 3536.9 3541.4 3545.2 5014.9 5188.3 5197.2 5214.4 5221.4 3644.9 3654.9 3655.9 3663.2 3670.9 3647.4 3660.1 3664.9 3694.4 3704.3 4161.3 4196.2 4197.2 4202.0 4202.8 4830.2 4895.1 4921.6 4950.8 5010.1 1251.8 1257.9 1278.5 1279.9 1281.7 799.8 818.0 900.1 943.8 945.2 4370.4 4387.5 4402.6 4404.9 4452.7 5049.2 5079.2 5083.9 5087.0 5102.6 4192.9 4335.2 4375.4 4376.9 4408.4 2649.2 2673.0 2676.5 2701.1 2710.6 4761.5 4765.5 4773.9 4789.1 4816.2 5015.4 5059.0 5162.5 5170.3 5174.2 4713.6 4751.3 4761.4 4767.2 4782.4 5038.0 5038.6 5055.7 5058.5 5066.4 4704.3 4933.0 4953.6 4975.5 4986.9 4755.8 4773.6 4841.5 4842.6 4865.3 3676.9 3699.9 3733.3 3736.1 3755.3 4736.5 4977.7 4978.8 4988.5 4989.5 4872.7 4918.9 4926.3 4932.3 4939.5 4872.4 4894.8 4906.1 4950.3 4956.8 4662.3 4811.8 4831.0 4840.2 4864.9 4944.1 4944.6 4969.5 4995.2 4997.2 4867.7 4870.8 4884.7 4896.3 4897.4 01:01:33 INFO - PROCESS | 25048 | 01:01:33 INFO - PROCESS | 25048 | [#5] yui.html Cycles:180 Average:13582.24 Median:470.44 stddev:16207.75 (3445.2%) stddev-sans-first:16224.43 01:01:33 INFO - PROCESS | 25048 | Values: 719.7 727.1 731.0 752.7 781.1 11829.8 11963.2 12064.5 12100.3 12121.6 12364.8 12390.1 12424.2 12424.6 12435.5 628.4 783.1 803.9 805.0 806.9 794.1 795.3 795.6 799.1 799.9 510.6 857.3 857.7 858.4 859.4 820.3 838.8 842.7 844.8 845.1 616.8 616.9 617.1 617.3 617.4 11720.2 11766.9 11780.7 11786.4 11859.6 11621.2 11834.0 11891.1 12207.3 12302.6 10537.3 10553.1 10596.6 10790.0 10910.1 4092.4 4132.9 4152.6 4187.9 4297.3 44058.0 44059.8 44215.0 44933.8 46024.1 9753.7 9875.4 9891.1 9899.3 9946.3 16661.6 16745.2 16798.0 16804.9 16841.4 6413.3 6416.4 6439.6 6448.7 6783.2 3828.0 3841.5 3864.8 3885.6 3895.8 2692.5 2798.2 2802.4 2825.6 2837.1 479.8 503.4 522.3 538.5 544.4 599.0 599.2 608.4 609.2 615.7 8314.4 8362.6 8383.9 8432.0 8615.0 461.1 520.3 579.4 583.0 607.2 3829.9 3893.7 3935.2 4033.6 4065.1 60422.7 60722.7 61050.4 61111.4 61546.0 54688.5 54706.0 55113.4 55271.4 55859.0 49967.5 50377.0 50395.5 50514.5 51572.0 7507.8 7813.6 7840.1 7853.9 7915.0 32765.5 33351.0 33469.5 33508.7 34408.5 36486.8 37023.8 37451.3 39710.6 40144.4 10746.9 10852.7 10874.8 10921.8 10990.8 11632.1 11741.4 11861.5 12153.3 12850.1 11228.8 11273.9 11500.1 11572.1 11823.2 10991.9 11666.7 11760.2 11904.0 12151.5 10796.4 11041.1 11271.4 11768.2 11795.6 9049.1 9283.2 9525.7 9669.9 9880.2 9650.5 9737.9 9940.8 9962.3 9966.7 01:01:33 INFO - PROCESS | 25048 | -------- Summary: end -------- 01:01:33 INFO - PROCESS | 25048 | 01:01:34 INFO - TEST-INFO | 25048: exit 0 01:01:34 INFO - TEST-OK | dromaeo_css | took 1117860ms 01:01:34 INFO - TEST-START | kraken 01:01:34 INFO - operating with platform_type : linux_ 01:01:34 INFO - Initialising browser for kraken test... 01:01:34 INFO - TEST-INFO | started process 25226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCSvRqs/profile http://localhost:60565/getInfo.html) 01:01:38 INFO - PROCESS | 25226 | __metrics Screen width/height:1600/1200 01:01:38 INFO - PROCESS | 25226 | colorDepth:24 01:01:38 INFO - PROCESS | 25226 | Browser inner width/height: 1024/697 01:01:38 INFO - PROCESS | 25226 | __metrics 01:01:39 ERROR - PROCESS | 25226 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:01:39 INFO - TEST-INFO | 25226: exit 0 01:01:39 INFO - Browser initialized. 01:01:39 INFO - Running cycle 1/1 for kraken test... 01:01:39 INFO - TEST-INFO | started process 25307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCSvRqs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:51 INFO - PROCESS | 25307 | RSS: Main: 154963968 01:01:51 INFO - PROCESS | 25307 | 01:01:54 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-beat-detection) 01:01:55 INFO - PROCESS | 25307 | RSS: Main: 210161664 01:01:55 INFO - PROCESS | 25307 | 01:01:58 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-dft) 01:01:59 INFO - PROCESS | 25307 | RSS: Main: 198352896 01:01:59 INFO - PROCESS | 25307 | 01:02:02 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-fft) 01:02:02 INFO - PROCESS | 25307 | RSS: Main: 267522048 01:02:02 INFO - PROCESS | 25307 | 01:02:05 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60565/tests/kraken/driver.html?testName=audio-oscillator) 01:02:05 INFO - PROCESS | 25307 | RSS: Main: 177758208 01:02:05 INFO - PROCESS | 25307 | 01:02:08 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:02:08 INFO - PROCESS | 25307 | RSS: Main: 181309440 01:02:08 INFO - PROCESS | 25307 | 01:02:12 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60565/tests/kraken/driver.html?testName=imaging-darkroom) 01:02:12 INFO - PROCESS | 25307 | RSS: Main: 216158208 01:02:12 INFO - PROCESS | 25307 | 01:02:16 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60565/tests/kraken/driver.html?testName=imaging-desaturate) 01:02:17 INFO - PROCESS | 25307 | RSS: Main: 214638592 01:02:17 INFO - PROCESS | 25307 | 01:02:20 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60565/tests/kraken/driver.html?testName=json-parse-financial) 01:02:20 INFO - PROCESS | 25307 | RSS: Main: 215498752 01:02:20 INFO - PROCESS | 25307 | 01:02:22 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:02:23 INFO - PROCESS | 25307 | RSS: Main: 208822272 01:02:23 INFO - PROCESS | 25307 | 01:02:25 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:02:25 INFO - PROCESS | 25307 | RSS: Main: 213618688 01:02:25 INFO - PROCESS | 25307 | 01:02:28 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:02:28 INFO - PROCESS | 25307 | RSS: Main: 219242496 01:02:28 INFO - PROCESS | 25307 | 01:02:31 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:02:32 INFO - PROCESS | 25307 | RSS: Main: 220463104 01:02:32 INFO - PROCESS | 25307 | 01:02:35 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:02:35 INFO - PROCESS | 25307 | RSS: Main: 218705920 01:02:35 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | Cycle 1(1): loaded http://localhost:60565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60565/tests/kraken/driver.html?testName=ai-astar) 01:02:37 INFO - PROCESS | 25307 | RSS: Main: 265474048 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | __start_tp_report 01:02:37 INFO - PROCESS | 25307 | _x_x_mozilla_page_load 01:02:37 INFO - PROCESS | 25307 | _x_x_mozilla_page_load_details 01:02:37 INFO - PROCESS | 25307 | |i|pagename|runs| 01:02:37 INFO - PROCESS | 25307 | |0;ai-astar;113;112;114;114;113;115;115;115;113;115 01:02:37 INFO - PROCESS | 25307 | |1;audio-beat-detection;170;131;129;188;130;161;150;130;194;129 01:02:37 INFO - PROCESS | 25307 | |2;audio-dft;163;161;161;161;161;166;162;163;163;163 01:02:37 INFO - PROCESS | 25307 | |3;audio-fft;76;76;75;133;76;76;75;77;135;76 01:02:37 INFO - PROCESS | 25307 | |4;audio-oscillator;93;94;161;93;93;94;138;94;94;126 01:02:37 INFO - PROCESS | 25307 | |5;imaging-gaussian-blur;117;117;116;118;117;117;118;117;117;117 01:02:37 INFO - PROCESS | 25307 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 01:02:37 INFO - PROCESS | 25307 | |7;imaging-desaturate;95;94;95;94;95;95;95;94;95;95 01:02:37 INFO - PROCESS | 25307 | |8;json-parse-financial;65;64;66;64;64;67;65;64;64;66 01:02:37 INFO - PROCESS | 25307 | |9;json-stringify-tinderbox;64;64;65;64;65;65;64;67;65;65 01:02:37 INFO - PROCESS | 25307 | |10;stanford-crypto-aes;83;83;82;89;82;83;84;88;159;89 01:02:37 INFO - PROCESS | 25307 | |11;stanford-crypto-ccm;130;132;128;135;128;127;127;129;158;140 01:02:37 INFO - PROCESS | 25307 | |12;stanford-crypto-pbkdf2;176;171;176;178;169;169;172;174;170;172 01:02:37 INFO - PROCESS | 25307 | |13;stanford-crypto-sha256-iterative;67;69;67;68;66;67;66;66;66;66 01:02:37 INFO - PROCESS | 25307 | __end_tp_report 01:02:37 INFO - PROCESS | 25307 | __start_cc_report 01:02:37 INFO - PROCESS | 25307 | _x_x_mozilla_cycle_collect,2088 01:02:37 INFO - PROCESS | 25307 | __end_cc_report 01:02:37 INFO - PROCESS | 25307 | __startTimestamp1464076957980__endTimestamp 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | ------- Summary: start ------- 01:02:37 INFO - PROCESS | 25307 | Number of tests: 14 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.10 (1.0%) stddev-sans-first:1.12 01:02:37 INFO - PROCESS | 25307 | Values: 113.0 112.0 114.0 114.0 113.0 115.0 115.0 115.0 113.0 115.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.50 stddev:25.67 (16.5%) stddev-sans-first:26.31 01:02:37 INFO - PROCESS | 25307 | Values: 170.0 131.0 129.0 188.0 130.0 161.0 150.0 130.0 194.0 129.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 01:02:37 INFO - PROCESS | 25307 | Values: 163.0 161.0 161.0 161.0 161.0 166.0 162.0 163.0 163.0 163.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#3] audio-fft Cycles:10 Average:87.50 Median:76.00 stddev:24.52 (32.3%) stddev-sans-first:25.65 01:02:37 INFO - PROCESS | 25307 | Values: 76.0 76.0 75.0 133.0 76.0 76.0 75.0 77.0 135.0 76.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.50 stddev:24.70 (26.4%) stddev-sans-first:25.60 01:02:37 INFO - PROCESS | 25307 | Values: 93.0 94.0 161.0 93.0 93.0 94.0 138.0 94.0 94.0 126.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 01:02:37 INFO - PROCESS | 25307 | Values: 117.0 117.0 116.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 01:02:37 INFO - PROCESS | 25307 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:02:37 INFO - PROCESS | 25307 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 01:02:37 INFO - PROCESS | 25307 | Values: 65.0 64.0 66.0 64.0 64.0 67.0 65.0 64.0 64.0 66.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 01:02:37 INFO - PROCESS | 25307 | Values: 64.0 64.0 65.0 64.0 65.0 65.0 64.0 67.0 65.0 65.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:83.50 stddev:23.64 (28.3%) stddev-sans-first:24.84 01:02:37 INFO - PROCESS | 25307 | Values: 83.0 83.0 82.0 89.0 82.0 83.0 84.0 88.0 159.0 89.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:131.00 stddev:9.57 (7.3%) stddev-sans-first:10.07 01:02:37 INFO - PROCESS | 25307 | Values: 130.0 132.0 128.0 135.0 128.0 127.0 127.0 129.0 158.0 140.0 01:02:37 INFO - PROCESS | 25307 | 01:02:37 INFO - PROCESS | 25307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:3.16 (1.8%) stddev-sans-first:3.12 01:02:38 INFO - PROCESS | 25307 | Values: 176.0 171.0 176.0 178.0 169.0 169.0 172.0 174.0 170.0 172.0 01:02:38 INFO - PROCESS | 25307 | 01:02:38 INFO - PROCESS | 25307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 01:02:38 INFO - PROCESS | 25307 | Values: 67.0 69.0 67.0 68.0 66.0 67.0 66.0 66.0 66.0 66.0 01:02:38 INFO - PROCESS | 25307 | -------- Summary: end -------- 01:02:38 INFO - PROCESS | 25307 | 01:02:39 INFO - TEST-INFO | 25307: exit 0 01:02:39 INFO - TEST-OK | kraken | took 64935ms 01:02:39 INFO - SUITE-END | took 1182s 01:02:39 INFO - Completed test suite (00:19:43) 01:02:39 INFO - javascript benchmark 01:02:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.1477927063343, 2669.3460102274944, 2713.5793951937444, 2725.591161325801, 2731.877065532051, 4596.0578081493295, 4643.257078867382, 4698.483166851648, 4742.52574742526, 4794.041191761648, 4712.222483290261, 4758.785854636541, 4758.8096476141, 4761.928571071437, 4767.1657459944545, 4358.585934336233, 4361.302191649337, 4432.0, 4461.0, 4522.932156017662, 4432.268675668527, 4460.643148548124, 4474.843380481684, 4481.596656300932, 4505.279155335147, 4280.0797828466875, 4322.956770432287, 4339.349097635349, 4381.978090109561, 4430.025394413224, 4343.413639158704, 4352.36890650857, 4383.364412160219, 4395.516493185747, 4405.427294451701, 4378.868633940987, 4378.890527736832, 4379.627731642814, 4407.0524837160165, 4422.137683151786, 4475.216837053503, 4589.908201835945, 4648.861029047871, 4652.5114862939245, 4713.293006049086, 5042.369703787027, 5101.4133374662015, 5109.923351149736, 5111.591072714174, 5114.079465696173, 4957.628177886637, 5058.721770302632, 5142.717150556718, 5149.382074151088, 5151.819686310999, 4654.0, 4733.692309999908, 4736.95263047372, 4759.190937540627, 4787.54518320766, 5244.554212891947, 5268.947310526923, 5272.130098533776, 5272.815451459181, 5275.815346462856, 4946.876328091755, 4954.157793175169, 5024.171011783088, 5032.194848824171, 5032.471590482946, 5063.8480845574695, 5067.391912970467, 5081.034603425412, 5092.0, 5138.38339399267, 5027.824026159067, 5041.974790126026, 5043.4956504349275, 5045.672031317952, 5087.389513258433, 4894.608431325485, 4953.25701144824, 4982.202847544376, 5012.448630650625, 5019.52314530119, 4241.893952651209, 4250.893727656771, 4262.936055959163, 4298.075913678574, 4302.978485107555, 3727.552693676722, 3737.9439308410397, 3747.5315585551807, 3780.0, 3790.374588192917, 4310.331898555729, 4350.2387082260475, 4396.406485124531, 4405.933910991338, 4454.042380888124, 5108.872278193075, 5146.30524879144, 5146.6911985281, 5149.922751158736, 5190.0, 4451.06527629195, 4454.554544545519, 4458.866234012985, 4478.798454069574, 4506.59440650343, 4455.420795296655, 4526.411566496335, 4559.202139625552, 4573.748443835621, 4577.473590537064, 4838.346823178826, 4855.732934688626, 4857.708537487762, 4893.217085266411, 4913.1893237615395, 5121.974390128025, 5133.56364708989, 5135.820246291362, 5138.486151384981, 5139.8458046258675, 4697.788599512962, 4724.338592596971, 4761.6428767843245, 4767.4517430495935, 4872.196087645641, 4942.431620363561, 4956.479569645279, 4958.2810492477665, 4980.252962055576, 5028.723420211923, 5044.47033061538, 5051.318072060225, 5056.494350565061, 5057.31726216956, 5107.719075450886, 4852.660313778002, 4917.311576379381, 4969.130402179532, 4971.9005619886675, 4979.3526841510375, 4942.5304596063315, 4973.726445045412, 4990.226514890198, 4993.4756850530175, 5037.042961837239, 4742.66801323904, 4895.779689914034, 4902.411710594752, 4903.705777653352, 4959.950400496094, 4941.135301322182, 4965.255211718271, 4989.426215985208, 4997.275395067622, 5010.674306170087, 4896.951030489649, 4900.92648610264, 4901.50984901507, 4903.068417000758, 4955.950440495693], "value": 4671.18079401851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.2571197435245, 590.1030433740714, 599.3077994915874, 603.8037637767727, 603.86714922717, 42321.36517952229, 44252.999999999956, 44264.55735442645, 44271.55728442719, 44315.55684443154, 38297.23405531888, 38550.228995420075, 38660.42009369854, 38691.22617547648, 38780.76459677942, 7510.0, 7589.08930928288, 7752.457327987043, 7763.378929685611, 9885.308028438012, 9656.565454554562, 10098.444585547792, 10105.343152695088, 10106.039926207035, 10107.0, 10153.796924061515, 10226.233032522554, 10230.07929286364, 10232.13026892715, 10235.539400726986, 7496.512726672749, 9899.059589339002, 10063.446510441923, 10190.133838623726, 10207.693769186937, 9946.403215807075, 10030.849537256947, 10039.949800251024, 10040.397576145455, 10042.246831487668, 37263.81368093169, 37523.4371484428, 37568.43647345292, 37626.81186594077, 37701.43447848284, 3041.8022828516077, 3270.2314955985325, 3356.2784001439563, 3496.7027802636553, 3581.301646178996, 29005.56491652627, 29016.70983290161, 29085.41829163405, 29297.853510732522, 29834.55248171279, 3484.0, 3524.3479956207925, 3548.3967725486727, 3587.121155316964, 3588.802615856127, 246127.0, 246785.0, 247001.0, 247318.0, 248270.0, 31012.53481197784, 51411.401201916255, 51687.0, 51762.0, 51864.0, 31715.84142079321, 33837.830810845786, 34100.31799363999, 34128.31743365119, 34151.31697366088, 11414.828777568344, 11547.422628868522, 11556.537738490535, 11557.479913403917, 11563.248388854698, 7884.408669349822, 8929.866052009225, 9278.62885484573, 9301.767455813659, 9463.337566370288, 7913.0504339478475, 7958.204179581995, 7987.440879138405, 8040.517568945882, 8049.315808156372, 3140.9214769630944, 3147.7324427423923, 3183.5861338025907, 3189.202699325169, 3199.776015678927, 882.8896387951506, 913.2693844924034, 990.0347161517607, 1001.3791449301334, 1004.884438289606, 26855.597166042524, 27849.164525063876, 28193.57709634357, 28199.71800282012, 28212.43575128486, 979.808937257228, 997.7854761226371, 999.9050090241416, 1011.5650270383659, 1051.5951358726793, 14853.851461485247, 14933.925330373278, 15061.0, 15212.391504339923, 15252.847471525365, 120593.0, 120632.0, 120647.0, 120713.0, 120946.3952680231, 48825.0, 49129.26306105412, 49215.75392123016, 49295.260571091465, 49360.50639493559, 1109.4064675398622, 1185.7095011722183, 1240.6030070377392, 1246.246021157205, 1259.9370031498388, 27521.724782751917, 28310.57534137031, 28393.858030709715, 28575.571366429103, 29082.41835163327, 40411.595884040784, 40653.390199146445, 40878.59121408748, 40916.18167636571, 40925.795371022956, 282111.0, 283495.0, 283704.0, 283994.0, 284396.0, 21894.0, 23841.52316953686, 24494.877525612257, 24646.260612181664, 25764.227073187834, 40127.79936100301, 40417.59582404138, 40506.0, 41006.17987640171, 41439.0, 35116.64883351134, 35641.28717425689, 35820.0, 36157.27685446329, 36323.091922702144, 35451.64548354483, 36021.0, 36091.639083608825, 36135.819320903225, 36208.0, 33599.66400336063, 34101.0, 34627.30745385129, 34833.79329822143, 35195.120121997155, 30702.0, 31570.36859262756, 31631.0, 31860.681393185772, 32223.0, 24179.87910060509, 24372.756272437757, 24671.506569868143, 25019.74980250247, 25051.624225636264], "value": 16205.320443265397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5839272425796, 369.0865108855582, 370.8831718008827, 381.47166174847825, 384.34277385670504, 16662.250198741072, 17303.39438119666, 17362.39231626893, 17697.82302176978, 17747.0, 13770.724585508284, 16321.0, 17056.0, 17187.570310742238, 17221.7416738749, 4954.1330267203275, 5127.256547800566, 5155.845324640267, 5168.948310516885, 5175.353080864892, 3738.7943663098517, 3912.256671232471, 5070.2141168119, 5570.192322113291, 5913.408659134074, 5929.347771745104, 5934.792282270121, 5952.613080149798, 5955.315138759055, 5960.463558279754, 5715.228444160048, 5952.3154837193415, 5953.3451320354725, 5958.106284057404, 5965.224520812289, 3390.4066788312193, 4929.778159982773, 5234.0, 5244.423113457517, 5253.50091741284, 19936.80063199364, 20459.2839250627, 20524.281650142173, 20850.895745521175, 20935.895320523454, 1916.8179022992792, 1934.7001214811726, 1968.2028778344793, 2221.6445368741083, 2511.748825117492, 12259.203151795105, 13248.668783280398, 13331.0, 13380.330983450789, 13760.0, 1746.362577659158, 1801.306496998665, 1810.6469238498498, 1848.2514581594476, 1848.473185142228, 65309.0, 67205.66397168032, 67304.32695673029, 67759.3224067758, 69059.0, 9507.382020168667, 9510.90489095114, 9965.0, 10000.399976001463, 10170.135538479311, 13916.930415347859, 13990.930045349709, 14000.929995349958, 14003.299835008209, 14006.299685015709, 6724.0, 6826.488013398915, 6830.692618832065, 6913.792586222421, 6926.757563485254, 6229.781957631461, 6263.123162757218, 6426.325235850169, 6434.356564343529, 6442.162518872517, 6194.628322300677, 6293.118963345135, 6297.748090076438, 6302.558820882494, 6369.681515924185, 1650.4553497345846, 1693.1618848669987, 1758.2000189913558, 1765.9646807063787, 1774.5803357314096, 862.3833958719546, 890.8619164029586, 921.3412410126791, 1004.3923426327113, 1024.6669832304383, 16432.178391080397, 17356.09083000869, 17547.385841495485, 17637.470875873743, 17755.378561750276, 878.1350369885657, 883.3772190605607, 887.1572006593761, 894.3247847874812, 925.2366797392178, 8702.173293537104, 9789.608415663293, 9995.600175992879, 10061.647842325483, 10262.948685256526, 397311.0, 398255.0, 400451.0, 403361.0, 414058.0, 65709.34290657128, 67697.0, 67790.66104669445, 67824.6608766953, 68253.65873170702, 905.1401168889581, 919.2645883293338, 932.0353434195575, 942.0767647705287, 943.8065196634674, 15209.239538022834, 15301.46444874424, 15320.846791531942, 15556.766648500055, 15776.526704198892, 31946.36107277795, 32263.838680806446, 32613.0, 32689.18277043093, 33174.838880639065, 41251.38122928098, 42982.78508607437, 43915.0, 44451.0, 45532.0, 7065.929340706527, 7202.603856787927, 7307.26927307265, 7381.0, 7419.258074192538, 10566.207534435101, 10794.244402892036, 10861.945690271497, 10909.181811364339, 10940.945295273472, 8971.102889710977, 9103.499307537884, 9121.86175051074, 9160.633574656938, 9284.442933424016, 9113.544322783968, 9276.768080798034, 9318.580663870007, 9372.000959693105, 9529.904700952902, 8991.100889911218, 9005.14451127142, 9102.908970910472, 9450.952745236229, 9451.338406311766, 7056.50604457683, 7132.965719970472, 7197.784066478014, 7229.385502232369, 7339.669714862737, 8558.914410856061, 8868.379213454997, 8929.821403572023, 9015.774605634911, 9140.628905664204], "value": 8148.2622002211765, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.4313302147061, 1423.8220222472191, 1465.6335916020994, 1542.2288855572215, 1735.3405705831783, 6762.222344430385, 7542.585157816318, 7760.844783104335, 7769.339606133485, 7960.562169080698, 7700.114486834016, 7879.0, 7952.125266220725, 7978.242067003625, 7980.640871160797, 1848.4639454558162, 2160.8919554022314, 2201.7137772089645, 2215.534737705084, 2232.1071571371417, 2234.1398561553838, 2258.8192944564394, 2259.1189436119926, 2260.4235919840416, 2261.977380226193, 2183.094015983365, 2183.814375778061, 2213.3691897809126, 2222.6666000100035, 2237.451824303048, 1755.6400937807718, 2081.115525901486, 2150.5483848391855, 2152.806247437738, 2153.91384344626, 2207.172310383606, 2234.910603575855, 2236.4297104238476, 2236.563870045342, 2240.2271216430304, 7852.3325517331095, 7884.566348850811, 7887.566183859885, 7889.368850491946, 7904.920950790476, 4353.499347575038, 4502.2571275739465, 4508.752018638974, 4510.864674059783, 4518.006038671487, 2778.4165325281715, 2838.7161283871656, 2993.266649670823, 2996.4306781711407, 3001.069668402802, 936.9109934556207, 956.8803899512561, 962.6245764151986, 977.4575110813496, 981.9950900245453, 11143.275687080395, 11148.386838723867, 11166.776664466664, 11179.217454778169, 11190.664280071529, 4119.196756632487, 4183.3515805050265, 4286.314189729628, 4291.206126866539, 4293.484781826201, 9274.675386361445, 9345.439273643604, 9367.0, 9372.297077719199, 9396.06039396055, 4477.574630410171, 4483.103379324149, 4487.753173575419, 4488.753118578509, 4489.034857505652, 3419.230673098583, 3866.6133386661672, 4000.3999400089638, 4007.2987227235117, 4058.573849745734, 3616.0598244456633, 3654.8720794772057, 3721.8511259549855, 3751.756135851161, 3792.6965842732516, 1153.5270539078938, 1158.7972104881612, 1159.5245949160972, 1171.6777886081395, 1186.211169572242, 718.8562287542512, 766.3907193780957, 792.5482474989201, 815.5799763121997, 833.1876420489974, 4767.237242041257, 4777.211760059621, 4802.447718512346, 4864.36763220779, 4941.135301322254, 801.4750338528273, 813.8209593889335, 850.6724910909345, 869.6738722978882, 878.5036454403241, 3139.8744050238192, 3192.393445245396, 3193.5848339716154, 3311.718503927145, 3354.6477619849566, 9226.90773092274, 9889.505524723734, 9889.604415823287, 9892.307538472382, 9907.45508997012, 9635.084666956627, 9643.180329671915, 9666.323357364918, 9743.561539730728, 9746.75633109178, 7235.819104522429, 7514.812129696692, 7520.699172033167, 7526.473146879666, 7543.358814500719, 4781.102550319598, 4977.477364876636, 5031.295618613471, 5263.973680131575, 5275.0, 8920.643174272956, 9123.49820759838, 9147.451152930846, 9163.404378715362, 9168.954155229181, 8970.551472426483, 9140.954295228481, 9215.539223038955, 9306.953465232631, 9342.579583918876, 6501.1548498694865, 6527.934720652733, 6530.281669016499, 6575.901361479678, 6595.208574971034, 7358.852822943618, 7387.667554959932, 7401.111866576045, 7427.851442971219, 7475.925240747523, 6600.438962688226, 6828.351306625863, 6859.965700171467, 6924.723011079501, 6972.372486476242, 6029.186059882035, 6200.937990620217, 6246.750129994749, 6249.687515624291, 6309.747610095545, 5432.565394768488, 5843.590948633555, 5896.380880007538, 5909.704514774158, 5913.467787898938, 4171.916561668689, 4299.731579184086, 4325.567443255649, 4360.454943132108, 4362.585554372329, 4330.415393921906, 4348.760818155032, 4364.018095928391, 4419.337099435111, 4448.154850578379], "value": 4084.548813435543, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.3560842258594, 293.27122101577584, 297.09830663934963, 303.7372672638169, 305.42884805413877, 4756.643251756115, 4758.833440829571, 4770.928436073453, 4787.162246606843, 4799.904001919964, 4697.919478519934, 4699.4256923930525, 4704.741239231841, 4713.151632706112, 4733.739644319561, 3546.414841551141, 3609.9892030231445, 3658.762180458275, 3748.512693349861, 3809.733318667694, 3752.6810221131236, 3771.622837716234, 3776.3013842439236, 3789.4505296732095, 3801.771893686374, 3545.468179773042, 3743.681787048104, 3747.7001839852746, 3755.2864955658474, 3758.361078616642, 3613.313470440621, 3715.770537677372, 3719.1074142205675, 3723.03201167697, 3733.831977561016, 3266.9019929402157, 3275.885344012972, 3284.850302394143, 3296.76922615417, 3312.96687033129, 4516.9159401743345, 4522.3216517522305, 4524.457065152203, 4545.545445455428, 4548.204064288736, 4003.2393845169327, 4208.389783481409, 4215.831366745327, 4235.767032813194, 4254.91490170198, 4920.261960705887, 4938.049470459185, 4955.315192834453, 4968.453470118284, 4977.058947010669, 3525.294941011782, 3534.5581802274714, 3536.8938931832085, 3541.3979623464074, 3545.2023294758733, 5014.924776128361, 5188.299579556749, 5197.22041693749, 5214.374275086976, 5221.39953905302, 3644.85420583179, 3654.8903532894055, 3655.9451608225368, 3663.19409729859, 3670.908227294339, 3647.3981793004386, 3660.103274697663, 3664.9083772905356, 3694.371956767356, 3704.2961837250837, 4161.313383291784, 4196.160767846443, 4197.160567886435, 4202.0, 4202.768847713344, 4830.154722923475, 4895.143349913751, 4921.581665558396, 4950.8267210647455, 5010.073136469765, 1251.7684228417772, 1257.8930790882878, 1278.5461161287794, 1279.9104062715521, 1281.7052078022107, 799.7800604833717, 817.9918200818034, 900.0954041188694, 943.8112377524523, 945.191860958884, 4370.366296886998, 4387.473503179639, 4402.559744025636, 4404.867853964322, 4452.688311818141, 5049.166887463527, 5079.161938280216, 5083.949160508421, 5087.033463641897, 5102.642815002989, 4192.930802645306, 4335.197988372098, 4375.431193944767, 4376.934345984812, 4408.382826404306, 2649.205238428464, 2673.0, 2676.5182267191703, 2701.122135306033, 2710.6340644012807, 4761.4524329701835, 4765.475797662254, 4773.856784296477, 4789.09007288621, 4816.157172494799, 5015.3577225621175, 5058.962912602908, 5162.45794191612, 5170.276161337416, 5174.24973378858, 4713.646476514206, 4751.311059896296, 4761.428628564456, 4767.189577771787, 4782.3543821584335, 5038.035166285078, 5038.622103342191, 5055.7219352935945, 5058.494150584912, 5066.417362003417, 4704.341392205026, 4932.975335123301, 4953.554180123806, 4975.527324904128, 4986.8753281168265, 4755.809767609257, 4773.641976851681, 4841.491643377535, 4842.58837998774, 4865.343178670834, 3676.926461470809, 3699.9085269844923, 3733.290674771785, 3736.0858530346372, 3755.267722794029, 4736.5069256488205, 4977.680914557717, 4978.800847966186, 4988.530677314752, 4989.453269486471, 4872.660018494942, 4918.901621967469, 4926.261060840902, 4932.260160975882, 4939.53074457926, 4872.3909511311085, 4894.804207831647, 4906.141425250496, 4950.306957025947, 4956.7769450375545, 4662.32396302541, 4811.821103829584, 4830.95169048305, 4840.249761287007, 4864.878378040577, 4944.1100601892, 4944.5549900507685, 4969.4782047884455, 4995.225740010304, 4997.200447928314, 4867.659263851497, 4870.829520966749, 4884.682495637772, 4896.338994235875, 4897.436794768647], "value": 3739.1372533486115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.6869361827605, 727.0766127018686, 730.9853802923942, 752.6876346316279, 781.0549235425135, 11829.7634047319, 11963.1625786195, 12064.457099430525, 12100.334481603508, 12121.57574484891, 12364.752704945919, 12390.07074469414, 12424.192427492208, 12424.627261182157, 12435.502579896816, 628.4218518962565, 783.1072577261926, 803.8633432316491, 804.9959750201241, 806.9193080691942, 794.1224946434194, 795.2882170457437, 795.5624406576388, 799.1489064146695, 799.9280064794167, 510.57877251267666, 857.3012994409536, 857.7126662568047, 858.4162769316862, 859.3640705877668, 820.3314298846421, 838.7609531283616, 842.6629348260744, 844.7888027993001, 845.0873057098319, 616.7532986805269, 616.8519555306694, 617.0836308082494, 617.3425302053299, 617.4473845907933, 11720.179587428884, 11766.882331176665, 11780.705482362924, 11786.410679466078, 11859.584914528037, 11621.24461909973, 11834.0, 11891.108166887432, 12207.267563946103, 12302.569410070604, 10537.315074520131, 10553.102986246178, 10596.576136954513, 10790.0, 10910.127189824794, 4092.4270602115726, 4132.876013719593, 4152.6055024772595, 4187.937180942288, 4297.269464191064, 44058.0, 44059.77970110161, 44215.0, 44933.77533112346, 46024.07951840978, 9753.658621948198, 9875.358101723365, 9891.109800118023, 9899.30704850668, 9946.303758736818, 16661.583460413585, 16745.246463909152, 16798.0, 16804.915975420045, 16841.41055063067, 6413.3266007069515, 6416.390442907917, 6439.613623182624, 6448.677566121675, 6783.219929708048, 3828.0, 3841.4621952926614, 3864.806759662006, 3885.6206046853526, 3895.7857317847793, 2692.5018871508832, 2798.2164993801766, 2802.355458244615, 2825.6044153818484, 2837.120492647286, 479.79608666316676, 503.40598094248406, 522.2531779555196, 538.4534697282262, 544.4337888595816, 599.0355527600559, 599.2240049136379, 608.4493533352323, 609.1776102261999, 615.7321565119188, 8314.422529016025, 8362.58187090643, 8383.916160838435, 8431.988161420668, 8614.956925215334, 461.0916494505818, 520.2560338715673, 579.3684883477031, 582.9826951968757, 607.2348840461051, 3829.9042523937123, 3893.7274390792372, 3935.2129574085297, 4033.576474470197, 4065.10567675111, 60422.69788651117, 60722.69638651867, 61050.38949610447, 61111.38888611146, 61546.0, 54688.45311546913, 54706.0, 55113.44886551083, 55271.447285527436, 55859.0, 49967.50032499701, 50377.0, 50395.496045039814, 50514.49485505098, 51572.0, 7507.849843003219, 7813.609319533887, 7840.098388685146, 7853.882191767014, 7915.0, 32765.50851737178, 33351.0, 33469.497957531144, 33508.664913350556, 34408.48387274243, 36486.817565912, 37023.81488092542, 37451.250974980896, 39710.60289397069, 40144.397834033094, 10746.892531074589, 10852.674419767103, 10874.836877446687, 10921.781564368826, 10990.780184396428, 11632.069434445393, 11741.354225517678, 11861.525538978343, 12153.270803751802, 12850.100492965403, 11228.775424491629, 11273.887261127284, 11500.079993600659, 11572.074234061087, 11823.172377933806, 10991.945040274748, 11666.70833229176, 11760.235584686969, 11904.0, 12151.513939442324, 10796.352218866894, 11041.116710663287, 11271.436428178395, 11768.235064720766, 11795.587154449553, 9049.140331668481, 9283.164515193665, 9525.714228573153, 9669.854952175863, 9880.160186384237, 9650.517474126125, 9737.902620973982, 9940.801183976424, 9962.302638815214, 9966.651167209113], "value": 6077.926569287779, "unit": "score"}], "name": "dromaeo_css", "value": 6208.374669516728, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 114.0, 113.0, 115.0, 115.0, 115.0, 113.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 131.0, 129.0, 188.0, 130.0, 161.0, 150.0, 130.0, 194.0, 129.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 161.0, 166.0, 162.0, 163.0, 163.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 133.0, 76.0, 76.0, 75.0, 77.0, 135.0, 76.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 161.0, 93.0, 93.0, 94.0, 138.0, 94.0, 94.0, 126.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 64.0, 67.0, 65.0, 64.0, 64.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 67.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 89.0, 82.0, 83.0, 84.0, 88.0, 159.0, 89.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 128.0, 135.0, 128.0, 127.0, 127.0, 129.0, 158.0, 140.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 176.0, 178.0, 169.0, 169.0, 172.0, 174.0, 170.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 68.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1575.7000000000003, "alertThreshold": 2.0}]} 01:02:39 INFO - Return code: 0 01:02:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:02:39 ERROR - # TBPL SUCCESS # 01:02:39 INFO - Running post-action listener: _resource_record_post_action 01:02:39 INFO - ##### 01:02:39 INFO - ##### Finished run-tests step (success) 01:02:39 INFO - ##### 01:02:39 INFO - Running post-run listener: _resource_record_post_run 01:02:39 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 544509952; Read time: 0; Write time: 523712 01:02:39 INFO - TinderboxPrint: CPU usage
13.1% 01:02:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:02:39 INFO - TinderboxPrint: I/O write bytes / time
544,509,952 / 523,712 01:02:39 INFO - TinderboxPrint: CPU idle
8,326.0 (86.9%) 01:02:39 INFO - TinderboxPrint: CPU user
1,211.1 (12.6%) 01:02:39 INFO - TinderboxPrint: Swap in / out
0 / 0 01:02:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246579200; Read time: 0; Write time: 276940 01:02:39 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 295763968; Read time: 0; Write time: 246532 01:02:40 INFO - Running post-run listener: _upload_blobber_files 01:02:40 INFO - Blob upload gear active. 01:02:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:02:40 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 01:02:40 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'] 01:02:40 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 01:02:40 INFO - (blobuploader) - INFO - Open directory for files ... 01:02:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:02:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:02:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:41 INFO - (blobuploader) - INFO - Done attempting. 01:02:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:02:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:02:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:42 INFO - (blobuploader) - INFO - Done attempting. 01:02:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:02:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:02:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:02:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:02:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:02:47 INFO - (blobuploader) - INFO - Done attempting. 01:02:47 INFO - (blobuploader) - INFO - Iteration through files over. 01:02:47 INFO - Return code: 0 01:02:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:02:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:02:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1344d6aed2555e06b6eb0c6434caece177c6a44d7de49dc4adfe07585edb0ed98e93712071f2525e6895c6064c34ac4047b5270803fa42685aabf6a78b39154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d3a69c3dc0968b5aa67e83852dff16c5cda98cbda11fee52d21b4bc4c4695066e7bc76497bd3804af76cc82c78ff7d45e806648a28b7e9f7bae6b35721b7dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7b25ab8960bd305c38972f40dcd74df947ab414ed33c7486fe0223b9168aca568f4cd31948db8cd6993de7d3e689b8ac8bee0e32acb16769062414b6f2dfdfd"} 01:02:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:02:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:02:47 INFO - Contents: 01:02:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c1344d6aed2555e06b6eb0c6434caece177c6a44d7de49dc4adfe07585edb0ed98e93712071f2525e6895c6064c34ac4047b5270803fa42685aabf6a78b39154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d3a69c3dc0968b5aa67e83852dff16c5cda98cbda11fee52d21b4bc4c4695066e7bc76497bd3804af76cc82c78ff7d45e806648a28b7e9f7bae6b35721b7dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7b25ab8960bd305c38972f40dcd74df947ab414ed33c7486fe0223b9168aca568f4cd31948db8cd6993de7d3e689b8ac8bee0e32acb16769062414b6f2dfdfd"} 01:02:47 INFO - Running post-run listener: copy_logs_to_upload_dir 01:02:47 INFO - Copying logs to upload dir... 01:02:47 INFO - mkdir: /builds/slave/test/build/upload/logs 01:02:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.349003 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 01:02:46.867577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 01:02:46.870907) ========= 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=0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783 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/c1344d6aed2555e06b6eb0c6434caece177c6a44d7de49dc4adfe07585edb0ed98e93712071f2525e6895c6064c34ac4047b5270803fa42685aabf6a78b39154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d3a69c3dc0968b5aa67e83852dff16c5cda98cbda11fee52d21b4bc4c4695066e7bc76497bd3804af76cc82c78ff7d45e806648a28b7e9f7bae6b35721b7dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7b25ab8960bd305c38972f40dcd74df947ab414ed33c7486fe0223b9168aca568f4cd31948db8cd6993de7d3e689b8ac8bee0e32acb16769062414b6f2dfdfd"} build_url:https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/Sk6q_QKQScGgkk8qLzsAhA/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/c1344d6aed2555e06b6eb0c6434caece177c6a44d7de49dc4adfe07585edb0ed98e93712071f2525e6895c6064c34ac4047b5270803fa42685aabf6a78b39154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d3a69c3dc0968b5aa67e83852dff16c5cda98cbda11fee52d21b4bc4c4695066e7bc76497bd3804af76cc82c78ff7d45e806648a28b7e9f7bae6b35721b7dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7b25ab8960bd305c38972f40dcd74df947ab414ed33c7486fe0223b9168aca568f4cd31948db8cd6993de7d3e689b8ac8bee0e32acb16769062414b6f2dfdfd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 01:02:46.895707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:02:46.896021) ========= 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=0333a256a5e4f052382dd180000001b1-1464075722.923161-1965279783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:02:46.981467) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 01:02:46.981810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 01:02:46.982107) ========= ========= Total master_lag: 0.18 =========