builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0131 starttime: 1462521663.44 results: success (0) buildid: 20160505231124 builduid: d8b4ba1f94314efea96a886ae453a60c revision: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.437127) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.437610) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.437904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.459574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.459955) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-06 01:01:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-05-06 01:01:03 (37.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.562971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.566319) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027496 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:03.614792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-06 01:01:03.618190) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 --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 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-06 01:01:03,686 truncating revision to first 12 chars 2016-05-06 01:01:03,687 Setting DEBUG logging. 2016-05-06 01:01:03,687 attempt 1/10 2016-05-06 01:01:03,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e9cb8b89a10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 01:01:05,522 unpacking tar archive at: fx-team-9e9cb8b89a10/testing/mozharness/ program finished with exit code 0 elapsedTime=2.083424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-06 01:01:05.721276) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:05.721622) ========= script_repo_revision: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:05.722011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:05.722289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 01:01:05.735827) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-06 01:01:05.736239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:01:05 INFO - MultiFileLogger online at 20160506 01:01:05 in /builds/slave/test 01:01:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:01:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:01:05 INFO - {'append_to_log': False, 01:01:05 INFO - 'base_work_dir': '/builds/slave/test', 01:01:05 INFO - 'blob_upload_branch': 'Fx-Team', 01:01:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:01:05 INFO - 'branch': 'Fx-Team', 01:01:05 INFO - 'buildbot_json_path': 'buildprops.json', 01:01:05 INFO - 'config_files': ('talos/mac_config.py',), 01:01:05 INFO - 'default_actions': ('clobber', 01:01:05 INFO - 'read-buildbot-config', 01:01:05 INFO - 'download-and-extract', 01:01:05 INFO - 'populate-webroot', 01:01:05 INFO - 'create-virtualenv', 01:01:05 INFO - 'install', 01:01:05 INFO - 'run-tests'), 01:01:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:01:05 INFO - 'download_minidump_stackwalk': True, 01:01:05 INFO - 'download_symbols': 'ondemand', 01:01:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:01:05 INFO - 'tooltool.py': '/tools/tooltool.py', 01:01:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:01:05 INFO - '/tools/misc-python/virtualenv.py')}, 01:01:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:01:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:01:05 INFO - 'installer_path': 'installer.exe', 01:01:05 INFO - 'log_level': 'info', 01:01:05 INFO - 'log_name': 'talos', 01:01:05 INFO - 'log_to_console': True, 01:01:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:01:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:01:05 INFO - 'opt_config_files': (), 01:01:05 INFO - 'pip_index': False, 01:01:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:01:05 INFO - 'cmd': ('bash', 01:01:05 INFO - '-c', 01:01:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:01:05 INFO - 'enabled': True, 01:01:05 INFO - 'halt_on_failure': False, 01:01:05 INFO - 'name': 'check_screen_resolution'},), 01:01:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:01:05 INFO - 'cmd': ('bash', 01:01:05 INFO - '-c', 01:01:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:01:05 INFO - 'enabled': True, 01:01:05 INFO - 'halt_on_failure': False, 01:01:05 INFO - 'name': 'check_screen_resolution'},), 01:01:05 INFO - 'run_cmd_checks_enabled': True, 01:01:05 INFO - 'sps_profile': False, 01:01:05 INFO - 'sps_profile_interval': 0, 01:01:05 INFO - 'suite': 'dromaeojs', 01:01:05 INFO - 'system_bits': '32', 01:01:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:01:05 INFO - 'title': 't-yosemite-r7-0131', 01:01:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:01:05 INFO - 'use_talos_json': True, 01:01:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:01:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:01:05 INFO - 'work_dir': 'build'} 01:01:05 INFO - ##### 01:01:05 INFO - ##### Running clobber step. 01:01:05 INFO - ##### 01:01:05 INFO - Running pre-action listener: _resource_record_pre_action 01:01:05 INFO - Running main action method: clobber 01:01:05 INFO - rmtree: /builds/slave/test/build 01:01:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:01:07 INFO - Running post-action listener: _resource_record_post_action 01:01:07 INFO - ##### 01:01:07 INFO - ##### Running read-buildbot-config step. 01:01:07 INFO - ##### 01:01:07 INFO - Running pre-action listener: _resource_record_pre_action 01:01:07 INFO - Running main action method: read_buildbot_config 01:01:07 INFO - Using buildbot properties: 01:01:07 INFO - { 01:01:07 INFO - "project": "", 01:01:07 INFO - "product": "firefox", 01:01:07 INFO - "script_repo_revision": "production", 01:01:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:01:07 INFO - "repository": "", 01:01:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:01:07 INFO - "buildid": "20160505231124", 01:01:07 INFO - "pgo_build": "False", 01:01:07 INFO - "basedir": "/builds/slave/test", 01:01:07 INFO - "buildnumber": 0, 01:01:07 INFO - "slavename": "t-yosemite-r7-0131", 01:01:07 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 01:01:07 INFO - "platform": "yosemite_r7", 01:01:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:01:07 INFO - "branch": "fx-team", 01:01:07 INFO - "repo_path": "integration/fx-team", 01:01:07 INFO - "revision": "9e9cb8b89a1091c9b9e582c2865a771f9a2a0936", 01:01:07 INFO - "stage_platform": "macosx64", 01:01:07 INFO - "builduid": "d8b4ba1f94314efea96a886ae453a60c", 01:01:07 INFO - "slavebuilddir": "test" 01:01:07 INFO - } 01:01:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 01:01:07 INFO - Running post-action listener: _resource_record_post_action 01:01:07 INFO - ##### 01:01:07 INFO - ##### Running download-and-extract step. 01:01:07 INFO - ##### 01:01:07 INFO - Running pre-action listener: _resource_record_pre_action 01:01:07 INFO - Running main action method: download_and_extract 01:01:07 INFO - mkdir: /builds/slave/test/build/tests 01:01: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')]} 01:01:07 INFO - https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 01:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 01:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 01:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 01:01:08 INFO - Downloaded 1199 bytes. 01:01:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 01:01:08 INFO - Using the following test package requirements: 01:01:08 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 01:01:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 01:01:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 01:01:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'jsshell-mac.zip'], 01:01:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 01:01:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 01:01:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 01:01:08 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 01:01:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 01:01:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:01:08 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 01:01:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:08 INFO - https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:01:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:01:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:01:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:01:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:01:10 INFO - Downloaded 18145052 bytes. 01:01:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:01:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:01:13 INFO - Return code: 0 01:01:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:01:13 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')]} 01:01:13 INFO - https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:01:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:01:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:01:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:01:15 INFO - Downloaded 18145052 bytes. 01:01:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:01:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:01:18 INFO - Return code: 0 01:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:18 INFO - https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:01:19 INFO - Downloaded 10840152 bytes. 01:01:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:01:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:01:19 INFO - Return code: 0 01:01: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')]} 01:01:19 INFO - https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 01:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 01:01:23 INFO - Downloaded 110404043 bytes. 01:01:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:01:23 INFO - mkdir: /builds/slave/test/properties 01:01:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:01:23 INFO - Writing to file /builds/slave/test/properties/build_url 01:01:23 INFO - Contents: 01:01:23 INFO - build_url:https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:01:24 INFO - Running post-action listener: _resource_record_post_action 01:01:24 INFO - Running post-action listener: set_extra_try_arguments 01:01:24 INFO - ##### 01:01:24 INFO - ##### Running populate-webroot step. 01:01:24 INFO - ##### 01:01:24 INFO - Running pre-action listener: _resource_record_pre_action 01:01:24 INFO - Running main action method: populate_webroot 01:01:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:01:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:01:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:01:24 INFO - '--tppagecycles', 01:01:24 INFO - '7'], 01:01:24 INFO - 'tests': ['tsvgm']}}, 01:01:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:01:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:01:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:01:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:01:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:01:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:01:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['damp', 'tps']}, 01:01:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'tests': ['damp', 'tps']}, 01:01:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['dromaeo_dom']}, 01:01:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:01:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['a11yr', 01:01:24 INFO - 'ts_paint', 01:01:24 INFO - 'tpaint', 01:01:24 INFO - 'sessionrestore', 01:01:24 INFO - 'sessionrestore_no_auto_restore', 01:01:24 INFO - 'tabpaint']}, 01:01:24 INFO - 'other-e10s': {'tests': ['a11yr', 01:01:24 INFO - 'ts_paint', 01:01:24 INFO - 'tpaint', 01:01:24 INFO - 'sessionrestore', 01:01:24 INFO - 'sessionrestore_no_auto_restore', 01:01:24 INFO - 'tabpaint']}, 01:01:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:01:24 INFO - 'ts_paint', 01:01:24 INFO - 'tpaint', 01:01:24 INFO - 'sessionrestore', 01:01:24 INFO - 'sessionrestore_no_auto_restore', 01:01:24 INFO - 'tabpaint']}, 01:01:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:01:24 INFO - 'ts_paint', 01:01:24 INFO - 'tpaint', 01:01:24 INFO - 'sessionrestore', 01:01:24 INFO - 'sessionrestore_no_auto_restore', 01:01:24 INFO - 'tabpaint']}, 01:01:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['a11yr', 01:01:24 INFO - 'ts_paint', 01:01:24 INFO - 'tpaint', 01:01:24 INFO - 'sessionrestore', 01:01:24 INFO - 'sessionrestore_no_auto_restore', 01:01:24 INFO - 'tabpaint']}, 01:01:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['a11yr', 01:01:24 INFO - 'ts_paint', 01:01:24 INFO - 'tpaint', 01:01:24 INFO - 'sessionrestore', 01:01:24 INFO - 'sessionrestore_no_auto_restore', 01:01:24 INFO - 'tabpaint']}, 01:01:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['tsvgx', 01:01:24 INFO - 'tsvgr_opacity', 01:01:24 INFO - 'tart', 01:01:24 INFO - 'tscrollx', 01:01:24 INFO - 'cart']}, 01:01:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:01:24 INFO - 'tsvgr_opacity', 01:01:24 INFO - 'tart', 01:01:24 INFO - 'tscrollx', 01:01:24 INFO - 'cart']}, 01:01:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'talos_options': ['--disable-e10s'], 01:01:24 INFO - 'tests': ['tp5o']}, 01:01:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'tests': ['tp5o']}, 01:01:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'talos_options': ['--disable-e10s', 01:01:24 INFO - '--xperf_path', 01:01:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:01:24 INFO - 'tests': ['tp5n']}, 01:01:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:01:24 INFO - 'talos_options': ['--xperf_path', 01:01:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:01:24 INFO - 'tests': ['tp5n']}}, 01:01:24 INFO - 'talos.zip': {'path': '', 01:01:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:01:24 INFO - Running post-action listener: _resource_record_post_action 01:01:24 INFO - ##### 01:01:24 INFO - ##### Running create-virtualenv step. 01:01:24 INFO - ##### 01:01:24 INFO - Running pre-action listener: _resource_record_pre_action 01:01:24 INFO - Running main action method: create_virtualenv 01:01:24 INFO - Creating virtualenv /builds/slave/test/build/venv 01:01:24 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 01:01:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:01:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:01:24 INFO - Using real prefix '/tools/python27' 01:01:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:01:25 INFO - Installing distribute.............................................................................................................................................................................................done. 01:01:27 INFO - Installing pip.................done. 01:01:28 INFO - Return code: 0 01:01:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:01:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:28 INFO - 'HOME': '/Users/cltbld', 01:01:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:28 INFO - 'LOGNAME': 'cltbld', 01:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:28 INFO - 'MOZ_NO_REMOTE': '1', 01:01:28 INFO - 'NO_EM_RESTART': '1', 01:01:28 INFO - 'PAGER': '/bin/cat', 01:01:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:28 INFO - 'PWD': '/builds/slave/test', 01:01:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:28 INFO - 'SHELL': '/bin/bash', 01:01:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:28 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:28 INFO - 'USER': 'cltbld', 01:01:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:28 INFO - 'XPC_FLAGS': '0x0', 01:01:28 INFO - 'XPC_SERVICE_NAME': '0', 01:01:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:28 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 01:01:28 INFO - Cleaning up... 01:01:28 INFO - Return code: 0 01:01:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:01:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:28 INFO - 'HOME': '/Users/cltbld', 01:01:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:28 INFO - 'LOGNAME': 'cltbld', 01:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:28 INFO - 'MOZ_NO_REMOTE': '1', 01:01:28 INFO - 'NO_EM_RESTART': '1', 01:01:28 INFO - 'PAGER': '/bin/cat', 01:01:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:28 INFO - 'PWD': '/builds/slave/test', 01:01:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:28 INFO - 'SHELL': '/bin/bash', 01:01:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:28 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:28 INFO - 'USER': 'cltbld', 01:01:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:28 INFO - 'XPC_FLAGS': '0x0', 01:01:28 INFO - 'XPC_SERVICE_NAME': '0', 01:01:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:28 INFO - Downloading/unpacking psutil>=0.7.1 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01: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 01:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:01:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:31 INFO - Installing collected packages: psutil 01:01:31 INFO - Running setup.py install for psutil 01:01:31 INFO - building 'psutil._psutil_osx' extension 01:01:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:01:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:01:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:01:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:01:32 INFO - building 'psutil._psutil_posix' extension 01:01:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:01:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:01:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:01:32 INFO - ^ 01:01:32 INFO - 1 warning generated. 01:01:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:01:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:01:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:01:32 INFO - Successfully installed psutil 01:01:32 INFO - Cleaning up... 01:01:32 INFO - Return code: 0 01:01:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:01:32 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')]} 01:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:32 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')]} 01:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:32 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:32 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.0.0'] in /builds/slave/test/build 01:01:32 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.0.0 01:01:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:32 INFO - 'HOME': '/Users/cltbld', 01:01:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:32 INFO - 'LOGNAME': 'cltbld', 01:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:32 INFO - 'MOZ_NO_REMOTE': '1', 01:01:32 INFO - 'NO_EM_RESTART': '1', 01:01:32 INFO - 'PAGER': '/bin/cat', 01:01:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:32 INFO - 'PWD': '/builds/slave/test', 01:01:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:32 INFO - 'SHELL': '/bin/bash', 01:01:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:32 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:32 INFO - 'USER': 'cltbld', 01:01:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:32 INFO - 'XPC_FLAGS': '0x0', 01:01:32 INFO - 'XPC_SERVICE_NAME': '0', 01:01:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:01:35 INFO - Installing collected packages: mozsystemmonitor 01:01:35 INFO - Running setup.py install for mozsystemmonitor 01:01:35 INFO - Successfully installed mozsystemmonitor 01:01:35 INFO - Cleaning up... 01:01:35 INFO - Return code: 0 01:01:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:01:35 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')]} 01:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:35 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')]} 01:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:35 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 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:35 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 01:01:35 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 01:01:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:35 INFO - 'HOME': '/Users/cltbld', 01:01:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:35 INFO - 'LOGNAME': 'cltbld', 01:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:35 INFO - 'MOZ_NO_REMOTE': '1', 01:01:35 INFO - 'NO_EM_RESTART': '1', 01:01:35 INFO - 'PAGER': '/bin/cat', 01:01:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:35 INFO - 'PWD': '/builds/slave/test', 01:01:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:35 INFO - 'SHELL': '/bin/bash', 01:01:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:35 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:35 INFO - 'USER': 'cltbld', 01:01:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:35 INFO - 'XPC_FLAGS': '0x0', 01:01:35 INFO - 'XPC_SERVICE_NAME': '0', 01:01:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:36 INFO - Downloading/unpacking blobuploader==1.2.4 01:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:38 INFO - Downloading blobuploader-1.2.4.tar.gz 01:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:01:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:01:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:39 INFO - Downloading docopt-0.6.1.tar.gz 01:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:01:39 INFO - Installing collected packages: blobuploader, requests, docopt 01:01:39 INFO - Running setup.py install for blobuploader 01:01:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:01:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:01:39 INFO - Running setup.py install for requests 01:01:40 INFO - Running setup.py install for docopt 01:01:40 INFO - Successfully installed blobuploader requests docopt 01:01:40 INFO - Cleaning up... 01:01:40 INFO - Return code: 0 01:01:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:40 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')]} 01:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:40 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')]} 01:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:40 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 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:40 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 01:01:40 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 01:01:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:40 INFO - 'HOME': '/Users/cltbld', 01:01:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:40 INFO - 'LOGNAME': 'cltbld', 01:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:40 INFO - 'MOZ_NO_REMOTE': '1', 01:01:40 INFO - 'NO_EM_RESTART': '1', 01:01:40 INFO - 'PAGER': '/bin/cat', 01:01:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:40 INFO - 'PWD': '/builds/slave/test', 01:01:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:40 INFO - 'SHELL': '/bin/bash', 01:01:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:40 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:40 INFO - 'USER': 'cltbld', 01:01:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:40 INFO - 'XPC_FLAGS': '0x0', 01:01:40 INFO - 'XPC_SERVICE_NAME': '0', 01:01:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:40 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-nkTcwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-mhPQSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-EGRjJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BEOmbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-iQnA2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jTqdF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-EC5C35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wWYI4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-rqSobS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-9390Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:41 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ljbSWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-RaOBOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-zKiJ82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-pHfRYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-vam2W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-bs8kdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:42 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-O3Zj6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:01:42 INFO - Running setup.py install for manifestparser 01:01:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:01:42 INFO - Running setup.py install for mozcrash 01:01:42 INFO - Running setup.py install for mozdebug 01:01:43 INFO - Running setup.py install for mozdevice 01:01:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Running setup.py install for mozfile 01:01:43 INFO - Running setup.py install for mozhttpd 01:01:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Running setup.py install for mozinfo 01:01:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Running setup.py install for mozInstall 01:01:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:01:43 INFO - Running setup.py install for mozleak 01:01:43 INFO - Running setup.py install for mozlog 01:01:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:01:44 INFO - Running setup.py install for moznetwork 01:01:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:01:44 INFO - Running setup.py install for mozprocess 01:01:44 INFO - Running setup.py install for mozprofile 01:01:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:01:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:01:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:01:44 INFO - Running setup.py install for mozrunner 01:01:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:01:44 INFO - Running setup.py install for mozscreenshot 01:01:44 INFO - Running setup.py install for moztest 01:01:45 INFO - Running setup.py install for mozversion 01:01:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:01:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:01:45 INFO - Cleaning up... 01:01:45 INFO - Return code: 0 01:01:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:45 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 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:45 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 01:01:45 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 01:01:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:45 INFO - 'HOME': '/Users/cltbld', 01:01:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:45 INFO - 'LOGNAME': 'cltbld', 01:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:45 INFO - 'MOZ_NO_REMOTE': '1', 01:01:45 INFO - 'NO_EM_RESTART': '1', 01:01:45 INFO - 'PAGER': '/bin/cat', 01:01:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:45 INFO - 'PWD': '/builds/slave/test', 01:01:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:45 INFO - 'SHELL': '/bin/bash', 01:01:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:45 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:45 INFO - 'USER': 'cltbld', 01:01:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:45 INFO - 'XPC_FLAGS': '0x0', 01:01:45 INFO - 'XPC_SERVICE_NAME': '0', 01:01:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:01:45 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ivL5tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:01:45 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)) 01:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:01:45 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-VUtt4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:01:45 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)) 01:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:01:45 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Yzg91O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:01:45 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)) 01:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:01:45 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-1wHMaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:01:45 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)) 01:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:01:45 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_fYXjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-i0TwfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wPV7HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wsAPWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-JUR9TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-GEeOVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ThHSWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TVw8Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-KmoNA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:01:46 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)) 01:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:01:46 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-3uOEQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:01:47 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)) 01:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:47 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wiKMGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:01:47 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)) 01:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:01:47 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-CZWnJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:01:47 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)) 01:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:01:47 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-wFCOpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:01:47 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)) 01:01:47 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)) 01:01:47 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)) 01:01:47 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)) 01:01:47 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)) 01:01:47 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)) 01:01:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:01:47 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 01:01:47 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 01:01:47 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 01:01:47 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 01:01:47 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 01:01:47 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 01:01:49 INFO - Downloading blessings-1.6.tar.gz 01:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:01:49 INFO - Installing collected packages: blessings 01:01:49 INFO - Running setup.py install for blessings 01:01:50 INFO - Successfully installed blessings 01:01:50 INFO - Cleaning up... 01:01:50 INFO - Return code: 0 01:01:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:50 INFO - Reading from file tmpfile_stdout 01:01:50 INFO - Current package versions: 01:01:50 INFO - blessings == 1.6 01:01:50 INFO - blobuploader == 1.2.4 01:01:50 INFO - docopt == 0.6.1 01:01:50 INFO - manifestparser == 1.1 01:01:50 INFO - mozInstall == 1.12 01:01:50 INFO - mozcrash == 0.17 01:01:50 INFO - mozdebug == 0.1 01:01:50 INFO - mozdevice == 0.48 01:01:50 INFO - mozfile == 1.2 01:01:50 INFO - mozhttpd == 0.7 01:01:50 INFO - mozinfo == 0.9 01:01:50 INFO - mozleak == 0.1 01:01:50 INFO - mozlog == 3.1 01:01:50 INFO - moznetwork == 0.27 01:01:50 INFO - mozprocess == 0.22 01:01:50 INFO - mozprofile == 0.28 01:01:50 INFO - mozrunner == 6.11 01:01:50 INFO - mozscreenshot == 0.1 01:01:50 INFO - mozsystemmonitor == 0.0 01:01:50 INFO - moztest == 0.7 01:01:50 INFO - mozversion == 1.4 01:01:50 INFO - psutil == 3.1.1 01:01:50 INFO - requests == 1.2.3 01:01:50 INFO - wsgiref == 0.1.2 01:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:50 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 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:50 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 01:01:50 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 01:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:50 INFO - 'HOME': '/Users/cltbld', 01:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:50 INFO - 'LOGNAME': 'cltbld', 01:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:50 INFO - 'MOZ_NO_REMOTE': '1', 01:01:50 INFO - 'NO_EM_RESTART': '1', 01:01:50 INFO - 'PAGER': '/bin/cat', 01:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:50 INFO - 'PWD': '/builds/slave/test', 01:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:50 INFO - 'SHELL': '/bin/bash', 01:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:50 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:50 INFO - 'USER': 'cltbld', 01:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:50 INFO - 'XPC_FLAGS': '0x0', 01:01:50 INFO - 'XPC_SERVICE_NAME': '0', 01:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 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)) 01:01:50 INFO - Cleaning up... 01:01:50 INFO - Return code: 0 01:01:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:50 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 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:50 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 01:01:50 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 01:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:50 INFO - 'HOME': '/Users/cltbld', 01:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:50 INFO - 'LOGNAME': 'cltbld', 01:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:50 INFO - 'MOZ_NO_REMOTE': '1', 01:01:50 INFO - 'NO_EM_RESTART': '1', 01:01:50 INFO - 'PAGER': '/bin/cat', 01:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:50 INFO - 'PWD': '/builds/slave/test', 01:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:50 INFO - 'SHELL': '/bin/bash', 01:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:50 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:50 INFO - 'USER': 'cltbld', 01:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:50 INFO - 'XPC_FLAGS': '0x0', 01:01:50 INFO - 'XPC_SERVICE_NAME': '0', 01:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:50 INFO - Downloading/unpacking jsonschema 01:01:50 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 01:01:50 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 01:01:50 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 01:01:50 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 01:01:50 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 01:01:50 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 01:01:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:01:53 INFO - Downloading/unpacking functools32 (from jsonschema) 01:01:53 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 01:01:53 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 01:01:53 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 01:01:53 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 01:01:53 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 01:01:53 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 01:01:53 INFO - Downloading functools32-3.2.3-2.tar.gz 01:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:01:53 INFO - warning: no files found matching '*.txt' 01:01:53 INFO - no previously-included directories found matching 'build' 01:01:53 INFO - no previously-included directories found matching 'dist' 01:01:53 INFO - no previously-included directories found matching '.git*' 01:01:53 INFO - Installing collected packages: jsonschema, functools32 01:01:53 INFO - Running setup.py install for functools32 01:01:53 INFO - warning: no files found matching '*.txt' 01:01:53 INFO - no previously-included directories found matching 'build' 01:01:53 INFO - no previously-included directories found matching 'dist' 01:01:53 INFO - no previously-included directories found matching '.git*' 01:01:53 INFO - Successfully installed jsonschema functools32 01:01:53 INFO - Cleaning up... 01:01:54 INFO - Return code: 0 01:01:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:01: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')]} 01:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01: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')]} 01:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:01:54 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 0x10285aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10286a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad99c3e830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:01:54 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 01:01:54 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 01:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:54 INFO - 'HOME': '/Users/cltbld', 01:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:54 INFO - 'LOGNAME': 'cltbld', 01:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:54 INFO - 'MOZ_NO_REMOTE': '1', 01:01:54 INFO - 'NO_EM_RESTART': '1', 01:01:54 INFO - 'PAGER': '/bin/cat', 01:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:54 INFO - 'PWD': '/builds/slave/test', 01:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:54 INFO - 'SHELL': '/bin/bash', 01:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:01:54 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:54 INFO - 'USER': 'cltbld', 01:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:54 INFO - 'XPC_FLAGS': '0x0', 01:01:54 INFO - 'XPC_SERVICE_NAME': '0', 01:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:01:54 INFO - Downloading/unpacking flake8 01:01:54 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 01:01:54 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 01:01:54 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 01:01:54 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 01:01:54 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 01:01:54 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 01:01:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:01:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:01:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:01:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 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 01:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:01:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:01:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:01:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:01:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:01:57 INFO - no previously-included directories found matching 'docs/_build' 01:01:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:01:58 INFO - Running setup.py install for pep8 01:01:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:01:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:01:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:01:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:01:58 INFO - no previously-included directories found matching 'docs/_build' 01:01:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:01:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:01:58 INFO - Cleaning up... 01:01:58 INFO - Return code: 0 01:01:58 INFO - Running post-action listener: _resource_record_post_action 01:01:58 INFO - Running post-action listener: _start_resource_monitoring 01:01:58 INFO - Starting resource monitoring. 01:01:58 INFO - ##### 01:01:58 INFO - ##### Running install step. 01:01:58 INFO - ##### 01:01:58 INFO - Running pre-action listener: _resource_record_pre_action 01:01:58 INFO - Running main action method: install 01:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:01:58 INFO - Reading from file tmpfile_stdout 01:01:58 INFO - Detecting whether we're running mozinstall >=1.0... 01:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:01:58 INFO - Reading from file tmpfile_stdout 01:01:58 INFO - Output received: 01:01:58 INFO - Usage: mozinstall [options] installer 01:01:58 INFO - Options: 01:01:58 INFO - -h, --help show this help message and exit 01:01:58 INFO - -d DEST, --destination=DEST 01:01:58 INFO - Directory to install application into. [default: 01:01:58 INFO - "/builds/slave/test"] 01:01:58 INFO - --app=APP Application being installed. [default: firefox] 01:01:58 INFO - mkdir: /builds/slave/test/build/application 01:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:02:32 INFO - Reading from file tmpfile_stdout 01:02:32 INFO - Output received: 01:02:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:02:32 INFO - Running post-action listener: _resource_record_post_action 01:02:32 INFO - ##### 01:02:32 INFO - ##### Running run-tests step. 01:02:32 INFO - ##### 01:02:32 INFO - Running pre-action listener: _resource_record_pre_action 01:02:32 INFO - Running main action method: run_tests 01:02:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:02:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:02:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:02:32 INFO - 2016-05-06 01:02:32.196 screenresolution[1650:7681] starting screenresolution argv=screenresolution get 01:02:32 INFO - 2016-05-06 01:02:32.198 screenresolution[1650:7681] Display 0: 1600x1200x32@60 01:02:32 INFO - 2016-05-06 01:02:32.204 screenresolution[1651:7683] starting screenresolution argv=screenresolution list 01:02:32 INFO - Available Modes on Display 0 01:02:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:02:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:02:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:02:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:02:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:02:32 INFO - Intel Iris: 01:02:32 INFO - Chipset Model: Intel Iris 01:02:32 INFO - Type: GPU 01:02:32 INFO - Bus: Built-In 01:02:32 INFO - VRAM (Dynamic, Max): 1536 MB 01:02:32 INFO - Vendor: Intel (0x8086) 01:02:32 INFO - Device ID: 0x0a2e 01:02:32 INFO - Revision ID: 0x0009 01:02:32 INFO - Displays: 01:02:32 INFO - Display: 01:02:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:02:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:02:32 INFO - Display Serial Number: 1600x1200 60 01:02:32 INFO - Main Display: Yes 01:02:32 INFO - Mirror: Off 01:02:32 INFO - Online: Yes 01:02:32 INFO - Rotation: Supported 01:02:32 INFO - Return code: 0 01:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:02:32 INFO - Python 2.7.3 01:02:32 INFO - Return code: 0 01:02:32 INFO - grabbing minidump binary from tooltool 01:02:32 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')]} 01:02:32 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026f9e00>, '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 0x102522db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026f4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:02:32 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:02:32 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:02:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:02:32 INFO - Return code: 0 01:02:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:02:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:02:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:02:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:02:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:02:33 INFO - Return code: 0 01:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 01:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --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 01:02:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render', 01:02:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:33 INFO - 'HOME': '/Users/cltbld', 01:02:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:33 INFO - 'LOGNAME': 'cltbld', 01:02:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:02:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:33 INFO - 'MOZ_NO_REMOTE': '1', 01:02:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:02:33 INFO - 'NO_EM_RESTART': '1', 01:02:33 INFO - 'PAGER': '/bin/cat', 01:02:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:33 INFO - 'PWD': '/builds/slave/test', 01:02:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:02:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:33 INFO - 'SHELL': '/bin/bash', 01:02:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners', 01:02:33 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 01:02:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:33 INFO - 'USER': 'cltbld', 01:02:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:33 INFO - 'XPC_FLAGS': '0x0', 01:02:33 INFO - 'XPC_SERVICE_NAME': '0', 01:02:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 01:02:33 INFO - mozversion application_buildid: 20160505231124 01:02:33 INFO - mozversion application_changeset: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 01:02:33 INFO - mozversion application_display_name: Nightly 01:02:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:02:33 INFO - mozversion application_name: Firefox 01:02:33 INFO - mozversion application_remotingname: firefox 01:02:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:02:33 INFO - mozversion application_vendor: Mozilla 01:02:33 INFO - mozversion application_version: 49.0a1 01:02:33 INFO - mozversion platform_buildid: 20160505231124 01:02:33 INFO - mozversion platform_changeset: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 01:02:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:02:33 INFO - mozversion platform_version: 49.0a1 01:02:33 INFO - using testdate: 1462521753 01:02:33 INFO - actual date: 1462521753 01:02:33 INFO - starting webserver on 'localhost:49275' 01:02:33 INFO - SUITE-START | Running 2 tests 01:02:33 INFO - TEST-START | dromaeo_css 01:02:33 INFO - operating with platform_type : mac_ 01:02:33 INFO - Initialising browser for dromaeo_css test... 01:02:33 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpBp35mA/profile http://localhost:49275/getInfo.html) 01:02:36 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 01:02:36 INFO - PROCESS | 1669 | colorDepth:24 01:02:36 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 01:02:36 INFO - PROCESS | 1669 | __metrics 01:02:36 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:02:36 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:02:36 INFO - TEST-INFO | 1669: exit 0 01:02:36 INFO - Browser initialized. 01:02:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:02:36 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpBp35mA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:02:48 INFO - PROCESS | 1671 | RSS: Main: 239095808 01:02:48 INFO - PROCESS | 1671 | 01:03:40 INFO - PROCESS | 1671 | 1462521820135 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] 01:05:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 01:05:51 INFO - PROCESS | 1671 | RSS: Main: 354070528 01:05:51 INFO - PROCESS | 1671 | 01:08:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 01:08:55 INFO - PROCESS | 1671 | RSS: Main: 376725504 01:08:55 INFO - PROCESS | 1671 | 01:11:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 01:11:58 INFO - PROCESS | 1671 | RSS: Main: 372596736 01:11:58 INFO - PROCESS | 1671 | 01:15:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 01:15:01 INFO - PROCESS | 1671 | RSS: Main: 369201152 01:15:01 INFO - PROCESS | 1671 | 01:18:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 01:18:05 INFO - PROCESS | 1671 | RSS: Main: 335335424 01:18:05 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 01:21:08 INFO - PROCESS | 1671 | RSS: Main: 374763520 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | __start_tp_report 01:21:08 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 01:21:08 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 01:21:08 INFO - PROCESS | 1671 | |i|pagename|runs| 01:21:08 INFO - PROCESS | 1671 | |0;dojo.html;3368.0401085690573;3392.966070339296;3398.796072235666;3439.1402149462633;3471.982640086799;5523.309586301712;5560.999020176367;5592.748326325315;5607.074832652607;5626.971865140678;5719.370869204384;5723.51350135239;5822.796202132926;5833.504152147062;5834.037383831663;5077.365329333833;5133.537981581657;5172.534471897528;5198.714070726109;5319.787208511674;5246.606504512177;5298.708571028592;5314.707691076989;5331.57347412208;5338.519533242007;5110.897782044357;5155.149400348938;5158.200478925735;5206;5248.6588371755715;5184.377874655065;5194.662346947474;5206.479352064801;5305.65513241638;5318.97340513295;3718.4980027696456;5038.370203724535;5176.145935920568;5218.843434696965;5230.08473517133;4549.363089167519;5610.24261724666;5696.231008813798;5699.373068962411;5721.856953576153;6138.081874382042;6224.439800417938;6245.6252624842655;6259.123722678829;6264.27960784511;6172.722227499773;6179.87640247197;6227.96886015567;6229.53278504114;6235.469985051276;5729.598928074995;5772.913406298909;5844.056030742531;5929.8814023719715;5939.584229103964;6158;6211.627302361872;6218.347073557211;6250.156228909039;6275.780347687901;6182.443580077815;6183.96908015457;6184.81445556634;6185.8144255672405;6201.286852011986;6115.327313995457;6136.6624835633575;6220.782272620437;6233.563650544509;6253.843653908689;6150.985087460608;6160.199174107337;6188.288346840171;6196.659183744847;6222.844428889314;6193.969030154821;6247.187865577446;6262.248530176317;6281.623102613858;6290.779822706275;4958.975205124024;4962.230854217602;4971.502849715;4972.154733695281;4990.076835785391;4399.186150562092;4462.352958820953;4488.753118578445;4502.954970450253;4544.727316361029;5792.0732682771395;5807.5644326675665;5820.505257053113;5830.7959221427045;5839.737211825478;5218.843434696965;6214.5960512566535;6223.253209614875;6235.314115447297;6236.376362363727;5656.8868622627315;5678.545716342683;5701.059325211377;5742.770289188469;5756.33802112754;5417.4582541746295;5422.48486393792;5429.022775900296;5431.864203394946;5433.320834895638;6313.021481670348;6354.269259035178;6373.203349581302;6382.297947225894;6384.776532821329;6113.537117903944;6131.407250743203;6214.751409943552;6231.594946328474;6252.718627661857;6376.776812811529;6408.00675895237;6417.26201486835;6424.775132870514;6435.131257280207;6077.787277445268;6224.346443623535;6244.375562443719;6257.687115644108;6259.96870015647;5124.333836601218;6168.352323006199;6196.721147548461;6199.783007594712;6214.5960512566535;5844.561657875592;6077.939220607915;6189.721462534287;6205.162303089025;6208.317085120723;5903.2916050072545;5912.083627037816;5957.880842383215;5968.074948383008;5968.343482217039;5856.824295271149;5931.13998470228;5934.080217566284;5937.050071988461;5943.435373639497;4755.334253204624;6076.726547305293;6125.928510892973;6147.323794382703;6176.722047507783;6018.789342372996;6024.457798798129;6030.819075427744;6040.244969378828;6050.304215015153 01:21:08 INFO - PROCESS | 1671 | |1;ext.html;493.72598207994565;501.3632686488158;505.88111793728467;519.4441947116585;540.2868213957576;30439.847800760992;42209.944751381234;43268.783656081716;43413.34879976803;43484.78257608708;43885.56114438855;44211.67364979048;44259.55740442595;44435.55564444363;44554;8697.565121743919;9619.951900240489;9799.628052072716;9812.264080193978;9820.410775353466;8591.957040214791;11636.650900472958;11952.282863028202;11958.701032474171;12107.515699372014;11837.940810295979;11900.880991190064;11910.34493102879;11911.106666999965;11931.821022684666;8717.912820871774;11612.129090318176;11783.94108029463;11828.467718952668;11872.94063529681;11709.824352634718;11803.645890623295;11807.291562506278;11813.468393922294;11817.586384476503;39214.80392598019;39454.40818387726;39568.802155989324;39584.802075989435;39670.40494392587;3306.6528014558367;3376.7467439941856;3443.913902152441;3835.846566137351;3904.629060239273;23798.762012379826;28234.43531129366;28878;29616.70383296161;30067.248318791986;2776.3753155540044;2779.805413621027;2785.5960885671666;2890.638670166229;2894.1028281232675;478645.60677196394;481320;482623;483803.9999999965;486192;35242.11894702653;35941.28117437637;36029.819850901105;37394.87815365543;59848.70075649594;37172.44241336328;37183.44224836629;37381.43927841084;37418.812905935294;37492.43761343582;15376.538703838904;15544.76682849758;15558.22208889551;15574.766378504331;15581.688366232613;11827.763444731228;12011.159218854771;12044.277343359252;12253.816192757116;12965.740685186243;8216.507009579444;8219.342452603778;8262.256396924306;8270.338372930151;8333.958330208432;2905.941881162365;3355.865765369358;3376.5104059911178;3376.848041838123;3411.675890790371;859.5573279760928;924.8843894513186;1035.042148110542;1056.1867362131115;1096.753230523126;23581.646275305884;28169.859150704524;30005.849970750005;30187;31344.843275783474;1083.257968291707;1099.2470157941837;1124.3478782306242;1177.217150594862;1189.7204157023093;15188.772168417483;15213;15260.771088433683;15617.60955976087;15707.4502392418;619015.9049204725;620230.8988455029;622545;625352;626216;50056.749716251186;59891;60448.39551604516;60521.69739151276;60598;1124.3478782306242;1277.7380636969585;1430.2848575712144;1479.5487376350316;1487.8437764034836;28882.711172888;30471.847640761654;30534.625941833114;31132.844335779082;31135.53296700506;50296.74851625718;50431.747841260556;51008.74495627498;51038;51094.74452627713;486973;487406;487583;488017;489417;23413;23893.044278229372;25911.352216194748;26532.734672653027;26782;45699.54300456953;46239.537604623525;46426;46700.7664961673;46738;38140.427893581065;38218.808905955295;38372.23255534818;38875.6112438872;38894.2221155581;37090.44364334591;37256.44115338326;37496.43755343727;38017;38266.426003610526;37254.44118338173;38276.617233828416;38433.03917401975;38464.2307153861;38469;32996.83501582477;33023.24883905719;33837;33908.66091339153;33971.64113435435;24599.016039358226;24649;24713.629295560222;24971.625425618993;25922.740772592788 01:21:08 INFO - PROCESS | 1671 | |2;jquery.html;357.83718408124304;399.94000899865017;400.9759414435136;402.65312529588516;423.8135220502978;14110.788338174936;20413.795862041374;20606.793932060675;21114.366569002934;21126.471838204052;16149.525643130406;17950.910245448787;20162.899185504088;20515.589688206226;20702.48243793906;4876.487968763282;6121.296050954131;6122.693865306717;6163.167972323746;6181.227346581677;5980.611260268069;6012.909806352908;6058.363871793465;6064.241370002694;6086.026235802273;5886.470217680408;6011.75952961881;6047.183630209931;6059.545534084961;6066.969665151668;5870.7945221917025;5941.287045554518;6015.067664511986;6087.634741915499;6096.4817990470865;5262.131748261532;5282.154855223184;5293.232481290192;5294.470552944713;5298.390685071227;25826;26452.86773566139;26469.073582424524;26680.466390672078;26846.73153268462;2104.305579158874;2216.2243214874666;2258.4128126687015;2294.4378627236265;2304.8271379646594;14565.781513277308;14772.187529685863;14835.629109272246;15693.686126277411;15890.126043067627;1738.1048759888668;1754.0791084680645;1789.4273832373647;1826.6803309420798;1869.1588785046783;112128.75742485186;115046.42476787647;115372.99999999916;115686.42156789247;117651.4117429416;11107.166962477846;11425.371604561662;11612.187146899805;11655.88344116565;11716.957649610871;11987.820182697267;12990.285534295705;14114.153150810984;14749.926250368679;14774.26128693561;7552.282533159341;7954.482958607672;8040.437169398203;8849.159329863653;9038.09619038091;8961.731148065568;8971.013188549254;8988.910110898938;9093.454392736458;9141.862872056925;6806.625635589991;6951.296932251529;6962.477814163856;6964.965175174193;6976.407005404496;1619.9433019844248;1914.2056046740447;1923.0961448119363;1942.8931408772653;1967.4687834284664;813.6297984417076;931.4969916245152;994.7612572982432;1004.4475538453821;1039.781645854364;18288.90855545714;20394.592108157754;21430.678539821914;21557.56884862294;21604.13583456644;963.9180669643018;995.3430735714394;1021;1021.3922715983978;1094.9811706958358;9104.8634270486;9463.810723785486;11794.88205117955;11849.229800062969;11857.644270671894;475477.7165598444;562890;580504;601080;605096.872578189;94868;98471.50764246134;117061.82938170509;122815.38592306981;125127;1004.3020101029861;1032.0762917188924;1049.2969710294121;1050.5430137890041;1052.7736536644659;18867.339643112424;19132.23471061142;19226.423207303804;19309.51726206856;19329;30485.695143048284;50135.49864501308;50287;50928.23607645962;52872;73214.63392683002;73758;74040;74155.258447417;75664.86502702573;7641.694332226871;8138.226868447488;8198.959005204935;8237.588120594066;8526.957365213135;10623.946880265548;12493.625191244277;12625.558105466265;13035.608931732064;13084.345782711016;9175.311851611023;11085.889141108486;11436.142289328167;11443.427828608703;11527.88472115268;9470.621175152917;10752.946235268773;10821.080208182393;11012.614558490415;11122.165837562054;5860.150278209721;8113.742369932434;10789;11346;11486.94256528712;8056.959715201387;8172.182781722018;8183.549904755296;8324;8513.021002584783;11222.49498772541;11320.37737924422;11556.942215289206;11638.476268567765;11704.063674906158 01:21:08 INFO - PROCESS | 1671 | |3;mootools.html;1284.9614511564657;1616.1434439746931;1641.8850680452365;1866.4120801947386;1985.741853559037;7704.768856934294;8337.458065225763;8611.56942152893;8617.91382086179;8747.781305467366;8406.663733450654;8631.093735157812;8647.610857511412;8654.956725216365;8661.133886611336;2422.370183752224;2453.3008092693585;2459.102427613917;2459.827812053157;2462.22439931421;2379.274321331993;2435.5737745894485;2438.0491608272787;2444.022391043579;2444.9511009779794;2361.657559653849;2370.8340416170877;2385.642153676945;2395.2814155753204;2395.9760402396014;2381.1903952656007;2400.5918993771015;2410.09621391978;2415.033986405443;2418.044872275459;2275.863448193097;2301.7583153768946;2310.8844557772213;2312.479692069288;2315.81473482121;7671.769846904602;7958.801029974239;8662.826743465095;8746.431481953652;8770.298376129958;4936.4076310842565;5081.466446023188;5085.542301192873;5128.743562821844;5224.582033437354;3463.6709512596262;3519.6480351964856;3601.3697602919383;3609.9278014439565;3613.1328481164596;1030.8247597908298;1045.5974449836867;1046.0689985912543;1054.673051354075;1059.978800423995;9968.651097211636;11305.886941130566;11338.886611133865;11500.654980350602;11522.769544609144;3936.9606303937167;4496.662750293741;4820.8794780130775;4944.208926571731;4951.90096198074;9778.804423911624;9782.461964592016;9790.755231119136;9794.510274486389;9797.16724078447;5410.242566040757;5416.891662166735;5454.509094181542;5479.178123281539;5513.42109078549;4817.27740838877;4939.481354457802;4971.850844474671;5000.374953130859;5006.299118123466;3434.8110853902776;3939.4090886366703;3981;4037.232925744158;4094.5086589609436;1330.5808670269028;1335.9933200333935;1338.6921008168176;1349.0961056092442;1355.4781409157545;923.4736200365727;935.9204467620328;936.3258453913172;941.2187884056217;992.503748125937;5775.537956963432;5861.736221870026;5999.710062336619;6136.6011209271255;6175.96912015437;933.4585940154694;943.4197718821084;943.5801068524578;995.3331268050424;996.9451680157516;3910.491636087347;3990.960090399117;4054.493188351456;4080.7959602019782;4092.856750013735;9921.107100361001;10425.843612345821;10460.68617941463;10555.577776888838;10643.893561064291;10510.684679459628;10552.103071239031;10604.840927386096;10617.256792024638;10626.73433164177;7888.64501097452;8104.39217058723;8114.553699546464;8121.675132994732;8126.065502467292;5709.172170035405;5779.133130030529;5994.460498555151;6031.879362412815;6098.817035488943;9502.334836561375;9535.47554884488;9766.316357854881;9814.75463113428;9821.017898210122;9547.665831696135;9782.853257201004;9826.4104153751;9895.109440150422;9986.300958932805;7374.151972523228;7458.552486850806;7518.097828260644;7520.887186692314;7536.547807131589;7766.883496747666;8011.278984891388;8076.313513351431;8112.513249205066;8114.229148230908;7484;7609.923900760921;7631.69473221065;7743.574103424366;7818.765437036898;7543.283388078124;7582.696692132253;7652.349550288288;7658.846823063396;7757.1079325878245;5662.462066103713;6989.685464154024;7006.474514411338;7053.435725141873;7072.893906591303;5080.847574572768;5108;5145.562627176732;5152.355955505562;5369.838904832861;5067.265246539305;5074.162763144188;5204.739763011758;5231.006108839309;5489.984352894728 01:21:08 INFO - PROCESS | 1671 | |4;prototype.html;314.0562609358876;315.6307120668817;331.2645926044181;333.8848097406397;335.35276915552976;4820.469748327681;4851.563359297663;5338.199270109486;5351.652142610727;5361.839144825652;4367.934480982788;4666.020135771492;4873.5613794758465;5111.795528178868;5120.615953803461;3629.927401451969;3986.3621820508724;4055.844084435929;4060.2946762359734;4097.467329247193;4020.256252593265;4064.2277967186287;4069.267531844267;4096.836126554949;4097.385392191165;3757.962420375802;3767.585565587783;3821.261326096633;4049.7367671101433;4056.1482088761395;3433.4334834752235;3566.4472006838982;3993.6805055595773;4010.9999999999854;4058.3100872851687;3328.270817929275;3465.740069494798;3543.3799085159994;3555.288942211568;3573.2317551726505;4437.644988400953;4487.753173575452;4830.227163653799;4838.782254798507;5058.114829904789;3810.4474851146706;3994.500687414073;4343.1747967886;4621.214393553104;4628;4840.48294886657;4956.3804524434445;5058.241263810458;5321.962217367615;5480.561555075585;3402.3195360927666;3664.3404187246283;3886.9805650971566;3889.9805500972598;3902.9219415611815;4879.975600121977;5319.335083114611;5428.728563571845;5743.684097374601;5779.537636989073;3942.231264903374;3965.4250133731025;3967.8177002649004;3979.263836190314;3994.960050399517;4047.8988025299013;4062.1469491407133;4082.897927551835;4090.877273681794;4092.570280120604;3994.9014021144417;4247.129338485664;4445.488768791631;4581.536869595184;4616.907661846812;4937.481564435754;5472.699001554873;5526.226328314039;5545.889082218333;5592.860178495489;1163.5281369068136;1232.648695121904;1245.6422499475616;1294.346355090692;1332.9733405332033;800.9279164875072;827.4497459189572;827.5696637748338;874;879.6701237036111;4658.930116048262;4885.120678277873;5115.820946266863;5211.973940130351;5217.921731174036;5076.568491678175;5727.5131613812455;5758.712064396764;5772.336181339116;5773.336066352424;4830.009847981156;5184.870378240575;5189.6107791915;5203.843884683465;5221.869453263623;2785.4123149804823;2848.245215018022;2872.928176795555;2885.783566232541;2886.4990205093236;4802.759862006886;5269.762860671279;5748.827535173868;5808.854778630483;5832.300123985149;4732.763361831895;5253.789848406097;5649.350324712628;5673.858153546194;5936.7031648417405;4933.55597996182;5069;5611.803586874522;5811.854703632443;5923.555733320019;4928.975355123202;5731.484166425042;5764.365919748908;5764.771727832427;5784.392638772868;5307.336582927134;5723.484886360247;5725.971370143123;5739.253896993531;5745.597808153389;5955.821325360246;6008.489278411209;6013.699315034319;6032.638041717511;6038.909416358671;3435.862565497352;3830.5211848518934;3834.1181528248103;3857.209272099269;3917.7061720371657;4816.446108697544;4880.658353915192;5285.365756109291;5699.6865172414255;5737.770489180386;4990.700557966534;5005.899882002413;5429.5656347492895;5530.391656917816;5558.610897237155;4650.697704649187;5524.392316845064;5525.977694126599;5539.8892022160135;5575.219469274224;5000.699958002531;5210.062188806051;5244.632875698817;5247.906632826402;5427.83716488506;4829.95170048295;5167.560757335668;5368.57051435892;5584.246126772996;5587.3015873015875;5055.797768089235;5111.801925172212;5229.424763275961;5499.395066542597;5508.256385387921 01:21:08 INFO - PROCESS | 1671 | |5;yui.html;673.256052062471;726.5459088069956;742.1962442482278;747.1295940229633;803.9758807235785;15146.545603631881;15670;15688.450904218354;15693.764593531092;15734.055956642609;14561.635959101028;14601.707965840676;14623.122612643248;14626.561203163923;14626.707465850677;750.7935317787598;770.2297702297702;915.0940568836837;938.5072836760704;946.564580293066;920.8710780490736;923.1599244687336;924.1959495239151;925.0287198441644;925.3938670171049;983.0759086458706;1000.824855650262;1001.694483182629;1004.1665417703289;1008.3445760255855;788.2157253532714;809.5102463009853;809.5426084262373;885.3315746611331;992.270681049428;607.159084667734;721.1706537481886;737.2553720742036;737.9704811807521;739.7632757517597;14562.417503299856;14582.708345833023;14587.70824583513;14616.634584135376;14628;12067.396630168456;12316.630501084981;12343.75312493754;12572.371381430983;12752.489900403973;10902.454877256185;10917.454127293604;11159.051480624075;11504.884951150549;11647.893450122225;4073.531543872463;4084.979575102135;4085.9387109193385;4209.98960249541;4223.049813791903;64129.67935160341;81157;82413.76379354254;83172.58413707954;83258.58370708168;7561.621918904033;9590.040995900494;9797.755056123511;9869.851952220723;10206.642767503101;21741.78258217429;21765.564688706454;21774.12903483843;21798.673019904712;21815.890920545295;7490.288422599844;7555.320021198118;7558.357539609195;7719.228077192348;7924.207579242145;4042.2723909696538;4093.263212621697;4096.160287141129;4106.486689163855;4108.794560271975;3520.331137083946;3594.9281014379567;3609.097725568608;3625.7099432045375;3626.3472574936764;634.8095571328583;662.8309781005813;665.0622622102812;673.050998092687;675.1864003875319;554.6727430815838;556.3907521264209;566.4929887750441;583.3670467542679;585.0288521055113;7787;7902.446828721934;7909.485883417559;8074;8248.298894594027;551.9199716041152;563.3859093588009;568.4315684315684;568.795233715862;574.4370516893384;3751.381022131318;3754.6808521276;3804.5814960354337;3895.1820117775583;4021.276170289376;83907.16092839115;86845.13154868496;88242.55878720565;88511.11488885157;88714.55642721745;76763.23236767673;77661.61169194231;77823;78425;81050;66191.66904165449;66904;67054;67236;67598.93008024417;6406.967965160145;7076.1508618964;7495.512791668524;7581.166071732216;7581.50720203185;42633.147337053706;43138.78430607953;43366.915827104574;44569.55430445654;45800.770996144805;58950.705246473495;59820.70089649698;59953.8009239804;60229.39770602238;61355.386446134966;8051.315638170821;9909.851352229867;10018.599256029676;10245.590176392861;10516.58039590054;10353;10444.373337599769;10564.15486761042;10658.094062004817;10922.017018468376;9826.55780489894;9863.852042219516;9955.701328960144;9979.800403992025;10118.342307749972;9845;9980.950095249767;10008.749781255527;10031.173402673772;10357.119644830274;9785.657501987396;9839.262055345735;9880.901190987997;9976.750581235527;10469.057784799405;8479.40644154928;8581.184787445183;8855.690050848189;8860.069692682175;8962.462252264884;6952;8375.832483350177;8486.957565212135;8596.570171491525;8804.119588041145 01:21:08 INFO - PROCESS | 1671 | __end_tp_report 01:21:08 INFO - PROCESS | 1671 | __start_cc_report 01:21:08 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1634 01:21:08 INFO - PROCESS | 1671 | __end_cc_report 01:21:08 INFO - PROCESS | 1671 | __startTimestamp1462522868717__endTimestamp 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | ------- Summary: start ------- 01:21:08 INFO - PROCESS | 1671 | Number of tests: 6 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5720.63 Median:5934.08 stddev:656.74 (11.1%) stddev-sans-first:632.29 01:21:08 INFO - PROCESS | 1671 | Values: 3368.0 3393.0 3398.8 3439.1 3472.0 5523.3 5561.0 5592.7 5607.1 5627.0 5719.4 5723.5 5822.8 5833.5 5834.0 5077.4 5133.5 5172.5 5198.7 5319.8 5246.6 5298.7 5314.7 5331.6 5338.5 5110.9 5155.1 5158.2 5206.0 5248.7 5184.4 5194.7 5206.5 5305.7 5319.0 3718.5 5038.4 5176.1 5218.8 5230.1 4549.4 5610.2 5696.2 5699.4 5721.9 6138.1 6224.4 6245.6 6259.1 6264.3 6172.7 6179.9 6228.0 6229.5 6235.5 5729.6 5772.9 5844.1 5929.9 5939.6 6158.0 6211.6 6218.3 6250.2 6275.8 6182.4 6184.0 6184.8 6185.8 6201.3 6115.3 6136.7 6220.8 6233.6 6253.8 6151.0 6160.2 6188.3 6196.7 6222.8 6194.0 6247.2 6262.2 6281.6 6290.8 4959.0 4962.2 4971.5 4972.2 4990.1 4399.2 4462.4 4488.8 4503.0 4544.7 5792.1 5807.6 5820.5 5830.8 5839.7 5218.8 6214.6 6223.3 6235.3 6236.4 5656.9 5678.5 5701.1 5742.8 5756.3 5417.5 5422.5 5429.0 5431.9 5433.3 6313.0 6354.3 6373.2 6382.3 6384.8 6113.5 6131.4 6214.8 6231.6 6252.7 6376.8 6408.0 6417.3 6424.8 6435.1 6077.8 6224.3 6244.4 6257.7 6260.0 5124.3 6168.4 6196.7 6199.8 6214.6 5844.6 6077.9 6189.7 6205.2 6208.3 5903.3 5912.1 5957.9 5968.1 5968.3 5856.8 5931.1 5934.1 5937.1 5943.4 4755.3 6076.7 6125.9 6147.3 6176.7 6018.8 6024.5 6030.8 6040.2 6050.3 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:65476.10 Median:35591.70 stddev:142933.77 (401.6%) stddev-sans-first:143251.47 01:21:08 INFO - PROCESS | 1671 | Values: 493.7 501.4 505.9 519.4 540.3 30439.8 42209.9 43268.8 43413.3 43484.8 43885.6 44211.7 44259.6 44435.6 44554.0 8697.6 9620.0 9799.6 9812.3 9820.4 8592.0 11636.7 11952.3 11958.7 12107.5 11837.9 11900.9 11910.3 11911.1 11931.8 8717.9 11612.1 11783.9 11828.5 11872.9 11709.8 11803.6 11807.3 11813.5 11817.6 39214.8 39454.4 39568.8 39584.8 39670.4 3306.7 3376.7 3443.9 3835.8 3904.6 23798.8 28234.4 28878.0 29616.7 30067.2 2776.4 2779.8 2785.6 2890.6 2894.1 478645.6 481320.0 482623.0 483804.0 486192.0 35242.1 35941.3 36029.8 37394.9 59848.7 37172.4 37183.4 37381.4 37418.8 37492.4 15376.5 15544.8 15558.2 15574.8 15581.7 11827.8 12011.2 12044.3 12253.8 12965.7 8216.5 8219.3 8262.3 8270.3 8334.0 2905.9 3355.9 3376.5 3376.8 3411.7 859.6 924.9 1035.0 1056.2 1096.8 23581.6 28169.9 30005.8 30187.0 31344.8 1083.3 1099.2 1124.3 1177.2 1189.7 15188.8 15213.0 15260.8 15617.6 15707.5 619015.9 620230.9 622545.0 625352.0 626216.0 50056.7 59891.0 60448.4 60521.7 60598.0 1124.3 1277.7 1430.3 1479.5 1487.8 28882.7 30471.8 30534.6 31132.8 31135.5 50296.7 50431.7 51008.7 51038.0 51094.7 486973.0 487406.0 487583.0 488017.0 489417.0 23413.0 23893.0 25911.4 26532.7 26782.0 45699.5 46239.5 46426.0 46700.8 46738.0 38140.4 38218.8 38372.2 38875.6 38894.2 37090.4 37256.4 37496.4 38017.0 38266.4 37254.4 38276.6 38433.0 38464.2 38469.0 32996.8 33023.2 33837.0 33908.7 33971.6 24599.0 24649.0 24713.6 24971.6 25922.7 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:33421.14 Median:2299.63 stddev:94393.78 (4104.7%) stddev-sans-first:94625.93 01:21:08 INFO - PROCESS | 1671 | Values: 357.8 399.9 401.0 402.7 423.8 14110.8 20413.8 20606.8 21114.4 21126.5 16149.5 17950.9 20162.9 20515.6 20702.5 4876.5 6121.3 6122.7 6163.2 6181.2 5980.6 6012.9 6058.4 6064.2 6086.0 5886.5 6011.8 6047.2 6059.5 6067.0 5870.8 5941.3 6015.1 6087.6 6096.5 5262.1 5282.2 5293.2 5294.5 5298.4 25826.0 26452.9 26469.1 26680.5 26846.7 2104.3 2216.2 2258.4 2294.4 2304.8 14565.8 14772.2 14835.6 15693.7 15890.1 1738.1 1754.1 1789.4 1826.7 1869.2 112128.8 115046.4 115373.0 115686.4 117651.4 11107.2 11425.4 11612.2 11655.9 11717.0 11987.8 12990.3 14114.2 14749.9 14774.3 7552.3 7954.5 8040.4 8849.2 9038.1 8961.7 8971.0 8988.9 9093.5 9141.9 6806.6 6951.3 6962.5 6965.0 6976.4 1619.9 1914.2 1923.1 1942.9 1967.5 813.6 931.5 994.8 1004.4 1039.8 18288.9 20394.6 21430.7 21557.6 21604.1 963.9 995.3 1021.0 1021.4 1095.0 9104.9 9463.8 11794.9 11849.2 11857.6 475477.7 562890.0 580504.0 601080.0 605096.9 94868.0 98471.5 117061.8 122815.4 125127.0 1004.3 1032.1 1049.3 1050.5 1052.8 18867.3 19132.2 19226.4 19309.5 19329.0 30485.7 50135.5 50287.0 50928.2 52872.0 73214.6 73758.0 74040.0 74155.3 75664.9 7641.7 8138.2 8199.0 8237.6 8527.0 10623.9 12493.6 12625.6 13035.6 13084.3 9175.3 11085.9 11436.1 11443.4 11527.9 9470.6 10752.9 10821.1 11012.6 11122.2 5860.2 8113.7 10789.0 11346.0 11486.9 8057.0 8172.2 8183.5 8324.0 8513.0 11222.5 11320.4 11556.9 11638.5 11704.1 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5673.24 Median:5300.42 stddev:3090.80 (58.3%) stddev-sans-first:3081.87 01:21:08 INFO - PROCESS | 1671 | Values: 1285.0 1616.1 1641.9 1866.4 1985.7 7704.8 8337.5 8611.6 8617.9 8747.8 8406.7 8631.1 8647.6 8655.0 8661.1 2422.4 2453.3 2459.1 2459.8 2462.2 2379.3 2435.6 2438.0 2444.0 2445.0 2361.7 2370.8 2385.6 2395.3 2396.0 2381.2 2400.6 2410.1 2415.0 2418.0 2275.9 2301.8 2310.9 2312.5 2315.8 7671.8 7958.8 8662.8 8746.4 8770.3 4936.4 5081.5 5085.5 5128.7 5224.6 3463.7 3519.6 3601.4 3609.9 3613.1 1030.8 1045.6 1046.1 1054.7 1060.0 9968.7 11305.9 11338.9 11500.7 11522.8 3937.0 4496.7 4820.9 4944.2 4951.9 9778.8 9782.5 9790.8 9794.5 9797.2 5410.2 5416.9 5454.5 5479.2 5513.4 4817.3 4939.5 4971.9 5000.4 5006.3 3434.8 3939.4 3981.0 4037.2 4094.5 1330.6 1336.0 1338.7 1349.1 1355.5 923.5 935.9 936.3 941.2 992.5 5775.5 5861.7 5999.7 6136.6 6176.0 933.5 943.4 943.6 995.3 996.9 3910.5 3991.0 4054.5 4080.8 4092.9 9921.1 10425.8 10460.7 10555.6 10643.9 10510.7 10552.1 10604.8 10617.3 10626.7 7888.6 8104.4 8114.6 8121.7 8126.1 5709.2 5779.1 5994.5 6031.9 6098.8 9502.3 9535.5 9766.3 9814.8 9821.0 9547.7 9782.9 9826.4 9895.1 9986.3 7374.2 7458.6 7518.1 7520.9 7536.5 7766.9 8011.3 8076.3 8112.5 8114.2 7484.0 7609.9 7631.7 7743.6 7818.8 7543.3 7582.7 7652.3 7658.8 7757.1 5662.5 6989.7 7006.5 7053.4 7072.9 5080.8 5108.0 5145.6 5152.4 5369.8 5067.3 5074.2 5204.7 5231.0 5490.0 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4461.42 Median:4931.27 stddev:1357.66 (27.5%) stddev-sans-first:1325.30 01:21:08 INFO - PROCESS | 1671 | Values: 314.1 315.6 331.3 333.9 335.4 4820.5 4851.6 5338.2 5351.7 5361.8 4367.9 4666.0 4873.6 5111.8 5120.6 3629.9 3986.4 4055.8 4060.3 4097.5 4020.3 4064.2 4069.3 4096.8 4097.4 3758.0 3767.6 3821.3 4049.7 4056.1 3433.4 3566.4 3993.7 4011.0 4058.3 3328.3 3465.7 3543.4 3555.3 3573.2 4437.6 4487.8 4830.2 4838.8 5058.1 3810.4 3994.5 4343.2 4621.2 4628.0 4840.5 4956.4 5058.2 5322.0 5480.6 3402.3 3664.3 3887.0 3890.0 3902.9 4880.0 5319.3 5428.7 5743.7 5779.5 3942.2 3965.4 3967.8 3979.3 3995.0 4047.9 4062.1 4082.9 4090.9 4092.6 3994.9 4247.1 4445.5 4581.5 4616.9 4937.5 5472.7 5526.2 5545.9 5592.9 1163.5 1232.6 1245.6 1294.3 1333.0 800.9 827.4 827.6 874.0 879.7 4658.9 4885.1 5115.8 5212.0 5217.9 5076.6 5727.5 5758.7 5772.3 5773.3 4830.0 5184.9 5189.6 5203.8 5221.9 2785.4 2848.2 2872.9 2885.8 2886.5 4802.8 5269.8 5748.8 5808.9 5832.3 4732.8 5253.8 5649.4 5673.9 5936.7 4933.6 5069.0 5611.8 5811.9 5923.6 4929.0 5731.5 5764.4 5764.8 5784.4 5307.3 5723.5 5726.0 5739.3 5745.6 5955.8 6008.5 6013.7 6032.6 6038.9 3435.9 3830.5 3834.1 3857.2 3917.7 4816.4 4880.7 5285.4 5699.7 5737.8 4990.7 5005.9 5429.6 5530.4 5558.6 4650.7 5524.4 5526.0 5539.9 5575.2 5000.7 5210.1 5244.6 5247.9 5427.8 4830.0 5167.6 5368.6 5584.2 5587.3 5055.8 5111.8 5229.4 5499.4 5508.3 01:21:08 INFO - PROCESS | 1671 | 01:21:08 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:17436.52 Median:35268.32 stddev:24512.58 (69.5%) stddev-sans-first:24549.02 01:21:08 INFO - PROCESS | 1671 | Values: 673.3 726.5 742.2 747.1 804.0 15146.5 15670.0 15688.5 15693.8 15734.1 14561.6 14601.7 14623.1 14626.6 14626.7 750.8 770.2 915.1 938.5 946.6 920.9 923.2 924.2 925.0 925.4 983.1 1000.8 1001.7 1004.2 1008.3 788.2 809.5 809.5 885.3 992.3 607.2 721.2 737.3 738.0 739.8 14562.4 14582.7 14587.7 14616.6 14628.0 12067.4 12316.6 12343.8 12572.4 12752.5 10902.5 10917.5 11159.1 11504.9 11647.9 4073.5 4085.0 4085.9 4210.0 4223.0 64129.7 81157.0 82413.8 83172.6 83258.6 7561.6 9590.0 9797.8 9869.9 10206.6 21741.8 21765.6 21774.1 21798.7 21815.9 7490.3 7555.3 7558.4 7719.2 7924.2 4042.3 4093.3 4096.2 4106.5 4108.8 3520.3 3594.9 3609.1 3625.7 3626.3 634.8 662.8 665.1 673.1 675.2 554.7 556.4 566.5 583.4 585.0 7787.0 7902.4 7909.5 8074.0 8248.3 551.9 563.4 568.4 568.8 574.4 3751.4 3754.7 3804.6 3895.2 4021.3 83907.2 86845.1 88242.6 88511.1 88714.6 76763.2 77661.6 77823.0 78425.0 81050.0 66191.7 66904.0 67054.0 67236.0 67598.9 6407.0 7076.2 7495.5 7581.2 7581.5 42633.1 43138.8 43366.9 44569.6 45800.8 58950.7 59820.7 59953.8 60229.4 61355.4 8051.3 9909.9 10018.6 10245.6 10516.6 10353.0 10444.4 10564.2 10658.1 10922.0 9826.6 9863.9 9955.7 9979.8 10118.3 9845.0 9981.0 10008.7 10031.2 10357.1 9785.7 9839.3 9880.9 9976.8 10469.1 8479.4 8581.2 8855.7 8860.1 8962.5 6952.0 8375.8 8487.0 8596.6 8804.1 01:21:08 INFO - PROCESS | 1671 | -------- Summary: end -------- 01:21:08 INFO - PROCESS | 1671 | 01:21:09 INFO - TEST-INFO | 1671: exit 0 01:21:09 INFO - TEST-OK | dromaeo_css | took 1115437ms 01:21:09 INFO - TEST-START | kraken 01:21:09 INFO - operating with platform_type : mac_ 01:21:09 INFO - Initialising browser for kraken test... 01:21:09 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpyqQouY/profile http://localhost:49275/getInfo.html) 01:21:11 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 01:21:11 INFO - PROCESS | 1681 | colorDepth:24 01:21:11 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 01:21:11 INFO - PROCESS | 1681 | __metrics 01:21:11 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:21:11 ERROR - PROCESS | 1681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:21:12 INFO - TEST-INFO | 1681: exit 0 01:21:12 INFO - Browser initialized. 01:21:12 INFO - Running cycle 1/1 for kraken test... 01:21:12 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpyqQouY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:21:24 INFO - PROCESS | 1683 | RSS: Main: 239280128 01:21:24 INFO - PROCESS | 1683 | 01:21:26 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 01:21:27 INFO - PROCESS | 1683 | RSS: Main: 286556160 01:21:27 INFO - PROCESS | 1683 | 01:21:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 01:21:30 INFO - PROCESS | 1683 | RSS: Main: 295268352 01:21:30 INFO - PROCESS | 1683 | 01:21:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 01:21:34 INFO - PROCESS | 1683 | RSS: Main: 385859584 01:21:34 INFO - PROCESS | 1683 | 01:21:36 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 01:21:37 INFO - PROCESS | 1683 | RSS: Main: 285474816 01:21:37 INFO - PROCESS | 1683 | 01:21:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:21:40 INFO - PROCESS | 1683 | RSS: Main: 289239040 01:21:40 INFO - PROCESS | 1683 | 01:21:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 01:21:43 INFO - PROCESS | 1683 | RSS: Main: 326213632 01:21:43 INFO - PROCESS | 1683 | 01:21:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 01:21:47 INFO - PROCESS | 1683 | RSS: Main: 328036352 01:21:47 INFO - PROCESS | 1683 | 01:21:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 01:21:50 INFO - PROCESS | 1683 | RSS: Main: 326844416 01:21:50 INFO - PROCESS | 1683 | 01:21:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:21:52 INFO - PROCESS | 1683 | RSS: Main: 314474496 01:21:52 INFO - PROCESS | 1683 | 01:21:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:21:55 INFO - PROCESS | 1683 | RSS: Main: 321126400 01:21:55 INFO - PROCESS | 1683 | 01:21:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:21:58 INFO - PROCESS | 1683 | RSS: Main: 322805760 01:21:58 INFO - PROCESS | 1683 | 01:22:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:22:01 INFO - PROCESS | 1683 | RSS: Main: 327827456 01:22:01 INFO - PROCESS | 1683 | 01:22:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:22:05 INFO - PROCESS | 1683 | RSS: Main: 325550080 01:22:05 INFO - PROCESS | 1683 | 01:22:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 01:22:07 INFO - PROCESS | 1683 | RSS: Main: 371920896 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | __start_tp_report 01:22:07 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 01:22:07 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 01:22:07 INFO - PROCESS | 1683 | |i|pagename|runs| 01:22:07 INFO - PROCESS | 1683 | |0;ai-astar;113;105;111;113;111;111;111;112;111;110 01:22:07 INFO - PROCESS | 1683 | |1;audio-beat-detection;155;116;154;165;118;138;136;116;166;115 01:22:07 INFO - PROCESS | 1683 | |2;audio-dft;186;186;186;183;184;188;185;183;188;185 01:22:07 INFO - PROCESS | 1683 | |3;audio-fft;78;73;58;107;56;61;57;58;114;55 01:22:07 INFO - PROCESS | 1683 | |4;audio-oscillator;92;98;101;80;81;77;103;81;80;101 01:22:07 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;86;84;86;84;86;83;87;84;85;84 01:22:07 INFO - PROCESS | 1683 | |6;imaging-darkroom;92;92;93;93;96;94;92;93;105;149 01:22:07 INFO - PROCESS | 1683 | |7;imaging-desaturate;84;86;84;86;84;85;84;86;84;83 01:22:07 INFO - PROCESS | 1683 | |8;json-parse-financial;60;60;58;57;57;58;59;76;60;58 01:22:07 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;65;71;71;80;70;70;68;69;68;71 01:22:07 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;85;85;86;85;82;85;71;85;91;107 01:22:07 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;140;137;142;136;135;140;147;153;169;160 01:22:07 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;212;226;167;168;167;167;170;167;168;165 01:22:07 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;68;67;66;66;66;65;66;65;66 01:22:07 INFO - PROCESS | 1683 | __end_tp_report 01:22:07 INFO - PROCESS | 1683 | __start_cc_report 01:22:07 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,2009 01:22:07 INFO - PROCESS | 1683 | __end_cc_report 01:22:07 INFO - PROCESS | 1683 | __startTimestamp1462522927158__endTimestamp 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | ------- Summary: start ------- 01:22:07 INFO - PROCESS | 1683 | Number of tests: 14 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.25 (2.0%) stddev-sans-first:2.24 01:22:07 INFO - PROCESS | 1683 | Values: 113.0 105.0 111.0 113.0 111.0 111.0 111.0 112.0 111.0 110.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:146.00 stddev:20.97 (14.4%) stddev-sans-first:21.31 01:22:07 INFO - PROCESS | 1683 | Values: 155.0 116.0 154.0 165.0 118.0 138.0 136.0 116.0 166.0 115.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.00 stddev:1.78 (1.0%) stddev-sans-first:1.87 01:22:07 INFO - PROCESS | 1683 | Values: 186.0 186.0 186.0 183.0 184.0 188.0 185.0 183.0 188.0 185.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:71.70 Median:58.00 stddev:21.88 (37.7%) stddev-sans-first:23.09 01:22:07 INFO - PROCESS | 1683 | Values: 78.0 73.0 58.0 107.0 56.0 61.0 57.0 58.0 114.0 55.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:80.50 stddev:10.57 (13.1%) stddev-sans-first:11.17 01:22:07 INFO - PROCESS | 1683 | Values: 92.0 98.0 101.0 80.0 81.0 77.0 103.0 81.0 80.0 101.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.30 01:22:07 INFO - PROCESS | 1683 | Values: 86.0 84.0 86.0 84.0 86.0 83.0 87.0 84.0 85.0 84.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:93.00 stddev:17.69 (19.0%) stddev-sans-first:18.53 01:22:07 INFO - PROCESS | 1683 | Values: 92.0 92.0 93.0 93.0 96.0 94.0 92.0 93.0 105.0 149.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.07 (1.3%) stddev-sans-first:1.12 01:22:07 INFO - PROCESS | 1683 | Values: 84.0 86.0 84.0 86.0 84.0 85.0 84.0 86.0 84.0 83.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.50 stddev:5.64 (9.5%) stddev-sans-first:5.98 01:22:07 INFO - PROCESS | 1683 | Values: 60.0 60.0 58.0 57.0 57.0 58.0 59.0 76.0 60.0 58.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:3.89 (5.5%) stddev-sans-first:3.62 01:22:07 INFO - PROCESS | 1683 | Values: 65.0 71.0 71.0 80.0 70.0 70.0 68.0 69.0 68.0 71.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:8.89 (10.5%) stddev-sans-first:9.42 01:22:07 INFO - PROCESS | 1683 | Values: 85.0 85.0 86.0 85.0 82.0 85.0 71.0 85.0 91.0 107.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:144.50 stddev:11.38 (7.9%) stddev-sans-first:11.86 01:22:07 INFO - PROCESS | 1683 | Values: 140.0 137.0 142.0 136.0 135.0 140.0 147.0 153.0 169.0 160.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:168.00 stddev:22.05 (13.1%) stddev-sans-first:19.59 01:22:07 INFO - PROCESS | 1683 | Values: 212.0 226.0 167.0 168.0 167.0 167.0 170.0 167.0 168.0 165.0 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 01:22:07 INFO - PROCESS | 1683 | Values: 67.0 68.0 67.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 01:22:07 INFO - PROCESS | 1683 | -------- Summary: end -------- 01:22:07 INFO - PROCESS | 1683 | 01:22:07 INFO - TEST-INFO | 1683: exit 0 01:22:07 INFO - TEST-OK | kraken | took 58669ms 01:22:07 INFO - SUITE-END | took 1174s 01:22:08 INFO - Completed test suite (00:19:34) 01:22:08 INFO - javascript benchmark 01:22:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.0401085690573, 3392.966070339296, 3398.796072235666, 3439.1402149462633, 3471.982640086799, 5523.309586301712, 5560.999020176367, 5592.748326325315, 5607.074832652607, 5626.971865140678, 5719.370869204384, 5723.51350135239, 5822.796202132926, 5833.504152147062, 5834.037383831663, 5077.365329333833, 5133.537981581657, 5172.534471897528, 5198.714070726109, 5319.787208511674, 5246.606504512177, 5298.708571028592, 5314.707691076989, 5331.57347412208, 5338.519533242007, 5110.897782044357, 5155.149400348938, 5158.200478925735, 5206.0, 5248.6588371755715, 5184.377874655065, 5194.662346947474, 5206.479352064801, 5305.65513241638, 5318.97340513295, 3718.4980027696456, 5038.370203724535, 5176.145935920568, 5218.843434696965, 5230.08473517133, 4549.363089167519, 5610.24261724666, 5696.231008813798, 5699.373068962411, 5721.856953576153, 6138.081874382042, 6224.439800417938, 6245.6252624842655, 6259.123722678829, 6264.27960784511, 6172.722227499773, 6179.87640247197, 6227.96886015567, 6229.53278504114, 6235.469985051276, 5729.598928074995, 5772.913406298909, 5844.056030742531, 5929.8814023719715, 5939.584229103964, 6158.0, 6211.627302361872, 6218.347073557211, 6250.156228909039, 6275.780347687901, 6182.443580077815, 6183.96908015457, 6184.81445556634, 6185.8144255672405, 6201.286852011986, 6115.327313995457, 6136.6624835633575, 6220.782272620437, 6233.563650544509, 6253.843653908689, 6150.985087460608, 6160.199174107337, 6188.288346840171, 6196.659183744847, 6222.844428889314, 6193.969030154821, 6247.187865577446, 6262.248530176317, 6281.623102613858, 6290.779822706275, 4958.975205124024, 4962.230854217602, 4971.502849715, 4972.154733695281, 4990.076835785391, 4399.186150562092, 4462.352958820953, 4488.753118578445, 4502.954970450253, 4544.727316361029, 5792.0732682771395, 5807.5644326675665, 5820.505257053113, 5830.7959221427045, 5839.737211825478, 5218.843434696965, 6214.5960512566535, 6223.253209614875, 6235.314115447297, 6236.376362363727, 5656.8868622627315, 5678.545716342683, 5701.059325211377, 5742.770289188469, 5756.33802112754, 5417.4582541746295, 5422.48486393792, 5429.022775900296, 5431.864203394946, 5433.320834895638, 6313.021481670348, 6354.269259035178, 6373.203349581302, 6382.297947225894, 6384.776532821329, 6113.537117903944, 6131.407250743203, 6214.751409943552, 6231.594946328474, 6252.718627661857, 6376.776812811529, 6408.00675895237, 6417.26201486835, 6424.775132870514, 6435.131257280207, 6077.787277445268, 6224.346443623535, 6244.375562443719, 6257.687115644108, 6259.96870015647, 5124.333836601218, 6168.352323006199, 6196.721147548461, 6199.783007594712, 6214.5960512566535, 5844.561657875592, 6077.939220607915, 6189.721462534287, 6205.162303089025, 6208.317085120723, 5903.2916050072545, 5912.083627037816, 5957.880842383215, 5968.074948383008, 5968.343482217039, 5856.824295271149, 5931.13998470228, 5934.080217566284, 5937.050071988461, 5943.435373639497, 4755.334253204624, 6076.726547305293, 6125.928510892973, 6147.323794382703, 6176.722047507783, 6018.789342372996, 6024.457798798129, 6030.819075427744, 6040.244969378828, 6050.304215015153], "value": 5680.451373757026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.72598207994565, 501.3632686488158, 505.88111793728467, 519.4441947116585, 540.2868213957576, 30439.847800760992, 42209.944751381234, 43268.783656081716, 43413.34879976803, 43484.78257608708, 43885.56114438855, 44211.67364979048, 44259.55740442595, 44435.55564444363, 44554.0, 8697.565121743919, 9619.951900240489, 9799.628052072716, 9812.264080193978, 9820.410775353466, 8591.957040214791, 11636.650900472958, 11952.282863028202, 11958.701032474171, 12107.515699372014, 11837.940810295979, 11900.880991190064, 11910.34493102879, 11911.106666999965, 11931.821022684666, 8717.912820871774, 11612.129090318176, 11783.94108029463, 11828.467718952668, 11872.94063529681, 11709.824352634718, 11803.645890623295, 11807.291562506278, 11813.468393922294, 11817.586384476503, 39214.80392598019, 39454.40818387726, 39568.802155989324, 39584.802075989435, 39670.40494392587, 3306.6528014558367, 3376.7467439941856, 3443.913902152441, 3835.846566137351, 3904.629060239273, 23798.762012379826, 28234.43531129366, 28878.0, 29616.70383296161, 30067.248318791986, 2776.3753155540044, 2779.805413621027, 2785.5960885671666, 2890.638670166229, 2894.1028281232675, 478645.60677196394, 481320.0, 482623.0, 483803.9999999965, 486192.0, 35242.11894702653, 35941.28117437637, 36029.819850901105, 37394.87815365543, 59848.70075649594, 37172.44241336328, 37183.44224836629, 37381.43927841084, 37418.812905935294, 37492.43761343582, 15376.538703838904, 15544.76682849758, 15558.22208889551, 15574.766378504331, 15581.688366232613, 11827.763444731228, 12011.159218854771, 12044.277343359252, 12253.816192757116, 12965.740685186243, 8216.507009579444, 8219.342452603778, 8262.256396924306, 8270.338372930151, 8333.958330208432, 2905.941881162365, 3355.865765369358, 3376.5104059911178, 3376.848041838123, 3411.675890790371, 859.5573279760928, 924.8843894513186, 1035.042148110542, 1056.1867362131115, 1096.753230523126, 23581.646275305884, 28169.859150704524, 30005.849970750005, 30187.0, 31344.843275783474, 1083.257968291707, 1099.2470157941837, 1124.3478782306242, 1177.217150594862, 1189.7204157023093, 15188.772168417483, 15213.0, 15260.771088433683, 15617.60955976087, 15707.4502392418, 619015.9049204725, 620230.8988455029, 622545.0, 625352.0, 626216.0, 50056.749716251186, 59891.0, 60448.39551604516, 60521.69739151276, 60598.0, 1124.3478782306242, 1277.7380636969585, 1430.2848575712144, 1479.5487376350316, 1487.8437764034836, 28882.711172888, 30471.847640761654, 30534.625941833114, 31132.844335779082, 31135.53296700506, 50296.74851625718, 50431.747841260556, 51008.74495627498, 51038.0, 51094.74452627713, 486973.0, 487406.0, 487583.0, 488017.0, 489417.0, 23413.0, 23893.044278229372, 25911.352216194748, 26532.734672653027, 26782.0, 45699.54300456953, 46239.537604623525, 46426.0, 46700.7664961673, 46738.0, 38140.427893581065, 38218.808905955295, 38372.23255534818, 38875.6112438872, 38894.2221155581, 37090.44364334591, 37256.44115338326, 37496.43755343727, 38017.0, 38266.426003610526, 37254.44118338173, 38276.617233828416, 38433.03917401975, 38464.2307153861, 38469.0, 32996.83501582477, 33023.24883905719, 33837.0, 33908.66091339153, 33971.64113435435, 24599.016039358226, 24649.0, 24713.629295560222, 24971.625425618993, 25922.740772592788], "value": 18744.655059737044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.83718408124304, 399.94000899865017, 400.9759414435136, 402.65312529588516, 423.8135220502978, 14110.788338174936, 20413.795862041374, 20606.793932060675, 21114.366569002934, 21126.471838204052, 16149.525643130406, 17950.910245448787, 20162.899185504088, 20515.589688206226, 20702.48243793906, 4876.487968763282, 6121.296050954131, 6122.693865306717, 6163.167972323746, 6181.227346581677, 5980.611260268069, 6012.909806352908, 6058.363871793465, 6064.241370002694, 6086.026235802273, 5886.470217680408, 6011.75952961881, 6047.183630209931, 6059.545534084961, 6066.969665151668, 5870.7945221917025, 5941.287045554518, 6015.067664511986, 6087.634741915499, 6096.4817990470865, 5262.131748261532, 5282.154855223184, 5293.232481290192, 5294.470552944713, 5298.390685071227, 25826.0, 26452.86773566139, 26469.073582424524, 26680.466390672078, 26846.73153268462, 2104.305579158874, 2216.2243214874666, 2258.4128126687015, 2294.4378627236265, 2304.8271379646594, 14565.781513277308, 14772.187529685863, 14835.629109272246, 15693.686126277411, 15890.126043067627, 1738.1048759888668, 1754.0791084680645, 1789.4273832373647, 1826.6803309420798, 1869.1588785046783, 112128.75742485186, 115046.42476787647, 115372.99999999916, 115686.42156789247, 117651.4117429416, 11107.166962477846, 11425.371604561662, 11612.187146899805, 11655.88344116565, 11716.957649610871, 11987.820182697267, 12990.285534295705, 14114.153150810984, 14749.926250368679, 14774.26128693561, 7552.282533159341, 7954.482958607672, 8040.437169398203, 8849.159329863653, 9038.09619038091, 8961.731148065568, 8971.013188549254, 8988.910110898938, 9093.454392736458, 9141.862872056925, 6806.625635589991, 6951.296932251529, 6962.477814163856, 6964.965175174193, 6976.407005404496, 1619.9433019844248, 1914.2056046740447, 1923.0961448119363, 1942.8931408772653, 1967.4687834284664, 813.6297984417076, 931.4969916245152, 994.7612572982432, 1004.4475538453821, 1039.781645854364, 18288.90855545714, 20394.592108157754, 21430.678539821914, 21557.56884862294, 21604.13583456644, 963.9180669643018, 995.3430735714394, 1021.0, 1021.3922715983978, 1094.9811706958358, 9104.8634270486, 9463.810723785486, 11794.88205117955, 11849.229800062969, 11857.644270671894, 475477.7165598444, 562890.0, 580504.0, 601080.0, 605096.872578189, 94868.0, 98471.50764246134, 117061.82938170509, 122815.38592306981, 125127.0, 1004.3020101029861, 1032.0762917188924, 1049.2969710294121, 1050.5430137890041, 1052.7736536644659, 18867.339643112424, 19132.23471061142, 19226.423207303804, 19309.51726206856, 19329.0, 30485.695143048284, 50135.49864501308, 50287.0, 50928.23607645962, 52872.0, 73214.63392683002, 73758.0, 74040.0, 74155.258447417, 75664.86502702573, 7641.694332226871, 8138.226868447488, 8198.959005204935, 8237.588120594066, 8526.957365213135, 10623.946880265548, 12493.625191244277, 12625.558105466265, 13035.608931732064, 13084.345782711016, 9175.311851611023, 11085.889141108486, 11436.142289328167, 11443.427828608703, 11527.88472115268, 9470.621175152917, 10752.946235268773, 10821.080208182393, 11012.614558490415, 11122.165837562054, 5860.150278209721, 8113.742369932434, 10789.0, 11346.0, 11486.94256528712, 8056.959715201387, 8172.182781722018, 8183.549904755296, 8324.0, 8513.021002584783, 11222.49498772541, 11320.37737924422, 11556.942215289206, 11638.476268567765, 11704.063674906158], "value": 9661.035950911302, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.9614511564657, 1616.1434439746931, 1641.8850680452365, 1866.4120801947386, 1985.741853559037, 7704.768856934294, 8337.458065225763, 8611.56942152893, 8617.91382086179, 8747.781305467366, 8406.663733450654, 8631.093735157812, 8647.610857511412, 8654.956725216365, 8661.133886611336, 2422.370183752224, 2453.3008092693585, 2459.102427613917, 2459.827812053157, 2462.22439931421, 2379.274321331993, 2435.5737745894485, 2438.0491608272787, 2444.022391043579, 2444.9511009779794, 2361.657559653849, 2370.8340416170877, 2385.642153676945, 2395.2814155753204, 2395.9760402396014, 2381.1903952656007, 2400.5918993771015, 2410.09621391978, 2415.033986405443, 2418.044872275459, 2275.863448193097, 2301.7583153768946, 2310.8844557772213, 2312.479692069288, 2315.81473482121, 7671.769846904602, 7958.801029974239, 8662.826743465095, 8746.431481953652, 8770.298376129958, 4936.4076310842565, 5081.466446023188, 5085.542301192873, 5128.743562821844, 5224.582033437354, 3463.6709512596262, 3519.6480351964856, 3601.3697602919383, 3609.9278014439565, 3613.1328481164596, 1030.8247597908298, 1045.5974449836867, 1046.0689985912543, 1054.673051354075, 1059.978800423995, 9968.651097211636, 11305.886941130566, 11338.886611133865, 11500.654980350602, 11522.769544609144, 3936.9606303937167, 4496.662750293741, 4820.8794780130775, 4944.208926571731, 4951.90096198074, 9778.804423911624, 9782.461964592016, 9790.755231119136, 9794.510274486389, 9797.16724078447, 5410.242566040757, 5416.891662166735, 5454.509094181542, 5479.178123281539, 5513.42109078549, 4817.27740838877, 4939.481354457802, 4971.850844474671, 5000.374953130859, 5006.299118123466, 3434.8110853902776, 3939.4090886366703, 3981.0, 4037.232925744158, 4094.5086589609436, 1330.5808670269028, 1335.9933200333935, 1338.6921008168176, 1349.0961056092442, 1355.4781409157545, 923.4736200365727, 935.9204467620328, 936.3258453913172, 941.2187884056217, 992.503748125937, 5775.537956963432, 5861.736221870026, 5999.710062336619, 6136.6011209271255, 6175.96912015437, 933.4585940154694, 943.4197718821084, 943.5801068524578, 995.3331268050424, 996.9451680157516, 3910.491636087347, 3990.960090399117, 4054.493188351456, 4080.7959602019782, 4092.856750013735, 9921.107100361001, 10425.843612345821, 10460.68617941463, 10555.577776888838, 10643.893561064291, 10510.684679459628, 10552.103071239031, 10604.840927386096, 10617.256792024638, 10626.73433164177, 7888.64501097452, 8104.39217058723, 8114.553699546464, 8121.675132994732, 8126.065502467292, 5709.172170035405, 5779.133130030529, 5994.460498555151, 6031.879362412815, 6098.817035488943, 9502.334836561375, 9535.47554884488, 9766.316357854881, 9814.75463113428, 9821.017898210122, 9547.665831696135, 9782.853257201004, 9826.4104153751, 9895.109440150422, 9986.300958932805, 7374.151972523228, 7458.552486850806, 7518.097828260644, 7520.887186692314, 7536.547807131589, 7766.883496747666, 8011.278984891388, 8076.313513351431, 8112.513249205066, 8114.229148230908, 7484.0, 7609.923900760921, 7631.69473221065, 7743.574103424366, 7818.765437036898, 7543.283388078124, 7582.696692132253, 7652.349550288288, 7658.846823063396, 7757.1079325878245, 5662.462066103713, 6989.685464154024, 7006.474514411338, 7053.435725141873, 7072.893906591303, 5080.847574572768, 5108.0, 5145.562627176732, 5152.355955505562, 5369.838904832861, 5067.265246539305, 5074.162763144188, 5204.739763011758, 5231.006108839309, 5489.984352894728], "value": 4605.995778214608, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.0562609358876, 315.6307120668817, 331.2645926044181, 333.8848097406397, 335.35276915552976, 4820.469748327681, 4851.563359297663, 5338.199270109486, 5351.652142610727, 5361.839144825652, 4367.934480982788, 4666.020135771492, 4873.5613794758465, 5111.795528178868, 5120.615953803461, 3629.927401451969, 3986.3621820508724, 4055.844084435929, 4060.2946762359734, 4097.467329247193, 4020.256252593265, 4064.2277967186287, 4069.267531844267, 4096.836126554949, 4097.385392191165, 3757.962420375802, 3767.585565587783, 3821.261326096633, 4049.7367671101433, 4056.1482088761395, 3433.4334834752235, 3566.4472006838982, 3993.6805055595773, 4010.9999999999854, 4058.3100872851687, 3328.270817929275, 3465.740069494798, 3543.3799085159994, 3555.288942211568, 3573.2317551726505, 4437.644988400953, 4487.753173575452, 4830.227163653799, 4838.782254798507, 5058.114829904789, 3810.4474851146706, 3994.500687414073, 4343.1747967886, 4621.214393553104, 4628.0, 4840.48294886657, 4956.3804524434445, 5058.241263810458, 5321.962217367615, 5480.561555075585, 3402.3195360927666, 3664.3404187246283, 3886.9805650971566, 3889.9805500972598, 3902.9219415611815, 4879.975600121977, 5319.335083114611, 5428.728563571845, 5743.684097374601, 5779.537636989073, 3942.231264903374, 3965.4250133731025, 3967.8177002649004, 3979.263836190314, 3994.960050399517, 4047.8988025299013, 4062.1469491407133, 4082.897927551835, 4090.877273681794, 4092.570280120604, 3994.9014021144417, 4247.129338485664, 4445.488768791631, 4581.536869595184, 4616.907661846812, 4937.481564435754, 5472.699001554873, 5526.226328314039, 5545.889082218333, 5592.860178495489, 1163.5281369068136, 1232.648695121904, 1245.6422499475616, 1294.346355090692, 1332.9733405332033, 800.9279164875072, 827.4497459189572, 827.5696637748338, 874.0, 879.6701237036111, 4658.930116048262, 4885.120678277873, 5115.820946266863, 5211.973940130351, 5217.921731174036, 5076.568491678175, 5727.5131613812455, 5758.712064396764, 5772.336181339116, 5773.336066352424, 4830.009847981156, 5184.870378240575, 5189.6107791915, 5203.843884683465, 5221.869453263623, 2785.4123149804823, 2848.245215018022, 2872.928176795555, 2885.783566232541, 2886.4990205093236, 4802.759862006886, 5269.762860671279, 5748.827535173868, 5808.854778630483, 5832.300123985149, 4732.763361831895, 5253.789848406097, 5649.350324712628, 5673.858153546194, 5936.7031648417405, 4933.55597996182, 5069.0, 5611.803586874522, 5811.854703632443, 5923.555733320019, 4928.975355123202, 5731.484166425042, 5764.365919748908, 5764.771727832427, 5784.392638772868, 5307.336582927134, 5723.484886360247, 5725.971370143123, 5739.253896993531, 5745.597808153389, 5955.821325360246, 6008.489278411209, 6013.699315034319, 6032.638041717511, 6038.909416358671, 3435.862565497352, 3830.5211848518934, 3834.1181528248103, 3857.209272099269, 3917.7061720371657, 4816.446108697544, 4880.658353915192, 5285.365756109291, 5699.6865172414255, 5737.770489180386, 4990.700557966534, 5005.899882002413, 5429.5656347492895, 5530.391656917816, 5558.610897237155, 4650.697704649187, 5524.392316845064, 5525.977694126599, 5539.8892022160135, 5575.219469274224, 5000.699958002531, 5210.062188806051, 5244.632875698817, 5247.906632826402, 5427.83716488506, 4829.95170048295, 5167.560757335668, 5368.57051435892, 5584.246126772996, 5587.3015873015875, 5055.797768089235, 5111.801925172212, 5229.424763275961, 5499.395066542597, 5508.256385387921], "value": 4030.4954991516292, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.256052062471, 726.5459088069956, 742.1962442482278, 747.1295940229633, 803.9758807235785, 15146.545603631881, 15670.0, 15688.450904218354, 15693.764593531092, 15734.055956642609, 14561.635959101028, 14601.707965840676, 14623.122612643248, 14626.561203163923, 14626.707465850677, 750.7935317787598, 770.2297702297702, 915.0940568836837, 938.5072836760704, 946.564580293066, 920.8710780490736, 923.1599244687336, 924.1959495239151, 925.0287198441644, 925.3938670171049, 983.0759086458706, 1000.824855650262, 1001.694483182629, 1004.1665417703289, 1008.3445760255855, 788.2157253532714, 809.5102463009853, 809.5426084262373, 885.3315746611331, 992.270681049428, 607.159084667734, 721.1706537481886, 737.2553720742036, 737.9704811807521, 739.7632757517597, 14562.417503299856, 14582.708345833023, 14587.70824583513, 14616.634584135376, 14628.0, 12067.396630168456, 12316.630501084981, 12343.75312493754, 12572.371381430983, 12752.489900403973, 10902.454877256185, 10917.454127293604, 11159.051480624075, 11504.884951150549, 11647.893450122225, 4073.531543872463, 4084.979575102135, 4085.9387109193385, 4209.98960249541, 4223.049813791903, 64129.67935160341, 81157.0, 82413.76379354254, 83172.58413707954, 83258.58370708168, 7561.621918904033, 9590.040995900494, 9797.755056123511, 9869.851952220723, 10206.642767503101, 21741.78258217429, 21765.564688706454, 21774.12903483843, 21798.673019904712, 21815.890920545295, 7490.288422599844, 7555.320021198118, 7558.357539609195, 7719.228077192348, 7924.207579242145, 4042.2723909696538, 4093.263212621697, 4096.160287141129, 4106.486689163855, 4108.794560271975, 3520.331137083946, 3594.9281014379567, 3609.097725568608, 3625.7099432045375, 3626.3472574936764, 634.8095571328583, 662.8309781005813, 665.0622622102812, 673.050998092687, 675.1864003875319, 554.6727430815838, 556.3907521264209, 566.4929887750441, 583.3670467542679, 585.0288521055113, 7787.0, 7902.446828721934, 7909.485883417559, 8074.0, 8248.298894594027, 551.9199716041152, 563.3859093588009, 568.4315684315684, 568.795233715862, 574.4370516893384, 3751.381022131318, 3754.6808521276, 3804.5814960354337, 3895.1820117775583, 4021.276170289376, 83907.16092839115, 86845.13154868496, 88242.55878720565, 88511.11488885157, 88714.55642721745, 76763.23236767673, 77661.61169194231, 77823.0, 78425.0, 81050.0, 66191.66904165449, 66904.0, 67054.0, 67236.0, 67598.93008024417, 6406.967965160145, 7076.1508618964, 7495.512791668524, 7581.166071732216, 7581.50720203185, 42633.147337053706, 43138.78430607953, 43366.915827104574, 44569.55430445654, 45800.770996144805, 58950.705246473495, 59820.70089649698, 59953.8009239804, 60229.39770602238, 61355.386446134966, 8051.315638170821, 9909.851352229867, 10018.599256029676, 10245.590176392861, 10516.58039590054, 10353.0, 10444.373337599769, 10564.15486761042, 10658.094062004817, 10922.017018468376, 9826.55780489894, 9863.852042219516, 9955.701328960144, 9979.800403992025, 10118.342307749972, 9845.0, 9980.950095249767, 10008.749781255527, 10031.173402673772, 10357.119644830274, 9785.657501987396, 9839.262055345735, 9880.901190987997, 9976.750581235527, 10469.057784799405, 8479.40644154928, 8581.184787445183, 8855.690050848189, 8860.069692682175, 8962.462252264884, 6952.0, 8375.832483350177, 8486.957565212135, 8596.570171491525, 8804.119588041145], "value": 6694.966818238948, "unit": "score"}], "name": "dromaeo_css", "value": 7097.844152275882, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 111.0, 113.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 116.0, 154.0, 165.0, 118.0, 138.0, 136.0, 116.0, 166.0, 115.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 186.0, 183.0, 184.0, 188.0, 185.0, 183.0, 188.0, 185.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 58.0, 107.0, 56.0, 61.0, 57.0, 58.0, 114.0, 55.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 98.0, 101.0, 80.0, 81.0, 77.0, 103.0, 81.0, 80.0, 101.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 84.0, 86.0, 83.0, 87.0, 84.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 96.0, 94.0, 92.0, 93.0, 105.0, 149.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 86.0, 84.0, 85.0, 84.0, 86.0, 84.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 57.0, 57.0, 58.0, 59.0, 76.0, 60.0, 58.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 71.0, 80.0, 70.0, 70.0, 68.0, 69.0, 68.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 82.0, 85.0, 71.0, 85.0, 91.0, 107.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 142.0, 136.0, 135.0, 140.0, 147.0, 153.0, 169.0, 160.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 226.0, 167.0, 168.0, 167.0, 167.0, 170.0, 167.0, 168.0, 165.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1471.2, "alertThreshold": 2.0}]} 01:22:08 INFO - Return code: 0 01:22:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:22:08 ERROR - # TBPL SUCCESS # 01:22:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:22:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:22:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:22:08 INFO - 2016-05-06 01:22:08.476 screenresolution[1687:10095] starting screenresolution argv=screenresolution get 01:22:08 INFO - 2016-05-06 01:22:08.478 screenresolution[1687:10095] Display 0: 1600x1200x32@60 01:22:08 INFO - 2016-05-06 01:22:08.484 screenresolution[1688:10098] starting screenresolution argv=screenresolution list 01:22:08 INFO - Available Modes on Display 0 01:22:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:22:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:22:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:22:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:22:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:22:08 INFO - Intel Iris: 01:22:08 INFO - Chipset Model: Intel Iris 01:22:08 INFO - Type: GPU 01:22:08 INFO - Bus: Built-In 01:22:08 INFO - VRAM (Dynamic, Max): 1536 MB 01:22:08 INFO - Vendor: Intel (0x8086) 01:22:08 INFO - Device ID: 0x0a2e 01:22:08 INFO - Revision ID: 0x0009 01:22:08 INFO - Displays: 01:22:08 INFO - Display: 01:22:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:22:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:22:08 INFO - Display Serial Number: 1600x1200 60 01:22:08 INFO - Main Display: Yes 01:22:08 INFO - Mirror: Off 01:22:08 INFO - Online: Yes 01:22:08 INFO - Rotation: Supported 01:22:08 INFO - Return code: 0 01:22:08 INFO - Running post-action listener: _resource_record_post_action 01:22:08 INFO - Running post-run listener: _resource_record_post_run 01:22:09 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38184448; Write bytes: 696017408; Read time: 443; Write time: 1850 01:22:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 380340736; Write bytes: 373991424; Read time: 28344; Write time: 718 01:22:09 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36959744; Write bytes: 297097728; Read time: 381; Write time: 1081 01:22:09 INFO - Running post-run listener: _upload_blobber_files 01:22:09 INFO - Blob upload gear active. 01:22:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:22:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:22:10 INFO - (blobuploader) - INFO - Open directory for files ... 01:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:22:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:22:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:22:11 INFO - (blobuploader) - INFO - Done attempting. 01:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:22:12 INFO - (blobuploader) - INFO - Done attempting. 01:22:12 INFO - (blobuploader) - INFO - Iteration through files over. 01:22:12 INFO - Return code: 0 01:22:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:22:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:22:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b9511e8d1a381254b86e1aefd5132e7b9e82c66a74099484f5bc5235b1e05cfc6c48ea2f26d54e4a6e33521d493ca8f7136e7509b9980b10bd84793c8bb08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bd448e7f03a8db929436e5b48829eaf912c6fb1cc938f2cfa469ca88572a4bf1e9046ff5abb2e378acc739b1d1d7feed8af09cea797354badccc9a8a0fcdcb"} 01:22:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:22:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:22:12 INFO - Contents: 01:22:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b9511e8d1a381254b86e1aefd5132e7b9e82c66a74099484f5bc5235b1e05cfc6c48ea2f26d54e4a6e33521d493ca8f7136e7509b9980b10bd84793c8bb08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bd448e7f03a8db929436e5b48829eaf912c6fb1cc938f2cfa469ca88572a4bf1e9046ff5abb2e378acc739b1d1d7feed8af09cea797354badccc9a8a0fcdcb"} 01:22:12 INFO - Running post-run listener: copy_logs_to_upload_dir 01:22:12 INFO - Copying logs to upload dir... 01:22:12 INFO - mkdir: /builds/slave/test/build/upload/logs 01:22:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.660011 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-06 01:22:12.428839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 01:22:12.432442) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b9511e8d1a381254b86e1aefd5132e7b9e82c66a74099484f5bc5235b1e05cfc6c48ea2f26d54e4a6e33521d493ca8f7136e7509b9980b10bd84793c8bb08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bd448e7f03a8db929436e5b48829eaf912c6fb1cc938f2cfa469ca88572a4bf1e9046ff5abb2e378acc739b1d1d7feed8af09cea797354badccc9a8a0fcdcb"} build_url:https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010877 build_url: 'https://queue.taskcluster.net/v1/task/IySTx4x8TBqvfksrhX6kQg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69b9511e8d1a381254b86e1aefd5132e7b9e82c66a74099484f5bc5235b1e05cfc6c48ea2f26d54e4a6e33521d493ca8f7136e7509b9980b10bd84793c8bb08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d5bd448e7f03a8db929436e5b48829eaf912c6fb1cc938f2cfa469ca88572a4bf1e9046ff5abb2e378acc739b1d1d7feed8af09cea797354badccc9a8a0fcdcb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 01:22:12.459080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 01:22:12.459393) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F4m5Zlrx7D/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.jlWgfr0chV/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005094 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 01:22:12.507829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 01:22:12.508142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 01:22:12.508433) ========= ========= Total master_lag: 0.15 =========