builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1461334290.8 results: success (0) buildid: 20160422045408 builduid: 7b93c0d50626428ab80cd01e87445501 revision: 4ca15e44f0b59c06d35b776320cb149e2422a2fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 07:11:30.799514) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 07:11:30.799961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 mins, 51 secs) (at 2016-04-22 07:11:30.800240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 mins, 51 secs) (at 2016-04-22 07:13:22.573493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-22 07:13:22.573795) ========= 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.ptQHKqKcVG/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.xZNfip71B7/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-04-22 07:13:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.7M=0.001s 2016-04-22 07:13:23 (14.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.618322 ========= master_lag: 7.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-22 07:13:30.406871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 32 secs) (at 2016-04-22 07:13:30.407202) ========= 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.ptQHKqKcVG/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.xZNfip71B7/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.028176 ========= master_lag: 32.59 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 32 secs) (at 2016-04-22 07:14:03.024503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2016-04-22 07:14:03.024909) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4ca15e44f0b59c06d35b776320cb149e2422a2fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4ca15e44f0b59c06d35b776320cb149e2422a2fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ptQHKqKcVG/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.xZNfip71B7/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-04-22 07:14:05,049 truncating revision to first 12 chars 2016-04-22 07:14:05,049 Setting DEBUG logging. 2016-04-22 07:14:05,049 attempt 1/10 2016-04-22 07:14:05,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4ca15e44f0b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 07:14:05,897 unpacking tar archive at: fx-team-4ca15e44f0b5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.097767 ========= master_lag: 12.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2016-04-22 07:14:16.344447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 07:14:16.344970) ========= script_repo_revision: 4ca15e44f0b59c06d35b776320cb149e2422a2fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 07:14:16.345724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 14 secs) (at 2016-04-22 07:14:16.349411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 14 secs) (at 2016-04-22 07:14:30.595479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-22 07:14:30.595769) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ptQHKqKcVG/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.xZNfip71B7/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:14:31 INFO - MultiFileLogger online at 20160422 07:14:31 in /builds/slave/test 07:14:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:14:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:14:31 INFO - {'append_to_log': False, 07:14:31 INFO - 'base_work_dir': '/builds/slave/test', 07:14:31 INFO - 'blob_upload_branch': 'Fx-Team', 07:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:14:31 INFO - 'branch': 'Fx-Team', 07:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:31 INFO - 'config_files': ('talos/mac_config.py',), 07:14:31 INFO - 'default_actions': ('clobber', 07:14:31 INFO - 'read-buildbot-config', 07:14:31 INFO - 'download-and-extract', 07:14:31 INFO - 'populate-webroot', 07:14:31 INFO - 'create-virtualenv', 07:14:31 INFO - 'install', 07:14:31 INFO - 'run-tests'), 07:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:31 INFO - 'download_minidump_stackwalk': True, 07:14:31 INFO - 'download_symbols': 'ondemand', 07:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:31 INFO - 'installer_path': 'installer.exe', 07:14:31 INFO - 'log_level': 'info', 07:14:31 INFO - 'log_name': 'talos', 07:14:31 INFO - 'log_to_console': True, 07:14:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:14:31 INFO - 'opt_config_files': (), 07:14:31 INFO - 'pip_index': False, 07:14:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:14:31 INFO - 'cmd': ('bash', 07:14:31 INFO - '-c', 07:14:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:14:31 INFO - 'enabled': True, 07:14:31 INFO - 'halt_on_failure': False, 07:14:31 INFO - 'name': 'check_screen_resolution'},), 07:14:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:14:31 INFO - 'cmd': ('bash', 07:14:31 INFO - '-c', 07:14:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:14:31 INFO - 'enabled': True, 07:14:31 INFO - 'halt_on_failure': False, 07:14:31 INFO - 'name': 'check_screen_resolution'},), 07:14:31 INFO - 'run_cmd_checks_enabled': True, 07:14:31 INFO - 'sps_profile': False, 07:14:31 INFO - 'sps_profile_interval': 0, 07:14:31 INFO - 'suite': 'dromaeojs', 07:14:31 INFO - 'system_bits': '32', 07:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:31 INFO - 'title': 't-yosemite-r7-0103', 07:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:31 INFO - 'use_talos_json': True, 07:14:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:31 INFO - 'work_dir': 'build'} 07:14:31 INFO - ##### 07:14:31 INFO - ##### Running clobber step. 07:14:31 INFO - ##### 07:14:31 INFO - Running pre-action listener: _resource_record_pre_action 07:14:31 INFO - Running main action method: clobber 07:14:31 INFO - rmtree: /builds/slave/test/build 07:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:14:32 INFO - Running post-action listener: _resource_record_post_action 07:14:32 INFO - ##### 07:14:32 INFO - ##### Running read-buildbot-config step. 07:14:32 INFO - ##### 07:14:32 INFO - Running pre-action listener: _resource_record_pre_action 07:14:32 INFO - Running main action method: read_buildbot_config 07:14:32 INFO - Using buildbot properties: 07:14:32 INFO - { 07:14:32 INFO - "project": "", 07:14:32 INFO - "product": "firefox", 07:14:32 INFO - "script_repo_revision": "production", 07:14:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:14:32 INFO - "repository": "", 07:14:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:14:32 INFO - "buildid": "20160422045408", 07:14:32 INFO - "pgo_build": "False", 07:14:32 INFO - "basedir": "/builds/slave/test", 07:14:32 INFO - "buildnumber": 703, 07:14:32 INFO - "slavename": "t-yosemite-r7-0103", 07:14:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:14:32 INFO - "platform": "yosemite_r7", 07:14:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:14:32 INFO - "branch": "fx-team", 07:14:32 INFO - "repo_path": "integration/fx-team", 07:14:32 INFO - "revision": "4ca15e44f0b59c06d35b776320cb149e2422a2fc", 07:14:32 INFO - "stage_platform": "macosx64", 07:14:32 INFO - "builduid": "7b93c0d50626428ab80cd01e87445501", 07:14:32 INFO - "slavebuilddir": "test" 07:14:32 INFO - } 07:14:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:14:32 INFO - Running post-action listener: _resource_record_post_action 07:14:32 INFO - ##### 07:14:32 INFO - ##### Running download-and-extract step. 07:14:32 INFO - ##### 07:14:32 INFO - Running pre-action listener: _resource_record_pre_action 07:14:32 INFO - Running main action method: download_and_extract 07:14:32 INFO - mkdir: /builds/slave/test/build/tests 07:14: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')]} 07:14:32 INFO - https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:14:33 INFO - Downloaded 1199 bytes. 07:14:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:14:33 INFO - Using the following test package requirements: 07:14:33 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:14:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:14:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:14:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'jsshell-mac.zip'], 07:14:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:14:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:14:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:14:33 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:14:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:14:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:14:33 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:14:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:33 INFO - https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:14:34 INFO - Downloaded 18105878 bytes. 07:14:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:14:38 INFO - Return code: 0 07:14:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:38 INFO - https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:14:39 INFO - Downloaded 18105878 bytes. 07:14:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:14:43 INFO - Return code: 0 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:43 INFO - https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:14:44 INFO - Downloaded 10845952 bytes. 07:14:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:14:44 INFO - Return code: 0 07:14: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')]} 07:14:44 INFO - https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:14:47 INFO - Downloaded 110045700 bytes. 07:14:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:47 INFO - mkdir: /builds/slave/test/properties 07:14:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:47 INFO - Contents: 07:14:47 INFO - build_url:https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:48 INFO - Running post-action listener: _resource_record_post_action 07:14:48 INFO - Running post-action listener: set_extra_try_arguments 07:14:48 INFO - ##### 07:14:48 INFO - ##### Running populate-webroot step. 07:14:48 INFO - ##### 07:14:48 INFO - Running pre-action listener: _resource_record_pre_action 07:14:48 INFO - Running main action method: populate_webroot 07:14:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:48 INFO - '--tppagecycles', 07:14:48 INFO - '7'], 07:14:48 INFO - 'tests': ['tsvgm']}}, 07:14:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:14:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:14:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['damp', 'tps']}, 07:14:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'tests': ['damp', 'tps']}, 07:14:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['dromaeo_dom']}, 07:14:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['a11yr', 07:14:48 INFO - 'ts_paint', 07:14:48 INFO - 'tpaint', 07:14:48 INFO - 'sessionrestore', 07:14:48 INFO - 'sessionrestore_no_auto_restore', 07:14:48 INFO - 'tabpaint']}, 07:14:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:14:48 INFO - 'ts_paint', 07:14:48 INFO - 'tpaint', 07:14:48 INFO - 'sessionrestore', 07:14:48 INFO - 'sessionrestore_no_auto_restore', 07:14:48 INFO - 'tabpaint']}, 07:14:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:14:48 INFO - 'ts_paint', 07:14:48 INFO - 'tpaint', 07:14:48 INFO - 'sessionrestore', 07:14:48 INFO - 'sessionrestore_no_auto_restore', 07:14:48 INFO - 'tabpaint']}, 07:14:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:14:48 INFO - 'ts_paint', 07:14:48 INFO - 'tpaint', 07:14:48 INFO - 'sessionrestore', 07:14:48 INFO - 'sessionrestore_no_auto_restore', 07:14:48 INFO - 'tabpaint']}, 07:14:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['a11yr', 07:14:48 INFO - 'ts_paint', 07:14:48 INFO - 'tpaint', 07:14:48 INFO - 'sessionrestore', 07:14:48 INFO - 'sessionrestore_no_auto_restore', 07:14:48 INFO - 'tabpaint']}, 07:14:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['a11yr', 07:14:48 INFO - 'ts_paint', 07:14:48 INFO - 'tpaint', 07:14:48 INFO - 'sessionrestore', 07:14:48 INFO - 'sessionrestore_no_auto_restore', 07:14:48 INFO - 'tabpaint']}, 07:14:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['tsvgx', 07:14:48 INFO - 'tsvgr_opacity', 07:14:48 INFO - 'tart', 07:14:48 INFO - 'tscrollx', 07:14:48 INFO - 'cart']}, 07:14:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:14:48 INFO - 'tsvgr_opacity', 07:14:48 INFO - 'tart', 07:14:48 INFO - 'tscrollx', 07:14:48 INFO - 'cart']}, 07:14:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'talos_options': ['--disable-e10s'], 07:14:48 INFO - 'tests': ['tp5o']}, 07:14:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'tests': ['tp5o']}, 07:14:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'talos_options': ['--disable-e10s', 07:14:48 INFO - '--xperf_path', 07:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:48 INFO - 'tests': ['tp5n']}, 07:14:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:48 INFO - 'talos_options': ['--xperf_path', 07:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:48 INFO - 'tests': ['tp5n']}}, 07:14:48 INFO - 'talos.zip': {'path': '', 07:14:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:48 INFO - Running post-action listener: _resource_record_post_action 07:14:48 INFO - ##### 07:14:48 INFO - ##### Running create-virtualenv step. 07:14:48 INFO - ##### 07:14:48 INFO - Running pre-action listener: _resource_record_pre_action 07:14:48 INFO - Running main action method: create_virtualenv 07:14:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:14:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:48 INFO - Using real prefix '/tools/python27' 07:14:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:52 INFO - Installing pip.................done. 07:14:52 INFO - Return code: 0 07:14:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:52 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:52 INFO - 'HOME': '/Users/cltbld', 07:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:52 INFO - 'LOGNAME': 'cltbld', 07:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:52 INFO - 'MOZ_NO_REMOTE': '1', 07:14:52 INFO - 'NO_EM_RESTART': '1', 07:14:52 INFO - 'PAGER': '/bin/cat', 07:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:52 INFO - 'PWD': '/builds/slave/test', 07:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:52 INFO - 'SHELL': '/bin/bash', 07:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:14:52 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:52 INFO - 'USER': 'cltbld', 07:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:52 INFO - 'XPC_FLAGS': '0x0', 07:14:52 INFO - 'XPC_SERVICE_NAME': '0', 07:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:14:52 INFO - Cleaning up... 07:14:52 INFO - Return code: 0 07:14:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:52 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:14:52 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 07:14:52 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 07:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:52 INFO - 'HOME': '/Users/cltbld', 07:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:52 INFO - 'LOGNAME': 'cltbld', 07:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:52 INFO - 'MOZ_NO_REMOTE': '1', 07:14:52 INFO - 'NO_EM_RESTART': '1', 07:14:52 INFO - 'PAGER': '/bin/cat', 07:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:52 INFO - 'PWD': '/builds/slave/test', 07:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:52 INFO - 'SHELL': '/bin/bash', 07:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:14:52 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:52 INFO - 'USER': 'cltbld', 07:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:52 INFO - 'XPC_FLAGS': '0x0', 07:14:52 INFO - 'XPC_SERVICE_NAME': '0', 07:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:52 INFO - Downloading/unpacking psutil>=0.7.1 07:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:56 INFO - Installing collected packages: psutil 07:14:56 INFO - Running setup.py install for psutil 07:14:56 INFO - building 'psutil._psutil_osx' extension 07:14:56 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 07:14:56 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 07:14:57 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 07:14:57 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 07:14:57 INFO - building 'psutil._psutil_posix' extension 07:14:57 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 07:14:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:14:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:14:57 INFO - ^ 07:14:57 INFO - 1 warning generated. 07:14:57 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 07:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:57 INFO - Successfully installed psutil 07:14:57 INFO - Cleaning up... 07:14:57 INFO - Return code: 0 07:14:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:57 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:14:57 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 07:14:57 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 07:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:57 INFO - 'HOME': '/Users/cltbld', 07:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:57 INFO - 'LOGNAME': 'cltbld', 07:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:57 INFO - 'MOZ_NO_REMOTE': '1', 07:14:57 INFO - 'NO_EM_RESTART': '1', 07:14:57 INFO - 'PAGER': '/bin/cat', 07:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:57 INFO - 'PWD': '/builds/slave/test', 07:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:57 INFO - 'SHELL': '/bin/bash', 07:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:14:57 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:57 INFO - 'USER': 'cltbld', 07:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:57 INFO - 'XPC_FLAGS': '0x0', 07:14:57 INFO - 'XPC_SERVICE_NAME': '0', 07:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:00 INFO - Installing collected packages: mozsystemmonitor 07:15:00 INFO - Running setup.py install for mozsystemmonitor 07:15:00 INFO - Successfully installed mozsystemmonitor 07:15:00 INFO - Cleaning up... 07:15:00 INFO - Return code: 0 07:15:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:00 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:00 INFO - 'HOME': '/Users/cltbld', 07:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:00 INFO - 'LOGNAME': 'cltbld', 07:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:00 INFO - 'MOZ_NO_REMOTE': '1', 07:15:00 INFO - 'NO_EM_RESTART': '1', 07:15:00 INFO - 'PAGER': '/bin/cat', 07:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:00 INFO - 'PWD': '/builds/slave/test', 07:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:00 INFO - 'SHELL': '/bin/bash', 07:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:00 INFO - 'USER': 'cltbld', 07:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:00 INFO - 'XPC_FLAGS': '0x0', 07:15:00 INFO - 'XPC_SERVICE_NAME': '0', 07:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:04 INFO - Downloading docopt-0.6.1.tar.gz 07:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:04 INFO - Running setup.py install for blobuploader 07:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:04 INFO - Running setup.py install for requests 07:15:05 INFO - Running setup.py install for docopt 07:15:05 INFO - Successfully installed blobuploader requests docopt 07:15:05 INFO - Cleaning up... 07:15:05 INFO - Return code: 0 07:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:05 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:05 INFO - 'HOME': '/Users/cltbld', 07:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:05 INFO - 'LOGNAME': 'cltbld', 07:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:05 INFO - 'MOZ_NO_REMOTE': '1', 07:15:05 INFO - 'NO_EM_RESTART': '1', 07:15:05 INFO - 'PAGER': '/bin/cat', 07:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:05 INFO - 'PWD': '/builds/slave/test', 07:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:05 INFO - 'SHELL': '/bin/bash', 07:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:05 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:05 INFO - 'USER': 'cltbld', 07:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:05 INFO - 'XPC_FLAGS': '0x0', 07:15:05 INFO - 'XPC_SERVICE_NAME': '0', 07:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:05 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NsVaTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:05 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-nkIi0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:05 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-zIImRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:05 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-IVSexa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:05 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-6TzfK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-11kqkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-yUDK9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-g7YMXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-itrtjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NOgDbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-8UGdhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-AeHC20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-vKKiYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-2VkrfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:06 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-1Mlukq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:07 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-JeA9lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:07 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-222YCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:07 INFO - Running setup.py install for manifestparser 07:15:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:07 INFO - Running setup.py install for mozcrash 07:15:07 INFO - Running setup.py install for mozdebug 07:15:07 INFO - Running setup.py install for mozdevice 07:15:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:07 INFO - Running setup.py install for mozfile 07:15:08 INFO - Running setup.py install for mozhttpd 07:15:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Running setup.py install for mozinfo 07:15:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Running setup.py install for mozInstall 07:15:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Running setup.py install for mozleak 07:15:08 INFO - Running setup.py install for mozlog 07:15:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Running setup.py install for moznetwork 07:15:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:08 INFO - Running setup.py install for mozprocess 07:15:09 INFO - Running setup.py install for mozprofile 07:15:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Running setup.py install for mozrunner 07:15:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Running setup.py install for mozscreenshot 07:15:09 INFO - Running setup.py install for moztest 07:15:09 INFO - Running setup.py install for mozversion 07:15:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:09 INFO - Cleaning up... 07:15:09 INFO - Return code: 0 07:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:09 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:09 INFO - 'HOME': '/Users/cltbld', 07:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:09 INFO - 'LOGNAME': 'cltbld', 07:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:09 INFO - 'MOZ_NO_REMOTE': '1', 07:15:09 INFO - 'NO_EM_RESTART': '1', 07:15:09 INFO - 'PAGER': '/bin/cat', 07:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:09 INFO - 'PWD': '/builds/slave/test', 07:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:09 INFO - 'SHELL': '/bin/bash', 07:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:09 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:09 INFO - 'USER': 'cltbld', 07:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:09 INFO - 'XPC_FLAGS': '0x0', 07:15:09 INFO - 'XPC_SERVICE_NAME': '0', 07:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-cUJbXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-MNLAj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-PsaCk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-nLa2hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-e_wsef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Af3Jl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-s6PAt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-GewTc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:10 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-8E6TaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-4IXdHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:11 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)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-2MPreV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-MfeAhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-mwU8p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-bAHFko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-39UYbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-n3aRkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:11 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ZC7hRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:14 INFO - Downloading blessings-1.6.tar.gz 07:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:14 INFO - Installing collected packages: blessings 07:15:14 INFO - Running setup.py install for blessings 07:15:14 INFO - Successfully installed blessings 07:15:14 INFO - Cleaning up... 07:15:14 INFO - Return code: 0 07:15:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:15 INFO - Reading from file tmpfile_stdout 07:15:15 INFO - Current package versions: 07:15:15 INFO - blessings == 1.6 07:15:15 INFO - blobuploader == 1.2.4 07:15:15 INFO - docopt == 0.6.1 07:15:15 INFO - manifestparser == 1.1 07:15:15 INFO - mozInstall == 1.12 07:15:15 INFO - mozcrash == 0.17 07:15:15 INFO - mozdebug == 0.1 07:15:15 INFO - mozdevice == 0.48 07:15:15 INFO - mozfile == 1.2 07:15:15 INFO - mozhttpd == 0.7 07:15:15 INFO - mozinfo == 0.9 07:15:15 INFO - mozleak == 0.1 07:15:15 INFO - mozlog == 3.1 07:15:15 INFO - moznetwork == 0.27 07:15:15 INFO - mozprocess == 0.22 07:15:15 INFO - mozprofile == 0.28 07:15:15 INFO - mozrunner == 6.11 07:15:15 INFO - mozscreenshot == 0.1 07:15:15 INFO - mozsystemmonitor == 0.0 07:15:15 INFO - moztest == 0.7 07:15:15 INFO - mozversion == 1.4 07:15:15 INFO - psutil == 3.1.1 07:15:15 INFO - requests == 1.2.3 07:15:15 INFO - wsgiref == 0.1.2 07:15:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:15 INFO - 'HOME': '/Users/cltbld', 07:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:15 INFO - 'LOGNAME': 'cltbld', 07:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:15 INFO - 'MOZ_NO_REMOTE': '1', 07:15:15 INFO - 'NO_EM_RESTART': '1', 07:15:15 INFO - 'PAGER': '/bin/cat', 07:15:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:15 INFO - 'PWD': '/builds/slave/test', 07:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:15 INFO - 'SHELL': '/bin/bash', 07:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:15 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:15 INFO - 'USER': 'cltbld', 07:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:15 INFO - 'XPC_FLAGS': '0x0', 07:15:15 INFO - 'XPC_SERVICE_NAME': '0', 07:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:15:15 INFO - Cleaning up... 07:15:15 INFO - Return code: 0 07:15:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:15 INFO - 'HOME': '/Users/cltbld', 07:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:15 INFO - 'LOGNAME': 'cltbld', 07:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:15 INFO - 'MOZ_NO_REMOTE': '1', 07:15:15 INFO - 'NO_EM_RESTART': '1', 07:15:15 INFO - 'PAGER': '/bin/cat', 07:15:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:15 INFO - 'PWD': '/builds/slave/test', 07:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:15 INFO - 'SHELL': '/bin/bash', 07:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:15 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:15 INFO - 'USER': 'cltbld', 07:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:15 INFO - 'XPC_FLAGS': '0x0', 07:15:15 INFO - 'XPC_SERVICE_NAME': '0', 07:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:15 INFO - Downloading/unpacking jsonschema 07:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:17 INFO - Downloading/unpacking functools32 (from jsonschema) 07:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:18 INFO - warning: no files found matching '*.txt' 07:15:18 INFO - no previously-included directories found matching 'build' 07:15:18 INFO - no previously-included directories found matching 'dist' 07:15:18 INFO - no previously-included directories found matching '.git*' 07:15:18 INFO - Installing collected packages: jsonschema, functools32 07:15:18 INFO - Running setup.py install for functools32 07:15:18 INFO - warning: no files found matching '*.txt' 07:15:18 INFO - no previously-included directories found matching 'build' 07:15:18 INFO - no previously-included directories found matching 'dist' 07:15:18 INFO - no previously-included directories found matching '.git*' 07:15:18 INFO - Successfully installed jsonschema functools32 07:15:18 INFO - Cleaning up... 07:15:18 INFO - Return code: 0 07:15:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:18 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 0x107bf2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c02420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95934c52b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, '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.ptQHKqKcVG/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.xZNfip71B7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 07:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:18 INFO - 'HOME': '/Users/cltbld', 07:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:18 INFO - 'LOGNAME': 'cltbld', 07:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:18 INFO - 'MOZ_NO_REMOTE': '1', 07:15:18 INFO - 'NO_EM_RESTART': '1', 07:15:18 INFO - 'PAGER': '/bin/cat', 07:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:18 INFO - 'PWD': '/builds/slave/test', 07:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:18 INFO - 'SHELL': '/bin/bash', 07:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:18 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:18 INFO - 'USER': 'cltbld', 07:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:18 INFO - 'XPC_FLAGS': '0x0', 07:15:18 INFO - 'XPC_SERVICE_NAME': '0', 07:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:18 INFO - Downloading/unpacking flake8 07:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:15:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:15:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:22 INFO - no previously-included directories found matching 'docs/_build' 07:15:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:15:22 INFO - Running setup.py install for pep8 07:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:22 INFO - no previously-included directories found matching 'docs/_build' 07:15:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:15:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:15:22 INFO - Cleaning up... 07:15:22 INFO - Return code: 0 07:15:22 INFO - Running post-action listener: _resource_record_post_action 07:15:22 INFO - Running post-action listener: _start_resource_monitoring 07:15:22 INFO - Starting resource monitoring. 07:15:22 INFO - ##### 07:15:22 INFO - ##### Running install step. 07:15:22 INFO - ##### 07:15:22 INFO - Running pre-action listener: _resource_record_pre_action 07:15:22 INFO - Running main action method: install 07:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:23 INFO - Reading from file tmpfile_stdout 07:15:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:23 INFO - Reading from file tmpfile_stdout 07:15:23 INFO - Output received: 07:15:23 INFO - Usage: mozinstall [options] installer 07:15:23 INFO - Options: 07:15:23 INFO - -h, --help show this help message and exit 07:15:23 INFO - -d DEST, --destination=DEST 07:15:23 INFO - Directory to install application into. [default: 07:15:23 INFO - "/builds/slave/test"] 07:15:23 INFO - --app=APP Application being installed. [default: firefox] 07:15:23 INFO - mkdir: /builds/slave/test/build/application 07:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:15:56 INFO - Reading from file tmpfile_stdout 07:15:56 INFO - Output received: 07:15:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:15:56 INFO - Running post-action listener: _resource_record_post_action 07:15:56 INFO - ##### 07:15:56 INFO - ##### Running run-tests step. 07:15:56 INFO - ##### 07:15:56 INFO - Running pre-action listener: _resource_record_pre_action 07:15:56 INFO - Running main action method: run_tests 07:15:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:56 INFO - 2016-04-22 07:15:56.808 screenresolution[1647:8076] starting screenresolution argv=screenresolution get 07:15:56 INFO - 2016-04-22 07:15:56.810 screenresolution[1647:8076] Display 0: 1600x1200x32@60 07:15:56 INFO - 2016-04-22 07:15:56.816 screenresolution[1648:8078] starting screenresolution argv=screenresolution list 07:15:56 INFO - Available Modes on Display 0 07:15:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:57 INFO - Intel Iris: 07:15:57 INFO - Chipset Model: Intel Iris 07:15:57 INFO - Type: GPU 07:15:57 INFO - Bus: Built-In 07:15:57 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:57 INFO - Vendor: Intel (0x8086) 07:15:57 INFO - Device ID: 0x0a2e 07:15:57 INFO - Revision ID: 0x0009 07:15:57 INFO - Displays: 07:15:57 INFO - Display: 07:15:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:57 INFO - Display Serial Number: 1600x1200 60 07:15:57 INFO - Main Display: Yes 07:15:57 INFO - Mirror: Off 07:15:57 INFO - Online: Yes 07:15:57 INFO - Rotation: Supported 07:15:57 INFO - Return code: 0 07:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:57 INFO - Python 2.7.3 07:15:57 INFO - Return code: 0 07:15:57 INFO - grabbing minidump binary from tooltool 07:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:57 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 0x107a91e00>, '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 0x1078badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a8cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:57 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 07:15:57 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 07:15:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:57 INFO - Return code: 0 07:15:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:15:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:15:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:58 INFO - Return code: 0 07:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ptQHKqKcVG/Render', 07:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:58 INFO - 'HOME': '/Users/cltbld', 07:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:58 INFO - 'LOGNAME': 'cltbld', 07:15:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:58 INFO - 'MOZ_NO_REMOTE': '1', 07:15:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:58 INFO - 'NO_EM_RESTART': '1', 07:15:58 INFO - 'PAGER': '/bin/cat', 07:15:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:58 INFO - 'PWD': '/builds/slave/test', 07:15:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:58 INFO - 'SHELL': '/bin/bash', 07:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xZNfip71B7/Listeners', 07:15:58 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:58 INFO - 'USER': 'cltbld', 07:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:58 INFO - 'XPC_FLAGS': '0x0', 07:15:58 INFO - 'XPC_SERVICE_NAME': '0', 07:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:15:58 INFO - mozversion application_buildid: 20160422045408 07:15:58 INFO - mozversion application_changeset: 4ca15e44f0b59c06d35b776320cb149e2422a2fc 07:15:58 INFO - mozversion application_display_name: Nightly 07:15:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:58 INFO - mozversion application_name: Firefox 07:15:58 INFO - mozversion application_remotingname: firefox 07:15:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:15:58 INFO - mozversion application_vendor: Mozilla 07:15:58 INFO - mozversion application_version: 48.0a1 07:15:58 INFO - mozversion platform_buildid: 20160422045408 07:15:58 INFO - mozversion platform_changeset: 4ca15e44f0b59c06d35b776320cb149e2422a2fc 07:15:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:15:58 INFO - mozversion platform_version: 48.0a1 07:15:58 INFO - using testdate: 1461334558 07:15:58 INFO - actual date: 1461334558 07:15:58 INFO - starting webserver on 'localhost:49271' 07:15:58 INFO - SUITE-START | Running 2 tests 07:15:58 INFO - TEST-START | dromaeo_css 07:15:58 INFO - operating with platform_type : mac_ 07:15:58 INFO - Initialising browser for dromaeo_css test... 07:15:58 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp3fjmR7/profile http://localhost:49271/getInfo.html) 07:16:00 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 07:16:00 INFO - PROCESS | 1666 | colorDepth:24 07:16:00 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 07:16:00 INFO - PROCESS | 1666 | __metrics 07:16:00 INFO - PROCESS | 1666 | 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" 07:16:00 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:16:01 INFO - TEST-INFO | 1666: exit 0 07:16:01 INFO - Browser initialized. 07:16:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:01 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp3fjmR7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:13 INFO - PROCESS | 1669 | RSS: Main: 238804992 07:16:13 INFO - PROCESS | 1669 | 07:17:05 INFO - PROCESS | 1669 | 1461334625213 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:19:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 07:19:16 INFO - PROCESS | 1669 | RSS: Main: 326262784 07:19:16 INFO - PROCESS | 1669 | 07:22:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 07:22:20 INFO - PROCESS | 1669 | RSS: Main: 378269696 07:22:20 INFO - PROCESS | 1669 | 07:25:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 07:25:23 INFO - PROCESS | 1669 | RSS: Main: 375754752 07:25:23 INFO - PROCESS | 1669 | 07:28:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 07:28:26 INFO - PROCESS | 1669 | RSS: Main: 375848960 07:28:26 INFO - PROCESS | 1669 | 07:31:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 07:31:29 INFO - PROCESS | 1669 | RSS: Main: 342859776 07:31:29 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 07:34:32 INFO - PROCESS | 1669 | RSS: Main: 384237568 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | __start_tp_report 07:34:32 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 07:34:32 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 07:34:32 INFO - PROCESS | 1669 | |i|pagename|runs| 07:34:32 INFO - PROCESS | 1669 | |0;dojo.html;2829.603855460236;3430.742694297928;3441.776284541503;3441.98279008605;3487.0584942065643;5520.889582208353;5595.832125036245;5612.69130197839;5618.971905140474;5668.603197776158;4882.292067650189;5673.432656734324;5689.743961521731;5795;5807.41925807419;5084.3644544431945;5106.7701953412;5149.944261426399;5161.793528258884;5251.76367063483;5170.53465188133;5227.372715274172;5228.032813929416;5230.267762513251;5250.65870718402;5082.720450375228;5087.160618497944;5178.922316165261;5179.766910489037;5188.870278243036;5122.1036318644465;5152.227165925104;5184.092783762826;5211.661242019257;5230.267762513251;5076.517730815566;5119.232115182753;5120.462351453081;5153.969206158783;5182.274481572583;5504.366997795265;5596.468335508121;5631.690257035862;5632.493075623172;5636.4927156556105;6057.818265452043;6113.510919126459;6131.988406491147;6133.242854861876;6133.907991380132;6226.782062627786;6239.906401403982;6286.339934306923;6293.244810622755;6312.842178945517;5751.25233719618;5759.596828222068;5772.567057470665;5778.913316300259;5787.884242315172;6206.689665516707;6250.468710159596;6335.556511044183;6337.96831015842;6365.554411191172;6090.482309003784;6109.694515274307;6122.326544080148;6123.387661233841;6144.692765361714;4720.33915251865;5689.800856969986;6174.938250617526;6207.193064901534;6264.655443950535;6112.989854784112;6113.358097399798;6214.161088253028;6217.285012223561;6238.251409830758;6132.41742034506;6164.198654174928;6179.104029915727;6190.195274614362;6197.349278325801;4745.169595320874;4882.951170488321;4888.682235654671;4898.485659005824;4934.037862616827;4398.626116780046;4418.624416924533;4461.397711308997;4462.107578484316;4464.419625448736;5648.378678345379;5651.378348381675;5653.575981801381;5655.434456554394;5661.631993920382;6162.476189523851;6177.166082578794;6229.657368844757;6249.000159974473;6278.6860656966965;5701.230333904869;5712.371639119693;5721.828345149652;5726.914096288559;5742.28221472316;5263.736813159327;5335.279737235501;5347.705876176769;5356.062689029404;5364.275822763955;6253.280872699606;6301.6534090625455;6306.432421082033;6308.432241098231;6326.557141000086;6186;6216.036514340284;6233.501319894307;6235.563510554218;6248.968755156195;5275.235090911873;6257.405546473078;6306.369363063657;6315.27374351937;6328.778492752732;6123.418275263843;6152.78465253714;6158.230221222348;6162.506999439945;6163;6071.5446341523675;6228.096925945803;6248.437640612185;6261.311255761953;6264.68676566179;5267.236250743697;6012.969935150296;6041.546883983807;6054.969725151523;6073.453389194994;4702.600278976325;5565.1930470082425;6037.9094313584455;6045.455908968214;6060.909086363797;5840.123981402823;5849.883002339844;5892.499137573354;5900.586958912835;5911.733971971185;5861.296644402529;6033.637981721111;6073.635581865102;6113.449789518964;6138.938610613836;5894.675792831264;5918.822435326947;5926.348101708722;5928.584999050025;5930.881382372242 07:34:32 INFO - PROCESS | 1669 | |1;ext.html;517.8550005998321;522.187997663633;543.244889603451;547.3787251469581;575.839683038677;29817.701822981762;30272.394552108944;30298;30398.936037238702;36910.8154459228;40277;40935.79532102343;40943.97640059;40946.795266023706;41040.79479602605;9404.059594040593;9657.32398732089;9661.95169024154;9668.419894806335;9698.951505242463;8406.159384061606;8658.87011694825;9538.998405167462;9665.178459830922;11306.660800176009;11394.430278486085;11500.482478288455;11515.078793696526;11519.596814111508;11537.711557211094;8987.831581894377;11440.970312671858;11554.711132221677;11580.363080030595;11595.246308989888;8457.154284571494;8726.52004139772;8734.737957861274;8735.694250701195;11439;32854;38751.03122421962;39678.809635710975;39741.00647483807;39781;3178.3484385700876;3192.616885973675;3194.025822124251;3453.9654603454146;3979.920401591981;25404.364890877692;26763.063292784853;26899.731002689918;26900.461990760272;27151.185464436097;2629.3558078270944;2664.147472808702;2668.5997100434897;2875.5830404591215;2931.5309550472034;300344;356910;359360;359954;360225.19887400395;34069.829650851585;34707;34826.47760283598;34856.82571587126;56854;33844.32311353759;33979.150521236676;34165.975020749414;34180.48729269063;34192;14600.926995364955;14850.886183536062;14854.777178342334;14860.554183374516;14884.181370024753;12625.810612840814;12737.745245095046;12745.68135796594;12787.808182877265;12827.743445131231;7471;7617.200193979663;7892.684292628345;8006.319462845607;8117.025956885093;3252.837358132084;3287.8849240276954;3293.8353082346266;3301.752368572367;3322.9667703322657;961.7643677298967;1003;1015.2588610314364;1055.7518983038979;1062.9681109566725;27904.091779720602;28381.290467738472;28418.857905710338;28750.968580498327;29203.977860774772;1009.4296722351847;1098.6374496416324;1100.070440477795;1126.1947707389256;1185.0874826383636;14786.92606536982;14839.629009274855;14904.140094144956;15034.248287585577;15175.392984280727;650541.7472912605;704949;728897;737386;740084;53599.46400536023;54124;54311.72844135754;54485;54698.72650636722;1314.7633425983224;1337.852836188038;1460.167704408477;1462.6343414146463;1479.2086233864832;25071.080118516395;28016;28033.719662803112;28304.86780528838;28900.132996010154;43570.56429435792;51353.22970155376;52109;52151.95696086133;52157;584459;589561;589817.7636677353;590886;591950;23206;25750.356241094123;25781;26092;26365;39409.80295098621;39779;39797.60202397939;40220.1955960885;40524.59475405208;34739.61041558309;34740.826295868355;34815.47776783401;35553.644463555036;35565.82217088898;34084.65915340914;34234.45944932534;34337.484937726455;34426.82786586051;34969.650303497656;34667.13332166716;34917;34993.9501814946;35935;36941.70704025346;29261.97583084582;30307.848460757556;30733.078007659806;31935;32079.35841283208;22197.55604887861;23836.888767477365;23931.880340598185;23976.160834370712;24016.87991560031 07:34:32 INFO - PROCESS | 1669 | |2;jquery.html;301.13423906269475;360.9404448266036;388.50659662228963;403.35463258785944;417.7890165466439;16486.83513164868;20288.391348259556;20756.481087972807;20779.584408311825;20800.271990480316;19216.42350729477;20893.47766305843;21448.8927555362;21923.232686855965;22004.119835206573;5144.408393034792;5781.364049954502;5982.760689572412;5988.19159413478;6014.308354539218;4181.790910454481;4439.977800110995;5779.913301300463;6214.875702485948;6571.211454625452;6424.903626445607;6501.934980650204;6513.283538810727;6526.184226971629;6533.411992920636;6342.809715708513;6514.088027676153;6527.347265273482;6535.803925882231;6539.378759017885;3743.2139250757373;3957.1096503286817;4008.2076618124497;5692.829215123553;5711.685857277848;25477.49045019108;26002.6099608506;26562.468750625074;26756.464870702475;26940.59589106165;2096.6854971754206;2175.793299636548;2204.4929666176868;2382.285314405671;2758.462099890522;12550.937245313715;13832.930835345758;14766.375698673137;15118.924405377902;15260.084394936339;1683.225716170563;1758.8944663320242;1777.413453560335;1805.124514610413;1881.1534809335853;115758.42120789342;118516.40741796322;118971.4051429746;120194;121761;8943.23982461498;10916.727081823017;11351.716207094889;11353.205275630791;11478.598249061242;14598.41606335756;14615.342309596093;14666;14669.193194374198;14685.853141468662;8695.521746304014;8864.379493435526;8875.689350872817;8964.417312874773;9063;7829.530228186327;8532;8948;8949.194572488377;9104.544772761468;6744.359285867835;6843.893663801679;6851.143607049119;6857.908337956871;6861.348171923659;1580.91304978225;1594.226800001998;1597.249292832367;1604.8074231092344;1748.5191572317715;845.7378212754066;943.3726571829657;1019.9286049976579;1020.0564477857952;1103.2608152537819;19890.90054549747;21576.029078691183;22479.723051401434;22642.207522736626;22872.542549148922;961.1685891703626;997.7356000659831;997.870276864003;1007.0634310091685;1063.7234319077095;10277.331973421853;11405.714857128638;11691.590794322157;11766;11870.703232419259;572862.1356893189;576930.1153494206;586557;587018;590943;96995;125812.37093814473;137746.31126844502;139409.30295348662;145082;1016.7763092119721;1028.7068185567227;1041.063043261056;1059.2055958031476;1062.5112448273726;18342.724859126858;18399;18670;18862.811371886655;19046.333378332245;37355.439668404455;47075.52924470849;47786.04427911492;49538.00923981428;52683.73658131685;73281;74899.87650185142;74911;77482;79220.60389698014;7711.190325015793;7729.768106956801;7994.40041996841;8195.67217311301;8364.079951205484;10946.17903657213;11009.61466348674;12588.181768185039;12777;12970.740585188054;7232.734271502361;8663.740087797376;11152.832707509557;11154.498047587716;11704.824427633423;11088.168387370819;11204.215704900578;11351.262167959056;11407.600733974272;11530.3081815088;10832.837507437238;11179;11666.941665291619;11752.059835213333;11802.291862488279;8227.382946278933;8242.670293188205;8302.626381812954;8387.245147936716;8658.177473140293;10998.890011099787;11309.773804524028;11328.093752499944;11385.54457821711;11506.482208300478 07:34:32 INFO - PROCESS | 1669 | |3;mootools.html;1374.9243791591464;1381.2679279981612;1543.444360030389;1742.8845538855128;1957.4029920874136;7929.881051784228;8634.956825215873;8874.55627218638;8890.155435233659;8892.555372231394;8449.45078569894;8689.91310086899;8691.826163476742;8693.913060869405;8697.347698922575;1826.2056005637523;2379.4170428245106;2409.674693916321;2449.5223431430877;2465.839720418176;2465.815063870217;2480.8139389545854;2484.6024636058232;2493.1772515069983;2494.2641920633364;2066.5763518478752;2408.8554686718767;2449.2774631483667;2454.9263522094366;2457.913973010945;2125.6598944169014;2201.8128459081;2204.867707937529;2208.2381578355444;2415.4444477770126;2347.1080989224156;2430.3195105370523;2437.731849496554;2438.146648672968;2451.497443024176;8592.914070859273;8667.479951202948;8677.826443471095;8688.47869127848;8691.695790647296;5114.3862736471865;5259.684418934838;5263.315768950012;5284.471552844685;5292.49721276482;3396.575428071491;3426.109211605001;3470.4967779671806;3532.7350448716447;3545.53907991962;981.215027977615;989.1147423056397;1025.6974192613197;1034.9016843399866;1036.3056751976194;11478.88521114778;11539.884601153964;11555.884441155566;11562.710932226762;11566.595169169039;4588.931166032512;4768.117898188846;4818.036392721469;4819.204831202883;4854.199057155601;9790.755231119136;9793.069658382443;9802.509874506246;9853.014698530089;9853.211743060538;5331.840044798662;5334.093204155303;5346.278252435949;5348.893022139536;5358.142697168434;4415.381846541487;4587.174308624413;4779.593734532604;4915.926261106087;4935.210366341368;3880.728349015542;3924.411338299221;3979.3633018716864;4023.959760402417;4047.514298284225;1334.7797613393682;1335.2389138191331;1342.5435351980373;1352.4252192818012;1356.403182599653;829.2163905109613;840.8948881389827;879.9296056315479;902.2917010147003;939.9848163982882;5004.474530174352;5731.512821410227;5847.44449277318;6035.969820150959;6103.84740381494;970.4419958523877;983.4492684096929;992.1864071461332;994.1500017484947;998.1665309466676;3832.3485007548784;3913.491246138041;3976.602339766;4015.7791321477016;4020.83916643331;10078.798424031625;10652;10742.892571074346;10746.086582640406;10752.569897204181;10465.9476702616;10556.049955504042;10705.304155229886;10714.196435267386;10720.678379648467;8244.587770611446;8253.33973282124;8399.832003360021;8399.874001889977;8416.989961204694;5762.250907382014;5825.563082768725;5906.320773110975;5991.041433370639;6006.849828754316;9729.221662267144;9950.950245249018;10053.899461005589;10101.949490252502;10159.7460063499;8924.419912705653;10075.899241007495;10371.688849334532;10493.108085812486;10527.315724477885;6447.0651755494255;6641.767538136142;6855.691493882688;7015.754448594274;7100.644967751488;8274;8287.792805179677;8380.24577788002;8384.371172162235;8403.159684031549;7330.560166390033;7464.290892365217;7467.813304667209;7547.886781698388;7694.345980591488;7247.166575843635;7280.635968201675;7336.669849856876;7341.522801018131;7475.551466912003;6974.58152510851;7079.82300442493;7125;7125.251848555827;7142.750003749844;4753.226429484046;4904.019196160853;4910.45984941649;4966.751662416792;5098.796048158032;4807.254875494304;4863.610911127172;4940.407151141886;5023.799048038038;5149.819756308661 07:34:32 INFO - PROCESS | 1669 | |4;prototype.html;247.69780867341842;309.1606288925568;323.5874260318094;330.6742858284588;332.2640351621159;5192.870178245536;5989.071693887444;6012.699365031747;6043.8489037774025;6078.452939235473;4689.320048592952;5131.43428285857;5188.870278243036;6001.369856165105;6005.789797357093;4468.4414448193975;4494.707843990146;4494.73031618104;4502.639788816895;4516.661250406216;3504.7196224302124;4415.977920110395;4494.842680506183;4510.706804057742;4536.5236650151755;3803.953912674009;4282.571742825724;4368.737875727466;4418.690691651585;4432.578905004019;3671.81640917953;4437.5784300491405;4440.888977775549;4453.576910193527;4463.085067561142;3376.881809136693;3523.365794157051;3581.6955558777536;3866.690664746842;3879.922401551953;5148.948510514884;5496.367917689477;5649.23735295734;5651.463111004489;5762.423757624246;4017.799110044486;4599.310103484504;5149.613778966593;5212.576152089297;5232;6023.578349515536;6301.243850737895;6313.337099604521;6314;6321.74713011479;3807.3146833569945;4309.676774241944;4313.1158112586845;4327.653787696977;4332.1985432695055;6332.68336583169;6578.237140401043;6704.329567043256;6708.66456677169;6722.4285935695525;4126.958730412657;4220.683448741357;4406.25093734066;4409.867703968822;4433.224185767478;3946.9210615787524;4457.9331310030375;4485.596296333346;4493.191225579427;4504.594586487232;4609.2564491653675;4819.6867203631655;5003.999200159982;5212.4266330703595;5241.31862857826;5628.437156284339;5660.716964151776;6329.177206963157;6331.366863313632;6363.395477429729;1280.2830414967648;1327.5353626230742;1535.7005383950022;1554.440401455475;1556.6419723463666;983.5475681186591;1017.5471914997755;1020.8162530744389;1025.5333823110466;1037.5486663301488;5453.318335208099;5898.233229680114;5940.881182376328;5962.522998160137;5965.79119730816;5180.766865491062;6550.314371107823;6563.835904102436;6577.506686998494;6583.769568065095;4995.925875936691;5582.218489411485;5680.204771332017;5919.200907877467;5950.649493450063;3024.9546256806166;3431.5024321473247;3448.896533104011;3480.408330583756;3482.460218666111;6626.966865165643;6910;6912.205096413876;6942.201646810681;6958.756443524452;5357.464253574612;6237.066509382015;6802.965985170142;6803.7618683345845;6820.5676807870905;6693.966530167416;6827.52207345481;6895.965520172367;6900.3099690031595;6916.377526022682;6301.558890877594;6565;6581.506387020897;6600.141981542369;6609.173853268341;6213.813585592439;6485.8702825944165;6495.480361571157;6501;6510.511711621552;5722.570807189394;6806.965965170142;6897.275786042594;6901.965490172718;6910.20532638753;4232.428622135973;4239.724417912826;4249.702520823636;4258.446401967724;4277.721948073366;6309.3690630936535;6554.770583029571;6607.9669601651685;6611.735530578723;6618.5770059437455;5831.679257640871;6107.969460152671;6252.843678908063;6354.301026887131;6378.649174295459;5156.716380599103;6329.885574376508;6333.018382150774;6343.492520598249;6361.332060133619;5451.809186678447;6196.535259855439;6253.37466253371;6273.545782494298;6281.654509002049;5763.510101641407;6359.20509936258;6380.3619638035825;6388.616682999035;6392.712327945346;5814.5639077068545;5846.544451330366;5891.793787217427;6001.309849367379;6296.0555916612875 07:34:32 INFO - PROCESS | 1669 | |5;yui.html;642.2517766801676;664.8936170212767;684.9965750171245;750.961140503533;751.0911796725961;14667.413303467862;15064.171470569114;15229.619259518518;15280.388784448609;15299.617509562266;13131.540396086139;13203.933980330108;13204;13220.471181152743;13251.138675986054;652.4649787174519;694.2675477371371;882.9558522073903;898.6315610599672;902.6163880350857;902.2962089570145;907.7412937312868;909.3361845852531;909.7498187998287;910.5947853205327;963.5230560872378;967.0233064604764;969.0600117885675;970.1559643110504;970.9271804614647;747.8616455955665;931.8136372725414;960.5053397500293;961.024560071528;962.451402700461;714.8463080437731;715.7244460882546;715.8568286342701;716.1978583985968;717.989230161548;14763.852361476462;14858.331375088146;14879.404823807035;14883.479078232318;14896.553103406915;12408.937955310166;12435.316057616827;12510.74978500434;12540.24758514492;12577.662831832122;9905.405675659484;10038.64864729731;10245.129164021067;10379.325343852626;10774.97637724415;3553.2640564852377;3563.518924945151;3565.322588708137;3617.1680513482047;3639.553381603006;84481.57759211225;84674.72987905248;86703.56648216782;86848.13151868463;87108;9266.490343031199;9486.288528360401;9490.90509094914;9691.660791872391;9854.901450985399;22429.102835886708;22455.32634020982;22461.775382246295;22468.775312246995;22483.66274505884;7285.235050319746;7335.486515943832;7409.259074092655;7624.5425274483705;7647.847043059219;4081.306177949696;4130.56629053951;4131.969228328967;4159.833606655699;4187.413762073312;3597.4963505109304;3696.648818362305;3700.204456041964;3700.2229531798084;3704.3517384457614;556.3296228045195;660.6828722213364;668.3383450384084;669.6584741781727;682.3858527325348;546.8140832117099;562.9465200805917;585.4145854145854;594.2334388638608;606.4663096475074;7836.373090152774;7888.171741967126;7891.84216315682;8242.340612750966;8305.137797916219;468.6461721400321;504.75771629617986;574.3395095639964;575.545319197829;593.0570393074945;3790.3935370341164;3852.5755676553817;3881.573026967031;3910.416281406035;4039.1517781265675;89547;93021.5348923251;102142.48928755458;103764.96235037704;105263.47368263263;85081;85922.99999999875;86236;86674;86730.13269867221;55865.441345586834;73838.15404615035;74661;75510.4897902039;76190;7799;7799.298063174341;7949.562774047483;7951.045874494866;8125.431219814556;46332;46813.53186468092;47138.76430617825;47268.7636561815;47678.52321476741;64441.193066908796;65430;69571.30428695648;70331;70406.64796675983;10090.596376145166;10132.848007280045;10263.84604230952;10310.690679279634;10602.522886469973;11058.944705276423;11249.381284029458;11253.381064041556;12323.50705971787;12452.813207802072;8139.898642307468;10650.254482186172;11267.830982535104;11477.253978491372;11615.070794336601;10810.783784324427;11425.028872545927;11560.6531804046;11561.768764624829;11689.298642081163;9095.636174553209;11190.496427660937;11232.213745037769;11241.044511216638;11249.156313276373;9390;9426.293028023063;9766;9774.511274436392;10044.347117437343;9651.372660777028;9673.081057299545;9730.80538389214;9853.802923941337;9885.524981137367 07:34:32 INFO - PROCESS | 1669 | __end_tp_report 07:34:32 INFO - PROCESS | 1669 | __start_cc_report 07:34:32 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1210 07:34:32 INFO - PROCESS | 1669 | __end_cc_report 07:34:32 INFO - PROCESS | 1669 | __startTimestamp1461335672706__endTimestamp 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | ------- Summary: start ------- 07:34:32 INFO - PROCESS | 1669 | Number of tests: 6 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5675.86 Median:5849.88 stddev:650.51 (11.1%) stddev-sans-first:612.98 07:34:32 INFO - PROCESS | 1669 | Values: 2829.6 3430.7 3441.8 3442.0 3487.1 5520.9 5595.8 5612.7 5619.0 5668.6 4882.3 5673.4 5689.7 5795.0 5807.4 5084.4 5106.8 5149.9 5161.8 5251.8 5170.5 5227.4 5228.0 5230.3 5250.7 5082.7 5087.2 5178.9 5179.8 5188.9 5122.1 5152.2 5184.1 5211.7 5230.3 5076.5 5119.2 5120.5 5154.0 5182.3 5504.4 5596.5 5631.7 5632.5 5636.5 6057.8 6113.5 6132.0 6133.2 6133.9 6226.8 6239.9 6286.3 6293.2 6312.8 5751.3 5759.6 5772.6 5778.9 5787.9 6206.7 6250.5 6335.6 6338.0 6365.6 6090.5 6109.7 6122.3 6123.4 6144.7 4720.3 5689.8 6174.9 6207.2 6264.7 6113.0 6113.4 6214.2 6217.3 6238.3 6132.4 6164.2 6179.1 6190.2 6197.3 4745.2 4883.0 4888.7 4898.5 4934.0 4398.6 4418.6 4461.4 4462.1 4464.4 5648.4 5651.4 5653.6 5655.4 5661.6 6162.5 6177.2 6229.7 6249.0 6278.7 5701.2 5712.4 5721.8 5726.9 5742.3 5263.7 5335.3 5347.7 5356.1 5364.3 6253.3 6301.7 6306.4 6308.4 6326.6 6186.0 6216.0 6233.5 6235.6 6249.0 5275.2 6257.4 6306.4 6315.3 6328.8 6123.4 6152.8 6158.2 6162.5 6163.0 6071.5 6228.1 6248.4 6261.3 6264.7 5267.2 6013.0 6041.5 6055.0 6073.5 4702.6 5565.2 6037.9 6045.5 6060.9 5840.1 5849.9 5892.5 5900.6 5911.7 5861.3 6033.6 6073.6 6113.4 6138.9 5894.7 5918.8 5926.3 5928.6 5930.9 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:65544.73 Median:34024.49 stddev:153704.99 (451.7%) stddev-sans-first:154058.63 07:34:32 INFO - PROCESS | 1669 | Values: 517.9 522.2 543.2 547.4 575.8 29817.7 30272.4 30298.0 30398.9 36910.8 40277.0 40935.8 40944.0 40946.8 41040.8 9404.1 9657.3 9662.0 9668.4 9699.0 8406.2 8658.9 9539.0 9665.2 11306.7 11394.4 11500.5 11515.1 11519.6 11537.7 8987.8 11441.0 11554.7 11580.4 11595.2 8457.2 8726.5 8734.7 8735.7 11439.0 32854.0 38751.0 39678.8 39741.0 39781.0 3178.3 3192.6 3194.0 3454.0 3979.9 25404.4 26763.1 26899.7 26900.5 27151.2 2629.4 2664.1 2668.6 2875.6 2931.5 300344.0 356910.0 359360.0 359954.0 360225.2 34069.8 34707.0 34826.5 34856.8 56854.0 33844.3 33979.2 34166.0 34180.5 34192.0 14600.9 14850.9 14854.8 14860.6 14884.2 12625.8 12737.7 12745.7 12787.8 12827.7 7471.0 7617.2 7892.7 8006.3 8117.0 3252.8 3287.9 3293.8 3301.8 3323.0 961.8 1003.0 1015.3 1055.8 1063.0 27904.1 28381.3 28418.9 28751.0 29204.0 1009.4 1098.6 1100.1 1126.2 1185.1 14786.9 14839.6 14904.1 15034.2 15175.4 650541.7 704949.0 728897.0 737386.0 740084.0 53599.5 54124.0 54311.7 54485.0 54698.7 1314.8 1337.9 1460.2 1462.6 1479.2 25071.1 28016.0 28033.7 28304.9 28900.1 43570.6 51353.2 52109.0 52152.0 52157.0 584459.0 589561.0 589817.8 590886.0 591950.0 23206.0 25750.4 25781.0 26092.0 26365.0 39409.8 39779.0 39797.6 40220.2 40524.6 34739.6 34740.8 34815.5 35553.6 35565.8 34084.7 34234.5 34337.5 34426.8 34969.7 34667.1 34917.0 34994.0 35935.0 36941.7 29262.0 30307.8 30733.1 31935.0 32079.4 22197.6 23836.9 23931.9 23976.2 24016.9 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34655.17 Median:12342.11 stddev:97430.90 (789.4%) stddev-sans-first:97670.07 07:34:32 INFO - PROCESS | 1669 | Values: 301.1 360.9 388.5 403.4 417.8 16486.8 20288.4 20756.5 20779.6 20800.3 19216.4 20893.5 21448.9 21923.2 22004.1 5144.4 5781.4 5982.8 5988.2 6014.3 4181.8 4440.0 5779.9 6214.9 6571.2 6424.9 6501.9 6513.3 6526.2 6533.4 6342.8 6514.1 6527.3 6535.8 6539.4 3743.2 3957.1 4008.2 5692.8 5711.7 25477.5 26002.6 26562.5 26756.5 26940.6 2096.7 2175.8 2204.5 2382.3 2758.5 12550.9 13832.9 14766.4 15118.9 15260.1 1683.2 1758.9 1777.4 1805.1 1881.2 115758.4 118516.4 118971.4 120194.0 121761.0 8943.2 10916.7 11351.7 11353.2 11478.6 14598.4 14615.3 14666.0 14669.2 14685.9 8695.5 8864.4 8875.7 8964.4 9063.0 7829.5 8532.0 8948.0 8949.2 9104.5 6744.4 6843.9 6851.1 6857.9 6861.3 1580.9 1594.2 1597.2 1604.8 1748.5 845.7 943.4 1019.9 1020.1 1103.3 19890.9 21576.0 22479.7 22642.2 22872.5 961.2 997.7 997.9 1007.1 1063.7 10277.3 11405.7 11691.6 11766.0 11870.7 572862.1 576930.1 586557.0 587018.0 590943.0 96995.0 125812.4 137746.3 139409.3 145082.0 1016.8 1028.7 1041.1 1059.2 1062.5 18342.7 18399.0 18670.0 18862.8 19046.3 37355.4 47075.5 47786.0 49538.0 52683.7 73281.0 74899.9 74911.0 77482.0 79220.6 7711.2 7729.8 7994.4 8195.7 8364.1 10946.2 11009.6 12588.2 12777.0 12970.7 7232.7 8663.7 11152.8 11154.5 11704.8 11088.2 11204.2 11351.3 11407.6 11530.3 10832.8 11179.0 11666.9 11752.1 11802.3 8227.4 8242.7 8302.6 8387.2 8658.2 10998.9 11309.8 11328.1 11385.5 11506.5 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5685.69 Median:4953.58 stddev:3173.73 (64.1%) stddev-sans-first:3166.10 07:34:32 INFO - PROCESS | 1669 | Values: 1374.9 1381.3 1543.4 1742.9 1957.4 7929.9 8635.0 8874.6 8890.2 8892.6 8449.5 8689.9 8691.8 8693.9 8697.3 1826.2 2379.4 2409.7 2449.5 2465.8 2465.8 2480.8 2484.6 2493.2 2494.3 2066.6 2408.9 2449.3 2454.9 2457.9 2125.7 2201.8 2204.9 2208.2 2415.4 2347.1 2430.3 2437.7 2438.1 2451.5 8592.9 8667.5 8677.8 8688.5 8691.7 5114.4 5259.7 5263.3 5284.5 5292.5 3396.6 3426.1 3470.5 3532.7 3545.5 981.2 989.1 1025.7 1034.9 1036.3 11478.9 11539.9 11555.9 11562.7 11566.6 4588.9 4768.1 4818.0 4819.2 4854.2 9790.8 9793.1 9802.5 9853.0 9853.2 5331.8 5334.1 5346.3 5348.9 5358.1 4415.4 4587.2 4779.6 4915.9 4935.2 3880.7 3924.4 3979.4 4024.0 4047.5 1334.8 1335.2 1342.5 1352.4 1356.4 829.2 840.9 879.9 902.3 940.0 5004.5 5731.5 5847.4 6036.0 6103.8 970.4 983.4 992.2 994.2 998.2 3832.3 3913.5 3976.6 4015.8 4020.8 10078.8 10652.0 10742.9 10746.1 10752.6 10465.9 10556.0 10705.3 10714.2 10720.7 8244.6 8253.3 8399.8 8399.9 8417.0 5762.3 5825.6 5906.3 5991.0 6006.8 9729.2 9951.0 10053.9 10101.9 10159.7 8924.4 10075.9 10371.7 10493.1 10527.3 6447.1 6641.8 6855.7 7015.8 7100.6 8274.0 8287.8 8380.2 8384.4 8403.2 7330.6 7464.3 7467.8 7547.9 7694.3 7247.2 7280.6 7336.7 7341.5 7475.6 6974.6 7079.8 7125.0 7125.3 7142.8 4753.2 4904.0 4910.5 4966.8 5098.8 4807.3 4863.6 4940.4 5023.8 5149.8 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5125.32 Median:5670.46 stddev:1629.96 (28.7%) stddev-sans-first:1592.89 07:34:32 INFO - PROCESS | 1669 | Values: 247.7 309.2 323.6 330.7 332.3 5192.9 5989.1 6012.7 6043.8 6078.5 4689.3 5131.4 5188.9 6001.4 6005.8 4468.4 4494.7 4494.7 4502.6 4516.7 3504.7 4416.0 4494.8 4510.7 4536.5 3804.0 4282.6 4368.7 4418.7 4432.6 3671.8 4437.6 4440.9 4453.6 4463.1 3376.9 3523.4 3581.7 3866.7 3879.9 5148.9 5496.4 5649.2 5651.5 5762.4 4017.8 4599.3 5149.6 5212.6 5232.0 6023.6 6301.2 6313.3 6314.0 6321.7 3807.3 4309.7 4313.1 4327.7 4332.2 6332.7 6578.2 6704.3 6708.7 6722.4 4127.0 4220.7 4406.3 4409.9 4433.2 3946.9 4457.9 4485.6 4493.2 4504.6 4609.3 4819.7 5004.0 5212.4 5241.3 5628.4 5660.7 6329.2 6331.4 6363.4 1280.3 1327.5 1535.7 1554.4 1556.6 983.5 1017.5 1020.8 1025.5 1037.5 5453.3 5898.2 5940.9 5962.5 5965.8 5180.8 6550.3 6563.8 6577.5 6583.8 4995.9 5582.2 5680.2 5919.2 5950.6 3025.0 3431.5 3448.9 3480.4 3482.5 6627.0 6910.0 6912.2 6942.2 6958.8 5357.5 6237.1 6803.0 6803.8 6820.6 6694.0 6827.5 6896.0 6900.3 6916.4 6301.6 6565.0 6581.5 6600.1 6609.2 6213.8 6485.9 6495.5 6501.0 6510.5 5722.6 6807.0 6897.3 6902.0 6910.2 4232.4 4239.7 4249.7 4258.4 4277.7 6309.4 6554.8 6608.0 6611.7 6618.6 5831.7 6108.0 6252.8 6354.3 6378.6 5156.7 6329.9 6333.0 6343.5 6361.3 5451.8 6196.5 6253.4 6273.5 6281.7 5763.5 6359.2 6380.4 6388.6 6392.7 5814.6 5846.5 5891.8 6001.3 6296.1 07:34:32 INFO - PROCESS | 1669 | 07:34:32 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18744.72 Median:593.65 stddev:27182.49 (4578.9%) stddev-sans-first:27224.76 07:34:32 INFO - PROCESS | 1669 | Values: 642.3 664.9 685.0 751.0 751.1 14667.4 15064.2 15229.6 15280.4 15299.6 13131.5 13203.9 13204.0 13220.5 13251.1 652.5 694.3 883.0 898.6 902.6 902.3 907.7 909.3 909.7 910.6 963.5 967.0 969.1 970.2 970.9 747.9 931.8 960.5 961.0 962.5 714.8 715.7 715.9 716.2 718.0 14763.9 14858.3 14879.4 14883.5 14896.6 12408.9 12435.3 12510.7 12540.2 12577.7 9905.4 10038.6 10245.1 10379.3 10775.0 3553.3 3563.5 3565.3 3617.2 3639.6 84481.6 84674.7 86703.6 86848.1 87108.0 9266.5 9486.3 9490.9 9691.7 9854.9 22429.1 22455.3 22461.8 22468.8 22483.7 7285.2 7335.5 7409.3 7624.5 7647.8 4081.3 4130.6 4132.0 4159.8 4187.4 3597.5 3696.6 3700.2 3700.2 3704.4 556.3 660.7 668.3 669.7 682.4 546.8 562.9 585.4 594.2 606.5 7836.4 7888.2 7891.8 8242.3 8305.1 468.6 504.8 574.3 575.5 593.1 3790.4 3852.6 3881.6 3910.4 4039.2 89547.0 93021.5 102142.5 103765.0 105263.5 85081.0 85923.0 86236.0 86674.0 86730.1 55865.4 73838.2 74661.0 75510.5 76190.0 7799.0 7799.3 7949.6 7951.0 8125.4 46332.0 46813.5 47138.8 47268.8 47678.5 64441.2 65430.0 69571.3 70331.0 70406.6 10090.6 10132.8 10263.8 10310.7 10602.5 11058.9 11249.4 11253.4 12323.5 12452.8 8139.9 10650.3 11267.8 11477.3 11615.1 10810.8 11425.0 11560.7 11561.8 11689.3 9095.6 11190.5 11232.2 11241.0 11249.2 9390.0 9426.3 9766.0 9774.5 10044.3 9651.4 9673.1 9730.8 9853.8 9885.5 07:34:32 INFO - PROCESS | 1669 | -------- Summary: end -------- 07:34:32 INFO - PROCESS | 1669 | 07:34:33 INFO - TEST-INFO | 1669: exit 0 07:34:33 INFO - TEST-OK | dromaeo_css | took 1114706ms 07:34:33 INFO - TEST-START | kraken 07:34:33 INFO - operating with platform_type : mac_ 07:34:33 INFO - Initialising browser for kraken test... 07:34:33 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp9miJne/profile http://localhost:49271/getInfo.html) 07:34:35 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 07:34:35 INFO - PROCESS | 1675 | colorDepth:24 07:34:35 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 07:34:35 INFO - PROCESS | 1675 | __metrics 07:34:35 INFO - PROCESS | 1675 | 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" 07:34:35 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:34:36 INFO - TEST-INFO | 1675: exit 0 07:34:36 INFO - Browser initialized. 07:34:36 INFO - Running cycle 1/1 for kraken test... 07:34:36 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp9miJne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:48 INFO - PROCESS | 1677 | RSS: Main: 238723072 07:34:48 INFO - PROCESS | 1677 | 07:34:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:51 INFO - PROCESS | 1677 | RSS: Main: 285446144 07:34:51 INFO - PROCESS | 1677 | 07:34:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 07:34:55 INFO - PROCESS | 1677 | RSS: Main: 298774528 07:34:55 INFO - PROCESS | 1677 | 07:34:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 07:34:59 INFO - PROCESS | 1677 | RSS: Main: 386179072 07:34:59 INFO - PROCESS | 1677 | 07:35:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 07:35:01 INFO - PROCESS | 1677 | RSS: Main: 287211520 07:35:01 INFO - PROCESS | 1677 | 07:35:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:04 INFO - PROCESS | 1677 | RSS: Main: 291328000 07:35:04 INFO - PROCESS | 1677 | 07:35:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:07 INFO - PROCESS | 1677 | RSS: Main: 330764288 07:35:07 INFO - PROCESS | 1677 | 07:35:10 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:11 INFO - PROCESS | 1677 | RSS: Main: 331333632 07:35:11 INFO - PROCESS | 1677 | 07:35:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 07:35:15 INFO - PROCESS | 1677 | RSS: Main: 330604544 07:35:15 INFO - PROCESS | 1677 | 07:35:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:17 INFO - PROCESS | 1677 | RSS: Main: 319639552 07:35:17 INFO - PROCESS | 1677 | 07:35:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:19 INFO - PROCESS | 1677 | RSS: Main: 327630848 07:35:19 INFO - PROCESS | 1677 | 07:35:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:22 INFO - PROCESS | 1677 | RSS: Main: 329478144 07:35:22 INFO - PROCESS | 1677 | 07:35:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:26 INFO - PROCESS | 1677 | RSS: Main: 334675968 07:35:26 INFO - PROCESS | 1677 | 07:35:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:29 INFO - PROCESS | 1677 | RSS: Main: 332218368 07:35:29 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 07:35:31 INFO - PROCESS | 1677 | RSS: Main: 396689408 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | __start_tp_report 07:35:31 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 07:35:31 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 07:35:31 INFO - PROCESS | 1677 | |i|pagename|runs| 07:35:31 INFO - PROCESS | 1677 | |0;ai-astar;111;110;111;112;113;114;122;158;165;110 07:35:31 INFO - PROCESS | 1677 | |1;audio-beat-detection;157;120;141;169;121;146;126;136;205;147 07:35:31 INFO - PROCESS | 1677 | |2;audio-dft;185;189;187;183;187;182;180;187;185;183 07:35:31 INFO - PROCESS | 1677 | |3;audio-fft;73;74;75;148;60;72;88;94;144;55 07:35:31 INFO - PROCESS | 1677 | |4;audio-oscillator;93;88;139;78;80;82;127;80;79;133 07:35:31 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;86;84;88;84;86;84;87;85;86;85 07:35:31 INFO - PROCESS | 1677 | |6;imaging-darkroom;117;148;109;92;93;102;92;92;105;145 07:35:31 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;86;84;83;85;82;85;69;139;135 07:35:31 INFO - PROCESS | 1677 | |8;json-parse-financial;61;62;61;60;60;60;60;83;92;91 07:35:31 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;64;72;77;76;70;66;68;69;67 07:35:31 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;82;84;78;84;82;81;81;81;81;83 07:35:31 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;135;140;136;136;136;137;138;139;176;168 07:35:31 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;171;166;169;171;175;170;172;169;166;224 07:35:31 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;71;70;70;68;69;70;68;68;69;83 07:35:31 INFO - PROCESS | 1677 | __end_tp_report 07:35:31 INFO - PROCESS | 1677 | __start_cc_report 07:35:31 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1973 07:35:31 INFO - PROCESS | 1677 | __end_cc_report 07:35:31 INFO - PROCESS | 1677 | __startTimestamp1461335731652__endTimestamp 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | ------- Summary: start ------- 07:35:31 INFO - PROCESS | 1677 | Number of tests: 14 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:122.60 Median:113.50 stddev:20.86 (18.4%) stddev-sans-first:21.70 07:35:31 INFO - PROCESS | 1677 | Values: 111.0 110.0 111.0 112.0 113.0 114.0 122.0 158.0 165.0 110.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:146.50 stddev:25.72 (17.6%) stddev-sans-first:27.01 07:35:31 INFO - PROCESS | 1677 | Values: 157.0 120.0 141.0 169.0 121.0 146.0 126.0 136.0 205.0 147.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.80 Median:186.00 stddev:2.78 (1.5%) stddev-sans-first:2.95 07:35:31 INFO - PROCESS | 1677 | Values: 185.0 189.0 187.0 183.0 187.0 182.0 180.0 187.0 185.0 183.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.50 stddev:32.47 (44.2%) stddev-sans-first:33.97 07:35:31 INFO - PROCESS | 1677 | Values: 73.0 74.0 75.0 148.0 60.0 72.0 88.0 94.0 144.0 55.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:80.00 stddev:24.80 (31.0%) stddev-sans-first:26.24 07:35:31 INFO - PROCESS | 1677 | Values: 93.0 88.0 139.0 78.0 80.0 82.0 127.0 80.0 79.0 133.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 07:35:31 INFO - PROCESS | 1677 | Values: 86.0 84.0 88.0 84.0 86.0 84.0 87.0 85.0 86.0 85.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:120.00 stddev:21.26 (17.7%) stddev-sans-first:22.37 07:35:31 INFO - PROCESS | 1677 | Values: 117.0 148.0 109.0 92.0 93.0 102.0 92.0 92.0 105.0 145.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:84.50 stddev:23.57 (27.9%) stddev-sans-first:24.80 07:35:31 INFO - PROCESS | 1677 | Values: 85.0 86.0 84.0 83.0 85.0 82.0 85.0 69.0 139.0 135.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:61.50 stddev:13.78 (22.4%) stddev-sans-first:14.31 07:35:31 INFO - PROCESS | 1677 | Values: 61.0 62.0 61.0 60.0 60.0 60.0 60.0 83.0 92.0 91.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:4.43 (6.4%) stddev-sans-first:4.40 07:35:31 INFO - PROCESS | 1677 | Values: 65.0 64.0 72.0 77.0 76.0 70.0 66.0 68.0 69.0 67.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.77 (2.2%) stddev-sans-first:1.87 07:35:31 INFO - PROCESS | 1677 | Values: 82.0 84.0 78.0 84.0 82.0 81.0 81.0 81.0 81.0 83.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:138.50 stddev:14.90 (10.8%) stddev-sans-first:15.44 07:35:31 INFO - PROCESS | 1677 | Values: 135.0 140.0 136.0 136.0 136.0 137.0 138.0 139.0 176.0 168.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:171.00 stddev:17.32 (10.1%) stddev-sans-first:18.30 07:35:31 INFO - PROCESS | 1677 | Values: 171.0 166.0 169.0 171.0 175.0 170.0 172.0 169.0 166.0 224.0 07:35:31 INFO - PROCESS | 1677 | 07:35:31 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:4.48 (6.4%) stddev-sans-first:4.75 07:35:31 INFO - PROCESS | 1677 | Values: 71.0 70.0 70.0 68.0 69.0 70.0 68.0 68.0 69.0 83.0 07:35:31 INFO - PROCESS | 1677 | -------- Summary: end -------- 07:35:31 INFO - PROCESS | 1677 | 07:35:32 INFO - TEST-INFO | 1677: exit 0 07:35:32 INFO - TEST-OK | kraken | took 59207ms 07:35:32 INFO - SUITE-END | took 1173s 07:35:32 INFO - Completed test suite (00:19:34) 07:35:32 INFO - javascript benchmark 07:35:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2829.603855460236, 3430.742694297928, 3441.776284541503, 3441.98279008605, 3487.0584942065643, 5520.889582208353, 5595.832125036245, 5612.69130197839, 5618.971905140474, 5668.603197776158, 4882.292067650189, 5673.432656734324, 5689.743961521731, 5795.0, 5807.41925807419, 5084.3644544431945, 5106.7701953412, 5149.944261426399, 5161.793528258884, 5251.76367063483, 5170.53465188133, 5227.372715274172, 5228.032813929416, 5230.267762513251, 5250.65870718402, 5082.720450375228, 5087.160618497944, 5178.922316165261, 5179.766910489037, 5188.870278243036, 5122.1036318644465, 5152.227165925104, 5184.092783762826, 5211.661242019257, 5230.267762513251, 5076.517730815566, 5119.232115182753, 5120.462351453081, 5153.969206158783, 5182.274481572583, 5504.366997795265, 5596.468335508121, 5631.690257035862, 5632.493075623172, 5636.4927156556105, 6057.818265452043, 6113.510919126459, 6131.988406491147, 6133.242854861876, 6133.907991380132, 6226.782062627786, 6239.906401403982, 6286.339934306923, 6293.244810622755, 6312.842178945517, 5751.25233719618, 5759.596828222068, 5772.567057470665, 5778.913316300259, 5787.884242315172, 6206.689665516707, 6250.468710159596, 6335.556511044183, 6337.96831015842, 6365.554411191172, 6090.482309003784, 6109.694515274307, 6122.326544080148, 6123.387661233841, 6144.692765361714, 4720.33915251865, 5689.800856969986, 6174.938250617526, 6207.193064901534, 6264.655443950535, 6112.989854784112, 6113.358097399798, 6214.161088253028, 6217.285012223561, 6238.251409830758, 6132.41742034506, 6164.198654174928, 6179.104029915727, 6190.195274614362, 6197.349278325801, 4745.169595320874, 4882.951170488321, 4888.682235654671, 4898.485659005824, 4934.037862616827, 4398.626116780046, 4418.624416924533, 4461.397711308997, 4462.107578484316, 4464.419625448736, 5648.378678345379, 5651.378348381675, 5653.575981801381, 5655.434456554394, 5661.631993920382, 6162.476189523851, 6177.166082578794, 6229.657368844757, 6249.000159974473, 6278.6860656966965, 5701.230333904869, 5712.371639119693, 5721.828345149652, 5726.914096288559, 5742.28221472316, 5263.736813159327, 5335.279737235501, 5347.705876176769, 5356.062689029404, 5364.275822763955, 6253.280872699606, 6301.6534090625455, 6306.432421082033, 6308.432241098231, 6326.557141000086, 6186.0, 6216.036514340284, 6233.501319894307, 6235.563510554218, 6248.968755156195, 5275.235090911873, 6257.405546473078, 6306.369363063657, 6315.27374351937, 6328.778492752732, 6123.418275263843, 6152.78465253714, 6158.230221222348, 6162.506999439945, 6163.0, 6071.5446341523675, 6228.096925945803, 6248.437640612185, 6261.311255761953, 6264.68676566179, 5267.236250743697, 6012.969935150296, 6041.546883983807, 6054.969725151523, 6073.453389194994, 4702.600278976325, 5565.1930470082425, 6037.9094313584455, 6045.455908968214, 6060.909086363797, 5840.123981402823, 5849.883002339844, 5892.499137573354, 5900.586958912835, 5911.733971971185, 5861.296644402529, 6033.637981721111, 6073.635581865102, 6113.449789518964, 6138.938610613836, 5894.675792831264, 5918.822435326947, 5926.348101708722, 5928.584999050025, 5930.881382372242], "value": 5635.3761047866365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.8550005998321, 522.187997663633, 543.244889603451, 547.3787251469581, 575.839683038677, 29817.701822981762, 30272.394552108944, 30298.0, 30398.936037238702, 36910.8154459228, 40277.0, 40935.79532102343, 40943.97640059, 40946.795266023706, 41040.79479602605, 9404.059594040593, 9657.32398732089, 9661.95169024154, 9668.419894806335, 9698.951505242463, 8406.159384061606, 8658.87011694825, 9538.998405167462, 9665.178459830922, 11306.660800176009, 11394.430278486085, 11500.482478288455, 11515.078793696526, 11519.596814111508, 11537.711557211094, 8987.831581894377, 11440.970312671858, 11554.711132221677, 11580.363080030595, 11595.246308989888, 8457.154284571494, 8726.52004139772, 8734.737957861274, 8735.694250701195, 11439.0, 32854.0, 38751.03122421962, 39678.809635710975, 39741.00647483807, 39781.0, 3178.3484385700876, 3192.616885973675, 3194.025822124251, 3453.9654603454146, 3979.920401591981, 25404.364890877692, 26763.063292784853, 26899.731002689918, 26900.461990760272, 27151.185464436097, 2629.3558078270944, 2664.147472808702, 2668.5997100434897, 2875.5830404591215, 2931.5309550472034, 300344.0, 356910.0, 359360.0, 359954.0, 360225.19887400395, 34069.829650851585, 34707.0, 34826.47760283598, 34856.82571587126, 56854.0, 33844.32311353759, 33979.150521236676, 34165.975020749414, 34180.48729269063, 34192.0, 14600.926995364955, 14850.886183536062, 14854.777178342334, 14860.554183374516, 14884.181370024753, 12625.810612840814, 12737.745245095046, 12745.68135796594, 12787.808182877265, 12827.743445131231, 7471.0, 7617.200193979663, 7892.684292628345, 8006.319462845607, 8117.025956885093, 3252.837358132084, 3287.8849240276954, 3293.8353082346266, 3301.752368572367, 3322.9667703322657, 961.7643677298967, 1003.0, 1015.2588610314364, 1055.7518983038979, 1062.9681109566725, 27904.091779720602, 28381.290467738472, 28418.857905710338, 28750.968580498327, 29203.977860774772, 1009.4296722351847, 1098.6374496416324, 1100.070440477795, 1126.1947707389256, 1185.0874826383636, 14786.92606536982, 14839.629009274855, 14904.140094144956, 15034.248287585577, 15175.392984280727, 650541.7472912605, 704949.0, 728897.0, 737386.0, 740084.0, 53599.46400536023, 54124.0, 54311.72844135754, 54485.0, 54698.72650636722, 1314.7633425983224, 1337.852836188038, 1460.167704408477, 1462.6343414146463, 1479.2086233864832, 25071.080118516395, 28016.0, 28033.719662803112, 28304.86780528838, 28900.132996010154, 43570.56429435792, 51353.22970155376, 52109.0, 52151.95696086133, 52157.0, 584459.0, 589561.0, 589817.7636677353, 590886.0, 591950.0, 23206.0, 25750.356241094123, 25781.0, 26092.0, 26365.0, 39409.80295098621, 39779.0, 39797.60202397939, 40220.1955960885, 40524.59475405208, 34739.61041558309, 34740.826295868355, 34815.47776783401, 35553.644463555036, 35565.82217088898, 34084.65915340914, 34234.45944932534, 34337.484937726455, 34426.82786586051, 34969.650303497656, 34667.13332166716, 34917.0, 34993.9501814946, 35935.0, 36941.70704025346, 29261.97583084582, 30307.848460757556, 30733.078007659806, 31935.0, 32079.35841283208, 22197.55604887861, 23836.888767477365, 23931.880340598185, 23976.160834370712, 24016.87991560031], "value": 17824.905246426286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.13423906269475, 360.9404448266036, 388.50659662228963, 403.35463258785944, 417.7890165466439, 16486.83513164868, 20288.391348259556, 20756.481087972807, 20779.584408311825, 20800.271990480316, 19216.42350729477, 20893.47766305843, 21448.8927555362, 21923.232686855965, 22004.119835206573, 5144.408393034792, 5781.364049954502, 5982.760689572412, 5988.19159413478, 6014.308354539218, 4181.790910454481, 4439.977800110995, 5779.913301300463, 6214.875702485948, 6571.211454625452, 6424.903626445607, 6501.934980650204, 6513.283538810727, 6526.184226971629, 6533.411992920636, 6342.809715708513, 6514.088027676153, 6527.347265273482, 6535.803925882231, 6539.378759017885, 3743.2139250757373, 3957.1096503286817, 4008.2076618124497, 5692.829215123553, 5711.685857277848, 25477.49045019108, 26002.6099608506, 26562.468750625074, 26756.464870702475, 26940.59589106165, 2096.6854971754206, 2175.793299636548, 2204.4929666176868, 2382.285314405671, 2758.462099890522, 12550.937245313715, 13832.930835345758, 14766.375698673137, 15118.924405377902, 15260.084394936339, 1683.225716170563, 1758.8944663320242, 1777.413453560335, 1805.124514610413, 1881.1534809335853, 115758.42120789342, 118516.40741796322, 118971.4051429746, 120194.0, 121761.0, 8943.23982461498, 10916.727081823017, 11351.716207094889, 11353.205275630791, 11478.598249061242, 14598.41606335756, 14615.342309596093, 14666.0, 14669.193194374198, 14685.853141468662, 8695.521746304014, 8864.379493435526, 8875.689350872817, 8964.417312874773, 9063.0, 7829.530228186327, 8532.0, 8948.0, 8949.194572488377, 9104.544772761468, 6744.359285867835, 6843.893663801679, 6851.143607049119, 6857.908337956871, 6861.348171923659, 1580.91304978225, 1594.226800001998, 1597.249292832367, 1604.8074231092344, 1748.5191572317715, 845.7378212754066, 943.3726571829657, 1019.9286049976579, 1020.0564477857952, 1103.2608152537819, 19890.90054549747, 21576.029078691183, 22479.723051401434, 22642.207522736626, 22872.542549148922, 961.1685891703626, 997.7356000659831, 997.870276864003, 1007.0634310091685, 1063.7234319077095, 10277.331973421853, 11405.714857128638, 11691.590794322157, 11766.0, 11870.703232419259, 572862.1356893189, 576930.1153494206, 586557.0, 587018.0, 590943.0, 96995.0, 125812.37093814473, 137746.31126844502, 139409.30295348662, 145082.0, 1016.7763092119721, 1028.7068185567227, 1041.063043261056, 1059.2055958031476, 1062.5112448273726, 18342.724859126858, 18399.0, 18670.0, 18862.811371886655, 19046.333378332245, 37355.439668404455, 47075.52924470849, 47786.04427911492, 49538.00923981428, 52683.73658131685, 73281.0, 74899.87650185142, 74911.0, 77482.0, 79220.60389698014, 7711.190325015793, 7729.768106956801, 7994.40041996841, 8195.67217311301, 8364.079951205484, 10946.17903657213, 11009.61466348674, 12588.181768185039, 12777.0, 12970.740585188054, 7232.734271502361, 8663.740087797376, 11152.832707509557, 11154.498047587716, 11704.824427633423, 11088.168387370819, 11204.215704900578, 11351.262167959056, 11407.600733974272, 11530.3081815088, 10832.837507437238, 11179.0, 11666.941665291619, 11752.059835213333, 11802.291862488279, 8227.382946278933, 8242.670293188205, 8302.626381812954, 8387.245147936716, 8658.177473140293, 10998.890011099787, 11309.773804524028, 11328.093752499944, 11385.54457821711, 11506.482208300478], "value": 9727.35485355794, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.9243791591464, 1381.2679279981612, 1543.444360030389, 1742.8845538855128, 1957.4029920874136, 7929.881051784228, 8634.956825215873, 8874.55627218638, 8890.155435233659, 8892.555372231394, 8449.45078569894, 8689.91310086899, 8691.826163476742, 8693.913060869405, 8697.347698922575, 1826.2056005637523, 2379.4170428245106, 2409.674693916321, 2449.5223431430877, 2465.839720418176, 2465.815063870217, 2480.8139389545854, 2484.6024636058232, 2493.1772515069983, 2494.2641920633364, 2066.5763518478752, 2408.8554686718767, 2449.2774631483667, 2454.9263522094366, 2457.913973010945, 2125.6598944169014, 2201.8128459081, 2204.867707937529, 2208.2381578355444, 2415.4444477770126, 2347.1080989224156, 2430.3195105370523, 2437.731849496554, 2438.146648672968, 2451.497443024176, 8592.914070859273, 8667.479951202948, 8677.826443471095, 8688.47869127848, 8691.695790647296, 5114.3862736471865, 5259.684418934838, 5263.315768950012, 5284.471552844685, 5292.49721276482, 3396.575428071491, 3426.109211605001, 3470.4967779671806, 3532.7350448716447, 3545.53907991962, 981.215027977615, 989.1147423056397, 1025.6974192613197, 1034.9016843399866, 1036.3056751976194, 11478.88521114778, 11539.884601153964, 11555.884441155566, 11562.710932226762, 11566.595169169039, 4588.931166032512, 4768.117898188846, 4818.036392721469, 4819.204831202883, 4854.199057155601, 9790.755231119136, 9793.069658382443, 9802.509874506246, 9853.014698530089, 9853.211743060538, 5331.840044798662, 5334.093204155303, 5346.278252435949, 5348.893022139536, 5358.142697168434, 4415.381846541487, 4587.174308624413, 4779.593734532604, 4915.926261106087, 4935.210366341368, 3880.728349015542, 3924.411338299221, 3979.3633018716864, 4023.959760402417, 4047.514298284225, 1334.7797613393682, 1335.2389138191331, 1342.5435351980373, 1352.4252192818012, 1356.403182599653, 829.2163905109613, 840.8948881389827, 879.9296056315479, 902.2917010147003, 939.9848163982882, 5004.474530174352, 5731.512821410227, 5847.44449277318, 6035.969820150959, 6103.84740381494, 970.4419958523877, 983.4492684096929, 992.1864071461332, 994.1500017484947, 998.1665309466676, 3832.3485007548784, 3913.491246138041, 3976.602339766, 4015.7791321477016, 4020.83916643331, 10078.798424031625, 10652.0, 10742.892571074346, 10746.086582640406, 10752.569897204181, 10465.9476702616, 10556.049955504042, 10705.304155229886, 10714.196435267386, 10720.678379648467, 8244.587770611446, 8253.33973282124, 8399.832003360021, 8399.874001889977, 8416.989961204694, 5762.250907382014, 5825.563082768725, 5906.320773110975, 5991.041433370639, 6006.849828754316, 9729.221662267144, 9950.950245249018, 10053.899461005589, 10101.949490252502, 10159.7460063499, 8924.419912705653, 10075.899241007495, 10371.688849334532, 10493.108085812486, 10527.315724477885, 6447.0651755494255, 6641.767538136142, 6855.691493882688, 7015.754448594274, 7100.644967751488, 8274.0, 8287.792805179677, 8380.24577788002, 8384.371172162235, 8403.159684031549, 7330.560166390033, 7464.290892365217, 7467.813304667209, 7547.886781698388, 7694.345980591488, 7247.166575843635, 7280.635968201675, 7336.669849856876, 7341.522801018131, 7475.551466912003, 6974.58152510851, 7079.82300442493, 7125.0, 7125.251848555827, 7142.750003749844, 4753.226429484046, 4904.019196160853, 4910.45984941649, 4966.751662416792, 5098.796048158032, 4807.254875494304, 4863.610911127172, 4940.407151141886, 5023.799048038038, 5149.819756308661], "value": 4578.318556380437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [247.69780867341842, 309.1606288925568, 323.5874260318094, 330.6742858284588, 332.2640351621159, 5192.870178245536, 5989.071693887444, 6012.699365031747, 6043.8489037774025, 6078.452939235473, 4689.320048592952, 5131.43428285857, 5188.870278243036, 6001.369856165105, 6005.789797357093, 4468.4414448193975, 4494.707843990146, 4494.73031618104, 4502.639788816895, 4516.661250406216, 3504.7196224302124, 4415.977920110395, 4494.842680506183, 4510.706804057742, 4536.5236650151755, 3803.953912674009, 4282.571742825724, 4368.737875727466, 4418.690691651585, 4432.578905004019, 3671.81640917953, 4437.5784300491405, 4440.888977775549, 4453.576910193527, 4463.085067561142, 3376.881809136693, 3523.365794157051, 3581.6955558777536, 3866.690664746842, 3879.922401551953, 5148.948510514884, 5496.367917689477, 5649.23735295734, 5651.463111004489, 5762.423757624246, 4017.799110044486, 4599.310103484504, 5149.613778966593, 5212.576152089297, 5232.0, 6023.578349515536, 6301.243850737895, 6313.337099604521, 6314.0, 6321.74713011479, 3807.3146833569945, 4309.676774241944, 4313.1158112586845, 4327.653787696977, 4332.1985432695055, 6332.68336583169, 6578.237140401043, 6704.329567043256, 6708.66456677169, 6722.4285935695525, 4126.958730412657, 4220.683448741357, 4406.25093734066, 4409.867703968822, 4433.224185767478, 3946.9210615787524, 4457.9331310030375, 4485.596296333346, 4493.191225579427, 4504.594586487232, 4609.2564491653675, 4819.6867203631655, 5003.999200159982, 5212.4266330703595, 5241.31862857826, 5628.437156284339, 5660.716964151776, 6329.177206963157, 6331.366863313632, 6363.395477429729, 1280.2830414967648, 1327.5353626230742, 1535.7005383950022, 1554.440401455475, 1556.6419723463666, 983.5475681186591, 1017.5471914997755, 1020.8162530744389, 1025.5333823110466, 1037.5486663301488, 5453.318335208099, 5898.233229680114, 5940.881182376328, 5962.522998160137, 5965.79119730816, 5180.766865491062, 6550.314371107823, 6563.835904102436, 6577.506686998494, 6583.769568065095, 4995.925875936691, 5582.218489411485, 5680.204771332017, 5919.200907877467, 5950.649493450063, 3024.9546256806166, 3431.5024321473247, 3448.896533104011, 3480.408330583756, 3482.460218666111, 6626.966865165643, 6910.0, 6912.205096413876, 6942.201646810681, 6958.756443524452, 5357.464253574612, 6237.066509382015, 6802.965985170142, 6803.7618683345845, 6820.5676807870905, 6693.966530167416, 6827.52207345481, 6895.965520172367, 6900.3099690031595, 6916.377526022682, 6301.558890877594, 6565.0, 6581.506387020897, 6600.141981542369, 6609.173853268341, 6213.813585592439, 6485.8702825944165, 6495.480361571157, 6501.0, 6510.511711621552, 5722.570807189394, 6806.965965170142, 6897.275786042594, 6901.965490172718, 6910.20532638753, 4232.428622135973, 4239.724417912826, 4249.702520823636, 4258.446401967724, 4277.721948073366, 6309.3690630936535, 6554.770583029571, 6607.9669601651685, 6611.735530578723, 6618.5770059437455, 5831.679257640871, 6107.969460152671, 6252.843678908063, 6354.301026887131, 6378.649174295459, 5156.716380599103, 6329.885574376508, 6333.018382150774, 6343.492520598249, 6361.332060133619, 5451.809186678447, 6196.535259855439, 6253.37466253371, 6273.545782494298, 6281.654509002049, 5763.510101641407, 6359.20509936258, 6380.3619638035825, 6388.616682999035, 6392.712327945346, 5814.5639077068545, 5846.544451330366, 5891.793787217427, 6001.309849367379, 6296.0555916612875], "value": 4595.613642363907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2517766801676, 664.8936170212767, 684.9965750171245, 750.961140503533, 751.0911796725961, 14667.413303467862, 15064.171470569114, 15229.619259518518, 15280.388784448609, 15299.617509562266, 13131.540396086139, 13203.933980330108, 13204.0, 13220.471181152743, 13251.138675986054, 652.4649787174519, 694.2675477371371, 882.9558522073903, 898.6315610599672, 902.6163880350857, 902.2962089570145, 907.7412937312868, 909.3361845852531, 909.7498187998287, 910.5947853205327, 963.5230560872378, 967.0233064604764, 969.0600117885675, 970.1559643110504, 970.9271804614647, 747.8616455955665, 931.8136372725414, 960.5053397500293, 961.024560071528, 962.451402700461, 714.8463080437731, 715.7244460882546, 715.8568286342701, 716.1978583985968, 717.989230161548, 14763.852361476462, 14858.331375088146, 14879.404823807035, 14883.479078232318, 14896.553103406915, 12408.937955310166, 12435.316057616827, 12510.74978500434, 12540.24758514492, 12577.662831832122, 9905.405675659484, 10038.64864729731, 10245.129164021067, 10379.325343852626, 10774.97637724415, 3553.2640564852377, 3563.518924945151, 3565.322588708137, 3617.1680513482047, 3639.553381603006, 84481.57759211225, 84674.72987905248, 86703.56648216782, 86848.13151868463, 87108.0, 9266.490343031199, 9486.288528360401, 9490.90509094914, 9691.660791872391, 9854.901450985399, 22429.102835886708, 22455.32634020982, 22461.775382246295, 22468.775312246995, 22483.66274505884, 7285.235050319746, 7335.486515943832, 7409.259074092655, 7624.5425274483705, 7647.847043059219, 4081.306177949696, 4130.56629053951, 4131.969228328967, 4159.833606655699, 4187.413762073312, 3597.4963505109304, 3696.648818362305, 3700.204456041964, 3700.2229531798084, 3704.3517384457614, 556.3296228045195, 660.6828722213364, 668.3383450384084, 669.6584741781727, 682.3858527325348, 546.8140832117099, 562.9465200805917, 585.4145854145854, 594.2334388638608, 606.4663096475074, 7836.373090152774, 7888.171741967126, 7891.84216315682, 8242.340612750966, 8305.137797916219, 468.6461721400321, 504.75771629617986, 574.3395095639964, 575.545319197829, 593.0570393074945, 3790.3935370341164, 3852.5755676553817, 3881.573026967031, 3910.416281406035, 4039.1517781265675, 89547.0, 93021.5348923251, 102142.48928755458, 103764.96235037704, 105263.47368263263, 85081.0, 85922.99999999875, 86236.0, 86674.0, 86730.13269867221, 55865.441345586834, 73838.15404615035, 74661.0, 75510.4897902039, 76190.0, 7799.0, 7799.298063174341, 7949.562774047483, 7951.045874494866, 8125.431219814556, 46332.0, 46813.53186468092, 47138.76430617825, 47268.7636561815, 47678.52321476741, 64441.193066908796, 65430.0, 69571.30428695648, 70331.0, 70406.64796675983, 10090.596376145166, 10132.848007280045, 10263.84604230952, 10310.690679279634, 10602.522886469973, 11058.944705276423, 11249.381284029458, 11253.381064041556, 12323.50705971787, 12452.813207802072, 8139.898642307468, 10650.254482186172, 11267.830982535104, 11477.253978491372, 11615.070794336601, 10810.783784324427, 11425.028872545927, 11560.6531804046, 11561.768764624829, 11689.298642081163, 9095.636174553209, 11190.496427660937, 11232.213745037769, 11241.044511216638, 11249.156313276373, 9390.0, 9426.293028023063, 9766.0, 9774.511274436392, 10044.347117437343, 9651.372660777028, 9673.081057299545, 9730.80538389214, 9853.802923941337, 9885.524981137367], "value": 6871.2156059140925, "unit": "score"}], "name": "dromaeo_css", "value": 7216.793166430788, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 112.0, 113.0, 114.0, 122.0, 158.0, 165.0, 110.0], "value": 122.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 141.0, 169.0, 121.0, 146.0, 126.0, 136.0, 205.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 189.0, 187.0, 183.0, 187.0, 182.0, 180.0, 187.0, 185.0, 183.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 148.0, 60.0, 72.0, 88.0, 94.0, 144.0, 55.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 139.0, 78.0, 80.0, 82.0, 127.0, 80.0, 79.0, 133.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 84.0, 86.0, 84.0, 87.0, 85.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 148.0, 109.0, 92.0, 93.0, 102.0, 92.0, 92.0, 105.0, 145.0], "value": 109.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 83.0, 85.0, 82.0, 85.0, 69.0, 139.0, 135.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 60.0, 60.0, 60.0, 60.0, 83.0, 92.0, 91.0], "value": 69.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 72.0, 77.0, 76.0, 70.0, 66.0, 68.0, 69.0, 67.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 78.0, 84.0, 82.0, 81.0, 81.0, 81.0, 81.0, 83.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 136.0, 136.0, 136.0, 137.0, 138.0, 139.0, 176.0, 168.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 169.0, 171.0, 175.0, 170.0, 172.0, 169.0, 166.0, 224.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 68.0, 69.0, 70.0, 68.0, 68.0, 69.0, 83.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1538.7999999999997, "alertThreshold": 2.0}]} 07:35:32 INFO - Return code: 0 07:35:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:35:32 ERROR - # TBPL SUCCESS # 07:35:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:32 INFO - 2016-04-22 07:35:32.947 screenresolution[1681:10249] starting screenresolution argv=screenresolution get 07:35:32 INFO - 2016-04-22 07:35:32.950 screenresolution[1681:10249] Display 0: 1600x1200x32@60 07:35:32 INFO - 2016-04-22 07:35:32.956 screenresolution[1682:10252] starting screenresolution argv=screenresolution list 07:35:32 INFO - Available Modes on Display 0 07:35:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:33 INFO - Intel Iris: 07:35:33 INFO - Chipset Model: Intel Iris 07:35:33 INFO - Type: GPU 07:35:33 INFO - Bus: Built-In 07:35:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:35:33 INFO - Vendor: Intel (0x8086) 07:35:33 INFO - Device ID: 0x0a2e 07:35:33 INFO - Revision ID: 0x0009 07:35:33 INFO - Displays: 07:35:33 INFO - Display: 07:35:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:33 INFO - Display Serial Number: 1600x1200 60 07:35:33 INFO - Main Display: Yes 07:35:33 INFO - Mirror: Off 07:35:33 INFO - Online: Yes 07:35:33 INFO - Rotation: Supported 07:35:33 INFO - Return code: 0 07:35:33 INFO - Running post-action listener: _resource_record_post_action 07:35:33 INFO - Running post-run listener: _resource_record_post_run 07:35:34 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32452096; Write bytes: 695056384; Read time: 321; Write time: 1884 07:35:34 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378034688; Write bytes: 372213760; Read time: 28474; Write time: 700 07:35:34 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 31526400; Write bytes: 297607168; Read time: 307; Write time: 1135 07:35:34 INFO - Running post-run listener: _upload_blobber_files 07:35:34 INFO - Blob upload gear active. 07:35:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:34 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 07:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:36 INFO - (blobuploader) - INFO - Done attempting. 07:35:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:37 INFO - (blobuploader) - INFO - Done attempting. 07:35:37 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:37 INFO - Return code: 0 07:35:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/257f079ed6ec6d3e2ead47ae8f7f97180ea4842a9bdf67e22a58263b8a0f6a87ccb9e2d30247e257660f857707a1d3c63c86261480db8434d357955df9f36425", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e56dca609a43436a7927bda1e0bd30ba5abadde23219039581980f5c61d14ad6be0a9b82242d4495e66318a785ae07fcbe664ead4037b7c8970943ffe53f071"} 07:35:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:37 INFO - Contents: 07:35:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/257f079ed6ec6d3e2ead47ae8f7f97180ea4842a9bdf67e22a58263b8a0f6a87ccb9e2d30247e257660f857707a1d3c63c86261480db8434d357955df9f36425", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e56dca609a43436a7927bda1e0bd30ba5abadde23219039581980f5c61d14ad6be0a9b82242d4495e66318a785ae07fcbe664ead4037b7c8970943ffe53f071"} 07:35:37 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:37 INFO - Copying logs to upload dir... 07:35:37 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.312466 ========= master_lag: 31.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-22 07:36:08.201373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-04-22 07:36:08.205589) ========= 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.ptQHKqKcVG/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.xZNfip71B7/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/257f079ed6ec6d3e2ead47ae8f7f97180ea4842a9bdf67e22a58263b8a0f6a87ccb9e2d30247e257660f857707a1d3c63c86261480db8434d357955df9f36425", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e56dca609a43436a7927bda1e0bd30ba5abadde23219039581980f5c61d14ad6be0a9b82242d4495e66318a785ae07fcbe664ead4037b7c8970943ffe53f071"} build_url:https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/OISEBVnlQ-ScnOSXaNSBBA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/257f079ed6ec6d3e2ead47ae8f7f97180ea4842a9bdf67e22a58263b8a0f6a87ccb9e2d30247e257660f857707a1d3c63c86261480db8434d357955df9f36425", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e56dca609a43436a7927bda1e0bd30ba5abadde23219039581980f5c61d14ad6be0a9b82242d4495e66318a785ae07fcbe664ead4037b7c8970943ffe53f071"}' ========= master_lag: 11.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-04-22 07:36:19.429869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 29 secs) (at 2016-04-22 07:36:19.430163) ========= 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.ptQHKqKcVG/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.xZNfip71B7/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005066 ========= master_lag: 29.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 29 secs) (at 2016-04-22 07:36:48.727415) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-22 07:36:48.727774) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-22 07:36:54.407336) ========= ========= Total master_lag: 123.82 =========