builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1464792592.45 results: success (0) buildid: 20160601060943 builduid: 88545bab70dd41caaf63ccd50c01c665 revision: 22047a4eea784c15026c77911c0bd6ea1b70fa68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.447738) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.448295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.448608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.463390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.463713) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:49:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.4M=0s 2016-06-01 07:49:52 (25.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.563878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.564265) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:52.615237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:49:52.615648) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 22047a4eea784c15026c77911c0bd6ea1b70fa68 --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 22047a4eea784c15026c77911c0bd6ea1b70fa68 --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=9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:49:52,778 truncating revision to first 12 chars 2016-06-01 07:49:52,778 Setting DEBUG logging. 2016-06-01 07:49:52,778 attempt 1/10 2016-06-01 07:49:52,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/22047a4eea78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:49:53,702 unpacking tar archive at: fx-team-22047a4eea78/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248397 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:49:53.878041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:53.878411) ========= script_repo_revision: 22047a4eea784c15026c77911c0bd6ea1b70fa68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:53.878874) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:53.879181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:49:53.889909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-01 07:49:53.890236) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:49:54 INFO - MultiFileLogger online at 20160601 07:49:54 in /builds/slave/test 07:49:54 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 07:49:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:49:54 INFO - {'append_to_log': False, 07:49:54 INFO - 'base_work_dir': '/builds/slave/test', 07:49:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:49:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:49:54 INFO - 'branch': 'Fx-Team-Non-PGO', 07:49:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:49:54 INFO - 'config_files': ('talos/linux_config.py',), 07:49:54 INFO - 'default_actions': ('clobber', 07:49:54 INFO - 'read-buildbot-config', 07:49:54 INFO - 'download-and-extract', 07:49:54 INFO - 'populate-webroot', 07:49:54 INFO - 'create-virtualenv', 07:49:54 INFO - 'install', 07:49:54 INFO - 'run-tests'), 07:49:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:49:54 INFO - 'download_minidump_stackwalk': True, 07:49:54 INFO - 'download_symbols': 'ondemand', 07:49:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:49:54 INFO - 'tooltool.py': '/tools/tooltool.py', 07:49:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:49:54 INFO - '/tools/misc-python/virtualenv.py')}, 07:49:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:49:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:49:54 INFO - 'installer_path': 'installer.exe', 07:49:54 INFO - 'log_level': 'info', 07:49:54 INFO - 'log_name': 'talos', 07:49:54 INFO - 'log_to_console': True, 07:49:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:49:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:49:54 INFO - 'opt_config_files': (), 07:49:54 INFO - 'pip_index': False, 07:49:54 INFO - 'sps_profile': False, 07:49:54 INFO - 'sps_profile_interval': 0, 07:49:54 INFO - 'suite': 'dromaeojs', 07:49:54 INFO - 'system_bits': '32', 07:49:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:49:54 INFO - 'title': 'talos-linux64-ix-040', 07:49:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:49:54 INFO - 'use_talos_json': True, 07:49:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:49:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:49:54 INFO - 'work_dir': 'build'} 07:49:54 INFO - ##### 07:49:54 INFO - ##### Running clobber step. 07:49:54 INFO - ##### 07:49:54 INFO - Running pre-action listener: _resource_record_pre_action 07:49:54 INFO - Running main action method: clobber 07:49:54 INFO - rmtree: /builds/slave/test/build 07:49:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:49:54 INFO - Running post-action listener: _resource_record_post_action 07:49:54 INFO - ##### 07:49:54 INFO - ##### Finished clobber step (success) 07:49:54 INFO - ##### 07:49:54 INFO - ##### 07:49:54 INFO - ##### Running read-buildbot-config step. 07:49:54 INFO - ##### 07:49:54 INFO - Running pre-action listener: _resource_record_pre_action 07:49:54 INFO - Running main action method: read_buildbot_config 07:49:54 INFO - Using buildbot properties: 07:49:54 INFO - { 07:49:54 INFO - "project": "", 07:49:54 INFO - "product": "firefox", 07:49:54 INFO - "script_repo_revision": "production", 07:49:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:49:54 INFO - "repository": "", 07:49:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:49:54 INFO - "buildid": "20160601060943", 07:49:54 INFO - "pgo_build": "False", 07:49:54 INFO - "basedir": "/builds/slave/test", 07:49:54 INFO - "buildnumber": 3030, 07:49:54 INFO - "slavename": "talos-linux64-ix-040", 07:49:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:49:54 INFO - "platform": "ubuntu64_hw", 07:49:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:49:54 INFO - "branch": "fx-team", 07:49:54 INFO - "repo_path": "integration/fx-team", 07:49:54 INFO - "revision": "22047a4eea784c15026c77911c0bd6ea1b70fa68", 07:49:54 INFO - "stage_platform": "linux64", 07:49:54 INFO - "builduid": "88545bab70dd41caaf63ccd50c01c665", 07:49:54 INFO - "slavebuilddir": "test" 07:49:54 INFO - } 07:49:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:49:54 INFO - Running post-action listener: _resource_record_post_action 07:49:54 INFO - ##### 07:49:54 INFO - ##### Finished read-buildbot-config step (success) 07:49:54 INFO - ##### 07:49:54 INFO - ##### 07:49:54 INFO - ##### Running download-and-extract step. 07:49:54 INFO - ##### 07:49:54 INFO - Running pre-action listener: _resource_record_pre_action 07:49:54 INFO - Running main action method: download_and_extract 07:49:54 INFO - mkdir: /builds/slave/test/build/tests 07:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:54 INFO - https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:49:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:49:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:49:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:49:55 INFO - Downloaded 1361 bytes. 07:49:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:49:55 INFO - Using the following test package requirements: 07:49:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:49:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:49:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'jsshell-linux-x86_64.zip'], 07:49:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:49:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:49:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:49:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:49:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:49:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:55 INFO - https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:49:56 INFO - Downloaded 22849784 bytes. 07:49:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:49:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:49:57 INFO - Return code: 0 07:49:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:57 INFO - https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:49:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:49:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:49:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:49:58 INFO - Downloaded 22849784 bytes. 07:49:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:49:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:50:00 INFO - Return code: 0 07:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:00 INFO - https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:50:01 INFO - Downloaded 10834055 bytes. 07:50:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:50:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:50:01 INFO - Return code: 0 07:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:01 INFO - https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:50:04 INFO - Downloaded 55058673 bytes. 07:50:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:50:04 INFO - mkdir: /builds/slave/test/properties 07:50:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:04 INFO - Contents: 07:50:04 INFO - build_url:https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:50:05 INFO - Running post-action listener: _resource_record_post_action 07:50:05 INFO - Running post-action listener: set_extra_try_arguments 07:50:05 INFO - ##### 07:50:05 INFO - ##### Finished download-and-extract step (success) 07:50:05 INFO - ##### 07:50:05 INFO - ##### 07:50:05 INFO - ##### Running populate-webroot step. 07:50:05 INFO - ##### 07:50:05 INFO - Running pre-action listener: _resource_record_pre_action 07:50:05 INFO - Running main action method: populate_webroot 07:50:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:05 INFO - '--tppagecycles', 07:50:05 INFO - '7'], 07:50:05 INFO - 'tests': ['tsvgm']}}, 07:50:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:50:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:50:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:50:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['damp', 'tps']}, 07:50:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'tests': ['damp', 'tps']}, 07:50:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['dromaeo_dom']}, 07:50:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:50:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['tsvgx', 07:50:05 INFO - 'tsvgr_opacity', 07:50:05 INFO - 'tart', 07:50:05 INFO - 'tscrollx', 07:50:05 INFO - 'cart']}, 07:50:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:50:05 INFO - 'tsvgr_opacity', 07:50:05 INFO - 'tart', 07:50:05 INFO - 'tscrollx', 07:50:05 INFO - 'cart']}, 07:50:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--disable-e10s'], 07:50:05 INFO - 'tests': ['tp5o']}, 07:50:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'tests': ['tp5o']}, 07:50:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--disable-e10s', 07:50:05 INFO - '--xperf_path', 07:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:05 INFO - 'tests': ['tp5n']}, 07:50:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--xperf_path', 07:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:05 INFO - 'tests': ['tp5n']}}, 07:50:05 INFO - 'talos.zip': {'path': '', 07:50:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:05 INFO - Running post-action listener: _resource_record_post_action 07:50:05 INFO - ##### 07:50:05 INFO - ##### Finished populate-webroot step (success) 07:50:05 INFO - ##### 07:50:05 INFO - ##### 07:50:05 INFO - ##### Running create-virtualenv step. 07:50:05 INFO - ##### 07:50:05 INFO - Running pre-action listener: _resource_record_pre_action 07:50:05 INFO - Running main action method: create_virtualenv 07:50:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:50:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:05 INFO - Using real prefix '/usr' 07:50:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:50:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:07 INFO - Installing pip.................done. 07:50:07 INFO - Return code: 0 07:50:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:50:07 INFO - Using env: {'DISPLAY': ':0', 07:50:07 INFO - 'HOME': '/home/cltbld', 07:50:07 INFO - 'LANG': 'en_US.UTF-8', 07:50:07 INFO - 'LANGUAGE': 'en_US:en', 07:50:07 INFO - 'LOGNAME': 'cltbld', 07:50:07 INFO - 'MAIL': '/var/mail/cltbld', 07:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:07 INFO - 'MOZ_NO_REMOTE': '1', 07:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:07 INFO - 'NO_EM_RESTART': '1', 07:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:07 INFO - 'PWD': '/builds/slave/test', 07:50:07 INFO - 'SHELL': '/bin/bash', 07:50:07 INFO - 'SHLVL': '1', 07:50:07 INFO - 'TERM': 'linux', 07:50:07 INFO - 'TMOUT': '86400', 07:50:07 INFO - 'USER': 'cltbld', 07:50:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:07 INFO - '_': '/tools/buildbot/bin/python'} 07:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:50:07 INFO - Cleaning up... 07:50:07 INFO - Return code: 0 07:50:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:50:07 INFO - Using env: {'DISPLAY': ':0', 07:50:07 INFO - 'HOME': '/home/cltbld', 07:50:07 INFO - 'LANG': 'en_US.UTF-8', 07:50:07 INFO - 'LANGUAGE': 'en_US:en', 07:50:07 INFO - 'LOGNAME': 'cltbld', 07:50:07 INFO - 'MAIL': '/var/mail/cltbld', 07:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:07 INFO - 'MOZ_NO_REMOTE': '1', 07:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:07 INFO - 'NO_EM_RESTART': '1', 07:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:07 INFO - 'PWD': '/builds/slave/test', 07:50:07 INFO - 'SHELL': '/bin/bash', 07:50:07 INFO - 'SHLVL': '1', 07:50:07 INFO - 'TERM': 'linux', 07:50:07 INFO - 'TMOUT': '86400', 07:50:07 INFO - 'USER': 'cltbld', 07:50:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:07 INFO - '_': '/tools/buildbot/bin/python'} 07:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:08 INFO - Downloading/unpacking psutil>=3.1.1 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:50:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:10 INFO - Installing collected packages: psutil 07:50:10 INFO - Running setup.py install for psutil 07:50:10 INFO - building 'psutil._psutil_linux' extension 07:50:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:50:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:50:10 INFO - building 'psutil._psutil_posix' extension 07:50:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:50:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:10 INFO - Successfully installed psutil 07:50:10 INFO - Cleaning up... 07:50:10 INFO - Return code: 0 07:50:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:10 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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:50:10 INFO - Using env: {'DISPLAY': ':0', 07:50:10 INFO - 'HOME': '/home/cltbld', 07:50:10 INFO - 'LANG': 'en_US.UTF-8', 07:50:10 INFO - 'LANGUAGE': 'en_US:en', 07:50:10 INFO - 'LOGNAME': 'cltbld', 07:50:10 INFO - 'MAIL': '/var/mail/cltbld', 07:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:10 INFO - 'MOZ_NO_REMOTE': '1', 07:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:10 INFO - 'NO_EM_RESTART': '1', 07:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:10 INFO - 'PWD': '/builds/slave/test', 07:50:10 INFO - 'SHELL': '/bin/bash', 07:50:10 INFO - 'SHLVL': '1', 07:50:10 INFO - 'TERM': 'linux', 07:50:10 INFO - 'TMOUT': '86400', 07:50:10 INFO - 'USER': 'cltbld', 07:50:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:10 INFO - '_': '/tools/buildbot/bin/python'} 07:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:50:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:50:12 INFO - Installing collected packages: mozsystemmonitor 07:50:12 INFO - Running setup.py install for mozsystemmonitor 07:50:12 INFO - Successfully installed mozsystemmonitor 07:50:12 INFO - Cleaning up... 07:50:12 INFO - Return code: 0 07:50:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:50:12 INFO - Using env: {'DISPLAY': ':0', 07:50:12 INFO - 'HOME': '/home/cltbld', 07:50:12 INFO - 'LANG': 'en_US.UTF-8', 07:50:12 INFO - 'LANGUAGE': 'en_US:en', 07:50:12 INFO - 'LOGNAME': 'cltbld', 07:50:12 INFO - 'MAIL': '/var/mail/cltbld', 07:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:12 INFO - 'MOZ_NO_REMOTE': '1', 07:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:12 INFO - 'NO_EM_RESTART': '1', 07:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:12 INFO - 'PWD': '/builds/slave/test', 07:50:12 INFO - 'SHELL': '/bin/bash', 07:50:12 INFO - 'SHLVL': '1', 07:50:12 INFO - 'TERM': 'linux', 07:50:12 INFO - 'TMOUT': '86400', 07:50:12 INFO - 'USER': 'cltbld', 07:50:12 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:12 INFO - '_': '/tools/buildbot/bin/python'} 07:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:13 INFO - Downloading/unpacking blobuploader==1.2.4 07:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:50:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:15 INFO - Downloading docopt-0.6.1.tar.gz 07:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:50:15 INFO - Installing collected packages: blobuploader, requests, docopt 07:50:15 INFO - Running setup.py install for blobuploader 07:50:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:50:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:50:15 INFO - Running setup.py install for requests 07:50:16 INFO - Running setup.py install for docopt 07:50:16 INFO - Successfully installed blobuploader requests docopt 07:50:16 INFO - Cleaning up... 07:50:16 INFO - Return code: 0 07:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:16 INFO - Using env: {'DISPLAY': ':0', 07:50:16 INFO - 'HOME': '/home/cltbld', 07:50:16 INFO - 'LANG': 'en_US.UTF-8', 07:50:16 INFO - 'LANGUAGE': 'en_US:en', 07:50:16 INFO - 'LOGNAME': 'cltbld', 07:50:16 INFO - 'MAIL': '/var/mail/cltbld', 07:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:16 INFO - 'MOZ_NO_REMOTE': '1', 07:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:16 INFO - 'NO_EM_RESTART': '1', 07:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:16 INFO - 'PWD': '/builds/slave/test', 07:50:16 INFO - 'SHELL': '/bin/bash', 07:50:16 INFO - 'SHLVL': '1', 07:50:16 INFO - 'TERM': 'linux', 07:50:16 INFO - 'TMOUT': '86400', 07:50:16 INFO - 'USER': 'cltbld', 07:50:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:16 INFO - '_': '/tools/buildbot/bin/python'} 07:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:16 INFO - Running setup.py (path:/tmp/pip-1exv2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:16 INFO - Running setup.py (path:/tmp/pip-6qvS6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:16 INFO - Running setup.py (path:/tmp/pip-HgCdv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:16 INFO - Running setup.py (path:/tmp/pip-vdsbv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:16 INFO - Running setup.py (path:/tmp/pip-Gc9X8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:16 INFO - Running setup.py (path:/tmp/pip-cIrqv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:16 INFO - Running setup.py (path:/tmp/pip-wDDbK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:17 INFO - Running setup.py (path:/tmp/pip-cartDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:17 INFO - Running setup.py (path:/tmp/pip-Ghnw9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:17 INFO - Running setup.py (path:/tmp/pip-39jpeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:17 INFO - Running setup.py (path:/tmp/pip-LTEbVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:17 INFO - Running setup.py (path:/tmp/pip-9VUwMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:17 INFO - Running setup.py (path:/tmp/pip-XHkg15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:17 INFO - Running setup.py (path:/tmp/pip-bwNJML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:17 INFO - Running setup.py (path:/tmp/pip-79QB8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:17 INFO - Running setup.py (path:/tmp/pip-8VDQej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:17 INFO - Running setup.py (path:/tmp/pip-9_6dBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:50:17 INFO - Running setup.py install for manifestparser 07:50:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:50:17 INFO - Running setup.py install for mozcrash 07:50:17 INFO - Running setup.py install for mozdebug 07:50:18 INFO - Running setup.py install for mozdevice 07:50:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Running setup.py install for mozfile 07:50:18 INFO - Running setup.py install for mozhttpd 07:50:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Running setup.py install for mozinfo 07:50:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Running setup.py install for mozInstall 07:50:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Running setup.py install for mozleak 07:50:18 INFO - Running setup.py install for mozlog 07:50:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Running setup.py install for moznetwork 07:50:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:50:18 INFO - Running setup.py install for mozprocess 07:50:18 INFO - Running setup.py install for mozprofile 07:50:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Running setup.py install for mozrunner 07:50:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Running setup.py install for mozscreenshot 07:50:19 INFO - Running setup.py install for moztest 07:50:19 INFO - Running setup.py install for mozversion 07:50:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:50:19 INFO - Cleaning up... 07:50:19 INFO - Return code: 0 07:50:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:19 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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:19 INFO - Using env: {'DISPLAY': ':0', 07:50:19 INFO - 'HOME': '/home/cltbld', 07:50:19 INFO - 'LANG': 'en_US.UTF-8', 07:50:19 INFO - 'LANGUAGE': 'en_US:en', 07:50:19 INFO - 'LOGNAME': 'cltbld', 07:50:19 INFO - 'MAIL': '/var/mail/cltbld', 07:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:19 INFO - 'MOZ_NO_REMOTE': '1', 07:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:19 INFO - 'NO_EM_RESTART': '1', 07:50:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:19 INFO - 'PWD': '/builds/slave/test', 07:50:19 INFO - 'SHELL': '/bin/bash', 07:50:19 INFO - 'SHLVL': '1', 07:50:19 INFO - 'TERM': 'linux', 07:50:19 INFO - 'TMOUT': '86400', 07:50:19 INFO - 'USER': 'cltbld', 07:50:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:19 INFO - '_': '/tools/buildbot/bin/python'} 07:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:19 INFO - Running setup.py (path:/tmp/pip-ZWLerF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:19 INFO - Running setup.py (path:/tmp/pip-nC7PRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:19 INFO - Running setup.py (path:/tmp/pip-LSw2zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:19 INFO - Running setup.py (path:/tmp/pip-OUNNSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:20 INFO - Running setup.py (path:/tmp/pip-4wpSVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:20 INFO - Running setup.py (path:/tmp/pip-y7nVvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:20 INFO - Running setup.py (path:/tmp/pip-dz8U0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:20 INFO - Running setup.py (path:/tmp/pip-1eGTxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:20 INFO - Running setup.py (path:/tmp/pip-THyvYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:20 INFO - Running setup.py (path:/tmp/pip-benYyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:20 INFO - Running setup.py (path:/tmp/pip-yoRnPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:20 INFO - Running setup.py (path:/tmp/pip-ZOeN7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:20 INFO - Running setup.py (path:/tmp/pip-7LSuKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:20 INFO - Running setup.py (path:/tmp/pip-xNUZbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:20 INFO - Running setup.py (path:/tmp/pip-3GN3jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:20 INFO - Running setup.py (path:/tmp/pip-7MY_Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:20 INFO - Running setup.py (path:/tmp/pip-9ZUUYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:22 INFO - Downloading blessings-1.6.tar.gz 07:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:50:22 INFO - Installing collected packages: blessings 07:50:22 INFO - Running setup.py install for blessings 07:50:23 INFO - Successfully installed blessings 07:50:23 INFO - Cleaning up... 07:50:23 INFO - Return code: 0 07:50:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:50:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:23 INFO - Reading from file tmpfile_stdout 07:50:23 INFO - Current package versions: 07:50:23 INFO - argparse == 1.2.1 07:50:23 INFO - blessings == 1.6 07:50:23 INFO - blobuploader == 1.2.4 07:50:23 INFO - docopt == 0.6.1 07:50:23 INFO - manifestparser == 1.1 07:50:23 INFO - mozInstall == 1.12 07:50:23 INFO - mozcrash == 0.17 07:50:23 INFO - mozdebug == 0.1 07:50:23 INFO - mozdevice == 0.48 07:50:23 INFO - mozfile == 1.2 07:50:23 INFO - mozhttpd == 0.7 07:50:23 INFO - mozinfo == 0.9 07:50:23 INFO - mozleak == 0.1 07:50:23 INFO - mozlog == 3.2 07:50:23 INFO - moznetwork == 0.27 07:50:23 INFO - mozprocess == 0.22 07:50:23 INFO - mozprofile == 0.28 07:50:23 INFO - mozrunner == 6.11 07:50:23 INFO - mozscreenshot == 0.1 07:50:23 INFO - mozsystemmonitor == 0.3 07:50:23 INFO - moztest == 0.7 07:50:23 INFO - mozversion == 1.4 07:50:23 INFO - psutil == 3.1.1 07:50:23 INFO - requests == 1.2.3 07:50:23 INFO - wsgiref == 0.1.2 07:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:23 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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:23 INFO - Using env: {'DISPLAY': ':0', 07:50:23 INFO - 'HOME': '/home/cltbld', 07:50:23 INFO - 'LANG': 'en_US.UTF-8', 07:50:23 INFO - 'LANGUAGE': 'en_US:en', 07:50:23 INFO - 'LOGNAME': 'cltbld', 07:50:23 INFO - 'MAIL': '/var/mail/cltbld', 07:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:23 INFO - 'MOZ_NO_REMOTE': '1', 07:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:23 INFO - 'NO_EM_RESTART': '1', 07:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:23 INFO - 'PWD': '/builds/slave/test', 07:50:23 INFO - 'SHELL': '/bin/bash', 07:50:23 INFO - 'SHLVL': '1', 07:50:23 INFO - 'TERM': 'linux', 07:50:23 INFO - 'TMOUT': '86400', 07:50:23 INFO - 'USER': 'cltbld', 07:50:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:23 INFO - '_': '/tools/buildbot/bin/python'} 07:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:50:23 INFO - Cleaning up... 07:50:23 INFO - Return code: 0 07:50:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:23 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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:50:23 INFO - Using env: {'DISPLAY': ':0', 07:50:23 INFO - 'HOME': '/home/cltbld', 07:50:23 INFO - 'LANG': 'en_US.UTF-8', 07:50:23 INFO - 'LANGUAGE': 'en_US:en', 07:50:23 INFO - 'LOGNAME': 'cltbld', 07:50:23 INFO - 'MAIL': '/var/mail/cltbld', 07:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:23 INFO - 'MOZ_NO_REMOTE': '1', 07:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:23 INFO - 'NO_EM_RESTART': '1', 07:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:23 INFO - 'PWD': '/builds/slave/test', 07:50:23 INFO - 'SHELL': '/bin/bash', 07:50:23 INFO - 'SHLVL': '1', 07:50:23 INFO - 'TERM': 'linux', 07:50:23 INFO - 'TMOUT': '86400', 07:50:23 INFO - 'USER': 'cltbld', 07:50:23 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:23 INFO - '_': '/tools/buildbot/bin/python'} 07:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:23 INFO - Downloading/unpacking jsonschema 07:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:50:25 INFO - Downloading/unpacking functools32 (from jsonschema) 07:50: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 07:50: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 07:50: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 07:50: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 07:50: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 07:50: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 07:50:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:50:25 INFO - warning: no files found matching '*.txt' 07:50:25 INFO - no previously-included directories found matching 'build' 07:50:25 INFO - no previously-included directories found matching 'dist' 07:50:25 INFO - no previously-included directories found matching '.git*' 07:50:25 INFO - Installing collected packages: jsonschema, functools32 07:50:25 INFO - Running setup.py install for functools32 07:50:26 INFO - warning: no files found matching '*.txt' 07:50:26 INFO - no previously-included directories found matching 'build' 07:50:26 INFO - no previously-included directories found matching 'dist' 07:50:26 INFO - no previously-included directories found matching '.git*' 07:50:26 INFO - Successfully installed jsonschema functools32 07:50:26 INFO - Cleaning up... 07:50:26 INFO - Return code: 0 07:50:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:26 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 0x7fc409aebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:50:26 INFO - Using env: {'DISPLAY': ':0', 07:50:26 INFO - 'HOME': '/home/cltbld', 07:50:26 INFO - 'LANG': 'en_US.UTF-8', 07:50:26 INFO - 'LANGUAGE': 'en_US:en', 07:50:26 INFO - 'LOGNAME': 'cltbld', 07:50:26 INFO - 'MAIL': '/var/mail/cltbld', 07:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:26 INFO - 'MOZ_NO_REMOTE': '1', 07:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:26 INFO - 'NO_EM_RESTART': '1', 07:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:26 INFO - 'PWD': '/builds/slave/test', 07:50:26 INFO - 'SHELL': '/bin/bash', 07:50:26 INFO - 'SHLVL': '1', 07:50:26 INFO - 'TERM': 'linux', 07:50:26 INFO - 'TMOUT': '86400', 07:50:26 INFO - 'USER': 'cltbld', 07:50:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:26 INFO - '_': '/tools/buildbot/bin/python'} 07:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:26 INFO - Downloading/unpacking flake8 07:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:50:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:50:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:50:28 INFO - no previously-included directories found matching 'docs/_build' 07:50:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:50:29 INFO - Running setup.py install for pep8 07:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:50:29 INFO - no previously-included directories found matching 'docs/_build' 07:50:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:50:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:50:29 INFO - Cleaning up... 07:50:29 INFO - Return code: 0 07:50:29 INFO - Running post-action listener: _resource_record_post_action 07:50:29 INFO - Running post-action listener: _start_resource_monitoring 07:50:29 INFO - Starting resource monitoring. 07:50:29 INFO - ##### 07:50:29 INFO - ##### Finished create-virtualenv step (success) 07:50:29 INFO - ##### 07:50:29 INFO - ##### 07:50:29 INFO - ##### Running install step. 07:50:29 INFO - ##### 07:50:29 INFO - Running pre-action listener: _resource_record_pre_action 07:50:29 INFO - Running main action method: install 07:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:29 INFO - Reading from file tmpfile_stdout 07:50:29 INFO - Detecting whether we're running mozinstall >=1.0... 07:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:50:29 INFO - Reading from file tmpfile_stdout 07:50:29 INFO - Output received: 07:50:29 INFO - Usage: mozinstall [options] installer 07:50:29 INFO - Options: 07:50:29 INFO - -h, --help show this help message and exit 07:50:29 INFO - -d DEST, --destination=DEST 07:50:29 INFO - Directory to install application into. [default: 07:50:29 INFO - "/builds/slave/test"] 07:50:29 INFO - --app=APP Application being installed. [default: firefox] 07:50:29 INFO - mkdir: /builds/slave/test/build/application 07:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:50:45 INFO - Reading from file tmpfile_stdout 07:50:45 INFO - Output received: 07:50:45 INFO - /builds/slave/test/build/application/firefox/firefox 07:50:45 INFO - Running post-action listener: _resource_record_post_action 07:50:45 INFO - ##### 07:50:45 INFO - ##### Finished install step (success) 07:50:45 INFO - ##### 07:50:45 INFO - ##### 07:50:45 INFO - ##### Running run-tests step. 07:50:45 INFO - ##### 07:50:45 INFO - Running pre-action listener: _resource_record_pre_action 07:50:45 INFO - Running main action method: run_tests 07:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:50:45 INFO - Python 2.7.3 07:50:45 INFO - Return code: 0 07:50:45 INFO - grabbing minidump binary from tooltool 07:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:45 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 0x2c809c0>, '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 0x2c818c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c81d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:50:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:50:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:50:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:50:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:50:45 INFO - Return code: 0 07:50:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:50:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:50:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:50:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:50:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:50:46 INFO - Return code: 0 07:50:46 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/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:50:46 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/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 07:50:46 INFO - Using env: {'DISPLAY': ':0', 07:50:46 INFO - 'HOME': '/home/cltbld', 07:50:46 INFO - 'LANG': 'en_US.UTF-8', 07:50:46 INFO - 'LANGUAGE': 'en_US:en', 07:50:46 INFO - 'LOGNAME': 'cltbld', 07:50:46 INFO - 'MAIL': '/var/mail/cltbld', 07:50:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:50:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:46 INFO - 'MOZ_NO_REMOTE': '1', 07:50:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:46 INFO - 'NO_EM_RESTART': '1', 07:50:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:46 INFO - 'PWD': '/builds/slave/test', 07:50:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:50:46 INFO - 'SHELL': '/bin/bash', 07:50:46 INFO - 'SHLVL': '1', 07:50:46 INFO - 'TERM': 'linux', 07:50:46 INFO - 'TMOUT': '86400', 07:50:46 INFO - 'USER': 'cltbld', 07:50:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297', 07:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:46 INFO - '_': '/tools/buildbot/bin/python'} 07:50:46 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/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:50:46 INFO - mozversion application_buildid: 20160601060943 07:50:46 INFO - mozversion application_changeset: 22047a4eea784c15026c77911c0bd6ea1b70fa68 07:50:46 INFO - mozversion application_display_name: Nightly 07:50:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:50:46 INFO - mozversion application_name: Firefox 07:50:46 INFO - mozversion application_remotingname: firefox 07:50:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:50:46 INFO - mozversion application_vendor: Mozilla 07:50:46 INFO - mozversion application_version: 49.0a1 07:50:46 INFO - mozversion platform_buildid: 20160601060943 07:50:46 INFO - mozversion platform_changeset: 22047a4eea784c15026c77911c0bd6ea1b70fa68 07:50:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:50:46 INFO - mozversion platform_version: 49.0a1 07:50:46 INFO - using testdate: 1464792646 07:50:46 INFO - actual date: 1464792646 07:50:46 INFO - starting webserver on 'localhost:40517' 07:50:46 INFO - SUITE-START | Running 2 tests 07:50:46 INFO - TEST-START | dromaeo_css 07:50:46 INFO - operating with platform_type : linux_ 07:50:46 INFO - Initialising browser for dromaeo_css test... 07:50:46 INFO - TEST-INFO | started process 4317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJ8l5Q/profile http://localhost:40517/getInfo.html) 07:50:51 INFO - PROCESS | 4317 | __metrics Screen width/height:1600/1200 07:50:51 INFO - PROCESS | 4317 | colorDepth:24 07:50:51 INFO - PROCESS | 4317 | Browser inner width/height: 1024/697 07:50:51 INFO - PROCESS | 4317 | __metrics 07:50:52 ERROR - PROCESS | 4317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:50:52 INFO - TEST-INFO | 4317: exit 0 07:50:52 INFO - Browser initialized. 07:50:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:50:52 INFO - TEST-INFO | started process 4401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJ8l5Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:04 INFO - PROCESS | 4401 | RSS: Main: 157655040 07:51:04 INFO - PROCESS | 4401 | 07:51:56 INFO - PROCESS | 4401 | 1464792716321 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:54:07 INFO - PROCESS | 4401 | Cycle 1(1): loaded http://localhost:40517/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40517/tests/dromaeo/cssquery-ext.html) 07:54:08 INFO - PROCESS | 4401 | RSS: Main: 244146176 07:54:08 INFO - PROCESS | 4401 | 07:57:10 INFO - PROCESS | 4401 | Cycle 1(1): loaded http://localhost:40517/tests/dromaeo/cssquery-ext.html (next: http://localhost:40517/tests/dromaeo/cssquery-jquery.html) 07:57:11 INFO - PROCESS | 4401 | RSS: Main: 243298304 07:57:11 INFO - PROCESS | 4401 | 08:00:13 INFO - PROCESS | 4401 | Cycle 1(1): loaded http://localhost:40517/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40517/tests/dromaeo/cssquery-mootools.html) 08:00:14 INFO - PROCESS | 4401 | RSS: Main: 242536448 08:00:14 INFO - PROCESS | 4401 | 08:03:16 INFO - PROCESS | 4401 | Cycle 1(1): loaded http://localhost:40517/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40517/tests/dromaeo/cssquery-prototype.html) 08:03:17 INFO - PROCESS | 4401 | RSS: Main: 230948864 08:03:17 INFO - PROCESS | 4401 | 08:06:20 INFO - PROCESS | 4401 | Cycle 1(1): loaded http://localhost:40517/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40517/tests/dromaeo/cssquery-yui.html) 08:06:20 INFO - PROCESS | 4401 | RSS: Main: 215420928 08:06:20 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | Cycle 1(1): loaded http://localhost:40517/tests/dromaeo/cssquery-yui.html (next: http://localhost:40517/tests/dromaeo/cssquery-dojo.html) 08:09:23 INFO - PROCESS | 4401 | RSS: Main: 265523200 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | __start_tp_report 08:09:23 INFO - PROCESS | 4401 | _x_x_mozilla_page_load 08:09:23 INFO - PROCESS | 4401 | _x_x_mozilla_page_load_details 08:09:23 INFO - PROCESS | 4401 | |i|pagename|runs| 08:09:23 INFO - PROCESS | 4401 | |0;dojo.html;2618.960715589266;2631.329011102171;2667.119850449352;2676.2774051006227;2695.5013322535333;4498.730076195422;4503.504614492404;4559.658025648073;4627.167109920213;4673.883152921178;4529.932051019229;4550.704204226731;4615.215413379725;4615.261558150696;4625.514320996297;3987.063040185554;4121.072758629314;4199.874003779892;4231.70378073535;4357.847475338363;4255.8084886180195;4304.332828411601;4316.2446571849805;4326.286162783137;4343.565643435662;4175.436316097318;4214.199302132585;4237.4279472271155;4271.615554600101;4289.528151903288;4175.164967006611;4183.477065366829;4198.034452076009;4225.894352641178;4238.682098842599;4214.38891360754;4227.3447615619625;4229;4257.318828987347;4262.488501379823;4384.167008268419;4400.471943366784;4446.844360447401;4456.108778244364;4534.9546504534865;4947.307376967192;4960.801567937278;4963.081829861487;4966.478519755446;4971.353724015855;4934.876628084291;4939.654224204307;4956.157453232959;4961.553460188564;4979.327790748239;4566.223741963874;4606.631469482433;4612.5156858530045;4617.076584683044;4724.267738500469;5094.694318340911;5112.36095488064;5116.181410974226;5121.769520371592;5131.461196574381;4898.142825005681;4938.728369939688;4955.256711493233;4956.653034287565;4957.3059771632;4847.709137451694;4878.780454879539;4879.121758083508;4890.24201248807;5027.396712394463;4851.393575803025;4853.80584776605;4854.320395144682;4854.854354369375;4910.189818679878;4845.466998630148;4847.248676455155;4855.441624213261;4866.513348665176;4917.754112294371;4210.431591735077;4221.936670949938;4230.725002874803;4296.462942132233;4300.1399720056115;3735.6637902588354;3764.0589852536864;3768.0768211788286;3777.86777462793;3778.7543809652284;4266.25340565406;4275.743455392686;4276.465441819772;4277.080427707995;4286.935695964563;4996.125678006334;4997.025580011936;4997.600191984632;5007.574356179765;5052.216906379517;4318;4319.568043195655;4321.69748117635;4350.499692535335;4365.890852728708;4395.3187255974735;4477.440319960005;4502.122086193226;4511.233090374644;4536.206163921301;4682.789274482657;4684.695494792828;4688.6717929745955;4693.882652933704;4736.644751643572;4929.309896614549;4971.403431588233;4975.278584605139;4980.252962055721;4990.3762029746285;4554.157480866051;4662.440507139165;4690.437147542317;4698.577128058491;4727.361806156263;4932.457429682804;4949.430815456269;4949.7030178189425;4961.70229786214;5001.124803159505;4837.032593481247;5011.198208286657;5019.196928491424;5025.39695236574;5070.062038522885;4710.387649605529;4723.622110231242;4731.3612662291525;4756.048790241896;4759.381280433521;4717.575418212377;4755.524447555217;4758.833440829554;4786.545278198705;4788.545088216614;4693.601043911306;4707.435107787088;4711.740854253049;4714.127886341038;4747.83382581608;4840.636952228527;4844.273358996179;4848.151573474698;4866.367372241586;4892.046051020017;4792.856214313437;4795.95204047969;4798.2802579613335;4802.759862006956;4856.028794241095 08:09:23 INFO - PROCESS | 4401 | |1;ext.html;545.4436474795708;570.7374607680467;582;583.5710752596841;588.9957622254058;28335.716642833566;31135;31145.532817007705;31155.84422077892;40303.19393612133;37894.62105378945;41891;42003.57996420043;42020.57979420205;42069;7589.658465369058;7764.883526747103;7771.067471903351;7772.650230739602;7774.222577742237;7616.809579760495;7741.303282704555;7751.992241008661;7759.9612001940195;7764.223577642247;7749.612519374037;7800.531968081905;7800.921990780076;7801.4929029612895;7804.687812487494;7698.846023079535;7739.071311442634;7752.496087754278;7763.107242667109;7763.107242667109;7475.700971961115;7533.209013053605;7538.8115297117465;7542;7545.207753185891;39567.60432395668;40066;40107.799461002505;40224.597754022674;40291.395629065584;2798.3571833450906;3287.309664970359;3450;3597;3845.1348446599573;29755.404891902257;30334.696653033407;30340.69659303401;30397.088087357413;30476.238094047603;3512.0868574170645;3616.4213725803747;3730.8321125549414;3740.4202348636004;3743.606921273254;240919;244038;244322;244665;244867;55842.441575583725;56247.71876140593;56263.71868140633;56310;56380.436195638336;58964.7051764747;59074.704626476596;59102;59126.40873591209;59239.70380148158;14895.851041489446;15043.473478428203;15046.774298385533;15064.548063558112;15086.924565377103;10697.572097116028;10708.518116684769;10722.356658600509;10722.41026743521;10730.678079657622;15367.769483457758;17433.302667893397;17739.556511087325;17750.28998840058;17821.910890445724;6064.4845188158615;6134.846628834225;6205.183811955615;6357.936420635827;6448.258450278185;759.369723129801;859.7821290268164;885.8936927568733;948.4783369146942;989.2926557511414;27347.589786153225;27938;28234.85882570574;28253;28592;951.3958636266021;956.799072194833;975.6243846119295;999.8900120986685;1066.504075604832;14670.779938300933;14734.263286835616;14791.556253312418;15267.694646107017;15272.923635381752;350865;353725;355581;356314;356851;49906.75046624744;50166.498335016186;50196.24705629418;50223.24665130026;50280;1077.859878215827;1168.3574034281112;1203.199872085071;1207.0343725020125;1213.7633161533415;28629.856850715612;29426.411471770018;29716.10851674453;30441.543376849808;30452.84773576118;42730.14539709126;43175.35236971511;43273.56726432696;43316;43376.56623433851;226750;226772;227062;228039;228380;36671.266574668894;38464.80767596144;38824.22351552897;38842.417363739;38926.2214755709;43305;43634;43933.78033109814;44395;45002;37209.44185837269;37354.8132259337;37484.625153748115;37689.62310376861;37703.81148094242;35809.46285805663;36029;36736.448953265186;36737.81631091827;37132;35725.64274357327;35943.64056359403;36136.27727445489;36769.816150919076;36932;32097.518537221495;32545.674543255212;33090.33819323552;33145.33709325848;33215.83392083024;25008.124715635593;25228.49543009166;25251.368715782253;25276.620850686886;25498.490030199664 08:09:23 INFO - PROCESS | 4401 | |2;jquery.html;371.12044454642484;371.5708356847841;375.2644816160326;378.239738126366;394.1466724541368;15434.459793907201;16396;16672.749908751364;16780;16988.320467181296;16010.919945400286;16394.508164755076;17232.310707571683;17311.567210819736;17314.393996210136;4909.607231421478;5029.47190544993;5103.2855400244;5109.054824857395;5111.642185047048;3673.1551743099103;3841.827117779693;5088.465711100337;5713.228714123582;6031.276246850362;6038.215032045828;6050.213472248602;6077.392260773931;6082.118092876531;6091.847703807418;5919.822405327847;6000.159977603139;6102.786402475915;6102.969485152568;6123.510119190454;3329.5505106810515;5039.44566097729;5288.180332048539;5297.947020529822;5336.9733151334385;19821.801781982285;20314;20335;20373.49066273355;20504.897475512527;1893.4414347767442;1941.2914286285545;2002.819746222847;2172.9565408691738;2385.1771138957033;12627.873721262762;12719.491220351174;13074.215547067206;13501.32493375337;13553.186808791505;1713.6315692126127;1745.5636090977255;1789.185920406225;1809.6109336492586;1811.112554848115;65661.67169164172;67892;72051;72187;72357.27642723559;9867;10084.899151008396;10095.466586694598;10123.341982771097;10235.130013948898;13980.650483737785;13998.020138590404;14042.719145617235;14090.647733806736;14100.153990760587;7054.400375967997;7265.382442492341;7456.888146677804;7559.697612095454;7595.962020189863;6944.548604340803;6990.405815505637;7049.330313620198;7061.752838650623;7119.644017799089;4396.692231543761;4421.712588681726;4459.777011149429;4470.888227794331;4473.731576105444;1671.3565277368057;1706.743988401725;1771.8228177182436;1822.683713965191;1864.5804693943753;849.426637020009;864.5288317866778;901.7384958362132;904.5115637555647;921.3918813583138;15788.21058947048;16534.83465165333;16707.749383759252;16756.6648667026;17027.48917532476;872.4634349874781;887.9600417981206;943.551812888886;952.6903756279098;960.2893858544627;9313.674021409219;9354.251659867194;9429.15137637616;9603.231741460806;9787.706368808947;367928;368845;377541;378651;381710;69810;73214.63392683002;73757;76180;77310.61344693354;921.6359787514516;930.1396208507103;946.8343039967978;947.0907928388824;948.3266880514911;14285.857141428452;14799.852001479847;14807.185604791839;15269.541913742605;15669.764953525479;25931.351716207246;28537.714622853506;30677.53983690202;34774.47838282478;37128.443073354465;48232.276515852995;48751;49408;49562.25656615226;49879;7134.250903655042;7279.599622020628;7414.962925185339;7484.887726683995;7558.093028836574;9936.751581210528;10597.735056623646;10660.466976650981;10748.140148788234;10920.453977301262;8537.18896704812;8835.761946081764;9183.494907780136;9564.091411315914;9589.760255993657;8821.955890220508;9085.591148398205;9382.48396338208;9438.150566449052;9492.288078394009;8721.825563488821;9078.092190781133;9474.526273686426;9708.417494950325;9746.415215087118;7248;7487.962560187382;7562.168161502341;7631.580263085361;7716.074071111502;8880.422772519765;9240.260779137787;9359.953200233955;9379.718608441757;9447.716568502956 08:09:23 INFO - PROCESS | 4401 | |3;mootools.html;1240.2310567448183;1390.0617083468655;1423.6085076603933;1483.6958423523172;1676.782018337616;6451.709673064712;7287.599182044985;7415.258474152589;7418.035655364809;7671.961640191791;7374.705011799535;7512;7514.849703005937;7539.246075392458;7569.886451703215;2166.729158855147;2198.692183094368;2200.0539767899795;2201.020545857094;2203.030666506732;2149.7742737012622;2172.3591540495513;2205.856619319747;2213.0594497338648;2213.634750266212;2154.235246487498;2171.5114099327684;2177.4882902517897;2180.9672854907108;2195.9560808783813;2071.59603877244;2073.460900165953;2078.1791192478886;2080.916763329465;2088.5092003379195;2063.0819285417997;2125.192426877792;2125.394262635142;2126.0326551419066;2126.7873212678765;7396.519226250331;7403.666834992438;7411.332980031823;7412.555246685162;7572.469927105105;4445.110977804452;4547.636189104896;4559.635229181657;4582.839600613963;4605.884852878705;2746.533089374811;2832.6884042755282;2889.5954566360515;2895.5222388305906;2900;907.9500627465487;917.8393781088283;920.6823645842173;933.2207606648457;951.9619215231382;10015.148712359458;10081.546330415149;10083.949580252125;10109.494525273707;10216.897831021743;3933.7246392752804;4040.5959404059945;4107.383892416162;4110.691698122653;4116.0533077392365;8116.147804480563;8121.796955076052;8127.837443251102;8148.837023259502;8162.224588664068;4370.825166993348;4378.233809083397;4381.123775244963;4396.692231543825;4402.493713222956;3583.157957879896;4006.3790112532606;4006.6994975376965;4081.4490043843703;4150.64719498846;3356.81537515439;3363.4618461046603;3416.4533674611944;3435.707964822968;3451.8274086295582;1024.774549599087;1051.6109039655375;1060.4167707760855;1064.5688496159069;1069.8555694981233;695.20399142981;762.523422860712;826.7354446577037;835.5279267214005;852.3479538153317;5011.52390522907;5028.8757033349075;5113.974430127825;5203.271541984125;5207.765650545734;420.3211812922109;422.25472041846166;422.38542920051253;431.34866351808995;434.1404020040338;3553.8400771965325;3569.303985722759;3574.3208790329754;3594.263176048904;3622.855085796539;8920.73237802867;9215.308851836138;9225.400348977295;9243.907560924305;9244.676436324697;9095.135962083723;9148.771280717901;9174.311926605531;9238.214751746176;9265.814683706289;6992.93007069933;7069.363757261768;7070.611116388648;7076.363127318566;7134.179569349488;4896.632752543503;4971.751412429437;5088.923666144937;5092.618053645917;5118.181091025418;8344.290735287568;8575.61409736551;8580.613872375883;8586.313094952264;8665;8699.217070463688;8721.215090641872;8802.29581633455;8821.2060914518;8833;5551.7779288828;6077.11881777131;6305.5901366411035;6356.586821856565;6373.171487706569;7170.641467926687;7334.266573342837;7381.557106573623;7394.519356241827;7405.9629701851145;6536.246503053363;6623.602583844985;6757.864842703217;6779.864402712017;6828.385445309946;6652.101966234496;6658.567193132625;6689.966550167218;6710.966445167743;6742.089817874524;6120.143179954721;6124.6325220486915;6137;6164.445199932027;6171.290301615192;4482.305242687388;4499.325101234841;4603.309503574491;4641.883952901069;4655;4634.791434385394;4695.718256904596;4705.7411842349;4725.385699858996;4773.71357718538 08:09:23 INFO - PROCESS | 4401 | |4;prototype.html;301.0396834099223;309.34419031652897;311.9173419043953;312.64514775729555;313.9089663997441;4746.288056791479;4768.809247630091;4774.9761251193695;4777.713337199766;4812.291636469051;4646.953530464694;4714.622830173586;4718.127146477904;4721.504242054578;4725.456572494164;3528.947065794015;3655.7935881159156;3693.409054551272;3746.1945681678435;3790;3616.132128289218;3737.663610275075;3779.754315969467;3780.451834483998;3790.639889210521;3533.823308834548;3684.281565094808;3695.815209239527;3711.164987877733;3722.4044152935535;3607.3867442534834;3719.3863012602887;3727.5340582427198;3736.1406876418305;3744.5132132822696;3309.4043072246986;3313.204830840605;3323.5845519310087;3329.334133173375;3334.483155110962;4463.973286144173;4476.89585894629;4481.439820022497;4486.8878278042985;4487.820487180509;4008.959910400888;4190.44953367253;4223.746575205467;4245.853619522712;4255.297875850512;4927.408710954673;4937.555619994182;4953.133201689726;4967.478414766434;4981.701097934136;3544.7873127612424;3547.0068380853404;3548.3790336690977;3552.520409744677;3558.3417067842274;5058.190689489664;5195.818146364859;5200.531952124327;5205.843824685227;5214.478552144793;3586.336527742376;3598.2623562169692;3637.672609465108;3646.4165733482514;3657.487951686766;3645.671889529902;3651.1419816343137;3657.8536858525895;3676.558812942464;3679.6136405677553;4181.330987042059;4198.6011328923705;4201.642860356904;4211;4216.198922204771;4889.951100489021;4943.209086546135;4957.727324997088;4958.305837182797;4964.007198560303;1258.4903114238748;1266.4870727355435;1272.7581759465672;1274.2354587247578;1278.0797825565578;809.4414853750893;815.3477218225396;850.9702160424356;868.487592320534;869.1395518436829;4355.934660980088;4366.951931536409;4397.2304846651705;4409.845655402046;4418.71857161426;5032.672876263031;5032.842446237386;5035.248739688882;5044.974775126174;5103.948960510422;4209.536950935395;4363.956360436355;4391.473023237232;4392.165488557164;4433.889152771142;2667.2662769200174;2684.463107378532;2686.0196028449477;2696.042904768779;2712.552428849218;4752.95247047532;4770.833020844254;4783.545563171563;4786.3777708898315;4794.184988551954;4997.675151115166;5161.200013997836;5192.714400707921;5192.740362981911;5265.236540701577;4839.370881785416;4846.733429661403;4848.3454733610515;4862.708237505761;4887.753622826157;5154.9690061987;5194.766235519486;5198.610104242272;5208.453112423141;5214.783716920218;4901.5588597026435;5086.923696144635;5095.808802215083;5122.231665250242;5155.814162742665;4826.7827947743135;4840.782164802522;4849.806007759791;4870.391201099863;4880.975595122001;3638.854445822243;3668.550922385696;3669.935718641564;3672.596014438463;3683.5211422514903;4837.733924634179;5096.464871188472;5126.641135120506;5178.766955486937;5193.4027586828;4910.6562540623245;4917.778699958582;4944.456109827988;4946.653734238569;4956.157453233031;4947.54047555979;4947.565206090194;4982.7508624569355;5004.124278251219;5031.823886164113;4696.976515117402;4846.321514987834;4848.95151048485;4935.432425270996;4961.05739909416;4719.457262414866;4871.8294859679745;4991.80196752784;4999.725015124203;5006.1739812930455;4851.611871050378;4873.757191916039;4896.2410826321975;4906.9018619626695;4908.8772780680765 08:09:23 INFO - PROCESS | 4401 | |5;yui.html;660.4584240922444;738.9334959853612;752.1425574844675;759.305235709326;759.4607828441808;11302.491387887545;12178.08664350174;12376.81434778479;12401.379931003436;12432.564860229904;13142.47430102797;13448.260345680983;13459.865401345984;14006.159630422157;14015.859841401583;633.22113800026;800.7157459102023;801.1347744435996;805.64551597297;806.1414593457978;778.3695206882443;808.312934006096;809.34038758412;810.6878851642131;810.8297257575916;837.6356285016008;838.3963546246692;839.6599377252222;840.2941529115542;840.369722707969;661.0579923608886;807.1444269074741;826.5867066466767;826.8428998490267;827.0034608297018;595.1043679262725;608.1091201389941;608.242737791448;609.0650850943824;610.3377835048933;12384.256944583354;12486.937565312115;12503.187292825936;12509;12521.74956500865;10607;11015.614453494169;11056.889431105747;11090.500927458284;11164.944175279154;10957.56169753209;10975;11103.611373601965;11266.718332041764;11269.887301126966;3978.7214894957365;3996.9600303997167;4006.779627120507;4024.2756303865294;4101.364288535282;50270.24594631083;50370.496295036945;51537.74231128858;51758.22362664601;51869;9628.229741620653;9759.902400976041;9860.506974651382;9925.3548519346;10062;17287;17777.555561111076;17778.37775677871;17779.911100444675;17783.644327113387;6524.347565243438;6645.2025756908515;6645.833854153588;6668.899966500507;6681.365270299314;3578.5705715313807;3619.3847046002243;3634.1823089804584;3677.4851520786574;3757.530308711411;2732.945341093167;2838.68774434812;2838.8722507487214;2846.0465743976;2847.8291302521916;528.2498851630694;545.5962587685084;549.9835004949858;551.5725312882548;553.4576115406843;519.5739493615199;589.666838236395;590.3624085987124;603.0833133636935;624.7469774741237;8040.717034555726;8055.436119471698;8163.7142700005215;8167.469114507538;8461.238488535939;580.0458246185002;584.476893180601;600.6096037575611;606.4541912278896;612.0818771842237;3915.804209789499;3953.8418463261723;3975.6421922027157;4024.8591299304385;4028.516578010599;53159.73420132875;54736;54914.450855491734;55020.174697379574;55069.44930550723;49042;49770.25344619834;50875.236871446956;50960;51171.23243151281;45131;45834.312485313414;45958;46092.3086153708;46493.767531162805;7059.541129826544;7257.782266532013;7341.6329183541675;7361.1166660001145;7373.631318434164;26652.333691657863;27366.5895011571;28185.295367615974;30686.539701904043;31514.842425787723;37963.620363796006;38217.617823821405;38266.426003610526;38593.614063859;38623.227535449696;10707.89292107069;10888.29226100301;10945.726356841144;11179.161562882653;11472.254303470248;11345.943270283597;11360.375179365214;11463.598774042868;11644.475998580254;12642.873571264538;7780.416468764752;10443.68668939933;11090.390028548507;11128;11206.831897521706;10838.211695070226;10945.83581246298;11009.449527523431;11206.215564910379;11252.26860254081;10762.73093172677;11104.500297486795;11305.208635395444;11412.714682133013;11687.532498699957;9752.512374381395;9846.991972940616;10013.749656258651;10132.189424846141;10142.442165680663;9542.141207291377;9705.708828735149;9729.805403891742;9806.85289720669;9886.117271798392 08:09:23 INFO - PROCESS | 4401 | __end_tp_report 08:09:23 INFO - PROCESS | 4401 | __start_cc_report 08:09:23 INFO - PROCESS | 4401 | _x_x_mozilla_cycle_collect,848 08:09:23 INFO - PROCESS | 4401 | __end_cc_report 08:09:23 INFO - PROCESS | 4401 | __startTimestamp1464793763747__endTimestamp 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | ------- Summary: start ------- 08:09:23 INFO - PROCESS | 4401 | Number of tests: 6 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | [#0] dojo.html Cycles:165 Average:4574.33 Median:4698.58 stddev:467.25 (9.9%) stddev-sans-first:442.79 08:09:23 INFO - PROCESS | 4401 | Values: 2619.0 2631.3 2667.1 2676.3 2695.5 4498.7 4503.5 4559.7 4627.2 4673.9 4529.9 4550.7 4615.2 4615.3 4625.5 3987.1 4121.1 4199.9 4231.7 4357.8 4255.8 4304.3 4316.2 4326.3 4343.6 4175.4 4214.2 4237.4 4271.6 4289.5 4175.2 4183.5 4198.0 4225.9 4238.7 4214.4 4227.3 4229.0 4257.3 4262.5 4384.2 4400.5 4446.8 4456.1 4535.0 4947.3 4960.8 4963.1 4966.5 4971.4 4934.9 4939.7 4956.2 4961.6 4979.3 4566.2 4606.6 4612.5 4617.1 4724.3 5094.7 5112.4 5116.2 5121.8 5131.5 4898.1 4938.7 4955.3 4956.7 4957.3 4847.7 4878.8 4879.1 4890.2 5027.4 4851.4 4853.8 4854.3 4854.9 4910.2 4845.5 4847.2 4855.4 4866.5 4917.8 4210.4 4221.9 4230.7 4296.5 4300.1 3735.7 3764.1 3768.1 3777.9 3778.8 4266.3 4275.7 4276.5 4277.1 4286.9 4996.1 4997.0 4997.6 5007.6 5052.2 4318.0 4319.6 4321.7 4350.5 4365.9 4395.3 4477.4 4502.1 4511.2 4536.2 4682.8 4684.7 4688.7 4693.9 4736.6 4929.3 4971.4 4975.3 4980.3 4990.4 4554.2 4662.4 4690.4 4698.6 4727.4 4932.5 4949.4 4949.7 4961.7 5001.1 4837.0 5011.2 5019.2 5025.4 5070.1 4710.4 4723.6 4731.4 4756.0 4759.4 4717.6 4755.5 4758.8 4786.5 4788.5 4693.6 4707.4 4711.7 4714.1 4747.8 4840.6 4844.3 4848.2 4866.4 4892.0 4792.9 4796.0 4798.3 4802.8 4856.0 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | [#1] ext.html Cycles:180 Average:44452.75 Median:3742.01 stddev:73649.55 (1968.2%) stddev-sans-first:73782.37 08:09:23 INFO - PROCESS | 4401 | Values: 545.4 570.7 582.0 583.6 589.0 28335.7 31135.0 31145.5 31155.8 40303.2 37894.6 41891.0 42003.6 42020.6 42069.0 7589.7 7764.9 7771.1 7772.7 7774.2 7616.8 7741.3 7752.0 7760.0 7764.2 7749.6 7800.5 7800.9 7801.5 7804.7 7698.8 7739.1 7752.5 7763.1 7763.1 7475.7 7533.2 7538.8 7542.0 7545.2 39567.6 40066.0 40107.8 40224.6 40291.4 2798.4 3287.3 3450.0 3597.0 3845.1 29755.4 30334.7 30340.7 30397.1 30476.2 3512.1 3616.4 3730.8 3740.4 3743.6 240919.0 244038.0 244322.0 244665.0 244867.0 55842.4 56247.7 56263.7 56310.0 56380.4 58964.7 59074.7 59102.0 59126.4 59239.7 14895.9 15043.5 15046.8 15064.5 15086.9 10697.6 10708.5 10722.4 10722.4 10730.7 15367.8 17433.3 17739.6 17750.3 17821.9 6064.5 6134.8 6205.2 6357.9 6448.3 759.4 859.8 885.9 948.5 989.3 27347.6 27938.0 28234.9 28253.0 28592.0 951.4 956.8 975.6 999.9 1066.5 14670.8 14734.3 14791.6 15267.7 15272.9 350865.0 353725.0 355581.0 356314.0 356851.0 49906.8 50166.5 50196.2 50223.2 50280.0 1077.9 1168.4 1203.2 1207.0 1213.8 28629.9 29426.4 29716.1 30441.5 30452.8 42730.1 43175.4 43273.6 43316.0 43376.6 226750.0 226772.0 227062.0 228039.0 228380.0 36671.3 38464.8 38824.2 38842.4 38926.2 43305.0 43634.0 43933.8 44395.0 45002.0 37209.4 37354.8 37484.6 37689.6 37703.8 35809.5 36029.0 36736.4 36737.8 37132.0 35725.6 35943.6 36136.3 36769.8 36932.0 32097.5 32545.7 33090.3 33145.3 33215.8 25008.1 25228.5 25251.4 25276.6 25498.5 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | [#2] jquery.html Cycles:180 Average:23566.66 Median:5106.17 stddev:61931.77 (1212.9%) stddev-sans-first:62081.02 08:09:23 INFO - PROCESS | 4401 | Values: 371.1 371.6 375.3 378.2 394.1 15434.5 16396.0 16672.7 16780.0 16988.3 16010.9 16394.5 17232.3 17311.6 17314.4 4909.6 5029.5 5103.3 5109.1 5111.6 3673.2 3841.8 5088.5 5713.2 6031.3 6038.2 6050.2 6077.4 6082.1 6091.8 5919.8 6000.2 6102.8 6103.0 6123.5 3329.6 5039.4 5288.2 5297.9 5337.0 19821.8 20314.0 20335.0 20373.5 20504.9 1893.4 1941.3 2002.8 2173.0 2385.2 12627.9 12719.5 13074.2 13501.3 13553.2 1713.6 1745.6 1789.2 1809.6 1811.1 65661.7 67892.0 72051.0 72187.0 72357.3 9867.0 10084.9 10095.5 10123.3 10235.1 13980.7 13998.0 14042.7 14090.6 14100.2 7054.4 7265.4 7456.9 7559.7 7596.0 6944.5 6990.4 7049.3 7061.8 7119.6 4396.7 4421.7 4459.8 4470.9 4473.7 1671.4 1706.7 1771.8 1822.7 1864.6 849.4 864.5 901.7 904.5 921.4 15788.2 16534.8 16707.7 16756.7 17027.5 872.5 888.0 943.6 952.7 960.3 9313.7 9354.3 9429.2 9603.2 9787.7 367928.0 368845.0 377541.0 378651.0 381710.0 69810.0 73214.6 73757.0 76180.0 77310.6 921.6 930.1 946.8 947.1 948.3 14285.9 14799.9 14807.2 15269.5 15669.8 25931.4 28537.7 30677.5 34774.5 37128.4 48232.3 48751.0 49408.0 49562.3 49879.0 7134.3 7279.6 7415.0 7484.9 7558.1 9936.8 10597.7 10660.5 10748.1 10920.5 8537.2 8835.8 9183.5 9564.1 9589.8 8822.0 9085.6 9382.5 9438.2 9492.3 8721.8 9078.1 9474.5 9708.4 9746.4 7248.0 7488.0 7562.2 7631.6 7716.1 8880.4 9240.3 9360.0 9379.7 9447.7 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | [#3] mootools.html Cycles:180 Average:4939.30 Median:4934.19 stddev:2742.66 (55.6%) stddev-sans-first:2736.26 08:09:23 INFO - PROCESS | 4401 | Values: 1240.2 1390.1 1423.6 1483.7 1676.8 6451.7 7287.6 7415.3 7418.0 7672.0 7374.7 7512.0 7514.8 7539.2 7569.9 2166.7 2198.7 2200.1 2201.0 2203.0 2149.8 2172.4 2205.9 2213.1 2213.6 2154.2 2171.5 2177.5 2181.0 2196.0 2071.6 2073.5 2078.2 2080.9 2088.5 2063.1 2125.2 2125.4 2126.0 2126.8 7396.5 7403.7 7411.3 7412.6 7572.5 4445.1 4547.6 4559.6 4582.8 4605.9 2746.5 2832.7 2889.6 2895.5 2900.0 908.0 917.8 920.7 933.2 952.0 10015.1 10081.5 10083.9 10109.5 10216.9 3933.7 4040.6 4107.4 4110.7 4116.1 8116.1 8121.8 8127.8 8148.8 8162.2 4370.8 4378.2 4381.1 4396.7 4402.5 3583.2 4006.4 4006.7 4081.4 4150.6 3356.8 3363.5 3416.5 3435.7 3451.8 1024.8 1051.6 1060.4 1064.6 1069.9 695.2 762.5 826.7 835.5 852.3 5011.5 5028.9 5114.0 5203.3 5207.8 420.3 422.3 422.4 431.3 434.1 3553.8 3569.3 3574.3 3594.3 3622.9 8920.7 9215.3 9225.4 9243.9 9244.7 9095.1 9148.8 9174.3 9238.2 9265.8 6992.9 7069.4 7070.6 7076.4 7134.2 4896.6 4971.8 5088.9 5092.6 5118.2 8344.3 8575.6 8580.6 8586.3 8665.0 8699.2 8721.2 8802.3 8821.2 8833.0 5551.8 6077.1 6305.6 6356.6 6373.2 7170.6 7334.3 7381.6 7394.5 7406.0 6536.2 6623.6 6757.9 6779.9 6828.4 6652.1 6658.6 6690.0 6711.0 6742.1 6120.1 6124.6 6137.0 6164.4 6171.3 4482.3 4499.3 4603.3 4641.9 4655.0 4634.8 4695.7 4705.7 4725.4 4773.7 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | [#4] prototype.html Cycles:180 Average:4126.09 Median:4723.48 stddev:1193.81 (25.3%) stddev-sans-first:1162.13 08:09:23 INFO - PROCESS | 4401 | Values: 301.0 309.3 311.9 312.6 313.9 4746.3 4768.8 4775.0 4777.7 4812.3 4647.0 4714.6 4718.1 4721.5 4725.5 3528.9 3655.8 3693.4 3746.2 3790.0 3616.1 3737.7 3779.8 3780.5 3790.6 3533.8 3684.3 3695.8 3711.2 3722.4 3607.4 3719.4 3727.5 3736.1 3744.5 3309.4 3313.2 3323.6 3329.3 3334.5 4464.0 4476.9 4481.4 4486.9 4487.8 4009.0 4190.4 4223.7 4245.9 4255.3 4927.4 4937.6 4953.1 4967.5 4981.7 3544.8 3547.0 3548.4 3552.5 3558.3 5058.2 5195.8 5200.5 5205.8 5214.5 3586.3 3598.3 3637.7 3646.4 3657.5 3645.7 3651.1 3657.9 3676.6 3679.6 4181.3 4198.6 4201.6 4211.0 4216.2 4890.0 4943.2 4957.7 4958.3 4964.0 1258.5 1266.5 1272.8 1274.2 1278.1 809.4 815.3 851.0 868.5 869.1 4355.9 4367.0 4397.2 4409.8 4418.7 5032.7 5032.8 5035.2 5045.0 5103.9 4209.5 4364.0 4391.5 4392.2 4433.9 2667.3 2684.5 2686.0 2696.0 2712.6 4753.0 4770.8 4783.5 4786.4 4794.2 4997.7 5161.2 5192.7 5192.7 5265.2 4839.4 4846.7 4848.3 4862.7 4887.8 5155.0 5194.8 5198.6 5208.5 5214.8 4901.6 5086.9 5095.8 5122.2 5155.8 4826.8 4840.8 4849.8 4870.4 4881.0 3638.9 3668.6 3669.9 3672.6 3683.5 4837.7 5096.5 5126.6 5178.8 5193.4 4910.7 4917.8 4944.5 4946.7 4956.2 4947.5 4947.6 4982.8 5004.1 5031.8 4697.0 4846.3 4849.0 4935.4 4961.1 4719.5 4871.8 4991.8 4999.7 5006.2 4851.6 4873.8 4896.2 4906.9 4908.9 08:09:23 INFO - PROCESS | 4401 | 08:09:23 INFO - PROCESS | 4401 | [#5] yui.html Cycles:180 Average:13194.35 Median:46025.15 stddev:15369.41 (33.4%) stddev-sans-first:15383.70 08:09:23 INFO - PROCESS | 4401 | Values: 660.5 738.9 752.1 759.3 759.5 11302.5 12178.1 12376.8 12401.4 12432.6 13142.5 13448.3 13459.9 14006.2 14015.9 633.2 800.7 801.1 805.6 806.1 778.4 808.3 809.3 810.7 810.8 837.6 838.4 839.7 840.3 840.4 661.1 807.1 826.6 826.8 827.0 595.1 608.1 608.2 609.1 610.3 12384.3 12486.9 12503.2 12509.0 12521.7 10607.0 11015.6 11056.9 11090.5 11164.9 10957.6 10975.0 11103.6 11266.7 11269.9 3978.7 3997.0 4006.8 4024.3 4101.4 50270.2 50370.5 51537.7 51758.2 51869.0 9628.2 9759.9 9860.5 9925.4 10062.0 17287.0 17777.6 17778.4 17779.9 17783.6 6524.3 6645.2 6645.8 6668.9 6681.4 3578.6 3619.4 3634.2 3677.5 3757.5 2732.9 2838.7 2838.9 2846.0 2847.8 528.2 545.6 550.0 551.6 553.5 519.6 589.7 590.4 603.1 624.7 8040.7 8055.4 8163.7 8167.5 8461.2 580.0 584.5 600.6 606.5 612.1 3915.8 3953.8 3975.6 4024.9 4028.5 53159.7 54736.0 54914.5 55020.2 55069.4 49042.0 49770.3 50875.2 50960.0 51171.2 45131.0 45834.3 45958.0 46092.3 46493.8 7059.5 7257.8 7341.6 7361.1 7373.6 26652.3 27366.6 28185.3 30686.5 31514.8 37963.6 38217.6 38266.4 38593.6 38623.2 10707.9 10888.3 10945.7 11179.2 11472.3 11345.9 11360.4 11463.6 11644.5 12642.9 7780.4 10443.7 11090.4 11128.0 11206.8 10838.2 10945.8 11009.4 11206.2 11252.3 10762.7 11104.5 11305.2 11412.7 11687.5 9752.5 9847.0 10013.7 10132.2 10142.4 9542.1 9705.7 9729.8 9806.9 9886.1 08:09:23 INFO - PROCESS | 4401 | -------- Summary: end -------- 08:09:23 INFO - PROCESS | 4401 | 08:09:24 INFO - TEST-INFO | 4401: exit 0 08:09:24 INFO - TEST-OK | dromaeo_css | took 1117909ms 08:09:24 INFO - TEST-START | kraken 08:09:24 INFO - operating with platform_type : linux_ 08:09:24 INFO - Initialising browser for kraken test... 08:09:24 INFO - TEST-INFO | started process 4574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQhumUM/profile http://localhost:40517/getInfo.html) 08:09:28 INFO - PROCESS | 4574 | __metrics Screen width/height:1600/1200 08:09:28 INFO - PROCESS | 4574 | colorDepth:24 08:09:28 INFO - PROCESS | 4574 | Browser inner width/height: 1024/697 08:09:28 INFO - PROCESS | 4574 | __metrics 08:09:29 ERROR - PROCESS | 4574 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:09:30 INFO - TEST-INFO | 4574: exit 0 08:09:30 INFO - Browser initialized. 08:09:30 INFO - Running cycle 1/1 for kraken test... 08:09:30 INFO - TEST-INFO | started process 4654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQhumUM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:42 INFO - PROCESS | 4654 | RSS: Main: 158072832 08:09:42 INFO - PROCESS | 4654 | 08:09:45 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40517/tests/kraken/driver.html?testName=audio-beat-detection) 08:09:46 INFO - PROCESS | 4654 | RSS: Main: 214810624 08:09:46 INFO - PROCESS | 4654 | 08:09:49 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40517/tests/kraken/driver.html?testName=audio-dft) 08:09:49 INFO - PROCESS | 4654 | RSS: Main: 202227712 08:09:49 INFO - PROCESS | 4654 | 08:09:52 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40517/tests/kraken/driver.html?testName=audio-fft) 08:09:53 INFO - PROCESS | 4654 | RSS: Main: 270979072 08:09:53 INFO - PROCESS | 4654 | 08:09:55 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40517/tests/kraken/driver.html?testName=audio-oscillator) 08:09:56 INFO - PROCESS | 4654 | RSS: Main: 180781056 08:09:56 INFO - PROCESS | 4654 | 08:09:58 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40517/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:09:59 INFO - PROCESS | 4654 | RSS: Main: 184848384 08:09:59 INFO - PROCESS | 4654 | 08:10:02 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40517/tests/kraken/driver.html?testName=imaging-darkroom) 08:10:02 INFO - PROCESS | 4654 | RSS: Main: 220413952 08:10:02 INFO - PROCESS | 4654 | 08:10:06 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40517/tests/kraken/driver.html?testName=imaging-desaturate) 08:10:06 INFO - PROCESS | 4654 | RSS: Main: 221171712 08:10:06 INFO - PROCESS | 4654 | 08:10:09 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40517/tests/kraken/driver.html?testName=json-parse-financial) 08:10:10 INFO - PROCESS | 4654 | RSS: Main: 221396992 08:10:10 INFO - PROCESS | 4654 | 08:10:12 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40517/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:10:12 INFO - PROCESS | 4654 | RSS: Main: 204087296 08:10:12 INFO - PROCESS | 4654 | 08:10:14 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:10:15 INFO - PROCESS | 4654 | RSS: Main: 209723392 08:10:15 INFO - PROCESS | 4654 | 08:10:17 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:10:18 INFO - PROCESS | 4654 | RSS: Main: 216776704 08:10:18 INFO - PROCESS | 4654 | 08:10:20 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:10:21 INFO - PROCESS | 4654 | RSS: Main: 224157696 08:10:21 INFO - PROCESS | 4654 | 08:10:24 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:10:25 INFO - PROCESS | 4654 | RSS: Main: 222138368 08:10:25 INFO - PROCESS | 4654 | 08:10:26 INFO - PROCESS | 4654 | Cycle 1(1): loaded http://localhost:40517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40517/tests/kraken/driver.html?testName=ai-astar) 08:10:27 INFO - PROCESS | 4654 | RSS: Main: 264445952 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | __start_tp_report 08:10:27 INFO - PROCESS | 4654 | _x_x_mozilla_page_load 08:10:27 INFO - PROCESS | 4654 | _x_x_mozilla_page_load_details 08:10:27 INFO - PROCESS | 4654 | |i|pagename|runs| 08:10:27 INFO - PROCESS | 4654 | |0;ai-astar;112;107;113;113;112;111;111;113;112;111 08:10:27 INFO - PROCESS | 4654 | |1;audio-beat-detection;159;135;134;191;131;151;156;131;193;135 08:10:27 INFO - PROCESS | 4654 | |2;audio-dft;163;162;163;163;161;162;164;162;161;162 08:10:27 INFO - PROCESS | 4654 | |3;audio-fft;74;76;75;105;76;76;75;75;111;74 08:10:27 INFO - PROCESS | 4654 | |4;audio-oscillator;84;85;113;84;86;84;112;85;85;126 08:10:27 INFO - PROCESS | 4654 | |5;imaging-gaussian-blur;117;119;117;117;117;117;117;117;116;118 08:10:27 INFO - PROCESS | 4654 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;145;146 08:10:27 INFO - PROCESS | 4654 | |7;imaging-desaturate;95;95;94;96;95;96;95;95;95;94 08:10:27 INFO - PROCESS | 4654 | |8;json-parse-financial;63;63;64;64;64;64;64;64;65;64 08:10:27 INFO - PROCESS | 4654 | |9;json-stringify-tinderbox;64;65;65;64;66;65;67;68;65;65 08:10:27 INFO - PROCESS | 4654 | |10;stanford-crypto-aes;83;84;82;84;85;85;84;85;120;85 08:10:27 INFO - PROCESS | 4654 | |11;stanford-crypto-ccm;133;133;134;137;130;133;130;134;135;131 08:10:27 INFO - PROCESS | 4654 | |12;stanford-crypto-pbkdf2;170;168;177;166;167;165;165;166;166;167 08:10:27 INFO - PROCESS | 4654 | |13;stanford-crypto-sha256-iterative;70;67;67;67;66;71;66;67;65;69 08:10:27 INFO - PROCESS | 4654 | __end_tp_report 08:10:27 INFO - PROCESS | 4654 | __start_cc_report 08:10:27 INFO - PROCESS | 4654 | _x_x_mozilla_cycle_collect,1919 08:10:27 INFO - PROCESS | 4654 | __end_cc_report 08:10:27 INFO - PROCESS | 4654 | __startTimestamp1464793827090__endTimestamp 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | ------- Summary: start ------- 08:10:27 INFO - PROCESS | 4654 | Number of tests: 14 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 08:10:27 INFO - PROCESS | 4654 | Values: 112.0 107.0 113.0 113.0 112.0 111.0 111.0 113.0 112.0 111.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:153.50 stddev:23.69 (15.4%) stddev-sans-first:24.97 08:10:27 INFO - PROCESS | 4654 | Values: 159.0 135.0 134.0 191.0 131.0 151.0 156.0 131.0 193.0 135.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 08:10:27 INFO - PROCESS | 4654 | Values: 163.0 162.0 163.0 163.0 161.0 162.0 164.0 162.0 161.0 162.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.95 (18.6%) stddev-sans-first:14.52 08:10:27 INFO - PROCESS | 4654 | Values: 74.0 76.0 75.0 105.0 76.0 76.0 75.0 75.0 111.0 74.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.50 stddev:16.04 (19.0%) stddev-sans-first:16.56 08:10:27 INFO - PROCESS | 4654 | Values: 84.0 85.0 113.0 84.0 86.0 84.0 112.0 85.0 85.0 126.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 08:10:27 INFO - PROCESS | 4654 | Values: 117.0 119.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:10:27 INFO - PROCESS | 4654 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:10:27 INFO - PROCESS | 4654 | Values: 95.0 95.0 94.0 96.0 95.0 96.0 95.0 95.0 95.0 94.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 08:10:27 INFO - PROCESS | 4654 | Values: 63.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 08:10:27 INFO - PROCESS | 4654 | Values: 64.0 65.0 65.0 64.0 66.0 65.0 67.0 68.0 65.0 65.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.50 stddev:11.39 (13.5%) stddev-sans-first:11.96 08:10:27 INFO - PROCESS | 4654 | Values: 83.0 84.0 82.0 84.0 85.0 85.0 84.0 85.0 120.0 85.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:133.50 stddev:2.21 (1.7%) stddev-sans-first:2.35 08:10:27 INFO - PROCESS | 4654 | Values: 133.0 133.0 134.0 137.0 130.0 133.0 130.0 134.0 135.0 131.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:167.00 stddev:3.59 (2.2%) stddev-sans-first:3.71 08:10:27 INFO - PROCESS | 4654 | Values: 170.0 168.0 177.0 166.0 167.0 165.0 165.0 166.0 166.0 167.0 08:10:27 INFO - PROCESS | 4654 | 08:10:27 INFO - PROCESS | 4654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.90 (2.8%) stddev-sans-first:1.79 08:10:27 INFO - PROCESS | 4654 | Values: 70.0 67.0 67.0 67.0 66.0 71.0 66.0 67.0 65.0 69.0 08:10:27 INFO - PROCESS | 4654 | -------- Summary: end -------- 08:10:27 INFO - PROCESS | 4654 | 08:10:28 INFO - TEST-INFO | 4654: exit 0 08:10:28 INFO - TEST-OK | kraken | took 63535ms 08:10:28 INFO - SUITE-END | took 1181s 08:10:28 INFO - Completed test suite (00:19:41) 08:10:28 INFO - javascript benchmark 08:10:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.960715589266, 2631.329011102171, 2667.119850449352, 2676.2774051006227, 2695.5013322535333, 4498.730076195422, 4503.504614492404, 4559.658025648073, 4627.167109920213, 4673.883152921178, 4529.932051019229, 4550.704204226731, 4615.215413379725, 4615.261558150696, 4625.514320996297, 3987.063040185554, 4121.072758629314, 4199.874003779892, 4231.70378073535, 4357.847475338363, 4255.8084886180195, 4304.332828411601, 4316.2446571849805, 4326.286162783137, 4343.565643435662, 4175.436316097318, 4214.199302132585, 4237.4279472271155, 4271.615554600101, 4289.528151903288, 4175.164967006611, 4183.477065366829, 4198.034452076009, 4225.894352641178, 4238.682098842599, 4214.38891360754, 4227.3447615619625, 4229.0, 4257.318828987347, 4262.488501379823, 4384.167008268419, 4400.471943366784, 4446.844360447401, 4456.108778244364, 4534.9546504534865, 4947.307376967192, 4960.801567937278, 4963.081829861487, 4966.478519755446, 4971.353724015855, 4934.876628084291, 4939.654224204307, 4956.157453232959, 4961.553460188564, 4979.327790748239, 4566.223741963874, 4606.631469482433, 4612.5156858530045, 4617.076584683044, 4724.267738500469, 5094.694318340911, 5112.36095488064, 5116.181410974226, 5121.769520371592, 5131.461196574381, 4898.142825005681, 4938.728369939688, 4955.256711493233, 4956.653034287565, 4957.3059771632, 4847.709137451694, 4878.780454879539, 4879.121758083508, 4890.24201248807, 5027.396712394463, 4851.393575803025, 4853.80584776605, 4854.320395144682, 4854.854354369375, 4910.189818679878, 4845.466998630148, 4847.248676455155, 4855.441624213261, 4866.513348665176, 4917.754112294371, 4210.431591735077, 4221.936670949938, 4230.725002874803, 4296.462942132233, 4300.1399720056115, 3735.6637902588354, 3764.0589852536864, 3768.0768211788286, 3777.86777462793, 3778.7543809652284, 4266.25340565406, 4275.743455392686, 4276.465441819772, 4277.080427707995, 4286.935695964563, 4996.125678006334, 4997.025580011936, 4997.600191984632, 5007.574356179765, 5052.216906379517, 4318.0, 4319.568043195655, 4321.69748117635, 4350.499692535335, 4365.890852728708, 4395.3187255974735, 4477.440319960005, 4502.122086193226, 4511.233090374644, 4536.206163921301, 4682.789274482657, 4684.695494792828, 4688.6717929745955, 4693.882652933704, 4736.644751643572, 4929.309896614549, 4971.403431588233, 4975.278584605139, 4980.252962055721, 4990.3762029746285, 4554.157480866051, 4662.440507139165, 4690.437147542317, 4698.577128058491, 4727.361806156263, 4932.457429682804, 4949.430815456269, 4949.7030178189425, 4961.70229786214, 5001.124803159505, 4837.032593481247, 5011.198208286657, 5019.196928491424, 5025.39695236574, 5070.062038522885, 4710.387649605529, 4723.622110231242, 4731.3612662291525, 4756.048790241896, 4759.381280433521, 4717.575418212377, 4755.524447555217, 4758.833440829554, 4786.545278198705, 4788.545088216614, 4693.601043911306, 4707.435107787088, 4711.740854253049, 4714.127886341038, 4747.83382581608, 4840.636952228527, 4844.273358996179, 4848.151573474698, 4866.367372241586, 4892.046051020017, 4792.856214313437, 4795.95204047969, 4798.2802579613335, 4802.759862006956, 4856.028794241095], "value": 4545.76113510363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.4436474795708, 570.7374607680467, 582.0, 583.5710752596841, 588.9957622254058, 28335.716642833566, 31135.0, 31145.532817007705, 31155.84422077892, 40303.19393612133, 37894.62105378945, 41891.0, 42003.57996420043, 42020.57979420205, 42069.0, 7589.658465369058, 7764.883526747103, 7771.067471903351, 7772.650230739602, 7774.222577742237, 7616.809579760495, 7741.303282704555, 7751.992241008661, 7759.9612001940195, 7764.223577642247, 7749.612519374037, 7800.531968081905, 7800.921990780076, 7801.4929029612895, 7804.687812487494, 7698.846023079535, 7739.071311442634, 7752.496087754278, 7763.107242667109, 7763.107242667109, 7475.700971961115, 7533.209013053605, 7538.8115297117465, 7542.0, 7545.207753185891, 39567.60432395668, 40066.0, 40107.799461002505, 40224.597754022674, 40291.395629065584, 2798.3571833450906, 3287.309664970359, 3450.0, 3597.0, 3845.1348446599573, 29755.404891902257, 30334.696653033407, 30340.69659303401, 30397.088087357413, 30476.238094047603, 3512.0868574170645, 3616.4213725803747, 3730.8321125549414, 3740.4202348636004, 3743.606921273254, 240919.0, 244038.0, 244322.0, 244665.0, 244867.0, 55842.441575583725, 56247.71876140593, 56263.71868140633, 56310.0, 56380.436195638336, 58964.7051764747, 59074.704626476596, 59102.0, 59126.40873591209, 59239.70380148158, 14895.851041489446, 15043.473478428203, 15046.774298385533, 15064.548063558112, 15086.924565377103, 10697.572097116028, 10708.518116684769, 10722.356658600509, 10722.41026743521, 10730.678079657622, 15367.769483457758, 17433.302667893397, 17739.556511087325, 17750.28998840058, 17821.910890445724, 6064.4845188158615, 6134.846628834225, 6205.183811955615, 6357.936420635827, 6448.258450278185, 759.369723129801, 859.7821290268164, 885.8936927568733, 948.4783369146942, 989.2926557511414, 27347.589786153225, 27938.0, 28234.85882570574, 28253.0, 28592.0, 951.3958636266021, 956.799072194833, 975.6243846119295, 999.8900120986685, 1066.504075604832, 14670.779938300933, 14734.263286835616, 14791.556253312418, 15267.694646107017, 15272.923635381752, 350865.0, 353725.0, 355581.0, 356314.0, 356851.0, 49906.75046624744, 50166.498335016186, 50196.24705629418, 50223.24665130026, 50280.0, 1077.859878215827, 1168.3574034281112, 1203.199872085071, 1207.0343725020125, 1213.7633161533415, 28629.856850715612, 29426.411471770018, 29716.10851674453, 30441.543376849808, 30452.84773576118, 42730.14539709126, 43175.35236971511, 43273.56726432696, 43316.0, 43376.56623433851, 226750.0, 226772.0, 227062.0, 228039.0, 228380.0, 36671.266574668894, 38464.80767596144, 38824.22351552897, 38842.417363739, 38926.2214755709, 43305.0, 43634.0, 43933.78033109814, 44395.0, 45002.0, 37209.44185837269, 37354.8132259337, 37484.625153748115, 37689.62310376861, 37703.81148094242, 35809.46285805663, 36029.0, 36736.448953265186, 36737.81631091827, 37132.0, 35725.64274357327, 35943.64056359403, 36136.27727445489, 36769.816150919076, 36932.0, 32097.518537221495, 32545.674543255212, 33090.33819323552, 33145.33709325848, 33215.83392083024, 25008.124715635593, 25228.49543009166, 25251.368715782253, 25276.620850686886, 25498.490030199664], "value": 17601.90908986371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.12044454642484, 371.5708356847841, 375.2644816160326, 378.239738126366, 394.1466724541368, 15434.459793907201, 16396.0, 16672.749908751364, 16780.0, 16988.320467181296, 16010.919945400286, 16394.508164755076, 17232.310707571683, 17311.567210819736, 17314.393996210136, 4909.607231421478, 5029.47190544993, 5103.2855400244, 5109.054824857395, 5111.642185047048, 3673.1551743099103, 3841.827117779693, 5088.465711100337, 5713.228714123582, 6031.276246850362, 6038.215032045828, 6050.213472248602, 6077.392260773931, 6082.118092876531, 6091.847703807418, 5919.822405327847, 6000.159977603139, 6102.786402475915, 6102.969485152568, 6123.510119190454, 3329.5505106810515, 5039.44566097729, 5288.180332048539, 5297.947020529822, 5336.9733151334385, 19821.801781982285, 20314.0, 20335.0, 20373.49066273355, 20504.897475512527, 1893.4414347767442, 1941.2914286285545, 2002.819746222847, 2172.9565408691738, 2385.1771138957033, 12627.873721262762, 12719.491220351174, 13074.215547067206, 13501.32493375337, 13553.186808791505, 1713.6315692126127, 1745.5636090977255, 1789.185920406225, 1809.6109336492586, 1811.112554848115, 65661.67169164172, 67892.0, 72051.0, 72187.0, 72357.27642723559, 9867.0, 10084.899151008396, 10095.466586694598, 10123.341982771097, 10235.130013948898, 13980.650483737785, 13998.020138590404, 14042.719145617235, 14090.647733806736, 14100.153990760587, 7054.400375967997, 7265.382442492341, 7456.888146677804, 7559.697612095454, 7595.962020189863, 6944.548604340803, 6990.405815505637, 7049.330313620198, 7061.752838650623, 7119.644017799089, 4396.692231543761, 4421.712588681726, 4459.777011149429, 4470.888227794331, 4473.731576105444, 1671.3565277368057, 1706.743988401725, 1771.8228177182436, 1822.683713965191, 1864.5804693943753, 849.426637020009, 864.5288317866778, 901.7384958362132, 904.5115637555647, 921.3918813583138, 15788.21058947048, 16534.83465165333, 16707.749383759252, 16756.6648667026, 17027.48917532476, 872.4634349874781, 887.9600417981206, 943.551812888886, 952.6903756279098, 960.2893858544627, 9313.674021409219, 9354.251659867194, 9429.15137637616, 9603.231741460806, 9787.706368808947, 367928.0, 368845.0, 377541.0, 378651.0, 381710.0, 69810.0, 73214.63392683002, 73757.0, 76180.0, 77310.61344693354, 921.6359787514516, 930.1396208507103, 946.8343039967978, 947.0907928388824, 948.3266880514911, 14285.857141428452, 14799.852001479847, 14807.185604791839, 15269.541913742605, 15669.764953525479, 25931.351716207246, 28537.714622853506, 30677.53983690202, 34774.47838282478, 37128.443073354465, 48232.276515852995, 48751.0, 49408.0, 49562.25656615226, 49879.0, 7134.250903655042, 7279.599622020628, 7414.962925185339, 7484.887726683995, 7558.093028836574, 9936.751581210528, 10597.735056623646, 10660.466976650981, 10748.140148788234, 10920.453977301262, 8537.18896704812, 8835.761946081764, 9183.494907780136, 9564.091411315914, 9589.760255993657, 8821.955890220508, 9085.591148398205, 9382.48396338208, 9438.150566449052, 9492.288078394009, 8721.825563488821, 9078.092190781133, 9474.526273686426, 9708.417494950325, 9746.415215087118, 7248.0, 7487.962560187382, 7562.168161502341, 7631.580263085361, 7716.074071111502, 8880.422772519765, 9240.260779137787, 9359.953200233955, 9379.718608441757, 9447.716568502956], "value": 8142.20557485654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.2310567448183, 1390.0617083468655, 1423.6085076603933, 1483.6958423523172, 1676.782018337616, 6451.709673064712, 7287.599182044985, 7415.258474152589, 7418.035655364809, 7671.961640191791, 7374.705011799535, 7512.0, 7514.849703005937, 7539.246075392458, 7569.886451703215, 2166.729158855147, 2198.692183094368, 2200.0539767899795, 2201.020545857094, 2203.030666506732, 2149.7742737012622, 2172.3591540495513, 2205.856619319747, 2213.0594497338648, 2213.634750266212, 2154.235246487498, 2171.5114099327684, 2177.4882902517897, 2180.9672854907108, 2195.9560808783813, 2071.59603877244, 2073.460900165953, 2078.1791192478886, 2080.916763329465, 2088.5092003379195, 2063.0819285417997, 2125.192426877792, 2125.394262635142, 2126.0326551419066, 2126.7873212678765, 7396.519226250331, 7403.666834992438, 7411.332980031823, 7412.555246685162, 7572.469927105105, 4445.110977804452, 4547.636189104896, 4559.635229181657, 4582.839600613963, 4605.884852878705, 2746.533089374811, 2832.6884042755282, 2889.5954566360515, 2895.5222388305906, 2900.0, 907.9500627465487, 917.8393781088283, 920.6823645842173, 933.2207606648457, 951.9619215231382, 10015.148712359458, 10081.546330415149, 10083.949580252125, 10109.494525273707, 10216.897831021743, 3933.7246392752804, 4040.5959404059945, 4107.383892416162, 4110.691698122653, 4116.0533077392365, 8116.147804480563, 8121.796955076052, 8127.837443251102, 8148.837023259502, 8162.224588664068, 4370.825166993348, 4378.233809083397, 4381.123775244963, 4396.692231543825, 4402.493713222956, 3583.157957879896, 4006.3790112532606, 4006.6994975376965, 4081.4490043843703, 4150.64719498846, 3356.81537515439, 3363.4618461046603, 3416.4533674611944, 3435.707964822968, 3451.8274086295582, 1024.774549599087, 1051.6109039655375, 1060.4167707760855, 1064.5688496159069, 1069.8555694981233, 695.20399142981, 762.523422860712, 826.7354446577037, 835.5279267214005, 852.3479538153317, 5011.52390522907, 5028.8757033349075, 5113.974430127825, 5203.271541984125, 5207.765650545734, 420.3211812922109, 422.25472041846166, 422.38542920051253, 431.34866351808995, 434.1404020040338, 3553.8400771965325, 3569.303985722759, 3574.3208790329754, 3594.263176048904, 3622.855085796539, 8920.73237802867, 9215.308851836138, 9225.400348977295, 9243.907560924305, 9244.676436324697, 9095.135962083723, 9148.771280717901, 9174.311926605531, 9238.214751746176, 9265.814683706289, 6992.93007069933, 7069.363757261768, 7070.611116388648, 7076.363127318566, 7134.179569349488, 4896.632752543503, 4971.751412429437, 5088.923666144937, 5092.618053645917, 5118.181091025418, 8344.290735287568, 8575.61409736551, 8580.613872375883, 8586.313094952264, 8665.0, 8699.217070463688, 8721.215090641872, 8802.29581633455, 8821.2060914518, 8833.0, 5551.7779288828, 6077.11881777131, 6305.5901366411035, 6356.586821856565, 6373.171487706569, 7170.641467926687, 7334.266573342837, 7381.557106573623, 7394.519356241827, 7405.9629701851145, 6536.246503053363, 6623.602583844985, 6757.864842703217, 6779.864402712017, 6828.385445309946, 6652.101966234496, 6658.567193132625, 6689.966550167218, 6710.966445167743, 6742.089817874524, 6120.143179954721, 6124.6325220486915, 6137.0, 6164.445199932027, 6171.290301615192, 4482.305242687388, 4499.325101234841, 4603.309503574491, 4641.883952901069, 4655.0, 4634.791434385394, 4695.718256904596, 4705.7411842349, 4725.385699858996, 4773.71357718538], "value": 3930.517923341868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.0396834099223, 309.34419031652897, 311.9173419043953, 312.64514775729555, 313.9089663997441, 4746.288056791479, 4768.809247630091, 4774.9761251193695, 4777.713337199766, 4812.291636469051, 4646.953530464694, 4714.622830173586, 4718.127146477904, 4721.504242054578, 4725.456572494164, 3528.947065794015, 3655.7935881159156, 3693.409054551272, 3746.1945681678435, 3790.0, 3616.132128289218, 3737.663610275075, 3779.754315969467, 3780.451834483998, 3790.639889210521, 3533.823308834548, 3684.281565094808, 3695.815209239527, 3711.164987877733, 3722.4044152935535, 3607.3867442534834, 3719.3863012602887, 3727.5340582427198, 3736.1406876418305, 3744.5132132822696, 3309.4043072246986, 3313.204830840605, 3323.5845519310087, 3329.334133173375, 3334.483155110962, 4463.973286144173, 4476.89585894629, 4481.439820022497, 4486.8878278042985, 4487.820487180509, 4008.959910400888, 4190.44953367253, 4223.746575205467, 4245.853619522712, 4255.297875850512, 4927.408710954673, 4937.555619994182, 4953.133201689726, 4967.478414766434, 4981.701097934136, 3544.7873127612424, 3547.0068380853404, 3548.3790336690977, 3552.520409744677, 3558.3417067842274, 5058.190689489664, 5195.818146364859, 5200.531952124327, 5205.843824685227, 5214.478552144793, 3586.336527742376, 3598.2623562169692, 3637.672609465108, 3646.4165733482514, 3657.487951686766, 3645.671889529902, 3651.1419816343137, 3657.8536858525895, 3676.558812942464, 3679.6136405677553, 4181.330987042059, 4198.6011328923705, 4201.642860356904, 4211.0, 4216.198922204771, 4889.951100489021, 4943.209086546135, 4957.727324997088, 4958.305837182797, 4964.007198560303, 1258.4903114238748, 1266.4870727355435, 1272.7581759465672, 1274.2354587247578, 1278.0797825565578, 809.4414853750893, 815.3477218225396, 850.9702160424356, 868.487592320534, 869.1395518436829, 4355.934660980088, 4366.951931536409, 4397.2304846651705, 4409.845655402046, 4418.71857161426, 5032.672876263031, 5032.842446237386, 5035.248739688882, 5044.974775126174, 5103.948960510422, 4209.536950935395, 4363.956360436355, 4391.473023237232, 4392.165488557164, 4433.889152771142, 2667.2662769200174, 2684.463107378532, 2686.0196028449477, 2696.042904768779, 2712.552428849218, 4752.95247047532, 4770.833020844254, 4783.545563171563, 4786.3777708898315, 4794.184988551954, 4997.675151115166, 5161.200013997836, 5192.714400707921, 5192.740362981911, 5265.236540701577, 4839.370881785416, 4846.733429661403, 4848.3454733610515, 4862.708237505761, 4887.753622826157, 5154.9690061987, 5194.766235519486, 5198.610104242272, 5208.453112423141, 5214.783716920218, 4901.5588597026435, 5086.923696144635, 5095.808802215083, 5122.231665250242, 5155.814162742665, 4826.7827947743135, 4840.782164802522, 4849.806007759791, 4870.391201099863, 4880.975595122001, 3638.854445822243, 3668.550922385696, 3669.935718641564, 3672.596014438463, 3683.5211422514903, 4837.733924634179, 5096.464871188472, 5126.641135120506, 5178.766955486937, 5193.4027586828, 4910.6562540623245, 4917.778699958582, 4944.456109827988, 4946.653734238569, 4956.157453233031, 4947.54047555979, 4947.565206090194, 4982.7508624569355, 5004.124278251219, 5031.823886164113, 4696.976515117402, 4846.321514987834, 4848.95151048485, 4935.432425270996, 4961.05739909416, 4719.457262414866, 4871.8294859679745, 4991.80196752784, 4999.725015124203, 5006.1739812930455, 4851.611871050378, 4873.757191916039, 4896.2410826321975, 4906.9018619626695, 4908.8772780680765], "value": 3750.8919954620815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.4584240922444, 738.9334959853612, 752.1425574844675, 759.305235709326, 759.4607828441808, 11302.491387887545, 12178.08664350174, 12376.81434778479, 12401.379931003436, 12432.564860229904, 13142.47430102797, 13448.260345680983, 13459.865401345984, 14006.159630422157, 14015.859841401583, 633.22113800026, 800.7157459102023, 801.1347744435996, 805.64551597297, 806.1414593457978, 778.3695206882443, 808.312934006096, 809.34038758412, 810.6878851642131, 810.8297257575916, 837.6356285016008, 838.3963546246692, 839.6599377252222, 840.2941529115542, 840.369722707969, 661.0579923608886, 807.1444269074741, 826.5867066466767, 826.8428998490267, 827.0034608297018, 595.1043679262725, 608.1091201389941, 608.242737791448, 609.0650850943824, 610.3377835048933, 12384.256944583354, 12486.937565312115, 12503.187292825936, 12509.0, 12521.74956500865, 10607.0, 11015.614453494169, 11056.889431105747, 11090.500927458284, 11164.944175279154, 10957.56169753209, 10975.0, 11103.611373601965, 11266.718332041764, 11269.887301126966, 3978.7214894957365, 3996.9600303997167, 4006.779627120507, 4024.2756303865294, 4101.364288535282, 50270.24594631083, 50370.496295036945, 51537.74231128858, 51758.22362664601, 51869.0, 9628.229741620653, 9759.902400976041, 9860.506974651382, 9925.3548519346, 10062.0, 17287.0, 17777.555561111076, 17778.37775677871, 17779.911100444675, 17783.644327113387, 6524.347565243438, 6645.2025756908515, 6645.833854153588, 6668.899966500507, 6681.365270299314, 3578.5705715313807, 3619.3847046002243, 3634.1823089804584, 3677.4851520786574, 3757.530308711411, 2732.945341093167, 2838.68774434812, 2838.8722507487214, 2846.0465743976, 2847.8291302521916, 528.2498851630694, 545.5962587685084, 549.9835004949858, 551.5725312882548, 553.4576115406843, 519.5739493615199, 589.666838236395, 590.3624085987124, 603.0833133636935, 624.7469774741237, 8040.717034555726, 8055.436119471698, 8163.7142700005215, 8167.469114507538, 8461.238488535939, 580.0458246185002, 584.476893180601, 600.6096037575611, 606.4541912278896, 612.0818771842237, 3915.804209789499, 3953.8418463261723, 3975.6421922027157, 4024.8591299304385, 4028.516578010599, 53159.73420132875, 54736.0, 54914.450855491734, 55020.174697379574, 55069.44930550723, 49042.0, 49770.25344619834, 50875.236871446956, 50960.0, 51171.23243151281, 45131.0, 45834.312485313414, 45958.0, 46092.3086153708, 46493.767531162805, 7059.541129826544, 7257.782266532013, 7341.6329183541675, 7361.1166660001145, 7373.631318434164, 26652.333691657863, 27366.5895011571, 28185.295367615974, 30686.539701904043, 31514.842425787723, 37963.620363796006, 38217.617823821405, 38266.426003610526, 38593.614063859, 38623.227535449696, 10707.89292107069, 10888.29226100301, 10945.726356841144, 11179.161562882653, 11472.254303470248, 11345.943270283597, 11360.375179365214, 11463.598774042868, 11644.475998580254, 12642.873571264538, 7780.416468764752, 10443.68668939933, 11090.390028548507, 11128.0, 11206.831897521706, 10838.211695070226, 10945.83581246298, 11009.449527523431, 11206.215564910379, 11252.26860254081, 10762.73093172677, 11104.500297486795, 11305.208635395444, 11412.714682133013, 11687.532498699957, 9752.512374381395, 9846.991972940616, 10013.749656258651, 10132.189424846141, 10142.442165680663, 9542.141207291377, 9705.708828735149, 9729.805403891742, 9806.85289720669, 9886.117271798392], "value": 6018.785000415504, "unit": "score"}], "name": "dromaeo_css", "value": 6218.358509087564, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 113.0, 112.0, 111.0, 111.0, 113.0, 112.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 134.0, 191.0, 131.0, 151.0, 156.0, 131.0, 193.0, 135.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 161.0, 162.0, 164.0, 162.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 105.0, 76.0, 76.0, 75.0, 75.0, 111.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 84.0, 86.0, 84.0, 112.0, 85.0, 85.0, 126.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 65.0, 67.0, 68.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 84.0, 85.0, 85.0, 84.0, 85.0, 120.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 134.0, 137.0, 130.0, 133.0, 130.0, 134.0, 135.0, 131.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 177.0, 166.0, 167.0, 165.0, 165.0, 166.0, 166.0, 167.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 67.0, 66.0, 71.0, 66.0, 67.0, 65.0, 69.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1544.7, "alertThreshold": 2.0}]} 08:10:28 INFO - Return code: 0 08:10:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:10:28 ERROR - # TBPL SUCCESS # 08:10:28 INFO - Running post-action listener: _resource_record_post_action 08:10:28 INFO - ##### 08:10:28 INFO - ##### Finished run-tests step (success) 08:10:28 INFO - ##### 08:10:28 INFO - Running post-run listener: _resource_record_post_run 08:10:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522842112; Read time: 12; Write time: 411344 08:10:28 INFO - TinderboxPrint: CPU usage
13.1% 08:10:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:10:28 INFO - TinderboxPrint: I/O write bytes / time
522,842,112 / 411,344 08:10:28 INFO - TinderboxPrint: CPU idle
8,318.7 (86.9%) 08:10:28 INFO - TinderboxPrint: CPU user
1,208.1 (12.6%) 08:10:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:10:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 203218944; Read time: 0; Write time: 219896 08:10:28 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279281664; Read time: 12; Write time: 180876 08:10:29 INFO - Running post-run listener: _upload_blobber_files 08:10:29 INFO - Blob upload gear active. 08:10:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:10:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:10:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:10:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:33 INFO - (blobuploader) - INFO - Done attempting. 08:10:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:10:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:10:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:34 INFO - (blobuploader) - INFO - Done attempting. 08:10:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:10:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:10:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:35 INFO - (blobuploader) - INFO - Done attempting. 08:10:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:10:35 INFO - Return code: 0 08:10:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:10:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:10:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f4353012f8e2c62324248606b350d782e1dfb1d90dda252c73de48b3e4cbc106a9d918b3d8e559fca1a7fe9768f977c252bee2648bf9cdfb182475ac8c32c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afa4b317ca190b09b94b1d8aa765cca168bce8602ffa5844e3459f745734afca71457d5880f7af66f866619e36dcf8e6c63c5660c420625c0d6fc1266f8f32f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d0d447b02c87fab164a63f2c86a0898ba07f3323fa3f895b12d559ba071e9eec38f550df8cc7013f60d533f44b8d177a0cc52e3ec8adf470b64ef1dea3096f2"} 08:10:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:10:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:10:35 INFO - Contents: 08:10:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f4353012f8e2c62324248606b350d782e1dfb1d90dda252c73de48b3e4cbc106a9d918b3d8e559fca1a7fe9768f977c252bee2648bf9cdfb182475ac8c32c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afa4b317ca190b09b94b1d8aa765cca168bce8602ffa5844e3459f745734afca71457d5880f7af66f866619e36dcf8e6c63c5660c420625c0d6fc1266f8f32f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d0d447b02c87fab164a63f2c86a0898ba07f3323fa3f895b12d559ba071e9eec38f550df8cc7013f60d533f44b8d177a0cc52e3ec8adf470b64ef1dea3096f2"} 08:10:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:10:35 INFO - Copying logs to upload dir... 08:10:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:10:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.893891 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-01 08:10:35.811733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:10:35.815081) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297 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/6f4353012f8e2c62324248606b350d782e1dfb1d90dda252c73de48b3e4cbc106a9d918b3d8e559fca1a7fe9768f977c252bee2648bf9cdfb182475ac8c32c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afa4b317ca190b09b94b1d8aa765cca168bce8602ffa5844e3459f745734afca71457d5880f7af66f866619e36dcf8e6c63c5660c420625c0d6fc1266f8f32f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d0d447b02c87fab164a63f2c86a0898ba07f3323fa3f895b12d559ba071e9eec38f550df8cc7013f60d533f44b8d177a0cc52e3ec8adf470b64ef1dea3096f2"} build_url:https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/TKqjdKJSQlShWTg7Sc5LBA/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/6f4353012f8e2c62324248606b350d782e1dfb1d90dda252c73de48b3e4cbc106a9d918b3d8e559fca1a7fe9768f977c252bee2648bf9cdfb182475ac8c32c76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afa4b317ca190b09b94b1d8aa765cca168bce8602ffa5844e3459f745734afca71457d5880f7af66f866619e36dcf8e6c63c5660c420625c0d6fc1266f8f32f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d0d447b02c87fab164a63f2c86a0898ba07f3323fa3f895b12d559ba071e9eec38f550df8cc7013f60d533f44b8d177a0cc52e3ec8adf470b64ef1dea3096f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:10:35.841764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:10:35.842286) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464792591.838281-1126754297 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:10:35.927797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:10:35.928315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:10:35.928749) ========= ========= Total master_lag: 0.19 =========