builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0216 starttime: 1466586433.49 results: success (0) buildid: 20160622005102 builduid: 903bf3ba67ac4973b547cb89e44da7aa revision: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.489319) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.489893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.490178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.525740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:13.526410) ========= 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.y4qcndXWq3/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.QXiQHIzern/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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-06-22 02:07:13-- 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% 39.1M=0s 2016-06-22 02:07:14 (39.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.493800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:14.042429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:14.042751) ========= 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.y4qcndXWq3/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.QXiQHIzern/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.020095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:14.090928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 02:07:14.091252) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3d3e03d528e015cb85dd7acf15e65443c0d3d589 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3d3e03d528e015cb85dd7acf15e65443c0d3d589 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y4qcndXWq3/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.QXiQHIzern/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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-06-22 02:07:14,175 truncating revision to first 12 chars 2016-06-22 02:07:14,175 Setting DEBUG logging. 2016-06-22 02:07:14,175 attempt 1/10 2016-06-22 02:07:14,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3d3e03d528e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 02:07:15,141 unpacking tar archive at: mozilla-beta-3d3e03d528e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 02:07:15.359201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.359590) ========= script_repo_revision: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.359997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.360277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 02:07:15.377458) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-22 02:07:15.377804) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y4qcndXWq3/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.QXiQHIzern/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:15 INFO - MultiFileLogger online at 20160622 02:07:15 in /builds/slave/test 02:07:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:15 INFO - {'append_to_log': False, 02:07:15 INFO - 'base_work_dir': '/builds/slave/test', 02:07:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:15 INFO - 'branch': 'Mozilla-Beta', 02:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:15 INFO - 'config_files': ('talos/mac_config.py',), 02:07:15 INFO - 'default_actions': ('clobber', 02:07:15 INFO - 'read-buildbot-config', 02:07:15 INFO - 'download-and-extract', 02:07:15 INFO - 'populate-webroot', 02:07:15 INFO - 'create-virtualenv', 02:07:15 INFO - 'install', 02:07:15 INFO - 'run-tests'), 02:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:15 INFO - 'download_minidump_stackwalk': True, 02:07:15 INFO - 'download_symbols': 'ondemand', 02:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:15 INFO - 'installer_path': 'installer.exe', 02:07:15 INFO - 'log_level': 'info', 02:07:15 INFO - 'log_name': 'talos', 02:07:15 INFO - 'log_to_console': True, 02:07:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:07:15 INFO - 'opt_config_files': (), 02:07:15 INFO - 'pip_index': False, 02:07:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:15 INFO - 'cmd': ('bash', 02:07:15 INFO - '-c', 02:07:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:15 INFO - 'enabled': True, 02:07:15 INFO - 'halt_on_failure': False, 02:07:15 INFO - 'name': 'check_screen_resolution'},), 02:07:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:15 INFO - 'cmd': ('bash', 02:07:15 INFO - '-c', 02:07:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:15 INFO - 'enabled': True, 02:07:15 INFO - 'halt_on_failure': False, 02:07:15 INFO - 'name': 'check_screen_resolution'},), 02:07:15 INFO - 'run_cmd_checks_enabled': True, 02:07:15 INFO - 'sps_profile': False, 02:07:15 INFO - 'sps_profile_interval': 0, 02:07:15 INFO - 'suite': 'dromaeojs', 02:07:15 INFO - 'system_bits': '32', 02:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:15 INFO - 'title': 't-yosemite-r7-0216', 02:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:15 INFO - 'use_talos_json': True, 02:07:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:15 INFO - 'work_dir': 'build'} 02:07:15 INFO - ##### 02:07:15 INFO - ##### Running clobber step. 02:07:15 INFO - ##### 02:07:15 INFO - Running pre-action listener: _resource_record_pre_action 02:07:15 INFO - Running main action method: clobber 02:07:15 INFO - rmtree: /builds/slave/test/build 02:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:16 INFO - Running post-action listener: _resource_record_post_action 02:07:16 INFO - ##### 02:07:16 INFO - ##### Running read-buildbot-config step. 02:07:16 INFO - ##### 02:07:16 INFO - Running pre-action listener: _resource_record_pre_action 02:07:16 INFO - Running main action method: read_buildbot_config 02:07:16 INFO - Using buildbot properties: 02:07:16 INFO - { 02:07:16 INFO - "project": "", 02:07:16 INFO - "product": "firefox", 02:07:16 INFO - "script_repo_revision": "production", 02:07:16 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:07:16 INFO - "repository": "", 02:07:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:07:16 INFO - "buildid": "20160622005102", 02:07:16 INFO - "pgo_build": "False", 02:07:16 INFO - "basedir": "/builds/slave/test", 02:07:16 INFO - "buildnumber": 8, 02:07:16 INFO - "slavename": "t-yosemite-r7-0216", 02:07:16 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:07:16 INFO - "platform": "yosemite_r7", 02:07:16 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:07:16 INFO - "branch": "mozilla-beta", 02:07:16 INFO - "repo_path": "releases/mozilla-beta", 02:07:16 INFO - "revision": "3d3e03d528e015cb85dd7acf15e65443c0d3d589", 02:07:16 INFO - "stage_platform": "macosx64", 02:07:16 INFO - "builduid": "903bf3ba67ac4973b547cb89e44da7aa", 02:07:16 INFO - "slavebuilddir": "test" 02:07:16 INFO - } 02:07:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 02:07:16 INFO - Running post-action listener: _resource_record_post_action 02:07:16 INFO - ##### 02:07:16 INFO - ##### Running download-and-extract step. 02:07:16 INFO - ##### 02:07:16 INFO - Running pre-action listener: _resource_record_pre_action 02:07:16 INFO - Running main action method: download_and_extract 02:07:16 INFO - mkdir: /builds/slave/test/build/tests 02:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:16 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 02:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 02:07:20 INFO - Downloaded 1165 bytes. 02:07:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 02:07:20 INFO - Using the following test package requirements: 02:07:20 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:07:20 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 02:07:20 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 02:07:20 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:07:20 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 02:07:20 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 02:07:20 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 02:07:20 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 02:07:20 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 02:07:20 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 02:07:20 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 02:07:20 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 02:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:20 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 02:07:22 INFO - Downloaded 18301167 bytes. 02:07:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:07:25 INFO - Return code: 0 02:07:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:07:25 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')]} 02:07:25 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 02:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 02:07:26 INFO - Downloaded 18301167 bytes. 02:07:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:07:30 INFO - Return code: 0 02:07:30 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')]} 02:07:30 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 02:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 02:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 02:07:31 INFO - Downloaded 10840145 bytes. 02:07:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:07:31 INFO - Return code: 0 02:07:31 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')]} 02:07:31 INFO - https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 02:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 02:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 02:07:35 INFO - Downloaded 86248654 bytes. 02:07:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:35 INFO - mkdir: /builds/slave/test/properties 02:07:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:35 INFO - Contents: 02:07:35 INFO - build_url:https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 02:07:36 INFO - Running post-action listener: _resource_record_post_action 02:07:36 INFO - Running post-action listener: set_extra_try_arguments 02:07:36 INFO - ##### 02:07:36 INFO - ##### Running populate-webroot step. 02:07:36 INFO - ##### 02:07:36 INFO - Running pre-action listener: _resource_record_pre_action 02:07:36 INFO - Running main action method: populate_webroot 02:07:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:36 INFO - '--tppagecycles', 02:07:36 INFO - '7'], 02:07:36 INFO - 'tests': ['tsvgm']}}, 02:07:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['damp', 'tps']}, 02:07:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'tests': ['damp', 'tps']}, 02:07:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['dromaeo_dom']}, 02:07:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['a11yr', 02:07:36 INFO - 'ts_paint', 02:07:36 INFO - 'tpaint', 02:07:36 INFO - 'sessionrestore', 02:07:36 INFO - 'sessionrestore_no_auto_restore', 02:07:36 INFO - 'tabpaint']}, 02:07:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:36 INFO - 'ts_paint', 02:07:36 INFO - 'tpaint', 02:07:36 INFO - 'sessionrestore', 02:07:36 INFO - 'sessionrestore_no_auto_restore', 02:07:36 INFO - 'tabpaint']}, 02:07:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:36 INFO - 'ts_paint', 02:07:36 INFO - 'tpaint', 02:07:36 INFO - 'sessionrestore', 02:07:36 INFO - 'sessionrestore_no_auto_restore', 02:07:36 INFO - 'tabpaint']}, 02:07:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:36 INFO - 'ts_paint', 02:07:36 INFO - 'tpaint', 02:07:36 INFO - 'sessionrestore', 02:07:36 INFO - 'sessionrestore_no_auto_restore', 02:07:36 INFO - 'tabpaint']}, 02:07:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['a11yr', 02:07:36 INFO - 'ts_paint', 02:07:36 INFO - 'tpaint', 02:07:36 INFO - 'sessionrestore', 02:07:36 INFO - 'sessionrestore_no_auto_restore', 02:07:36 INFO - 'tabpaint']}, 02:07:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['a11yr', 02:07:36 INFO - 'ts_paint', 02:07:36 INFO - 'tpaint', 02:07:36 INFO - 'sessionrestore', 02:07:36 INFO - 'sessionrestore_no_auto_restore', 02:07:36 INFO - 'tabpaint']}, 02:07:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['tsvgx', 02:07:36 INFO - 'tsvgr_opacity', 02:07:36 INFO - 'tart', 02:07:36 INFO - 'tscrollx', 02:07:36 INFO - 'cart']}, 02:07:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:36 INFO - 'tsvgr_opacity', 02:07:36 INFO - 'tart', 02:07:36 INFO - 'tscrollx', 02:07:36 INFO - 'cart']}, 02:07:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'talos_options': ['--disable-e10s'], 02:07:36 INFO - 'tests': ['tp5o']}, 02:07:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'tests': ['tp5o']}, 02:07:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'talos_options': ['--disable-e10s', 02:07:36 INFO - '--xperf_path', 02:07:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:36 INFO - 'tests': ['tp5n']}, 02:07:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:36 INFO - 'talos_options': ['--xperf_path', 02:07:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:36 INFO - 'tests': ['tp5n']}}, 02:07:36 INFO - 'talos.zip': {'path': '', 02:07:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:36 INFO - Running post-action listener: _resource_record_post_action 02:07:36 INFO - ##### 02:07:36 INFO - ##### Running create-virtualenv step. 02:07:36 INFO - ##### 02:07:36 INFO - Running pre-action listener: _resource_record_pre_action 02:07:36 INFO - Running main action method: create_virtualenv 02:07:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:36 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 02:07:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:36 INFO - Using real prefix '/tools/python27' 02:07:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:39 INFO - Installing pip.................done. 02:07:39 INFO - Return code: 0 02:07:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:39 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')]} 02:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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')]} 02:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:39 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 02:07:39 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 02:07:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:07:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:39 INFO - 'HOME': '/Users/cltbld', 02:07:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:39 INFO - 'LOGNAME': 'cltbld', 02:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:39 INFO - 'MOZ_NO_REMOTE': '1', 02:07:39 INFO - 'NO_EM_RESTART': '1', 02:07:39 INFO - 'PAGER': '/bin/cat', 02:07:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:39 INFO - 'PWD': '/builds/slave/test', 02:07:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:39 INFO - 'SHELL': '/bin/bash', 02:07:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:07:39 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:07:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:39 INFO - 'USER': 'cltbld', 02:07:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:39 INFO - 'XPC_FLAGS': '0x0', 02:07:39 INFO - 'XPC_SERVICE_NAME': '0', 02:07:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:40 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 02:07:40 INFO - Cleaning up... 02:07:40 INFO - Return code: 0 02:07:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:40 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:40 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 02:07:40 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 02:07:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:07:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:40 INFO - 'HOME': '/Users/cltbld', 02:07:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:40 INFO - 'LOGNAME': 'cltbld', 02:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:40 INFO - 'MOZ_NO_REMOTE': '1', 02:07:40 INFO - 'NO_EM_RESTART': '1', 02:07:40 INFO - 'PAGER': '/bin/cat', 02:07:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:40 INFO - 'PWD': '/builds/slave/test', 02:07:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:40 INFO - 'SHELL': '/bin/bash', 02:07:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:07:40 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:07:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:40 INFO - 'USER': 'cltbld', 02:07:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:40 INFO - 'XPC_FLAGS': '0x0', 02:07:40 INFO - 'XPC_SERVICE_NAME': '0', 02:07:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:40 INFO - Downloading/unpacking psutil>=0.7.1 02:07:40 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 02:07:40 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 02:07:40 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 02:07:40 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 02:07:40 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 02:07:40 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 02:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:43 INFO - Installing collected packages: psutil 02:07:43 INFO - Running setup.py install for psutil 02:07:43 INFO - building 'psutil._psutil_osx' extension 02:07:43 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 02:07:44 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 02:07:44 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 02:07:44 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 02:07:44 INFO - building 'psutil._psutil_posix' extension 02:07:44 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 02:07:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:07:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:07:44 INFO - ^ 02:07:44 INFO - 1 warning generated. 02:07:44 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 02:07:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:44 INFO - Successfully installed psutil 02:07:44 INFO - Cleaning up... 02:07:44 INFO - Return code: 0 02:07:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:07:44 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')]} 02:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:44 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')]} 02:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:44 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:44 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 02:07:44 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 02:07:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:07:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:44 INFO - 'HOME': '/Users/cltbld', 02:07:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:44 INFO - 'LOGNAME': 'cltbld', 02:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:44 INFO - 'MOZ_NO_REMOTE': '1', 02:07:44 INFO - 'NO_EM_RESTART': '1', 02:07:44 INFO - 'PAGER': '/bin/cat', 02:07:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:44 INFO - 'PWD': '/builds/slave/test', 02:07:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:44 INFO - 'SHELL': '/bin/bash', 02:07:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:07:44 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:07:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:44 INFO - 'USER': 'cltbld', 02:07:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:44 INFO - 'XPC_FLAGS': '0x0', 02:07:44 INFO - 'XPC_SERVICE_NAME': '0', 02:07:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07:44 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 02:07:44 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 02:07:44 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 02:07:44 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 02:07:44 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 02:07:44 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 02:07:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:07:47 INFO - Installing collected packages: mozsystemmonitor 02:07:47 INFO - Running setup.py install for mozsystemmonitor 02:07:47 INFO - Successfully installed mozsystemmonitor 02:07:47 INFO - Cleaning up... 02:07:47 INFO - Return code: 0 02:07:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07:47 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')]} 02:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:47 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')]} 02:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:47 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:47 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 02:07:47 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 02:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:47 INFO - 'HOME': '/Users/cltbld', 02:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:47 INFO - 'LOGNAME': 'cltbld', 02:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:47 INFO - 'MOZ_NO_REMOTE': '1', 02:07:47 INFO - 'NO_EM_RESTART': '1', 02:07:47 INFO - 'PAGER': '/bin/cat', 02:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:47 INFO - 'PWD': '/builds/slave/test', 02:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:47 INFO - 'SHELL': '/bin/bash', 02:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:07:47 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:47 INFO - 'USER': 'cltbld', 02:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:47 INFO - 'XPC_FLAGS': '0x0', 02:07:47 INFO - 'XPC_SERVICE_NAME': '0', 02:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:48 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 02:07:48 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 02:07:48 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 02:07:48 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 02:07:48 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 02:07:48 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 02:07:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:51 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 02:07:51 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 02:07:51 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 02:07:51 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 02:07:51 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 02:07:51 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 02:07:51 INFO - Downloading docopt-0.6.1.tar.gz 02:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:51 INFO - Running setup.py install for blobuploader 02:07:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:51 INFO - Running setup.py install for requests 02:07:52 INFO - Running setup.py install for docopt 02:07:52 INFO - Successfully installed blobuploader requests docopt 02:07:52 INFO - Cleaning up... 02:07:52 INFO - Return code: 0 02:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:52 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:52 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 02:07:52 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 02:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:52 INFO - 'HOME': '/Users/cltbld', 02:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:52 INFO - 'LOGNAME': 'cltbld', 02:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:52 INFO - 'MOZ_NO_REMOTE': '1', 02:07:52 INFO - 'NO_EM_RESTART': '1', 02:07:52 INFO - 'PAGER': '/bin/cat', 02:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:52 INFO - 'PWD': '/builds/slave/test', 02:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:52 INFO - 'SHELL': '/bin/bash', 02:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:07:52 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:52 INFO - 'USER': 'cltbld', 02:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:52 INFO - 'XPC_FLAGS': '0x0', 02:07:52 INFO - 'XPC_SERVICE_NAME': '0', 02:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-2ECvJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:52 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-7oDyfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-DhFa2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-_SbeIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-7F3IcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-bQfH5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-36NzbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-AHGQgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-skzjzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-u7vVHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-YSqPZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:53 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-jS9KUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-vRPtY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-xyjK54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-CGFYLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-bnAhDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:54 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-nc6eIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:54 INFO - Running setup.py install for manifestparser 02:07:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:54 INFO - Running setup.py install for mozcrash 02:07:54 INFO - Running setup.py install for mozdebug 02:07:54 INFO - Running setup.py install for mozdevice 02:07:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Running setup.py install for mozfile 02:07:55 INFO - Running setup.py install for mozhttpd 02:07:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Running setup.py install for mozinfo 02:07:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Running setup.py install for mozInstall 02:07:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:55 INFO - Running setup.py install for mozleak 02:07:55 INFO - Running setup.py install for mozlog 02:07:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for moznetwork 02:07:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozprocess 02:07:56 INFO - Running setup.py install for mozprofile 02:07:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozrunner 02:07:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:56 INFO - Running setup.py install for mozscreenshot 02:07:56 INFO - Running setup.py install for moztest 02:07:56 INFO - Running setup.py install for mozversion 02:07:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:57 INFO - Cleaning up... 02:07:57 INFO - Return code: 0 02:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:57 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:07:57 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 02:07:57 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 02:07:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:07:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:57 INFO - 'HOME': '/Users/cltbld', 02:07:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:57 INFO - 'LOGNAME': 'cltbld', 02:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:57 INFO - 'MOZ_NO_REMOTE': '1', 02:07:57 INFO - 'NO_EM_RESTART': '1', 02:07:57 INFO - 'PAGER': '/bin/cat', 02:07:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:57 INFO - 'PWD': '/builds/slave/test', 02:07:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:57 INFO - 'SHELL': '/bin/bash', 02:07:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:07:57 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:07:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:57 INFO - 'USER': 'cltbld', 02:07:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:57 INFO - 'XPC_FLAGS': '0x0', 02:07:57 INFO - 'XPC_SERVICE_NAME': '0', 02:07:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:57 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-dnzC2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:57 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)) 02:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:57 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-6WO7EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:57 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)) 02:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:57 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-foliq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:57 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)) 02:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:57 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-U8Nynf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:57 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)) 02:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:57 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-UXNdtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:57 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)) 02:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:57 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-zh9MiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-gEf7ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-X2iRPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-X5Rdu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-qHnZrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-tl7pIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-EJokK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-c5z1XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Rcpmjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-QeR8I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:58 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)) 02:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:58 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-R7UbFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:59 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)) 02:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:59 INFO - Running setup.py (path:/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/pip-Axqa6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:59 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)) 02:07:59 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)) 02:07:59 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)) 02:07:59 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)) 02:07:59 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)) 02:07:59 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)) 02:07:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:01 INFO - Downloading blessings-1.6.tar.gz 02:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:01 INFO - Installing collected packages: blessings 02:08:01 INFO - Running setup.py install for blessings 02:08:01 INFO - Successfully installed blessings 02:08:01 INFO - Cleaning up... 02:08:01 INFO - Return code: 0 02:08:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:02 INFO - Reading from file tmpfile_stdout 02:08:02 INFO - Current package versions: 02:08:02 INFO - blessings == 1.6 02:08:02 INFO - blobuploader == 1.2.4 02:08:02 INFO - docopt == 0.6.1 02:08:02 INFO - manifestparser == 1.1 02:08:02 INFO - mozInstall == 1.12 02:08:02 INFO - mozcrash == 0.17 02:08:02 INFO - mozdebug == 0.1 02:08:02 INFO - mozdevice == 0.48 02:08:02 INFO - mozfile == 1.2 02:08:02 INFO - mozhttpd == 0.7 02:08:02 INFO - mozinfo == 0.9 02:08:02 INFO - mozleak == 0.1 02:08:02 INFO - mozlog == 3.1 02:08:02 INFO - moznetwork == 0.27 02:08:02 INFO - mozprocess == 0.22 02:08:02 INFO - mozprofile == 0.28 02:08:02 INFO - mozrunner == 6.11 02:08:02 INFO - mozscreenshot == 0.1 02:08:02 INFO - mozsystemmonitor == 0.0 02:08:02 INFO - moztest == 0.7 02:08:02 INFO - mozversion == 1.4 02:08:02 INFO - psutil == 3.1.1 02:08:02 INFO - requests == 1.2.3 02:08:02 INFO - wsgiref == 0.1.2 02:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:02 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:08:02 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 02:08:02 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 02:08:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:08:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:02 INFO - 'HOME': '/Users/cltbld', 02:08:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:02 INFO - 'LOGNAME': 'cltbld', 02:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:02 INFO - 'MOZ_NO_REMOTE': '1', 02:08:02 INFO - 'NO_EM_RESTART': '1', 02:08:02 INFO - 'PAGER': '/bin/cat', 02:08:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:02 INFO - 'PWD': '/builds/slave/test', 02:08:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:02 INFO - 'SHELL': '/bin/bash', 02:08:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:08:02 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:08:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:02 INFO - 'USER': 'cltbld', 02:08:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:02 INFO - 'XPC_FLAGS': '0x0', 02:08:02 INFO - 'XPC_SERVICE_NAME': '0', 02:08:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 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)) 02:08:02 INFO - Cleaning up... 02:08:02 INFO - Return code: 0 02:08:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:08:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:08:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:02 INFO - 'HOME': '/Users/cltbld', 02:08:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:02 INFO - 'LOGNAME': 'cltbld', 02:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:02 INFO - 'MOZ_NO_REMOTE': '1', 02:08:02 INFO - 'NO_EM_RESTART': '1', 02:08:02 INFO - 'PAGER': '/bin/cat', 02:08:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:02 INFO - 'PWD': '/builds/slave/test', 02:08:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:02 INFO - 'SHELL': '/bin/bash', 02:08:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:08:02 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:08:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:02 INFO - 'USER': 'cltbld', 02:08:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:02 INFO - 'XPC_FLAGS': '0x0', 02:08:02 INFO - 'XPC_SERVICE_NAME': '0', 02:08:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:02 INFO - Downloading/unpacking jsonschema 02:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:05 INFO - Downloading/unpacking functools32 (from jsonschema) 02:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:05 INFO - warning: no files found matching '*.txt' 02:08:05 INFO - no previously-included directories found matching 'build' 02:08:05 INFO - no previously-included directories found matching 'dist' 02:08:05 INFO - no previously-included directories found matching '.git*' 02:08:05 INFO - Installing collected packages: jsonschema, functools32 02:08:05 INFO - Running setup.py install for functools32 02:08:05 INFO - warning: no files found matching '*.txt' 02:08:05 INFO - no previously-included directories found matching 'build' 02:08:05 INFO - no previously-included directories found matching 'dist' 02:08:05 INFO - no previously-included directories found matching '.git*' 02:08:05 INFO - Successfully installed jsonschema functools32 02:08:05 INFO - Cleaning up... 02:08:06 INFO - Return code: 0 02:08:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:06 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 0x10d102a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d112420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce3355c260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, '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.y4qcndXWq3/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.QXiQHIzern/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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 02:08:06 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 02:08:06 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 02:08:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:08:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:06 INFO - 'HOME': '/Users/cltbld', 02:08:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:06 INFO - 'LOGNAME': 'cltbld', 02:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:06 INFO - 'MOZ_NO_REMOTE': '1', 02:08:06 INFO - 'NO_EM_RESTART': '1', 02:08:06 INFO - 'PAGER': '/bin/cat', 02:08:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:06 INFO - 'PWD': '/builds/slave/test', 02:08:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:06 INFO - 'SHELL': '/bin/bash', 02:08:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:08:06 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:08:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:06 INFO - 'USER': 'cltbld', 02:08:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:06 INFO - 'XPC_FLAGS': '0x0', 02:08:06 INFO - 'XPC_SERVICE_NAME': '0', 02:08:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:06 INFO - Downloading/unpacking flake8 02:08:06 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 02:08:06 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 02:08:06 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 02:08:06 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 02:08:06 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 02:08:06 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 02:08:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:09 INFO - no previously-included directories found matching 'docs/_build' 02:08:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:10 INFO - Running setup.py install for pep8 02:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:10 INFO - no previously-included directories found matching 'docs/_build' 02:08:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:10 INFO - Cleaning up... 02:08:10 INFO - Return code: 0 02:08:10 INFO - Running post-action listener: _resource_record_post_action 02:08:10 INFO - Running post-action listener: _start_resource_monitoring 02:08:10 INFO - Starting resource monitoring. 02:08:10 INFO - ##### 02:08:10 INFO - ##### Running install step. 02:08:10 INFO - ##### 02:08:10 INFO - Running pre-action listener: _resource_record_pre_action 02:08:10 INFO - Running main action method: install 02:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:10 INFO - Reading from file tmpfile_stdout 02:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:10 INFO - Reading from file tmpfile_stdout 02:08:10 INFO - Output received: 02:08:10 INFO - Usage: mozinstall [options] installer 02:08:10 INFO - Options: 02:08:10 INFO - -h, --help show this help message and exit 02:08:10 INFO - -d DEST, --destination=DEST 02:08:10 INFO - Directory to install application into. [default: 02:08:10 INFO - "/builds/slave/test"] 02:08:10 INFO - --app=APP Application being installed. [default: firefox] 02:08:10 INFO - mkdir: /builds/slave/test/build/application 02:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 02:08:32 INFO - Reading from file tmpfile_stdout 02:08:32 INFO - Output received: 02:08:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:08:32 INFO - Running post-action listener: _resource_record_post_action 02:08:32 INFO - ##### 02:08:32 INFO - ##### Running run-tests step. 02:08:32 INFO - ##### 02:08:32 INFO - Running pre-action listener: _resource_record_pre_action 02:08:32 INFO - Running main action method: run_tests 02:08:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:08:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:08:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:08:32 INFO - 2016-06-22 02:08:32.602 screenresolution[2112:10986] starting screenresolution argv=screenresolution get 02:08:32 INFO - 2016-06-22 02:08:32.605 screenresolution[2112:10986] Display 0: 1600x1200x32@60 02:08:32 INFO - 2016-06-22 02:08:32.611 screenresolution[2113:10988] starting screenresolution argv=screenresolution list 02:08:32 INFO - Available Modes on Display 0 02:08:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:08:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:08:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:08:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:08:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:08:32 INFO - Intel Iris: 02:08:32 INFO - Chipset Model: Intel Iris 02:08:32 INFO - Type: GPU 02:08:32 INFO - Bus: Built-In 02:08:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:08:32 INFO - Vendor: Intel (0x8086) 02:08:32 INFO - Device ID: 0x0a2e 02:08:32 INFO - Revision ID: 0x0009 02:08:32 INFO - Displays: 02:08:32 INFO - Display: 02:08:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:08:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:08:32 INFO - Display Serial Number: 1600x1200 60 02:08:32 INFO - Main Display: Yes 02:08:32 INFO - Mirror: Off 02:08:32 INFO - Online: Yes 02:08:32 INFO - Rotation: Supported 02:08:32 INFO - Return code: 0 02:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:32 INFO - Python 2.7.3 02:08:32 INFO - Return code: 0 02:08:32 INFO - grabbing minidump binary from tooltool 02:08: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')]} 02:08: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 0x10cfa1e00>, '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 0x10ce0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf9cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08: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 02:08: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 02:08:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:32 INFO - Return code: 0 02:08:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:34 INFO - Return code: 0 02:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 02:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0216 --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 02:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y4qcndXWq3/Render', 02:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:34 INFO - 'HOME': '/Users/cltbld', 02:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:34 INFO - 'LOGNAME': 'cltbld', 02:08:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:34 INFO - 'MOZ_NO_REMOTE': '1', 02:08:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:34 INFO - 'NO_EM_RESTART': '1', 02:08:34 INFO - 'PAGER': '/bin/cat', 02:08:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:34 INFO - 'PWD': '/builds/slave/test', 02:08:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:34 INFO - 'SHELL': '/bin/bash', 02:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QXiQHIzern/Listeners', 02:08:34 INFO - 'TMPDIR': '/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/', 02:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:34 INFO - 'USER': 'cltbld', 02:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:34 INFO - 'XPC_FLAGS': '0x0', 02:08:34 INFO - 'XPC_SERVICE_NAME': '0', 02:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0216', '--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 02:08:34 INFO - mozversion application_buildid: 20160622005102 02:08:34 INFO - mozversion application_changeset: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 02:08:34 INFO - mozversion application_display_name: Firefox 02:08:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:34 INFO - mozversion application_name: Firefox 02:08:34 INFO - mozversion application_remotingname: firefox 02:08:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:34 INFO - mozversion application_vendor: Mozilla 02:08:34 INFO - mozversion application_version: 48.0 02:08:34 INFO - mozversion platform_buildid: 20160622005102 02:08:34 INFO - mozversion platform_changeset: 3d3e03d528e015cb85dd7acf15e65443c0d3d589 02:08:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:34 INFO - mozversion platform_version: 48.0 02:08:34 INFO - using testdate: 1466586514 02:08:34 INFO - actual date: 1466586514 02:08:34 INFO - starting webserver on 'localhost:49672' 02:08:34 INFO - SUITE-START | Running 2 tests 02:08:34 INFO - TEST-START | dromaeo_css 02:08:34 INFO - operating with platform_type : mac_ 02:08:34 INFO - Initialising browser for dromaeo_css test... 02:08:34 INFO - TEST-INFO | started process 2131 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpVwVfsL/profile http://localhost:49672/getInfo.html) 02:08:36 INFO - PROCESS | 2131 | __metrics Screen width/height:1600/1200 02:08:36 INFO - PROCESS | 2131 | colorDepth:24 02:08:36 INFO - PROCESS | 2131 | Browser inner width/height: 1024/689 02:08:36 INFO - PROCESS | 2131 | __metrics 02:08:36 INFO - PROCESS | 2131 | 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" 02:08:36 ERROR - PROCESS | 2131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:08:37 INFO - TEST-INFO | 2131: exit 0 02:08:37 INFO - Browser initialized. 02:08:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:37 INFO - TEST-INFO | started process 2133 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmpVwVfsL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:48 INFO - PROCESS | 2133 | RSS: Main: 161533952 02:08:48 INFO - PROCESS | 2133 | 02:09:39 INFO - PROCESS | 2133 | 1466586579838 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] 02:11:49 INFO - PROCESS | 2133 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49672/tests/dromaeo/cssquery-ext.html) 02:11:51 INFO - PROCESS | 2133 | RSS: Main: 290971648 02:11:51 INFO - PROCESS | 2133 | 02:14:53 INFO - PROCESS | 2133 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-ext.html (next: http://localhost:49672/tests/dromaeo/cssquery-jquery.html) 02:14:54 INFO - PROCESS | 2133 | RSS: Main: 304922624 02:14:54 INFO - PROCESS | 2133 | 02:17:56 INFO - PROCESS | 2133 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49672/tests/dromaeo/cssquery-mootools.html) 02:17:57 INFO - PROCESS | 2133 | RSS: Main: 311652352 02:17:57 INFO - PROCESS | 2133 | 02:20:59 INFO - PROCESS | 2133 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49672/tests/dromaeo/cssquery-prototype.html) 02:20:59 INFO - PROCESS | 2133 | RSS: Main: 307613696 02:20:59 INFO - PROCESS | 2133 | 02:24:02 INFO - PROCESS | 2133 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49672/tests/dromaeo/cssquery-yui.html) 02:24:03 INFO - PROCESS | 2133 | RSS: Main: 273801216 02:24:03 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-yui.html (next: http://localhost:49672/tests/dromaeo/cssquery-dojo.html) 02:27:06 INFO - PROCESS | 2133 | RSS: Main: 316248064 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | __start_tp_report 02:27:06 INFO - PROCESS | 2133 | _x_x_mozilla_page_load 02:27:06 INFO - PROCESS | 2133 | _x_x_mozilla_page_load_details 02:27:06 INFO - PROCESS | 2133 | |i|pagename|runs| 02:27:06 INFO - PROCESS | 2133 | |0;dojo.html;2763.3782398960248;2896.33384321606;3566.8038257895814;3568.0544655666235;3635.1820840310916;5796.507296879765;5829.358770535237;5832.416758324165;5852.092925596534;5881.264841894763;5810.622309549876;5875.941240587593;5883.29400471944;5890.499307558852;5896.734646940888;5211.7133557654315;5237.10969135247;5252.474752524755;5315.574754019669;5452.6183167178315;5277.234800953859;5332.120200166968;5343.812966546172;5349.625526213166;5352.411234764173;5272.499112584298;5315.176147697113;5316.5215130638235;5316.574674026068;5334.946650533484;5307.38965019022;5347.331583552056;5362.195670649395;5368.275282836845;5396.730163491809;4087.305158123126;5169.638125331228;5177.171652535576;5190.169572868323;5296.205569164617;5606.131049687264;5644.57665675076;5668.943310566924;5680.005998950209;5689.459501347406;6299.275583307886;6348.206474190726;6349.8412539686415;6357.618542887441;6371.585846919982;5797.884042319172;6215.87568248637;6280.15217945576;6328.430441260309;6344.587601805868;5945.554083443716;5956.106584012433;5968.313643931004;5974.820755377345;6016.067509536029;6384.4254017137755;6386.074019267273;6386.616802991835;6391.105245265667;6400.967995159995;6109.114178444101;6181.072839074085;6278.46633036197;6290.968545157245;6296.874062518724;6210.192674952227;6355.586886852339;6356.650384228912;6361.9045714314325;6375.0437434384285;6253.187085678924;6334.144890439824;6351.491880649537;6363.809085727436;6372.36276372359;6182.443580077815;6269.467095296951;6290.119383286344;6322.810315690536;6341.365863413714;4993.6005119590345;5023.824166154167;5025.824096156617;5043.470435604282;5067.6199285053035;4493.393391892118;4526.23054080807;4531.43357080365;4540.910181556403;4554.544545545486;5752.28096487939;5815.41845815415;5863.3257175424515;5951.464368206882;5979.641221526722;6311.463525600376;6322.620642761449;6325.7153428094925;6332.810015699536;6337.841553961188;5838.5037271831525;5895.204147440127;5974.581779275496;5978;5979.222701048923;5454.290942177491;5460.726963651801;5470.343558772893;5477.75350109246;5484.2047903053835;6290.811275661737;6387.105805187278;6393.168888044617;6397.296297407282;6430.421262086435;6245.6252624842655;6277.843053923689;6306.810795676137;6315.778947736807;6320.525960553069;6392.456641185551;6424.935750642434;6428.935710642833;6440.194975628046;6444.516661250331;6155.953487907156;6222.564420490522;6324.30432652417;6325.683715814099;6338.714757835816;6288.968555157195;6319.6208227506495;6348.984162534157;6353.872922541431;6354.52341074412;6278.246610406781;6278.497720182283;6289.654069026247;6290.622562646256;6307.180066591313;6106.816795496142;6148.692565371803;6244.500439964882;6284.402981716729;6290.874182516415;6095.481884039907;6097.17688112117;6098.725557350019;6113.969430152821;6124.081387791867;6146.5390095742105;6215.285242197025;6260.624362538262;6268.1851359323;6275.811725648238;5963.28440587115;6007.12896629995;6023.216981792339;6106.93092925953;6115.209918062534 02:27:06 INFO - PROCESS | 2133 | |1;ext.html;531.9122394702832;535.2987586261996;553.3912696034361;556.0602581637035;616.0728104203174;31458.370832583336;32513;41180.79409602952;42406.151876962445;42475.57524424755;45278.86802829931;45444.77277613607;45790.85522861922;45898.77050614742;46076.07847843041;8802.383833131684;9841.065098815601;10074.395536267812;10077.14344280737;10081.848772268386;9136.908630913706;10983.890161098407;11741.823872641917;12021.939890300537;12313.753724925496;11868.643940681794;11941.522339106425;11958.402079896014;11965.940170299136;11968.102392320567;11928.284302941807;11998.580049698307;12000.97991670709;12019.699507512294;12031.157818952677;10144.94927525365;10190.9490452548;11582.420878956103;11714.88285117155;11850.170488065838;42171.36742948858;42404;42568;42586.78706606447;42596;3325.218573635194;3359.6472370401243;3854.8458061677497;3857.9228415431817;3987.5813039631003;28949.565756513668;29401.823927042893;29578;29801;30231.697683023107;2460.692413448319;2775.403288293027;2785.206216228365;2862.842543660098;2873.994102064282;519216;520044;521496;522102;522213;37427.06432339214;38070.42894356587;38074.42888356677;62341;62844;35890.64109358873;36258.63741362606;36421.08947276339;36447;36447.63552364495;16058;16229.675406491804;16250;16256.59358516023;16313.510594682179;12903.290319032356;12970.740585188243;13836.584902452943;13902.192714946992;14103.083299585494;8368.37237207212;8371.665133394596;8385.790355241168;8432.156784321518;8466.534340611202;3524.1718196223865;3551.3252482028847;3551.449525323579;3574.8927532174075;3597.1007248187952;949.9721182187475;1022.8772547294373;1030.2190959179827;1081.0918828184363;1145.7593905279984;27298.727012730014;30765.538516922265;30789;31025;31453;1097.6542389147394;1102.2174256278133;1143.525436943659;1163.1276542593055;1230.477047254931;14865.554033379016;15017.399304027935;15036.097834129987;15201.543953681406;15328.923355383151;621993;624199;631419;632981;634677;59694.40305596888;60251;60267.69866150641;60300;60408.69795650994;1433.0613448191452;1445.3134760988446;1529;1552.7049860526463;1560.1964988031173;29467;29557.85221073881;29618.407631847673;29966.70033299639;30189;51073.97852042864;51709;51818;51862.481375185766;51870.74064629653;499281;501814;501904;502530;503880;27481.31296717598;39022.609773901895;43419.9145021377;43896.56103438925;44225.55774442214;43719.56280437155;45466;46628;47146.05707885754;47579.52420475751;31401;36122.27755444929;38418.0395490115;38929.6107038926;39037.609623903394;37601;37808.43287350747;38323.233535329695;38937.83186504409;38993.610063898996;38492.03769905663;38670.6132938667;39612.60387396089;39976.8001160004;40925.18149636931;27746.44507109806;30420;32551.837240813646;32663.67336326606;33372.99762014287;25207.305133174756;25456.745432546177;25561.488770224863;25912.61131083073;26056.34859128461 02:27:06 INFO - PROCESS | 2133 | |2;jquery.html;416.09706935948986;416.13444036404275;418.06353767560665;418.73201151263197;427.20326590907945;20372.185112595496;21171;21222;21735.13059477619;22776.54446911061;12472.314022728746;12758.170718903288;19133.33033343833;22471.438214044658;22518.66222006671;5388.676679399229;5700.087985922253;5815.447532484428;6154.230721159855;6160.84597885052;4154.210699966997;4369.126174765044;5851.7074146292725;6051;6126.0810878368375;6174.938250617482;6185.257769067718;6198.070289456595;6201.720922558473;6208.720607572647;6141.938580614204;6169.876602467948;6793.082933803923;6797.830054248634;6813.625250611214;4073.714839961204;5776.364599894008;6066.332703402666;6080.665563394012;6090.26916769986;13824.723505529833;14028.859711402858;14129.576112716635;14302.71394572113;14308.713825723531;2177.7495588007423;2205.485489054265;2267.0818318580837;2281.863088214696;2307.4810913357096;10125.392476451363;10428.322159059713;10441.947790261076;11938.761224775542;12232.449539770732;1581.992090039554;1752.6144248265362;1792.507060558344;1822.7265910113456;1836.1461920207034;113835;115926.26110608263;116324.41837790841;119264.40367798193;119605.40197298958;9834.704958851245;11683.591074312359;11927.389802376741;12117.091218158674;12290.569830056083;15671.451499197474;15826.44607438734;15843.762343564857;15901.363945442285;15911.363545458284;9429.717108486757;9430.19843313326;9446.38598491096;9457.243420526342;9551.904480955101;8768.167024132825;9524.238060955246;9537;9561.569729362196;9614.663486778069;4392.472903251566;4855.198892182821;4855.344528488679;4858.368412106403;4922.187839006596;1781.9894203452575;1946.4452631000097;1995.630808300469;2097.632914240002;2099.611571859211;929.7861491856911;934.238595544629;1023.0281232828694;1033.1476531861244;1091.050785816329;16512.4220652279;20273.18907243723;20698.379048628565;21003.894980525307;21090.367288981353;990.5641517732175;1008.294194064158;1027.244974943416;1032.6334151376304;1062.6758838554315;11292.830607540893;11623.709407264716;11630.476628551736;11633.360165190996;11633.88366116328;616209.9189504114;623344;627213;645388;646418;126541.36729316479;126960.36519817526;128682.35658821833;129679;137427;1000.849872519128;1052.2529004406956;1056.12869382758;1122.231271578971;1122.7080958950733;17826.37607683725;18697.53256168607;18705;18714.344997925553;19017.904910475358;53435;53437.465625344805;53520.4647953531;53780;55738.60653483533;74675.62662186654;75272;76926;77975;80047;8415.621297041771;8440.873386899078;8521.957390213258;8575.65697372123;8694.347923905605;9214.769630759285;12120.212351159458;13044.478220871439;13068.54260100892;13286.003549734001;10895.400752958663;11012.449377530931;11507.252028618113;11514.078873690252;11669.88330116722;9365.203957663674;10864.348139111678;11082.944585277344;11478.713032174262;11575.189736718348;11284.266522676;11521.769564608829;11835.881641183478;11848.526058957545;11871.109666774853;8433.325333973145;8474.533900635524;8506.404551681322;8631.6978905738;8813.030566637537;11315.20793544444;11419;11679.06567474617;11691.415429228335;11766.176367654525 02:27:06 INFO - PROCESS | 2133 | |3;mootools.html;1445.2340259662383;1579.6651829204318;1586.5795564175496;1824.8996305203216;1965.8918759468224;8215.835683286337;8433.24100830925;8444.535550544726;8448.788780280496;8450.450720703158;8393.622286997084;8602.569871506415;8654.048054713992;8670.002949660791;8683.305335573155;2469.5801713708624;2537.555927712652;2537.9111731089415;2540.5808041673104;2541.4917016596664;2455.987720061406;2559.9616005759926;2561.3212498687863;2561.4236796720684;2563.192594332779;2196.8132708719777;2506.586413241813;2540.2252313044514;2553.6807899012624;2556.4759224359054;2499.125306142854;2533.328667903007;2540.64430979663;2550.885210165547;2552.872356382192;2486.3908342456216;2519;2527.772500474966;2533.1513942829174;2546.567083595793;9067.274618030542;9092.818143637156;9105.908940910573;9106.590203440861;9116.453012819185;5483.890322193533;5577.05190117681;5591.4688104629995;5691.089425691911;5731.168980497846;3244.351129774031;3640.271945610862;3748.700103991674;3762.6049264827348;3778.017715394017;1068.6954218047897;1069.0859315285397;1097.8627671541058;1108.0692218536387;1116.6705821782512;11796;11820.23168494045;11854.644360669194;11873.881261187364;11878.584249551224;4672.252439609714;4687.203175460112;4835.1296766581645;4853.3447984522345;4856.68431551948;9395;9498.19265362452;9531.38046027006;9534.952325238468;9545.997670244664;5408.91886621701;5454.400015998237;5455.8363249102595;5470;5484.670919744828;4352.216601011848;4572.1312950539295;4770.928436073462;4984.352034235599;5067.797288108434;3358.7648864579246;4019.4171845082883;4055.4930633670792;4072.9613948442957;4157.127003329274;1213.9210951288314;1232.679503329141;1232.827404163418;1234.1977714485656;1238.8946939510063;951.6098399656246;952.7427594549433;976.4580657734883;984.542187882638;1001.249063202598;6073.605215661057;6119.418655227835;6185.8144255672405;6274.874502510015;6310.873782524323;437.9102284031766;476.4211483048113;482.58497691984866;490.8870959679294;495.85372315167115;4041.413994970713;4082.6733861291027;4117.094239267356;4158.625723684883;4170.52039015511;10269.229807764448;10687.984641459048;10717.035466808025;10733.08768754649;10735.83896241557;10460.424676642706;10467.738306542245;10503.422311772925;10515;10548.419836909045;8268.669253229804;8430.620622072021;8513.787155321043;8532.658693652184;8548.316134709208;5790.044642633919;5925.9407405925385;6121.204243448323;6139.386061393825;6221.5333849962335;9486.193673537826;9597.664081757104;9842.11420972116;9886.357386769838;9914.950425247827;8707.47755134694;9465.337426380363;9961.601535938482;10041;10237.641682541076;6999.580025198505;7239.963800180965;7425.851482970418;7720.227977202235;7864;8455.154484551496;8528.530930798866;8544.871826922725;8603.526806025478;8611.095834937241;7451.366633835968;7531.435142364235;7606.163322034461;7682.846343073219;7739.845203096019;7406.852387446141;7412.221716719882;7434;7526.473146879666;7571.545707257582;7173.820654483679;7278.126624805057;7317.2316906726155;7323.7436689715605;7324.194338622854;4305.2896272116;5020.899582008413;5066.442691304027;5084.542391184811;5139.717315547681;5022.648414610942;5095.082885080573;5127.256547800623;5192.818251361185;5372.758225879923 02:27:06 INFO - PROCESS | 2133 | |4;prototype.html;326.26915708812254;330.73210699333544;341.0671812592561;341.808587191173;347.2863265988394;6482.1573195484525;6657.300983396746;6686.732530698772;6736.124303840494;6744.224414192363;6503.252126005511;6607.5374723769355;6614.1070955421;6678.632675202862;6715.146062923262;4958.504149585049;4988.02733466974;5028.396592408916;5031.597472202215;5033.471485494026;5005.6746311489815;5013.874653133683;5015.247712843066;5016.27264046713;5038.269450929613;3830.942535861964;4863.051704917542;4866.635002374818;4868.878278043042;4884.535969082932;3880.9417858732;4774.307725379818;4915.9754201229125;4917.139500587418;4951.702897826142;4187.413762073312;4200.235900921621;4204.2432362174795;4206.116715489751;4212.157568486315;5737.963023126772;5943.3462319144855;6388.776392826276;6425.871482570323;6442.549021568492;5808.215890854723;5819.447152520504;5831.766729330821;5834.64992100471;5846.941530584682;6733.293004234582;7004.5096843221;7049.753258635975;7066.116735408074;7077.567379820783;3818.3508803503473;4589.931151032737;4594.862154135381;4610.239310513761;4631.907361852744;7431.516951398142;7518.43611729117;7535.321821036133;7543.7736867894055;7546.245375462465;4666.486686464486;4682.367880336179;4691.179043667345;4692.498400511803;4695.107929493385;4751.714897106184;4757.976210118927;4763.595094416944;4767.808047988003;4778.546038126373;5490.396056433789;5578.609497335228;5680.914786278209;5688.033034384164;5730.713464326767;7126.073610430611;7138.964305178441;7166.462515311373;7168.462365322622;7190.964045179845;1632.7224371856812;1652.5290292266645;1653.5287443078664;1655.6026553627044;1658.353242235529;990.955407006672;995.0596686131536;1023.2019025160387;1032.9638462653922;1063.7606538528769;6690.732370705215;6845.110135682329;6852.588844669336;6876.243613202544;6878.174619045646;7463.552186868806;7478.887816682754;7500.137484189279;7510.586917719578;7512.887306690404;6807.727690892309;6826.180858297036;6832.59004459734;6839.213490448662;6858.3827455529245;3801.201747633028;3905.199434116056;3946;3952.2293152835496;3952.2490726761825;7755.573443460551;7755.612219389121;7801;7803.414743894117;7813.413993950477;7588.468807183444;7622.69509219625;7630;7643.617819109022;7661.387089032864;7738.7291444800285;7764.06831180262;7776.961115194388;7777.494462859896;7777.844443111106;5988.401159884151;7145.714171433085;7431.145418276968;7440.776776696492;7447.329740323397;7229.963850180716;7265.346118849329;7279.7816065516;7288.562686238843;7296.927030729625;7724.420668449777;7763.611819408894;7767.262110099531;7769.378449724121;7771.950786643731;4685.390899183084;4686.765661716969;4690.601298889633;4700.4829468757725;4701.553352431513;6667.733130705151;6762.729490820312;7024.438044956493;7373.262673732584;7400.962995184989;6009.038553831366;6853.965730171317;7124.643767811485;7129.180144283474;7145.82135446618;7110.928890711233;7128.964355178191;7138.357547820721;7169.211386747558;7170.892436613351;6978.127734033246;6990.161180658353;6992.475564332797;6994.300569942965;7001.439884809101;6906.551074180162;7114.57312561248;7129.144502659714;7144.67848946809;7146.964265178641;5447.992121457543;5571.721413929368;6831.11195544576;6971.442284617117;7002.614856182959 02:27:06 INFO - PROCESS | 2133 | |5;yui.html;732.362844325437;770.5492287012098;789.8104454930815;792.3383974381392;803.9879401808972;15219.391224351026;15477.535673929771;15552.611184720388;15587.84412155878;15605.21973901306;14391.856081439182;14408.207548584824;14409.351579178936;14450.855491445081;14459.710805783905;759.4987308376459;769.8537277917205;776.9611519424006;950.909663581962;953.1469334945219;940.5438362394233;952.5761036338832;953.5137080089136;953.6471505542959;954.374884450686;915.4644532948233;1018.1651046142166;1019.1693769577807;1022.2537547590226;1023.8720159980003;812.175641723648;829.4567058576582;829.7344849648085;984.9655262065793;1014.9797004059915;753.3144838197269;753.6872198037807;754.4266357568233;755.252300222781;755.7581573896356;15111.244437778067;15199.544013679608;15231.314590843438;15232.314545845464;15271.160086195256;12368.628941131781;12738.490460381574;12954.157979731288;13114.737705245938;13162.144460610125;11180.720481987933;11224.04595609366;11317.03805176561;11438.313701177956;11674.649760507198;3316.585426821647;3558.4128618777872;3632.456206112418;3663.432168013962;3805.162864169906;83471.07851225178;83532.58233708792;84816.3036739268;87050.5647471765;87688;9808.068233517804;9878.357906736039;9977.45124018186;10025.248106391904;10032;22513.43716407103;22542;22545;22550.436239094153;22571.88714056419;7714.691412343555;7726.729564465217;7809.492382995087;7915.960420197977;7940.28537431634;4183.581641835853;4251.617354438115;4306.1172459645695;4332.133573285356;4426.424564806554;3767.2842159989514;3832.885013449545;3844;3848.3073046851277;3848.6728628066367;590.7725525672647;681.3969636871404;690.3890057299326;702.3222590200481;715.9713611455587;611.4069352727847;612.5222326585271;625.8842114208886;628.7924984755019;647.9254885688111;7834.099078605919;7922.168172341936;8398.328133749286;8511.233988941025;8577.528235947082;600.67263341479;605.6608299352376;617.450469082517;618.7741474361826;633.1831936801475;3383.2218589724503;3702.33357995558;3934.1541568562325;4026.7583944963394;4108.110269276166;78164.82752758713;82267.58866205631;83676.58161709152;88449.11550884409;92822;78116.21883781203;78583;80835.5958220205;80868.19131808724;85619.57190214009;69584;70710;70950.2262443443;72583.82248532448;77830.4827744444;8575.699850505453;8627.91372086271;8810.515421651615;8812.427192232484;8902.777430564029;49415.7529212366;50237.49762502328;51067;51797.74101129621;52398;69202;73788;73964.63017684878;74229.25770742439;74433;10875.347479151276;11114.944425277821;11270.323780573191;11330.320180789178;11424.885751142714;11958.940205298917;12102;12198.085143614442;12203.938980305042;12565.937170314455;11705.941470292593;11782.646520604396;11813.350265735467;11860.703482413008;11871.99088077523;11570.884291157317;11726.589569365031;11809.468573914022;11809.468573914022;12272.079594030662;11238.887611123784;11418.82871756941;11620.6513804586;12268.509259629514;12369.391979042666;9630.566624501775;9630.711078667651;9895.257855660999;10085.344452610558;10174.796504070026;9569;9677.467739274407;9682.56428460707;9698.70903872885;9816.361936474106 02:27:06 INFO - PROCESS | 2133 | __end_tp_report 02:27:06 INFO - PROCESS | 2133 | __start_cc_report 02:27:06 INFO - PROCESS | 2133 | _x_x_mozilla_cycle_collect,1103 02:27:06 INFO - PROCESS | 2133 | __end_cc_report 02:27:06 INFO - PROCESS | 2133 | __startTimestamp1466587626362__endTimestamp 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | ------- Summary: start ------- 02:27:06 INFO - PROCESS | 2133 | Number of tests: 6 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | [#0] dojo.html Cycles:165 Average:5841.32 Median:6106.82 stddev:675.73 (11.1%) stddev-sans-first:633.20 02:27:06 INFO - PROCESS | 2133 | Values: 2763.4 2896.3 3566.8 3568.1 3635.2 5796.5 5829.4 5832.4 5852.1 5881.3 5810.6 5875.9 5883.3 5890.5 5896.7 5211.7 5237.1 5252.5 5315.6 5452.6 5277.2 5332.1 5343.8 5349.6 5352.4 5272.5 5315.2 5316.5 5316.6 5334.9 5307.4 5347.3 5362.2 5368.3 5396.7 4087.3 5169.6 5177.2 5190.2 5296.2 5606.1 5644.6 5668.9 5680.0 5689.5 6299.3 6348.2 6349.8 6357.6 6371.6 5797.9 6215.9 6280.2 6328.4 6344.6 5945.6 5956.1 5968.3 5974.8 6016.1 6384.4 6386.1 6386.6 6391.1 6401.0 6109.1 6181.1 6278.5 6291.0 6296.9 6210.2 6355.6 6356.7 6361.9 6375.0 6253.2 6334.1 6351.5 6363.8 6372.4 6182.4 6269.5 6290.1 6322.8 6341.4 4993.6 5023.8 5025.8 5043.5 5067.6 4493.4 4526.2 4531.4 4540.9 4554.5 5752.3 5815.4 5863.3 5951.5 5979.6 6311.5 6322.6 6325.7 6332.8 6337.8 5838.5 5895.2 5974.6 5978.0 5979.2 5454.3 5460.7 5470.3 5477.8 5484.2 6290.8 6387.1 6393.2 6397.3 6430.4 6245.6 6277.8 6306.8 6315.8 6320.5 6392.5 6424.9 6428.9 6440.2 6444.5 6156.0 6222.6 6324.3 6325.7 6338.7 6289.0 6319.6 6349.0 6353.9 6354.5 6278.2 6278.5 6289.7 6290.6 6307.2 6106.8 6148.7 6244.5 6284.4 6290.9 6095.5 6097.2 6098.7 6114.0 6124.1 6146.5 6215.3 6260.6 6268.2 6275.8 5963.3 6007.1 6023.2 6106.9 6115.2 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | [#1] ext.html Cycles:180 Average:67903.96 Median:19732.77 stddev:147829.31 (749.2%) stddev-sans-first:148157.46 02:27:06 INFO - PROCESS | 2133 | Values: 531.9 535.3 553.4 556.1 616.1 31458.4 32513.0 41180.8 42406.2 42475.6 45278.9 45444.8 45790.9 45898.8 46076.1 8802.4 9841.1 10074.4 10077.1 10081.8 9136.9 10983.9 11741.8 12021.9 12313.8 11868.6 11941.5 11958.4 11965.9 11968.1 11928.3 11998.6 12001.0 12019.7 12031.2 10144.9 10190.9 11582.4 11714.9 11850.2 42171.4 42404.0 42568.0 42586.8 42596.0 3325.2 3359.6 3854.8 3857.9 3987.6 28949.6 29401.8 29578.0 29801.0 30231.7 2460.7 2775.4 2785.2 2862.8 2874.0 519216.0 520044.0 521496.0 522102.0 522213.0 37427.1 38070.4 38074.4 62341.0 62844.0 35890.6 36258.6 36421.1 36447.0 36447.6 16058.0 16229.7 16250.0 16256.6 16313.5 12903.3 12970.7 13836.6 13902.2 14103.1 8368.4 8371.7 8385.8 8432.2 8466.5 3524.2 3551.3 3551.4 3574.9 3597.1 950.0 1022.9 1030.2 1081.1 1145.8 27298.7 30765.5 30789.0 31025.0 31453.0 1097.7 1102.2 1143.5 1163.1 1230.5 14865.6 15017.4 15036.1 15201.5 15328.9 621993.0 624199.0 631419.0 632981.0 634677.0 59694.4 60251.0 60267.7 60300.0 60408.7 1433.1 1445.3 1529.0 1552.7 1560.2 29467.0 29557.9 29618.4 29966.7 30189.0 51074.0 51709.0 51818.0 51862.5 51870.7 499281.0 501814.0 501904.0 502530.0 503880.0 27481.3 39022.6 43419.9 43896.6 44225.6 43719.6 45466.0 46628.0 47146.1 47579.5 31401.0 36122.3 38418.0 38929.6 39037.6 37601.0 37808.4 38323.2 38937.8 38993.6 38492.0 38670.6 39612.6 39976.8 40925.2 27746.4 30420.0 32551.8 32663.7 33373.0 25207.3 25456.7 25561.5 25912.6 26056.3 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | [#2] jquery.html Cycles:180 Average:35800.54 Median:11551.75 stddev:105183.73 (910.5%) stddev-sans-first:105445.24 02:27:06 INFO - PROCESS | 2133 | Values: 416.1 416.1 418.1 418.7 427.2 20372.2 21171.0 21222.0 21735.1 22776.5 12472.3 12758.2 19133.3 22471.4 22518.7 5388.7 5700.1 5815.4 6154.2 6160.8 4154.2 4369.1 5851.7 6051.0 6126.1 6174.9 6185.3 6198.1 6201.7 6208.7 6141.9 6169.9 6793.1 6797.8 6813.6 4073.7 5776.4 6066.3 6080.7 6090.3 13824.7 14028.9 14129.6 14302.7 14308.7 2177.7 2205.5 2267.1 2281.9 2307.5 10125.4 10428.3 10441.9 11938.8 12232.4 1582.0 1752.6 1792.5 1822.7 1836.1 113835.0 115926.3 116324.4 119264.4 119605.4 9834.7 11683.6 11927.4 12117.1 12290.6 15671.5 15826.4 15843.8 15901.4 15911.4 9429.7 9430.2 9446.4 9457.2 9551.9 8768.2 9524.2 9537.0 9561.6 9614.7 4392.5 4855.2 4855.3 4858.4 4922.2 1782.0 1946.4 1995.6 2097.6 2099.6 929.8 934.2 1023.0 1033.1 1091.1 16512.4 20273.2 20698.4 21003.9 21090.4 990.6 1008.3 1027.2 1032.6 1062.7 11292.8 11623.7 11630.5 11633.4 11633.9 616209.9 623344.0 627213.0 645388.0 646418.0 126541.4 126960.4 128682.4 129679.0 137427.0 1000.8 1052.3 1056.1 1122.2 1122.7 17826.4 18697.5 18705.0 18714.3 19017.9 53435.0 53437.5 53520.5 53780.0 55738.6 74675.6 75272.0 76926.0 77975.0 80047.0 8415.6 8440.9 8522.0 8575.7 8694.3 9214.8 12120.2 13044.5 13068.5 13286.0 10895.4 11012.4 11507.3 11514.1 11669.9 9365.2 10864.3 11082.9 11478.7 11575.2 11284.3 11521.8 11835.9 11848.5 11871.1 8433.3 8474.5 8506.4 8631.7 8813.0 11315.2 11419.0 11679.1 11691.4 11766.2 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | [#3] mootools.html Cycles:180 Average:5762.76 Median:5067.12 stddev:3164.03 (62.4%) stddev-sans-first:3156.27 02:27:06 INFO - PROCESS | 2133 | Values: 1445.2 1579.7 1586.6 1824.9 1965.9 8215.8 8433.2 8444.5 8448.8 8450.5 8393.6 8602.6 8654.0 8670.0 8683.3 2469.6 2537.6 2537.9 2540.6 2541.5 2456.0 2560.0 2561.3 2561.4 2563.2 2196.8 2506.6 2540.2 2553.7 2556.5 2499.1 2533.3 2540.6 2550.9 2552.9 2486.4 2519.0 2527.8 2533.2 2546.6 9067.3 9092.8 9105.9 9106.6 9116.5 5483.9 5577.1 5591.5 5691.1 5731.2 3244.4 3640.3 3748.7 3762.6 3778.0 1068.7 1069.1 1097.9 1108.1 1116.7 11796.0 11820.2 11854.6 11873.9 11878.6 4672.3 4687.2 4835.1 4853.3 4856.7 9395.0 9498.2 9531.4 9535.0 9546.0 5408.9 5454.4 5455.8 5470.0 5484.7 4352.2 4572.1 4770.9 4984.4 5067.8 3358.8 4019.4 4055.5 4073.0 4157.1 1213.9 1232.7 1232.8 1234.2 1238.9 951.6 952.7 976.5 984.5 1001.2 6073.6 6119.4 6185.8 6274.9 6310.9 437.9 476.4 482.6 490.9 495.9 4041.4 4082.7 4117.1 4158.6 4170.5 10269.2 10688.0 10717.0 10733.1 10735.8 10460.4 10467.7 10503.4 10515.0 10548.4 8268.7 8430.6 8513.8 8532.7 8548.3 5790.0 5925.9 6121.2 6139.4 6221.5 9486.2 9597.7 9842.1 9886.4 9915.0 8707.5 9465.3 9961.6 10041.0 10237.6 6999.6 7240.0 7425.9 7720.2 7864.0 8455.2 8528.5 8544.9 8603.5 8611.1 7451.4 7531.4 7606.2 7682.8 7739.8 7406.9 7412.2 7434.0 7526.5 7571.5 7173.8 7278.1 7317.2 7323.7 7324.2 4305.3 5020.9 5066.4 5084.5 5139.7 5022.6 5095.1 5127.3 5192.8 5372.8 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | [#4] prototype.html Cycles:180 Average:5823.07 Median:6702.94 stddev:1878.18 (28.0%) stddev-sans-first:1837.58 02:27:06 INFO - PROCESS | 2133 | Values: 326.3 330.7 341.1 341.8 347.3 6482.2 6657.3 6686.7 6736.1 6744.2 6503.3 6607.5 6614.1 6678.6 6715.1 4958.5 4988.0 5028.4 5031.6 5033.5 5005.7 5013.9 5015.2 5016.3 5038.3 3830.9 4863.1 4866.6 4868.9 4884.5 3880.9 4774.3 4916.0 4917.1 4951.7 4187.4 4200.2 4204.2 4206.1 4212.2 5738.0 5943.3 6388.8 6425.9 6442.5 5808.2 5819.4 5831.8 5834.6 5846.9 6733.3 7004.5 7049.8 7066.1 7077.6 3818.4 4589.9 4594.9 4610.2 4631.9 7431.5 7518.4 7535.3 7543.8 7546.2 4666.5 4682.4 4691.2 4692.5 4695.1 4751.7 4758.0 4763.6 4767.8 4778.5 5490.4 5578.6 5680.9 5688.0 5730.7 7126.1 7139.0 7166.5 7168.5 7191.0 1632.7 1652.5 1653.5 1655.6 1658.4 991.0 995.1 1023.2 1033.0 1063.8 6690.7 6845.1 6852.6 6876.2 6878.2 7463.6 7478.9 7500.1 7510.6 7512.9 6807.7 6826.2 6832.6 6839.2 6858.4 3801.2 3905.2 3946.0 3952.2 3952.2 7755.6 7755.6 7801.0 7803.4 7813.4 7588.5 7622.7 7630.0 7643.6 7661.4 7738.7 7764.1 7777.0 7777.5 7777.8 5988.4 7145.7 7431.1 7440.8 7447.3 7230.0 7265.3 7279.8 7288.6 7296.9 7724.4 7763.6 7767.3 7769.4 7772.0 4685.4 4686.8 4690.6 4700.5 4701.6 6667.7 6762.7 7024.4 7373.3 7401.0 6009.0 6854.0 7124.6 7129.2 7145.8 7110.9 7129.0 7138.4 7169.2 7170.9 6978.1 6990.2 6992.5 6994.3 7001.4 6906.6 7114.6 7129.1 7144.7 7147.0 5448.0 5571.7 6831.1 6971.4 7002.6 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - PROCESS | 2133 | [#5] yui.html Cycles:180 Average:18760.85 Median:603.17 stddev:26075.10 (4323.0%) stddev-sans-first:26113.11 02:27:06 INFO - PROCESS | 2133 | Values: 732.4 770.5 789.8 792.3 804.0 15219.4 15477.5 15552.6 15587.8 15605.2 14391.9 14408.2 14409.4 14450.9 14459.7 759.5 769.9 777.0 950.9 953.1 940.5 952.6 953.5 953.6 954.4 915.5 1018.2 1019.2 1022.3 1023.9 812.2 829.5 829.7 985.0 1015.0 753.3 753.7 754.4 755.3 755.8 15111.2 15199.5 15231.3 15232.3 15271.2 12368.6 12738.5 12954.2 13114.7 13162.1 11180.7 11224.0 11317.0 11438.3 11674.6 3316.6 3558.4 3632.5 3663.4 3805.2 83471.1 83532.6 84816.3 87050.6 87688.0 9808.1 9878.4 9977.5 10025.2 10032.0 22513.4 22542.0 22545.0 22550.4 22571.9 7714.7 7726.7 7809.5 7916.0 7940.3 4183.6 4251.6 4306.1 4332.1 4426.4 3767.3 3832.9 3844.0 3848.3 3848.7 590.8 681.4 690.4 702.3 716.0 611.4 612.5 625.9 628.8 647.9 7834.1 7922.2 8398.3 8511.2 8577.5 600.7 605.7 617.5 618.8 633.2 3383.2 3702.3 3934.2 4026.8 4108.1 78164.8 82267.6 83676.6 88449.1 92822.0 78116.2 78583.0 80835.6 80868.2 85619.6 69584.0 70710.0 70950.2 72583.8 77830.5 8575.7 8627.9 8810.5 8812.4 8902.8 49415.8 50237.5 51067.0 51797.7 52398.0 69202.0 73788.0 73964.6 74229.3 74433.0 10875.3 11114.9 11270.3 11330.3 11424.9 11958.9 12102.0 12198.1 12203.9 12565.9 11705.9 11782.6 11813.4 11860.7 11872.0 11570.9 11726.6 11809.5 11809.5 12272.1 11238.9 11418.8 11620.7 12268.5 12369.4 9630.6 9630.7 9895.3 10085.3 10174.8 9569.0 9677.5 9682.6 9698.7 9816.4 02:27:06 INFO - PROCESS | 2133 | -------- Summary: end -------- 02:27:06 INFO - PROCESS | 2133 | 02:27:06 INFO - TEST-INFO | 2133: exit 0 02:27:06 INFO - TEST-OK | dromaeo_css | took 1112620ms 02:27:06 INFO - TEST-START | kraken 02:27:06 INFO - operating with platform_type : mac_ 02:27:06 INFO - Initialising browser for kraken test... 02:27:06 INFO - TEST-INFO | started process 2249 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmp3dZIDN/profile http://localhost:49672/getInfo.html) 02:27:09 INFO - PROCESS | 2249 | __metrics Screen width/height:1600/1200 02:27:09 INFO - PROCESS | 2249 | colorDepth:24 02:27:09 INFO - PROCESS | 2249 | Browser inner width/height: 1024/689 02:27:09 INFO - PROCESS | 2249 | __metrics 02:27:09 INFO - PROCESS | 2249 | 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" 02:27:09 ERROR - PROCESS | 2249 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:27:10 INFO - TEST-INFO | 2249: exit 0 02:27:10 INFO - Browser initialized. 02:27:10 INFO - Running cycle 1/1 for kraken test... 02:27:10 INFO - TEST-INFO | started process 2252 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/T/tmp3dZIDN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:22 INFO - PROCESS | 2252 | RSS: Main: 161677312 02:27:22 INFO - PROCESS | 2252 | 02:27:24 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:25 INFO - PROCESS | 2252 | RSS: Main: 224006144 02:27:25 INFO - PROCESS | 2252 | 02:27:28 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-dft) 02:27:28 INFO - PROCESS | 2252 | RSS: Main: 239480832 02:27:28 INFO - PROCESS | 2252 | 02:27:31 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-fft) 02:27:32 INFO - PROCESS | 2252 | RSS: Main: 324448256 02:27:32 INFO - PROCESS | 2252 | 02:27:34 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-oscillator) 02:27:34 INFO - PROCESS | 2252 | RSS: Main: 231051264 02:27:34 INFO - PROCESS | 2252 | 02:27:37 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:37 INFO - PROCESS | 2252 | RSS: Main: 231522304 02:27:37 INFO - PROCESS | 2252 | 02:27:40 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49672/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:41 INFO - PROCESS | 2252 | RSS: Main: 268554240 02:27:41 INFO - PROCESS | 2252 | 02:27:43 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49672/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:44 INFO - PROCESS | 2252 | RSS: Main: 269307904 02:27:44 INFO - PROCESS | 2252 | 02:27:47 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49672/tests/kraken/driver.html?testName=json-parse-financial) 02:27:47 INFO - PROCESS | 2252 | RSS: Main: 268169216 02:27:47 INFO - PROCESS | 2252 | 02:27:49 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:50 INFO - PROCESS | 2252 | RSS: Main: 260198400 02:27:50 INFO - PROCESS | 2252 | 02:27:51 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:52 INFO - PROCESS | 2252 | RSS: Main: 266534912 02:27:52 INFO - PROCESS | 2252 | 02:27:54 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:55 INFO - PROCESS | 2252 | RSS: Main: 270594048 02:27:55 INFO - PROCESS | 2252 | 02:27:57 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:58 INFO - PROCESS | 2252 | RSS: Main: 277528576 02:27:58 INFO - PROCESS | 2252 | 02:28:01 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:01 INFO - PROCESS | 2252 | RSS: Main: 274784256 02:28:01 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49672/tests/kraken/driver.html?testName=ai-astar) 02:28:03 INFO - PROCESS | 2252 | RSS: Main: 335818752 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | __start_tp_report 02:28:03 INFO - PROCESS | 2252 | _x_x_mozilla_page_load 02:28:03 INFO - PROCESS | 2252 | _x_x_mozilla_page_load_details 02:28:03 INFO - PROCESS | 2252 | |i|pagename|runs| 02:28:03 INFO - PROCESS | 2252 | |0;ai-astar;114;114;119;111;109;112;112;114;112;132 02:28:03 INFO - PROCESS | 2252 | |1;audio-beat-detection;157;122;143;160;119;139;117;156;154;117 02:28:03 INFO - PROCESS | 2252 | |2;audio-dft;182;185;187;184;185;183;185;183;183;182 02:28:03 INFO - PROCESS | 2252 | |3;audio-fft;71;79;72;156;56;55;56;67;131;55 02:28:03 INFO - PROCESS | 2252 | |4;audio-oscillator;92;90;151;80;88;87;126;79;78;124 02:28:03 INFO - PROCESS | 2252 | |5;imaging-gaussian-blur;88;86;133;88;90;86;89;86;89;86 02:28:03 INFO - PROCESS | 2252 | |6;imaging-darkroom;93;93;93;94;93;94;93;93;93;93 02:28:03 INFO - PROCESS | 2252 | |7;imaging-desaturate;84;86;83;85;86;83;83;83;83;83 02:28:03 INFO - PROCESS | 2252 | |8;json-parse-financial;59;58;61;84;89;89;87;78;59;57 02:28:03 INFO - PROCESS | 2252 | |9;json-stringify-tinderbox;60;64;62;71;68;72;67;65;65;66 02:28:03 INFO - PROCESS | 2252 | |10;stanford-crypto-aes;81;80;79;80;80;78;78;80;80;82 02:28:03 INFO - PROCESS | 2252 | |11;stanford-crypto-ccm;115;127;127;126;122;133;109;120;144;144 02:28:03 INFO - PROCESS | 2252 | |12;stanford-crypto-pbkdf2;164;164;161;171;165;164;163;162;161;160 02:28:03 INFO - PROCESS | 2252 | |13;stanford-crypto-sha256-iterative;67;67;68;70;91;90;91;87;67;65 02:28:03 INFO - PROCESS | 2252 | __end_tp_report 02:28:03 INFO - PROCESS | 2252 | __start_cc_report 02:28:03 INFO - PROCESS | 2252 | _x_x_mozilla_cycle_collect,1914 02:28:03 INFO - PROCESS | 2252 | __end_cc_report 02:28:03 INFO - PROCESS | 2252 | __startTimestamp1466587683962__endTimestamp 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | ------- Summary: start ------- 02:28:03 INFO - PROCESS | 2252 | Number of tests: 14 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:6.56 (5.8%) stddev-sans-first:6.95 02:28:03 INFO - PROCESS | 2252 | Values: 114.0 114.0 119.0 111.0 109.0 112.0 112.0 114.0 112.0 132.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:148.50 stddev:18.10 (12.2%) stddev-sans-first:17.90 02:28:03 INFO - PROCESS | 2252 | Values: 157.0 122.0 143.0 160.0 119.0 139.0 117.0 156.0 154.0 117.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.60 (0.9%) stddev-sans-first:1.54 02:28:03 INFO - PROCESS | 2252 | Values: 182.0 185.0 187.0 184.0 185.0 183.0 185.0 183.0 183.0 182.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#3] audio-fft Cycles:10 Average:79.80 Median:61.50 stddev:35.11 (57.1%) stddev-sans-first:37.09 02:28:03 INFO - PROCESS | 2252 | Values: 71.0 79.0 72.0 156.0 56.0 55.0 56.0 67.0 131.0 55.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:83.50 stddev:25.06 (30.0%) stddev-sans-first:26.43 02:28:03 INFO - PROCESS | 2252 | Values: 92.0 90.0 151.0 80.0 88.0 87.0 126.0 79.0 78.0 124.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:88.00 stddev:14.45 (16.4%) stddev-sans-first:15.25 02:28:03 INFO - PROCESS | 2252 | Values: 88.0 86.0 133.0 88.0 90.0 86.0 89.0 86.0 89.0 86.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 02:28:03 INFO - PROCESS | 2252 | Values: 93.0 93.0 93.0 94.0 93.0 94.0 93.0 93.0 93.0 93.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:83.50 stddev:1.29 (1.5%) stddev-sans-first:1.36 02:28:03 INFO - PROCESS | 2252 | Values: 84.0 86.0 83.0 85.0 86.0 83.0 83.0 83.0 83.0 83.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#8] json-parse-financial Cycles:10 Average:72.10 Median:81.00 stddev:14.39 (17.8%) stddev-sans-first:14.46 02:28:03 INFO - PROCESS | 2252 | Values: 59.0 58.0 61.0 84.0 89.0 89.0 87.0 78.0 59.0 57.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.50 stddev:3.71 (5.6%) stddev-sans-first:3.24 02:28:03 INFO - PROCESS | 2252 | Values: 60.0 64.0 62.0 71.0 68.0 72.0 67.0 65.0 65.0 66.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 02:28:03 INFO - PROCESS | 2252 | Values: 81.0 80.0 79.0 80.0 80.0 78.0 78.0 80.0 80.0 82.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:11.33 (8.9%) stddev-sans-first:11.20 02:28:03 INFO - PROCESS | 2252 | Values: 115.0 127.0 127.0 126.0 122.0 133.0 109.0 120.0 144.0 144.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:164.00 stddev:3.10 (1.9%) stddev-sans-first:3.28 02:28:03 INFO - PROCESS | 2252 | Values: 164.0 164.0 161.0 171.0 165.0 164.0 163.0 162.0 161.0 160.0 02:28:03 INFO - PROCESS | 2252 | 02:28:03 INFO - PROCESS | 2252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:78.50 stddev:11.69 (14.9%) stddev-sans-first:11.91 02:28:03 INFO - PROCESS | 2252 | Values: 67.0 67.0 68.0 70.0 91.0 90.0 91.0 87.0 67.0 65.0 02:28:03 INFO - PROCESS | 2252 | -------- Summary: end -------- 02:28:03 INFO - PROCESS | 2252 | 02:28:04 INFO - TEST-INFO | 2252: exit 0 02:28:04 INFO - TEST-OK | kraken | took 57851ms 02:28:04 INFO - SUITE-END | took 1170s 02:28:05 INFO - Completed test suite (00:19:30) 02:28:05 INFO - javascript benchmark 02:28:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2763.3782398960248, 2896.33384321606, 3566.8038257895814, 3568.0544655666235, 3635.1820840310916, 5796.507296879765, 5829.358770535237, 5832.416758324165, 5852.092925596534, 5881.264841894763, 5810.622309549876, 5875.941240587593, 5883.29400471944, 5890.499307558852, 5896.734646940888, 5211.7133557654315, 5237.10969135247, 5252.474752524755, 5315.574754019669, 5452.6183167178315, 5277.234800953859, 5332.120200166968, 5343.812966546172, 5349.625526213166, 5352.411234764173, 5272.499112584298, 5315.176147697113, 5316.5215130638235, 5316.574674026068, 5334.946650533484, 5307.38965019022, 5347.331583552056, 5362.195670649395, 5368.275282836845, 5396.730163491809, 4087.305158123126, 5169.638125331228, 5177.171652535576, 5190.169572868323, 5296.205569164617, 5606.131049687264, 5644.57665675076, 5668.943310566924, 5680.005998950209, 5689.459501347406, 6299.275583307886, 6348.206474190726, 6349.8412539686415, 6357.618542887441, 6371.585846919982, 5797.884042319172, 6215.87568248637, 6280.15217945576, 6328.430441260309, 6344.587601805868, 5945.554083443716, 5956.106584012433, 5968.313643931004, 5974.820755377345, 6016.067509536029, 6384.4254017137755, 6386.074019267273, 6386.616802991835, 6391.105245265667, 6400.967995159995, 6109.114178444101, 6181.072839074085, 6278.46633036197, 6290.968545157245, 6296.874062518724, 6210.192674952227, 6355.586886852339, 6356.650384228912, 6361.9045714314325, 6375.0437434384285, 6253.187085678924, 6334.144890439824, 6351.491880649537, 6363.809085727436, 6372.36276372359, 6182.443580077815, 6269.467095296951, 6290.119383286344, 6322.810315690536, 6341.365863413714, 4993.6005119590345, 5023.824166154167, 5025.824096156617, 5043.470435604282, 5067.6199285053035, 4493.393391892118, 4526.23054080807, 4531.43357080365, 4540.910181556403, 4554.544545545486, 5752.28096487939, 5815.41845815415, 5863.3257175424515, 5951.464368206882, 5979.641221526722, 6311.463525600376, 6322.620642761449, 6325.7153428094925, 6332.810015699536, 6337.841553961188, 5838.5037271831525, 5895.204147440127, 5974.581779275496, 5978.0, 5979.222701048923, 5454.290942177491, 5460.726963651801, 5470.343558772893, 5477.75350109246, 5484.2047903053835, 6290.811275661737, 6387.105805187278, 6393.168888044617, 6397.296297407282, 6430.421262086435, 6245.6252624842655, 6277.843053923689, 6306.810795676137, 6315.778947736807, 6320.525960553069, 6392.456641185551, 6424.935750642434, 6428.935710642833, 6440.194975628046, 6444.516661250331, 6155.953487907156, 6222.564420490522, 6324.30432652417, 6325.683715814099, 6338.714757835816, 6288.968555157195, 6319.6208227506495, 6348.984162534157, 6353.872922541431, 6354.52341074412, 6278.246610406781, 6278.497720182283, 6289.654069026247, 6290.622562646256, 6307.180066591313, 6106.816795496142, 6148.692565371803, 6244.500439964882, 6284.402981716729, 6290.874182516415, 6095.481884039907, 6097.17688112117, 6098.725557350019, 6113.969430152821, 6124.081387791867, 6146.5390095742105, 6215.285242197025, 6260.624362538262, 6268.1851359323, 6275.811725648238, 5963.28440587115, 6007.12896629995, 6023.216981792339, 6106.93092925953, 6115.209918062534], "value": 5795.448673786616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.9122394702832, 535.2987586261996, 553.3912696034361, 556.0602581637035, 616.0728104203174, 31458.370832583336, 32513.0, 41180.79409602952, 42406.151876962445, 42475.57524424755, 45278.86802829931, 45444.77277613607, 45790.85522861922, 45898.77050614742, 46076.07847843041, 8802.383833131684, 9841.065098815601, 10074.395536267812, 10077.14344280737, 10081.848772268386, 9136.908630913706, 10983.890161098407, 11741.823872641917, 12021.939890300537, 12313.753724925496, 11868.643940681794, 11941.522339106425, 11958.402079896014, 11965.940170299136, 11968.102392320567, 11928.284302941807, 11998.580049698307, 12000.97991670709, 12019.699507512294, 12031.157818952677, 10144.94927525365, 10190.9490452548, 11582.420878956103, 11714.88285117155, 11850.170488065838, 42171.36742948858, 42404.0, 42568.0, 42586.78706606447, 42596.0, 3325.218573635194, 3359.6472370401243, 3854.8458061677497, 3857.9228415431817, 3987.5813039631003, 28949.565756513668, 29401.823927042893, 29578.0, 29801.0, 30231.697683023107, 2460.692413448319, 2775.403288293027, 2785.206216228365, 2862.842543660098, 2873.994102064282, 519216.0, 520044.0, 521496.0, 522102.0, 522213.0, 37427.06432339214, 38070.42894356587, 38074.42888356677, 62341.0, 62844.0, 35890.64109358873, 36258.63741362606, 36421.08947276339, 36447.0, 36447.63552364495, 16058.0, 16229.675406491804, 16250.0, 16256.59358516023, 16313.510594682179, 12903.290319032356, 12970.740585188243, 13836.584902452943, 13902.192714946992, 14103.083299585494, 8368.37237207212, 8371.665133394596, 8385.790355241168, 8432.156784321518, 8466.534340611202, 3524.1718196223865, 3551.3252482028847, 3551.449525323579, 3574.8927532174075, 3597.1007248187952, 949.9721182187475, 1022.8772547294373, 1030.2190959179827, 1081.0918828184363, 1145.7593905279984, 27298.727012730014, 30765.538516922265, 30789.0, 31025.0, 31453.0, 1097.6542389147394, 1102.2174256278133, 1143.525436943659, 1163.1276542593055, 1230.477047254931, 14865.554033379016, 15017.399304027935, 15036.097834129987, 15201.543953681406, 15328.923355383151, 621993.0, 624199.0, 631419.0, 632981.0, 634677.0, 59694.40305596888, 60251.0, 60267.69866150641, 60300.0, 60408.69795650994, 1433.0613448191452, 1445.3134760988446, 1529.0, 1552.7049860526463, 1560.1964988031173, 29467.0, 29557.85221073881, 29618.407631847673, 29966.70033299639, 30189.0, 51073.97852042864, 51709.0, 51818.0, 51862.481375185766, 51870.74064629653, 499281.0, 501814.0, 501904.0, 502530.0, 503880.0, 27481.31296717598, 39022.609773901895, 43419.9145021377, 43896.56103438925, 44225.55774442214, 43719.56280437155, 45466.0, 46628.0, 47146.05707885754, 47579.52420475751, 31401.0, 36122.27755444929, 38418.0395490115, 38929.6107038926, 39037.609623903394, 37601.0, 37808.43287350747, 38323.233535329695, 38937.83186504409, 38993.610063898996, 38492.03769905663, 38670.6132938667, 39612.60387396089, 39976.8001160004, 40925.18149636931, 27746.44507109806, 30420.0, 32551.837240813646, 32663.67336326606, 33372.99762014287, 25207.305133174756, 25456.745432546177, 25561.488770224863, 25912.61131083073, 26056.34859128461], "value": 19452.776602128095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.09706935948986, 416.13444036404275, 418.06353767560665, 418.73201151263197, 427.20326590907945, 20372.185112595496, 21171.0, 21222.0, 21735.13059477619, 22776.54446911061, 12472.314022728746, 12758.170718903288, 19133.33033343833, 22471.438214044658, 22518.66222006671, 5388.676679399229, 5700.087985922253, 5815.447532484428, 6154.230721159855, 6160.84597885052, 4154.210699966997, 4369.126174765044, 5851.7074146292725, 6051.0, 6126.0810878368375, 6174.938250617482, 6185.257769067718, 6198.070289456595, 6201.720922558473, 6208.720607572647, 6141.938580614204, 6169.876602467948, 6793.082933803923, 6797.830054248634, 6813.625250611214, 4073.714839961204, 5776.364599894008, 6066.332703402666, 6080.665563394012, 6090.26916769986, 13824.723505529833, 14028.859711402858, 14129.576112716635, 14302.71394572113, 14308.713825723531, 2177.7495588007423, 2205.485489054265, 2267.0818318580837, 2281.863088214696, 2307.4810913357096, 10125.392476451363, 10428.322159059713, 10441.947790261076, 11938.761224775542, 12232.449539770732, 1581.992090039554, 1752.6144248265362, 1792.507060558344, 1822.7265910113456, 1836.1461920207034, 113835.0, 115926.26110608263, 116324.41837790841, 119264.40367798193, 119605.40197298958, 9834.704958851245, 11683.591074312359, 11927.389802376741, 12117.091218158674, 12290.569830056083, 15671.451499197474, 15826.44607438734, 15843.762343564857, 15901.363945442285, 15911.363545458284, 9429.717108486757, 9430.19843313326, 9446.38598491096, 9457.243420526342, 9551.904480955101, 8768.167024132825, 9524.238060955246, 9537.0, 9561.569729362196, 9614.663486778069, 4392.472903251566, 4855.198892182821, 4855.344528488679, 4858.368412106403, 4922.187839006596, 1781.9894203452575, 1946.4452631000097, 1995.630808300469, 2097.632914240002, 2099.611571859211, 929.7861491856911, 934.238595544629, 1023.0281232828694, 1033.1476531861244, 1091.050785816329, 16512.4220652279, 20273.18907243723, 20698.379048628565, 21003.894980525307, 21090.367288981353, 990.5641517732175, 1008.294194064158, 1027.244974943416, 1032.6334151376304, 1062.6758838554315, 11292.830607540893, 11623.709407264716, 11630.476628551736, 11633.360165190996, 11633.88366116328, 616209.9189504114, 623344.0, 627213.0, 645388.0, 646418.0, 126541.36729316479, 126960.36519817526, 128682.35658821833, 129679.0, 137427.0, 1000.849872519128, 1052.2529004406956, 1056.12869382758, 1122.231271578971, 1122.7080958950733, 17826.37607683725, 18697.53256168607, 18705.0, 18714.344997925553, 19017.904910475358, 53435.0, 53437.465625344805, 53520.4647953531, 53780.0, 55738.60653483533, 74675.62662186654, 75272.0, 76926.0, 77975.0, 80047.0, 8415.621297041771, 8440.873386899078, 8521.957390213258, 8575.65697372123, 8694.347923905605, 9214.769630759285, 12120.212351159458, 13044.478220871439, 13068.54260100892, 13286.003549734001, 10895.400752958663, 11012.449377530931, 11507.252028618113, 11514.078873690252, 11669.88330116722, 9365.203957663674, 10864.348139111678, 11082.944585277344, 11478.713032174262, 11575.189736718348, 11284.266522676, 11521.769564608829, 11835.881641183478, 11848.526058957545, 11871.109666774853, 8433.325333973145, 8474.533900635524, 8506.404551681322, 8631.6978905738, 8813.030566637537, 11315.20793544444, 11419.0, 11679.06567474617, 11691.415429228335, 11766.176367654525], "value": 9671.909988613952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.2340259662383, 1579.6651829204318, 1586.5795564175496, 1824.8996305203216, 1965.8918759468224, 8215.835683286337, 8433.24100830925, 8444.535550544726, 8448.788780280496, 8450.450720703158, 8393.622286997084, 8602.569871506415, 8654.048054713992, 8670.002949660791, 8683.305335573155, 2469.5801713708624, 2537.555927712652, 2537.9111731089415, 2540.5808041673104, 2541.4917016596664, 2455.987720061406, 2559.9616005759926, 2561.3212498687863, 2561.4236796720684, 2563.192594332779, 2196.8132708719777, 2506.586413241813, 2540.2252313044514, 2553.6807899012624, 2556.4759224359054, 2499.125306142854, 2533.328667903007, 2540.64430979663, 2550.885210165547, 2552.872356382192, 2486.3908342456216, 2519.0, 2527.772500474966, 2533.1513942829174, 2546.567083595793, 9067.274618030542, 9092.818143637156, 9105.908940910573, 9106.590203440861, 9116.453012819185, 5483.890322193533, 5577.05190117681, 5591.4688104629995, 5691.089425691911, 5731.168980497846, 3244.351129774031, 3640.271945610862, 3748.700103991674, 3762.6049264827348, 3778.017715394017, 1068.6954218047897, 1069.0859315285397, 1097.8627671541058, 1108.0692218536387, 1116.6705821782512, 11796.0, 11820.23168494045, 11854.644360669194, 11873.881261187364, 11878.584249551224, 4672.252439609714, 4687.203175460112, 4835.1296766581645, 4853.3447984522345, 4856.68431551948, 9395.0, 9498.19265362452, 9531.38046027006, 9534.952325238468, 9545.997670244664, 5408.91886621701, 5454.400015998237, 5455.8363249102595, 5470.0, 5484.670919744828, 4352.216601011848, 4572.1312950539295, 4770.928436073462, 4984.352034235599, 5067.797288108434, 3358.7648864579246, 4019.4171845082883, 4055.4930633670792, 4072.9613948442957, 4157.127003329274, 1213.9210951288314, 1232.679503329141, 1232.827404163418, 1234.1977714485656, 1238.8946939510063, 951.6098399656246, 952.7427594549433, 976.4580657734883, 984.542187882638, 1001.249063202598, 6073.605215661057, 6119.418655227835, 6185.8144255672405, 6274.874502510015, 6310.873782524323, 437.9102284031766, 476.4211483048113, 482.58497691984866, 490.8870959679294, 495.85372315167115, 4041.413994970713, 4082.6733861291027, 4117.094239267356, 4158.625723684883, 4170.52039015511, 10269.229807764448, 10687.984641459048, 10717.035466808025, 10733.08768754649, 10735.83896241557, 10460.424676642706, 10467.738306542245, 10503.422311772925, 10515.0, 10548.419836909045, 8268.669253229804, 8430.620622072021, 8513.787155321043, 8532.658693652184, 8548.316134709208, 5790.044642633919, 5925.9407405925385, 6121.204243448323, 6139.386061393825, 6221.5333849962335, 9486.193673537826, 9597.664081757104, 9842.11420972116, 9886.357386769838, 9914.950425247827, 8707.47755134694, 9465.337426380363, 9961.601535938482, 10041.0, 10237.641682541076, 6999.580025198505, 7239.963800180965, 7425.851482970418, 7720.227977202235, 7864.0, 8455.154484551496, 8528.530930798866, 8544.871826922725, 8603.526806025478, 8611.095834937241, 7451.366633835968, 7531.435142364235, 7606.163322034461, 7682.846343073219, 7739.845203096019, 7406.852387446141, 7412.221716719882, 7434.0, 7526.473146879666, 7571.545707257582, 7173.820654483679, 7278.126624805057, 7317.2316906726155, 7323.7436689715605, 7324.194338622854, 4305.2896272116, 5020.899582008413, 5066.442691304027, 5084.542391184811, 5139.717315547681, 5022.648414610942, 5095.082885080573, 5127.256547800623, 5192.818251361185, 5372.758225879923], "value": 4599.295056138066, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.26915708812254, 330.73210699333544, 341.0671812592561, 341.808587191173, 347.2863265988394, 6482.1573195484525, 6657.300983396746, 6686.732530698772, 6736.124303840494, 6744.224414192363, 6503.252126005511, 6607.5374723769355, 6614.1070955421, 6678.632675202862, 6715.146062923262, 4958.504149585049, 4988.02733466974, 5028.396592408916, 5031.597472202215, 5033.471485494026, 5005.6746311489815, 5013.874653133683, 5015.247712843066, 5016.27264046713, 5038.269450929613, 3830.942535861964, 4863.051704917542, 4866.635002374818, 4868.878278043042, 4884.535969082932, 3880.9417858732, 4774.307725379818, 4915.9754201229125, 4917.139500587418, 4951.702897826142, 4187.413762073312, 4200.235900921621, 4204.2432362174795, 4206.116715489751, 4212.157568486315, 5737.963023126772, 5943.3462319144855, 6388.776392826276, 6425.871482570323, 6442.549021568492, 5808.215890854723, 5819.447152520504, 5831.766729330821, 5834.64992100471, 5846.941530584682, 6733.293004234582, 7004.5096843221, 7049.753258635975, 7066.116735408074, 7077.567379820783, 3818.3508803503473, 4589.931151032737, 4594.862154135381, 4610.239310513761, 4631.907361852744, 7431.516951398142, 7518.43611729117, 7535.321821036133, 7543.7736867894055, 7546.245375462465, 4666.486686464486, 4682.367880336179, 4691.179043667345, 4692.498400511803, 4695.107929493385, 4751.714897106184, 4757.976210118927, 4763.595094416944, 4767.808047988003, 4778.546038126373, 5490.396056433789, 5578.609497335228, 5680.914786278209, 5688.033034384164, 5730.713464326767, 7126.073610430611, 7138.964305178441, 7166.462515311373, 7168.462365322622, 7190.964045179845, 1632.7224371856812, 1652.5290292266645, 1653.5287443078664, 1655.6026553627044, 1658.353242235529, 990.955407006672, 995.0596686131536, 1023.2019025160387, 1032.9638462653922, 1063.7606538528769, 6690.732370705215, 6845.110135682329, 6852.588844669336, 6876.243613202544, 6878.174619045646, 7463.552186868806, 7478.887816682754, 7500.137484189279, 7510.586917719578, 7512.887306690404, 6807.727690892309, 6826.180858297036, 6832.59004459734, 6839.213490448662, 6858.3827455529245, 3801.201747633028, 3905.199434116056, 3946.0, 3952.2293152835496, 3952.2490726761825, 7755.573443460551, 7755.612219389121, 7801.0, 7803.414743894117, 7813.413993950477, 7588.468807183444, 7622.69509219625, 7630.0, 7643.617819109022, 7661.387089032864, 7738.7291444800285, 7764.06831180262, 7776.961115194388, 7777.494462859896, 7777.844443111106, 5988.401159884151, 7145.714171433085, 7431.145418276968, 7440.776776696492, 7447.329740323397, 7229.963850180716, 7265.346118849329, 7279.7816065516, 7288.562686238843, 7296.927030729625, 7724.420668449777, 7763.611819408894, 7767.262110099531, 7769.378449724121, 7771.950786643731, 4685.390899183084, 4686.765661716969, 4690.601298889633, 4700.4829468757725, 4701.553352431513, 6667.733130705151, 6762.729490820312, 7024.438044956493, 7373.262673732584, 7400.962995184989, 6009.038553831366, 6853.965730171317, 7124.643767811485, 7129.180144283474, 7145.82135446618, 7110.928890711233, 7128.964355178191, 7138.357547820721, 7169.211386747558, 7170.892436613351, 6978.127734033246, 6990.161180658353, 6992.475564332797, 6994.300569942965, 7001.439884809101, 6906.551074180162, 7114.57312561248, 7129.144502659714, 7144.67848946809, 7146.964265178641, 5447.992121457543, 5571.721413929368, 6831.11195544576, 6971.442284617117, 7002.614856182959], "value": 5192.72664251369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.362844325437, 770.5492287012098, 789.8104454930815, 792.3383974381392, 803.9879401808972, 15219.391224351026, 15477.535673929771, 15552.611184720388, 15587.84412155878, 15605.21973901306, 14391.856081439182, 14408.207548584824, 14409.351579178936, 14450.855491445081, 14459.710805783905, 759.4987308376459, 769.8537277917205, 776.9611519424006, 950.909663581962, 953.1469334945219, 940.5438362394233, 952.5761036338832, 953.5137080089136, 953.6471505542959, 954.374884450686, 915.4644532948233, 1018.1651046142166, 1019.1693769577807, 1022.2537547590226, 1023.8720159980003, 812.175641723648, 829.4567058576582, 829.7344849648085, 984.9655262065793, 1014.9797004059915, 753.3144838197269, 753.6872198037807, 754.4266357568233, 755.252300222781, 755.7581573896356, 15111.244437778067, 15199.544013679608, 15231.314590843438, 15232.314545845464, 15271.160086195256, 12368.628941131781, 12738.490460381574, 12954.157979731288, 13114.737705245938, 13162.144460610125, 11180.720481987933, 11224.04595609366, 11317.03805176561, 11438.313701177956, 11674.649760507198, 3316.585426821647, 3558.4128618777872, 3632.456206112418, 3663.432168013962, 3805.162864169906, 83471.07851225178, 83532.58233708792, 84816.3036739268, 87050.5647471765, 87688.0, 9808.068233517804, 9878.357906736039, 9977.45124018186, 10025.248106391904, 10032.0, 22513.43716407103, 22542.0, 22545.0, 22550.436239094153, 22571.88714056419, 7714.691412343555, 7726.729564465217, 7809.492382995087, 7915.960420197977, 7940.28537431634, 4183.581641835853, 4251.617354438115, 4306.1172459645695, 4332.133573285356, 4426.424564806554, 3767.2842159989514, 3832.885013449545, 3844.0, 3848.3073046851277, 3848.6728628066367, 590.7725525672647, 681.3969636871404, 690.3890057299326, 702.3222590200481, 715.9713611455587, 611.4069352727847, 612.5222326585271, 625.8842114208886, 628.7924984755019, 647.9254885688111, 7834.099078605919, 7922.168172341936, 8398.328133749286, 8511.233988941025, 8577.528235947082, 600.67263341479, 605.6608299352376, 617.450469082517, 618.7741474361826, 633.1831936801475, 3383.2218589724503, 3702.33357995558, 3934.1541568562325, 4026.7583944963394, 4108.110269276166, 78164.82752758713, 82267.58866205631, 83676.58161709152, 88449.11550884409, 92822.0, 78116.21883781203, 78583.0, 80835.5958220205, 80868.19131808724, 85619.57190214009, 69584.0, 70710.0, 70950.2262443443, 72583.82248532448, 77830.4827744444, 8575.699850505453, 8627.91372086271, 8810.515421651615, 8812.427192232484, 8902.777430564029, 49415.7529212366, 50237.49762502328, 51067.0, 51797.74101129621, 52398.0, 69202.0, 73788.0, 73964.63017684878, 74229.25770742439, 74433.0, 10875.347479151276, 11114.944425277821, 11270.323780573191, 11330.320180789178, 11424.885751142714, 11958.940205298917, 12102.0, 12198.085143614442, 12203.938980305042, 12565.937170314455, 11705.941470292593, 11782.646520604396, 11813.350265735467, 11860.703482413008, 11871.99088077523, 11570.884291157317, 11726.589569365031, 11809.468573914022, 11809.468573914022, 12272.079594030662, 11238.887611123784, 11418.82871756941, 11620.6513804586, 12268.509259629514, 12369.391979042666, 9630.566624501775, 9630.711078667651, 9895.257855660999, 10085.344452610558, 10174.796504070026, 9569.0, 9677.467739274407, 9682.56428460707, 9698.70903872885, 9816.361936474106], "value": 7138.235164908528, "unit": "score"}], "name": "dromaeo_css", "value": 7554.674754694668, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 119.0, 111.0, 109.0, 112.0, 112.0, 114.0, 112.0, 132.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 143.0, 160.0, 119.0, 139.0, 117.0, 156.0, 154.0, 117.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 187.0, 184.0, 185.0, 183.0, 185.0, 183.0, 183.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 72.0, 156.0, 56.0, 55.0, 56.0, 67.0, 131.0, 55.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 151.0, 80.0, 88.0, 87.0, 126.0, 79.0, 78.0, 124.0], "value": 99.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 133.0, 88.0, 90.0, 86.0, 89.0, 86.0, 89.0, 86.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 85.0, 86.0, 83.0, 83.0, 83.0, 83.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 61.0, 84.0, 89.0, 89.0, 87.0, 78.0, 59.0, 57.0], "value": 72.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 62.0, 71.0, 68.0, 72.0, 67.0, 65.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 80.0, 78.0, 78.0, 80.0, 80.0, 82.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 127.0, 127.0, 126.0, 122.0, 133.0, 109.0, 120.0, 144.0, 144.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 171.0, 165.0, 164.0, 163.0, 162.0, 161.0, 160.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 70.0, 91.0, 90.0, 91.0, 87.0, 67.0, 65.0], "value": 76.3, "unit": "score"}], "name": "kraken", "value": 1470.1000000000001, "alertThreshold": 2.0}]} 02:28:05 INFO - Return code: 0 02:28:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:28:05 ERROR - # TBPL SUCCESS # 02:28:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:05 INFO - 2016-06-22 02:28:05.268 screenresolution[2262:13220] starting screenresolution argv=screenresolution get 02:28:05 INFO - 2016-06-22 02:28:05.270 screenresolution[2262:13220] Display 0: 1600x1200x32@60 02:28:05 INFO - 2016-06-22 02:28:05.276 screenresolution[2263:13223] starting screenresolution argv=screenresolution list 02:28:05 INFO - Available Modes on Display 0 02:28:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:05 INFO - Intel Iris: 02:28:05 INFO - Chipset Model: Intel Iris 02:28:05 INFO - Type: GPU 02:28:05 INFO - Bus: Built-In 02:28:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:05 INFO - Vendor: Intel (0x8086) 02:28:05 INFO - Device ID: 0x0a2e 02:28:05 INFO - Revision ID: 0x0009 02:28:05 INFO - Displays: 02:28:05 INFO - Display: 02:28:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:05 INFO - Display Serial Number: 1600x1200 60 02:28:05 INFO - Main Display: Yes 02:28:05 INFO - Mirror: Off 02:28:05 INFO - Online: Yes 02:28:05 INFO - Rotation: Supported 02:28:05 INFO - Return code: 0 02:28:05 INFO - Running post-action listener: _resource_record_post_action 02:28:05 INFO - Running post-run listener: _resource_record_post_run 02:28:06 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 102400; Write bytes: 496163840; Read time: 3; Write time: 1575 02:28:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191074816; Write bytes: 184639488; Read time: 17547; Write time: 393 02:28:06 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 102400; Write bytes: 300735488; Read time: 3; Write time: 1144 02:28:06 INFO - Running post-run listener: _upload_blobber_files 02:28:06 INFO - Blob upload gear active. 02:28:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:06 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 02:28:06 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:06 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:28:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:28:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:07 INFO - (blobuploader) - INFO - Done attempting. 02:28:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:28:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:08 INFO - (blobuploader) - INFO - Done attempting. 02:28:08 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:08 INFO - Return code: 0 02:28:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01f685c0e934489cc4ab24e6d98973bc35a1fc98ff8e90511fb6c728798493ca7cdfdca0361d7f27d3eb0e8ec56e91179f48cb82541f4c7f1310e14682a4a4e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab1e23bae7d8f52fd45d3a723be8e93e761fc0151a017b8fc09bedf22f0cc4d87e53775e8cfd562c58008d23d7e0153d57249ba68e38be55a35741ff39fe81f5"} 02:28:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:08 INFO - Contents: 02:28:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01f685c0e934489cc4ab24e6d98973bc35a1fc98ff8e90511fb6c728798493ca7cdfdca0361d7f27d3eb0e8ec56e91179f48cb82541f4c7f1310e14682a4a4e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab1e23bae7d8f52fd45d3a723be8e93e761fc0151a017b8fc09bedf22f0cc4d87e53775e8cfd562c58008d23d7e0153d57249ba68e38be55a35741ff39fe81f5"} 02:28:08 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:08 INFO - Copying logs to upload dir... 02:28:08 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.299927 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-22 02:28:08.715801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:08.719776) ========= 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.y4qcndXWq3/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.QXiQHIzern/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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/Mozilla-Beta/sha512/01f685c0e934489cc4ab24e6d98973bc35a1fc98ff8e90511fb6c728798493ca7cdfdca0361d7f27d3eb0e8ec56e91179f48cb82541f4c7f1310e14682a4a4e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab1e23bae7d8f52fd45d3a723be8e93e761fc0151a017b8fc09bedf22f0cc4d87e53775e8cfd562c58008d23d7e0153d57249ba68e38be55a35741ff39fe81f5"} build_url:https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/GdT2oDXzRAqEQjQdMYfVbg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01f685c0e934489cc4ab24e6d98973bc35a1fc98ff8e90511fb6c728798493ca7cdfdca0361d7f27d3eb0e8ec56e91179f48cb82541f4c7f1310e14682a4a4e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab1e23bae7d8f52fd45d3a723be8e93e761fc0151a017b8fc09bedf22f0cc4d87e53775e8cfd562c58008d23d7e0153d57249ba68e38be55a35741ff39fe81f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:08.754051) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:08.754383) ========= 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.y4qcndXWq3/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.QXiQHIzern/Listeners TMPDIR=/var/folders/63/97m36r0j7js9vzr9g5gsghq400000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 02:28:08.803199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:28:08.803516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 02:28:08.803838) ========= ========= Total master_lag: 0.18 =========