builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1476105104.07 results: success (0) buildid: 20161010031417 builduid: fbb853e05c8b4f5e92a472d0f75a2bc3 revision: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.074357) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.074916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.075192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.098815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.099380) ========= 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.cpba9AAmOm/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.kKueAannhq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-10-10 06:11:44-- 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% 9.10M=0.001s 2016-10-10 06:11:44 (9.10 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.236106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.236421) ========= 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.cpba9AAmOm/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.kKueAannhq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.033795 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:44.289457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 06:11:44.289872) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf --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 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cpba9AAmOm/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.kKueAannhq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-10-10 06:11:44,361 truncating revision to first 12 chars 2016-10-10 06:11:44,361 Setting DEBUG logging. 2016-10-10 06:11:44,361 attempt 1/10 2016-10-10 06:11:44,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7be6b348c431?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 06:11:44,663 unpacking tar archive at: fx-team-7be6b348c431/testing/mozharness/ program finished with exit code 0 elapsedTime=1.170441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 06:11:45.482613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:45.482963) ========= script_repo_revision: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:45.483428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:45.483718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 06:11:45.502555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-10 06:11:45.503062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.cpba9AAmOm/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.kKueAannhq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:11:45 INFO - MultiFileLogger online at 20161010 06:11:45 in /builds/slave/test 06:11:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:11:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:45 INFO - {'append_to_log': False, 06:11:45 INFO - 'base_work_dir': '/builds/slave/test', 06:11:45 INFO - 'blob_upload_branch': 'Fx-Team', 06:11:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:45 INFO - 'branch': 'Fx-Team', 06:11:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:45 INFO - 'config_files': ('talos/mac_config.py',), 06:11:45 INFO - 'default_actions': ('clobber', 06:11:45 INFO - 'read-buildbot-config', 06:11:45 INFO - 'download-and-extract', 06:11:45 INFO - 'populate-webroot', 06:11:45 INFO - 'create-virtualenv', 06:11:45 INFO - 'install', 06:11:45 INFO - 'run-tests'), 06:11:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:45 INFO - 'download_minidump_stackwalk': True, 06:11:45 INFO - 'download_symbols': 'ondemand', 06:11:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:45 INFO - 'installer_path': 'installer.exe', 06:11:45 INFO - 'log_level': 'info', 06:11:45 INFO - 'log_name': 'talos', 06:11:45 INFO - 'log_to_console': True, 06:11:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:11:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:11:45 INFO - 'opt_config_files': (), 06:11:45 INFO - 'pip_index': False, 06:11:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:11:45 INFO - 'cmd': ('bash', 06:11:45 INFO - '-c', 06:11:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:11:45 INFO - 'enabled': True, 06:11:45 INFO - 'halt_on_failure': False, 06:11:45 INFO - 'name': 'check_screen_resolution'},), 06:11:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:11:45 INFO - 'cmd': ('bash', 06:11:45 INFO - '-c', 06:11:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:11:45 INFO - 'enabled': True, 06:11:45 INFO - 'halt_on_failure': False, 06:11:45 INFO - 'name': 'check_screen_resolution'},), 06:11:45 INFO - 'run_cmd_checks_enabled': True, 06:11:45 INFO - 'sps_profile': False, 06:11:45 INFO - 'sps_profile_interval': 0, 06:11:45 INFO - 'suite': 'dromaeojs-e10s', 06:11:45 INFO - 'system_bits': '32', 06:11:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:45 INFO - 'title': 't-yosemite-r7-0163', 06:11:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:45 INFO - 'use_talos_json': True, 06:11:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:45 INFO - 'work_dir': 'build'} 06:11:45 INFO - [mozharness: 2016-10-10 13:11:45.720466Z] Running clobber step. 06:11:45 INFO - Running pre-action listener: _resource_record_pre_action 06:11:45 INFO - Running main action method: clobber 06:11:45 INFO - rmtree: /builds/slave/test/build 06:11:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:47 INFO - Running post-action listener: _resource_record_post_action 06:11:47 INFO - [mozharness: 2016-10-10 13:11:47.936234Z] Finished clobber step (success) 06:11:47 INFO - [mozharness: 2016-10-10 13:11:47.936395Z] Running read-buildbot-config step. 06:11:47 INFO - Running pre-action listener: _resource_record_pre_action 06:11:47 INFO - Running main action method: read_buildbot_config 06:11:47 INFO - Using buildbot properties: 06:11:47 INFO - { 06:11:47 INFO - "project": "", 06:11:47 INFO - "product": "firefox", 06:11:47 INFO - "script_repo_revision": "production", 06:11:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:11:47 INFO - "repository": "", 06:11:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:11:47 INFO - "buildid": "20161010031417", 06:11:47 INFO - "pgo_build": "False", 06:11:47 INFO - "basedir": "/builds/slave/test", 06:11:47 INFO - "buildnumber": 61, 06:11:47 INFO - "slavename": "t-yosemite-r7-0163", 06:11:47 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:11:47 INFO - "platform": "yosemite_r7", 06:11:47 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 06:11:47 INFO - "branch": "fx-team", 06:11:47 INFO - "repo_path": "integration/fx-team", 06:11:47 INFO - "revision": "7be6b348c431d69f96f0765af3a0c0a0fe56d4bf", 06:11:47 INFO - "stage_platform": "macosx64", 06:11:47 INFO - "builduid": "fbb853e05c8b4f5e92a472d0f75a2bc3", 06:11:47 INFO - "slavebuilddir": "test" 06:11:47 INFO - } 06:11:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:11:47 INFO - Running post-action listener: _resource_record_post_action 06:11:47 INFO - [mozharness: 2016-10-10 13:11:47.940061Z] Finished read-buildbot-config step (success) 06:11:47 INFO - [mozharness: 2016-10-10 13:11:47.940192Z] Running download-and-extract step. 06:11:47 INFO - Running pre-action listener: _resource_record_pre_action 06:11:47 INFO - Running main action method: download_and_extract 06:11:47 INFO - mkdir: /builds/slave/test/build/tests 06:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:11:47 INFO - trying https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:11:47 INFO - Downloading https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:11:48 INFO - Downloaded 1199 bytes. 06:11:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:11:48 INFO - Using the following test package requirements: 06:11:48 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:11:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:11:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:11:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'jsshell-mac.zip'], 06:11:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:11:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:11:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:11:48 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:11:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:11:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:11:48 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:11:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:11:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:11:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:11:48 INFO - Fetch https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:11:49 INFO - Http code: 200 06:11:49 INFO - via: 1.1 4a55d86b7263f73c6817c7c25d4b3643.cloudfront.net (CloudFront) 06:11:49 INFO - x-amz-cf-id: yYQx-cNz8dzkOkEzxWOPpoJ_43yRBd01lII-1NUln1-uBIv-lKkHUQ== 06:11:49 INFO - x-amz-version-id: rLnMkqV.ul.9Qw0wbXYrozy01_dbPEjA 06:11:49 INFO - Expected file size: 16497211 06:11:49 INFO - Obtained file size: 16497211 06:11:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:11:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:11:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:11:56 INFO - Fetch https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:11:56 INFO - Http code: 200 06:11:56 INFO - via: 1.1 dc7c4fb5024ff022cad1642ec506a6e8.cloudfront.net (CloudFront) 06:11:56 INFO - x-amz-cf-id: -cY06dmot3x4OtSpd3rvIqLG2EcoHlYe9OoOx8oo3Eh8xjgYVrm-NQ== 06:11:56 INFO - x-amz-version-id: rLnMkqV.ul.9Qw0wbXYrozy01_dbPEjA 06:11:57 INFO - Expected file size: 16497211 06:11:57 INFO - Obtained file size: 16497211 06:12:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:12:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:12:03 INFO - Fetch https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:12:04 INFO - Http code: 200 06:12:04 INFO - via: 1.1 4a7b695b8ae560fe9087da065a2b7812.cloudfront.net (CloudFront) 06:12:04 INFO - x-amz-cf-id: GjwccBTsQeWY4o1Bdqch0arO5kx1d7wCtaBbY6GxznkmQ_-t_k3K7A== 06:12:04 INFO - x-amz-version-id: wYW9Tz6wRFueRqIK7zY_ny6aUN2MovwU 06:12:05 INFO - Expected file size: 14409006 06:12:05 INFO - Obtained file size: 14409006 06:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:05 INFO - trying https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:12:05 INFO - Downloading https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:12:08 INFO - Downloaded 111706661 bytes. 06:12:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:12:08 INFO - mkdir: /builds/slave/test/properties 06:12:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:12:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:12:08 INFO - Contents: 06:12:08 INFO - build_url:https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:12:09 INFO - Running post-action listener: _resource_record_post_action 06:12:09 INFO - Running post-action listener: set_extra_try_arguments 06:12:09 INFO - [mozharness: 2016-10-10 13:12:09.568907Z] Finished download-and-extract step (success) 06:12:09 INFO - [mozharness: 2016-10-10 13:12:09.569036Z] Running populate-webroot step. 06:12:09 INFO - Running pre-action listener: _resource_record_pre_action 06:12:09 INFO - Running main action method: populate_webroot 06:12:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:12:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:12:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:12:09 INFO - '--tppagecycles', 06:12:09 INFO - '7'], 06:12:09 INFO - 'tests': ['tsvgm']}}, 06:12:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:12:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:12:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:12:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:12:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['damp', 'tps']}, 06:12:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'tests': ['damp', 'tps']}, 06:12:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['dromaeo_dom']}, 06:12:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:12:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['basic_compositor_video']}, 06:12:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:12:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['a11yr', 06:12:09 INFO - 'ts_paint', 06:12:09 INFO - 'tpaint', 06:12:09 INFO - 'sessionrestore', 06:12:09 INFO - 'sessionrestore_no_auto_restore', 06:12:09 INFO - 'tabpaint']}, 06:12:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:12:09 INFO - 'ts_paint', 06:12:09 INFO - 'tpaint', 06:12:09 INFO - 'sessionrestore', 06:12:09 INFO - 'sessionrestore_no_auto_restore', 06:12:09 INFO - 'tabpaint']}, 06:12:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:12:09 INFO - 'ts_paint', 06:12:09 INFO - 'tpaint', 06:12:09 INFO - 'sessionrestore', 06:12:09 INFO - 'sessionrestore_no_auto_restore', 06:12:09 INFO - 'tabpaint']}, 06:12:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:12:09 INFO - 'ts_paint', 06:12:09 INFO - 'tpaint', 06:12:09 INFO - 'sessionrestore', 06:12:09 INFO - 'sessionrestore_no_auto_restore', 06:12:09 INFO - 'tabpaint']}, 06:12:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['a11yr', 06:12:09 INFO - 'ts_paint', 06:12:09 INFO - 'tpaint', 06:12:09 INFO - 'sessionrestore', 06:12:09 INFO - 'sessionrestore_no_auto_restore', 06:12:09 INFO - 'tabpaint']}, 06:12:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['a11yr', 06:12:09 INFO - 'ts_paint', 06:12:09 INFO - 'tpaint', 06:12:09 INFO - 'sessionrestore', 06:12:09 INFO - 'sessionrestore_no_auto_restore', 06:12:09 INFO - 'tabpaint']}, 06:12:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['tsvgx', 06:12:09 INFO - 'tsvgr_opacity', 06:12:09 INFO - 'tart', 06:12:09 INFO - 'tscrollx', 06:12:09 INFO - 'cart']}, 06:12:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:12:09 INFO - 'tsvgr_opacity', 06:12:09 INFO - 'tart', 06:12:09 INFO - 'tscrollx', 06:12:09 INFO - 'cart']}, 06:12:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'talos_options': ['--disable-e10s'], 06:12:09 INFO - 'tests': ['tp5o']}, 06:12:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'tests': ['tp5o']}, 06:12:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'talos_options': ['--disable-e10s', 06:12:09 INFO - '--xperf_path', 06:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:09 INFO - 'tests': ['tp5n']}, 06:12:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:12:09 INFO - 'talos_options': ['--xperf_path', 06:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:09 INFO - 'tests': ['tp5n']}}, 06:12:09 INFO - 'talos.zip': {'path': '', 06:12:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:12:09 INFO - Running post-action listener: _resource_record_post_action 06:12:09 INFO - [mozharness: 2016-10-10 13:12:09.588031Z] Finished populate-webroot step (success) 06:12:09 INFO - [mozharness: 2016-10-10 13:12:09.588165Z] Running create-virtualenv step. 06:12:09 INFO - Running pre-action listener: _resource_record_pre_action 06:12:09 INFO - Running main action method: create_virtualenv 06:12:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:12:09 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 06:12:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:12:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:12:09 INFO - Using real prefix '/tools/python27' 06:12:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:12:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:12:13 INFO - Installing pip.................done. 06:12:13 INFO - Return code: 0 06:12:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:12:13 INFO - Reading from file tmpfile_stdout 06:12:13 INFO - Output received: 06:12:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:12:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 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 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:13 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 06:12:13 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 06:12:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:13 INFO - 'HOME': '/Users/cltbld', 06:12:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:13 INFO - 'LOGNAME': 'cltbld', 06:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:13 INFO - 'MOZ_NO_REMOTE': '1', 06:12:13 INFO - 'NO_EM_RESTART': '1', 06:12:13 INFO - 'PAGER': '/bin/cat', 06:12:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:13 INFO - 'PWD': '/builds/slave/test', 06:12:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:13 INFO - 'SHELL': '/bin/bash', 06:12:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:13 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:13 INFO - 'USER': 'cltbld', 06:12:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:13 INFO - 'XPC_FLAGS': '0x0', 06:12:13 INFO - 'XPC_SERVICE_NAME': '0', 06:12:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:13 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 06:12:13 INFO - Cleaning up... 06:12:13 INFO - Return code: 0 06:12:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:12:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:13 INFO - 'HOME': '/Users/cltbld', 06:12:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:13 INFO - 'LOGNAME': 'cltbld', 06:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:13 INFO - 'MOZ_NO_REMOTE': '1', 06:12:13 INFO - 'NO_EM_RESTART': '1', 06:12:13 INFO - 'PAGER': '/bin/cat', 06:12:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:13 INFO - 'PWD': '/builds/slave/test', 06:12:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:13 INFO - 'SHELL': '/bin/bash', 06:12:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:13 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:13 INFO - 'USER': 'cltbld', 06:12:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:13 INFO - 'XPC_FLAGS': '0x0', 06:12:13 INFO - 'XPC_SERVICE_NAME': '0', 06:12:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:14 INFO - Downloading/unpacking psutil>=3.1.1 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:14 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 06:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:12:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:17 INFO - Installing collected packages: psutil 06:12:17 INFO - Running setup.py install for psutil 06:12:18 INFO - building 'psutil._psutil_osx' extension 06:12:18 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 06:12:18 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 06:12:18 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 06:12:18 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 06:12:18 INFO - building 'psutil._psutil_posix' extension 06:12:18 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 06:12:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:12:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:12:18 INFO - ^ 06:12:18 INFO - 1 warning generated. 06:12:18 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 06:12:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:19 INFO - Successfully installed psutil 06:12:19 INFO - Cleaning up... 06:12:19 INFO - Return code: 0 06:12:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:19 INFO - 'HOME': '/Users/cltbld', 06:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:19 INFO - 'LOGNAME': 'cltbld', 06:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:19 INFO - 'MOZ_NO_REMOTE': '1', 06:12:19 INFO - 'NO_EM_RESTART': '1', 06:12:19 INFO - 'PAGER': '/bin/cat', 06:12:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:19 INFO - 'PWD': '/builds/slave/test', 06:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:19 INFO - 'SHELL': '/bin/bash', 06:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:19 INFO - 'USER': 'cltbld', 06:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:19 INFO - 'XPC_FLAGS': '0x0', 06:12:19 INFO - 'XPC_SERVICE_NAME': '0', 06:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:12:19 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 06:12:19 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 06:12:19 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 06:12:19 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 06:12:19 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 06:12:19 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 06:12:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:12:22 INFO - Installing collected packages: mozsystemmonitor 06:12:22 INFO - Running setup.py install for mozsystemmonitor 06:12:22 INFO - Successfully installed mozsystemmonitor 06:12:22 INFO - Cleaning up... 06:12:22 INFO - Return code: 0 06:12:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:22 INFO - 'HOME': '/Users/cltbld', 06:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:22 INFO - 'LOGNAME': 'cltbld', 06:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:22 INFO - 'MOZ_NO_REMOTE': '1', 06:12:22 INFO - 'NO_EM_RESTART': '1', 06:12:22 INFO - 'PAGER': '/bin/cat', 06:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:22 INFO - 'PWD': '/builds/slave/test', 06:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:22 INFO - 'SHELL': '/bin/bash', 06:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:22 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:22 INFO - 'USER': 'cltbld', 06:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:22 INFO - 'XPC_FLAGS': '0x0', 06:12:22 INFO - 'XPC_SERVICE_NAME': '0', 06:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:12: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 06:12: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 06:12: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 06:12: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 06:12: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 06:12: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 06:12:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:12:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:12:25 INFO - warning: no files found matching '*.txt' 06:12:25 INFO - no previously-included directories found matching 'build' 06:12:25 INFO - no previously-included directories found matching 'dist' 06:12:25 INFO - no previously-included directories found matching '.git*' 06:12:25 INFO - Installing collected packages: jsonschema, functools32 06:12:25 INFO - Running setup.py install for functools32 06:12:25 INFO - warning: no files found matching '*.txt' 06:12:25 INFO - no previously-included directories found matching 'build' 06:12:25 INFO - no previously-included directories found matching 'dist' 06:12:25 INFO - no previously-included directories found matching '.git*' 06:12:25 INFO - Successfully installed jsonschema functools32 06:12:25 INFO - Cleaning up... 06:12:25 INFO - Return code: 0 06:12:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:25 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:25 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:12:25 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 functools32==3.2.3-2 06:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:25 INFO - 'HOME': '/Users/cltbld', 06:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:25 INFO - 'LOGNAME': 'cltbld', 06:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:25 INFO - 'MOZ_NO_REMOTE': '1', 06:12:25 INFO - 'NO_EM_RESTART': '1', 06:12:25 INFO - 'PAGER': '/bin/cat', 06:12:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:25 INFO - 'PWD': '/builds/slave/test', 06:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:25 INFO - 'SHELL': '/bin/bash', 06:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:25 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:25 INFO - 'USER': 'cltbld', 06:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:25 INFO - 'XPC_FLAGS': '0x0', 06:12:25 INFO - 'XPC_SERVICE_NAME': '0', 06:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:12:26 INFO - Cleaning up... 06:12:26 INFO - Return code: 0 06:12:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:12:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:26 INFO - 'HOME': '/Users/cltbld', 06:12:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:26 INFO - 'LOGNAME': 'cltbld', 06:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:26 INFO - 'MOZ_NO_REMOTE': '1', 06:12:26 INFO - 'NO_EM_RESTART': '1', 06:12:26 INFO - 'PAGER': '/bin/cat', 06:12:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:26 INFO - 'PWD': '/builds/slave/test', 06:12:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:26 INFO - 'SHELL': '/bin/bash', 06:12:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:26 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:26 INFO - 'USER': 'cltbld', 06:12:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:26 INFO - 'XPC_FLAGS': '0x0', 06:12:26 INFO - 'XPC_SERVICE_NAME': '0', 06:12:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:28 INFO - Downloading blobuploader-1.2.4.tar.gz 06:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:12:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:12:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:12:29 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 06:12:29 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 06:12:29 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 06:12:29 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 06:12:29 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 06:12:29 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 06:12:30 INFO - Downloading docopt-0.6.1.tar.gz 06:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:12:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:12:30 INFO - Running setup.py install for blobuploader 06:12:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:12:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:12:30 INFO - Running setup.py install for requests 06:12:30 INFO - Running setup.py install for docopt 06:12:30 INFO - Successfully installed blobuploader requests docopt 06:12:30 INFO - Cleaning up... 06:12:30 INFO - Return code: 0 06:12:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:31 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 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:31 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 06:12:31 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 06:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:31 INFO - 'HOME': '/Users/cltbld', 06:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:31 INFO - 'LOGNAME': 'cltbld', 06:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:31 INFO - 'MOZ_NO_REMOTE': '1', 06:12:31 INFO - 'NO_EM_RESTART': '1', 06:12:31 INFO - 'PAGER': '/bin/cat', 06:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:31 INFO - 'PWD': '/builds/slave/test', 06:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:31 INFO - 'SHELL': '/bin/bash', 06:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:31 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:31 INFO - 'USER': 'cltbld', 06:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:31 INFO - 'XPC_FLAGS': '0x0', 06:12:31 INFO - 'XPC_SERVICE_NAME': '0', 06:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4y9CsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jv0ksq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-e5awen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-tJR0Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Iq3VVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PCYulh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jj1YiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-nmwisl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PoBEBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Iuoyri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Su4seQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bS71Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hev53A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vrYEAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YTptMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-SahGU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:32 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MOwxNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:33 INFO - Running setup.py install for manifestparser 06:12:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:33 INFO - Running setup.py install for mozcrash 06:12:33 INFO - Running setup.py install for mozdebug 06:12:33 INFO - Running setup.py install for mozdevice 06:12:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:12:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:33 INFO - Running setup.py install for mozfile 06:12:33 INFO - Running setup.py install for mozhttpd 06:12:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:33 INFO - Running setup.py install for mozinfo 06:12:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Running setup.py install for mozInstall 06:12:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Running setup.py install for mozleak 06:12:34 INFO - Running setup.py install for mozlog 06:12:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Running setup.py install for moznetwork 06:12:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Running setup.py install for mozprocess 06:12:34 INFO - Running setup.py install for mozprofile 06:12:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:34 INFO - Running setup.py install for mozrunner 06:12:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:35 INFO - Running setup.py install for mozscreenshot 06:12:35 INFO - Running setup.py install for moztest 06:12:35 INFO - Running setup.py install for mozversion 06:12:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:35 INFO - Cleaning up... 06:12:35 INFO - Return code: 0 06:12:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:35 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 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:35 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 06:12:35 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 06:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:35 INFO - 'HOME': '/Users/cltbld', 06:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:35 INFO - 'LOGNAME': 'cltbld', 06:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:35 INFO - 'MOZ_NO_REMOTE': '1', 06:12:35 INFO - 'NO_EM_RESTART': '1', 06:12:35 INFO - 'PAGER': '/bin/cat', 06:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:35 INFO - 'PWD': '/builds/slave/test', 06:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:35 INFO - 'SHELL': '/bin/bash', 06:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:35 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:35 INFO - 'USER': 'cltbld', 06:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:35 INFO - 'XPC_FLAGS': '0x0', 06:12:35 INFO - 'XPC_SERVICE_NAME': '0', 06:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RTEJ2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:35 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)) 06:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LWe6A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1kuC5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DDXISM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-A2ajFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vr13dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rhroEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5CN29H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-KJu1Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:36 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-zMsh3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 06:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-eN4CjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:37 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)) 06:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GeK54B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RfsHdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:37 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)) 06:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rKmOwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ADCwP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:37 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)) 06:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-o4Rgoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:37 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)) 06:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0qouHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:37 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)) 06:12:37 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)) 06:12:37 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)) 06:12:37 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)) 06:12:37 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)) 06:12:37 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)) 06:12:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:37 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 06:12:37 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 06:12:37 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 06:12:37 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 06:12:37 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 06:12:37 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 06:12:40 INFO - Downloading blessings-1.6.tar.gz 06:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:40 INFO - Installing collected packages: blessings 06:12:40 INFO - Running setup.py install for blessings 06:12:40 INFO - Successfully installed blessings 06:12:40 INFO - Cleaning up... 06:12:40 INFO - Return code: 0 06:12:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:40 INFO - Reading from file tmpfile_stdout 06:12:40 INFO - Current package versions: 06:12:40 INFO - blessings == 1.6 06:12:40 INFO - blobuploader == 1.2.4 06:12:40 INFO - docopt == 0.6.1 06:12:40 INFO - functools32 == 3.2.3-2 06:12:40 INFO - jsonschema == 2.5.1 06:12:40 INFO - manifestparser == 1.1 06:12:40 INFO - mozInstall == 1.12 06:12:40 INFO - mozcrash == 0.17 06:12:40 INFO - mozdebug == 0.1 06:12:40 INFO - mozdevice == 0.48 06:12:40 INFO - mozfile == 1.2 06:12:40 INFO - mozhttpd == 0.7 06:12:40 INFO - mozinfo == 0.9 06:12:40 INFO - mozleak == 0.1 06:12:40 INFO - mozlog == 3.4 06:12:40 INFO - moznetwork == 0.27 06:12:40 INFO - mozprocess == 0.23 06:12:40 INFO - mozprofile == 0.28 06:12:40 INFO - mozrunner == 6.12 06:12:40 INFO - mozscreenshot == 0.1 06:12:40 INFO - mozsystemmonitor == 0.3 06:12:40 INFO - moztest == 0.7 06:12:40 INFO - mozversion == 1.4 06:12:40 INFO - psutil == 3.1.1 06:12:40 INFO - requests == 1.2.3 06:12:40 INFO - wsgiref == 0.1.2 06:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:40 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 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:40 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 06:12:40 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 06:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:40 INFO - 'HOME': '/Users/cltbld', 06:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:40 INFO - 'LOGNAME': 'cltbld', 06:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:40 INFO - 'MOZ_NO_REMOTE': '1', 06:12:40 INFO - 'NO_EM_RESTART': '1', 06:12:40 INFO - 'PAGER': '/bin/cat', 06:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:40 INFO - 'PWD': '/builds/slave/test', 06:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:40 INFO - 'SHELL': '/bin/bash', 06:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:40 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:40 INFO - 'USER': 'cltbld', 06:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:40 INFO - 'XPC_FLAGS': '0x0', 06:12:40 INFO - 'XPC_SERVICE_NAME': '0', 06:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 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)) 06:12:40 INFO - Cleaning up... 06:12:41 INFO - Return code: 0 06:12:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:41 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 0x1018f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101867570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbec1494180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, '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.cpba9AAmOm/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.kKueAannhq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:12:41 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 06:12:41 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 06:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:41 INFO - 'HOME': '/Users/cltbld', 06:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:41 INFO - 'LOGNAME': 'cltbld', 06:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:41 INFO - 'MOZ_NO_REMOTE': '1', 06:12:41 INFO - 'NO_EM_RESTART': '1', 06:12:41 INFO - 'PAGER': '/bin/cat', 06:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:41 INFO - 'PWD': '/builds/slave/test', 06:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:41 INFO - 'SHELL': '/bin/bash', 06:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:12:41 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:41 INFO - 'USER': 'cltbld', 06:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:41 INFO - 'XPC_FLAGS': '0x0', 06:12:41 INFO - 'XPC_SERVICE_NAME': '0', 06:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:41 INFO - Cleaning up... 06:12:41 INFO - Return code: 0 06:12:41 INFO - Running post-action listener: _resource_record_post_action 06:12:41 INFO - Running post-action listener: _start_resource_monitoring 06:12:41 INFO - Starting resource monitoring. 06:12:41 INFO - [mozharness: 2016-10-10 13:12:41.300401Z] Finished create-virtualenv step (success) 06:12:41 INFO - [mozharness: 2016-10-10 13:12:41.301371Z] Running install step. 06:12:41 INFO - Running pre-action listener: _resource_record_pre_action 06:12:41 INFO - Running main action method: install 06:12:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:41 INFO - Reading from file tmpfile_stdout 06:12:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:41 INFO - Reading from file tmpfile_stdout 06:12:41 INFO - Output received: 06:12:41 INFO - Usage: mozinstall [options] installer 06:12:41 INFO - Options: 06:12:41 INFO - -h, --help show this help message and exit 06:12:41 INFO - -d DEST, --destination=DEST 06:12:41 INFO - Directory to install application into. [default: 06:12:41 INFO - "/builds/slave/test"] 06:12:41 INFO - --app=APP Application being installed. [default: firefox] 06:12:41 INFO - mkdir: /builds/slave/test/build/application 06:12:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:13:15 INFO - Reading from file tmpfile_stdout 06:13:15 INFO - Output received: 06:13:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:13:15 INFO - Running post-action listener: _resource_record_post_action 06:13:15 INFO - [mozharness: 2016-10-10 13:13:15.880085Z] Finished install step (success) 06:13:15 INFO - [mozharness: 2016-10-10 13:13:15.880218Z] Running run-tests step. 06:13:15 INFO - Running pre-action listener: _resource_record_pre_action 06:13:15 INFO - Running main action method: run_tests 06:13:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:15 INFO - 2016-10-10 06:13:15.894 screenresolution[1645:8596] starting screenresolution argv=screenresolution get 06:13:15 INFO - 2016-10-10 06:13:15.897 screenresolution[1645:8596] Display 0: 1600x1200x32@60 06:13:15 INFO - 2016-10-10 06:13:15.903 screenresolution[1646:8598] starting screenresolution argv=screenresolution list 06:13:15 INFO - Available Modes on Display 0 06:13:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:16 INFO - Intel Iris: 06:13:16 INFO - Chipset Model: Intel Iris 06:13:16 INFO - Type: GPU 06:13:16 INFO - Bus: Built-In 06:13:16 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:16 INFO - Vendor: Intel (0x8086) 06:13:16 INFO - Device ID: 0x0a2e 06:13:16 INFO - Revision ID: 0x0009 06:13:16 INFO - Displays: 06:13:16 INFO - Display: 06:13:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:16 INFO - Display Serial Number: 1600x1200 60 06:13:16 INFO - Main Display: Yes 06:13:16 INFO - Mirror: Off 06:13:16 INFO - Online: Yes 06:13:16 INFO - Rotation: Supported 06:13:16 INFO - Return code: 0 06:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:13:16 INFO - Python 2.7.3 06:13:16 INFO - Return code: 0 06:13:16 INFO - grabbing minidump binary from tooltool 06:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:16 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101705d30>, '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 0x10152bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:13:16 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 06:13:16 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 06:13:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:13:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:13:16 INFO - Return code: 0 06:13:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:13:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:13:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:13:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:13:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:13:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:13:16 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cpba9AAmOm/Render', 06:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:16 INFO - 'HOME': '/Users/cltbld', 06:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:16 INFO - 'LOGNAME': 'cltbld', 06:13:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:13:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:16 INFO - 'MOZ_NO_REMOTE': '1', 06:13:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:13:16 INFO - 'NO_EM_RESTART': '1', 06:13:16 INFO - 'PAGER': '/bin/cat', 06:13:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:16 INFO - 'PWD': '/builds/slave/test', 06:13:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:16 INFO - 'SHELL': '/bin/bash', 06:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kKueAannhq/Listeners', 06:13:16 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:16 INFO - 'USER': 'cltbld', 06:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:16 INFO - 'XPC_FLAGS': '0x0', 06:13:16 INFO - 'XPC_SERVICE_NAME': '0', 06:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:13:16 INFO - mozversion application_buildid: 20161010031417 06:13:16 INFO - mozversion application_changeset: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf 06:13:16 INFO - mozversion application_display_name: Nightly 06:13:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:13:16 INFO - mozversion application_name: Firefox 06:13:16 INFO - mozversion application_remotingname: firefox 06:13:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:13:16 INFO - mozversion application_vendor: Mozilla 06:13:16 INFO - mozversion application_version: 52.0a1 06:13:16 INFO - mozversion platform_buildid: 20161010031417 06:13:16 INFO - mozversion platform_changeset: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf 06:13:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:13:16 INFO - mozversion platform_version: 52.0a1 06:13:16 INFO - using testdate: 1476105196 06:13:16 INFO - actual date: 1476105196 06:13:16 INFO - starting webserver on 'localhost:49273' 06:13:16 INFO - SUITE-START | Running 2 tests 06:13:16 INFO - TEST-START | dromaeo_css 06:13:16 INFO - operating with platform_type : mac_ 06:13:16 INFO - Initialising browser for dromaeo_css test... 06:13:16 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp489DZ0/profile http://localhost:49273/getInfo.html) 06:13:19 INFO - PROCESS | 1656 | 2016-10-10 06:13:19.320 plugin-container[1660:8784] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 06:13:19 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:19 INFO - PROCESS | 1656 | 2016-10-10 06:13:19.323 plugin-container[1660:8784] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 06:13:19 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:19 INFO - PROCESS | 1656 | 2016-10-10 06:13:19.323 plugin-container[1660:8784] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:13:19 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 06:13:19 INFO - PROCESS | 1656 | colorDepth:24 06:13:19 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 06:13:19 INFO - PROCESS | 1656 | __metrics 06:13:19 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:13:20 INFO - TEST-INFO | 1656: exit 0 06:13:20 INFO - Browser initialized. 06:13:20 INFO - Running cycle 1/1 for dromaeo_css test... 06:13:20 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp489DZ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:22 INFO - PROCESS | 1661 | 2016-10-10 06:13:22.589 plugin-container[1662:8902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.tsm.portname' 06:13:22 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:22 INFO - PROCESS | 1661 | 2016-10-10 06:13:22.591 plugin-container[1662:8902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 06:13:22 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:22 INFO - PROCESS | 1661 | 2016-10-10 06:13:22.591 plugin-container[1662:8902] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:13:32 INFO - PROCESS | 1661 | RSS: Main: 239140864 06:13:32 INFO - PROCESS | 1661 | 06:14:21 INFO - PROCESS | 1661 | 1476105261957 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] 06:16:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 06:16:36 INFO - PROCESS | 1661 | RSS: Main: 252301312 06:16:36 INFO - PROCESS | 1661 | 06:19:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 06:19:39 INFO - PROCESS | 1661 | RSS: Main: 264675328 06:19:39 INFO - PROCESS | 1661 | 06:22:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 06:22:41 INFO - PROCESS | 1661 | RSS: Main: 269316096 06:22:41 INFO - PROCESS | 1661 | 06:25:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 06:25:44 INFO - PROCESS | 1661 | RSS: Main: 269049856 06:25:44 INFO - PROCESS | 1661 | 06:28:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 06:28:47 INFO - PROCESS | 1661 | RSS: Main: 274874368 06:28:47 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 06:31:50 INFO - PROCESS | 1661 | RSS: Main: 277434368 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | __start_tp_report 06:31:50 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 06:31:50 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 06:31:50 INFO - PROCESS | 1661 | |i|pagename|runs| 06:31:50 INFO - PROCESS | 1661 | |0;dojo.html;3331.8667253309854;3360.495925611158;3384.8815291464803;3396.9830150849243;3412.6075501317323;5608.383077861432;5683.31800183978;5688.317401911766;5725.141228815674;5775.971120144404;5654.37801841797;5719.656820590757;5748.827535173941;5787.13193021046;5890;5134.2812006319145;5212.009718153538;5217.47825217479;5233.188855727369;5306.336707911511;5181.663191892534;5280.234366016925;5291.206319052154;5313.043652142613;5361.195820626898;5089.821856235014;5155.639105262633;5227.686338819683;5262.394824595163;5275.973620131875;5190.532852043297;5196.480351964811;5231.947680523184;5258.07983602868;5289;5172.120739474299;5182.844514664528;5203.869903252449;5205.947940520584;5218.165093585008;5573.777048918038;5595.832125036215;5621.690807005613;5649.830505084813;5737.7131143443075;5347;6077.939220607782;6161.229846269216;6242.313345532033;6269.122322874801;6238.095476155932;6239.157713708682;6258.937410625881;6275;6293.748250070037;4096.365063415175;5644.520215781622;5793.81226848495;5833.912491312633;5844.152597873284;6181.258249010058;6231.3145553989025;6239.812805615838;6269.247690277105;6294.622322660655;6151.2618485781995;6154.046122850965;6156.230471191101;6181.227346581677;6195.938040619626;6112.297085835097;6113.510919126459;6256.812295631138;6273.0904018917;6315.210598675166;5614.775408983676;6098.613770999398;6135.937063216329;6142.222533142175;6201.348858369896;6183.072539119078;6256.217972753406;6269;6273.247210334698;6295.401936815995;3896.5129358830145;4951.331570237971;4952.801887924515;4967.503249675004;5003.799848006039;3506.6668666476644;4330.415393921843;4351.108022855307;4360.367746676778;4451.243288640939;5770.076787713946;5872.530197584183;5893.322267939242;5907.232059832194;5971.970140149271;6248.50011999039;6258.468030217391;6259.217597800275;6263.655498947602;6273.9372606273355;5712.171735098471;5801.274840644919;5830.329512106077;5862.882742345129;5904.261967254093;5443.183522471661;5450.345958485007;5464.508194262536;5471.23402723619;5503.944960550423;6282.026285925689;6282.2147231596055;6293.527985401113;6319.999999999908;6328.493720502441;6112.290716697506;6170.259568851767;6203.31763506005;6309.085182648582;6346.90479642815;6173.41352571505;6227.252729672468;6285.779997700059;6287.937120628918;6294.622322660655;5494.670319780826;6151.569390142647;6166.876662466815;6202.627842329474;6205.193324867739;6103.755849765959;6147;6195.721192546436;6241.407066328691;6266.968665156645;4862.343583616308;6077.604955677867;6109.6639684817765;6119.541283489692;6149.200603921461;6098.492741543504;6127.036821038878;6127.7393367763425;6130.3369889931655;6142.98993493194;4363.520012798526;5884.941150588439;5923.851903702442;5942.61373010753;6061.6666083365835;6115.848865095124;6118.497354392036;6120.0205129226715;6127.6936153193055;6141.393954534099;5973.880522389441;6029.276486821609;6036.275646922221;6043.214382130295;6051.697415129138 06:31:50 INFO - PROCESS | 1661 | |1;ext.html;472.1807663703474;480.5554861752878;528.9074411977903;538.3324677400022;542.0703493508634;39504;40030.7998460008;40067.998300042476;40074.99812504689;40087.59912400872;41315.17369652605;41601.37597936033;41667;41798;41847.79076104623;9637.855432168522;9807.31348805584;9812.852807207897;9823.165030972375;9846.359986600848;9755.463449510275;9810;9839.803203935917;9856.211503079736;9876.629608893849;9818.45998470084;9867.457289849055;9871.753206169868;9881.061299176567;9887.258455615822;9796.902030979705;9839.55721992512;9839.950800246024;9851.753706157368;9879.407235565888;9630.422174669542;9709.271804614611;9728.367656102402;9732.854007189897;9737.026297370207;40031.79984100061;40069.59930400688;40226.59773402258;40273.59726402757;40320.39519407211;3295.2256219788333;3361.6302206757236;3376.7467439941856;3454.963510946706;3871.5741268460447;30602.84698576493;31395;31486.527702084488;31617.8419107903;31769.682303177135;3158.9052328430184;3255.251292202783;3324.6010478742464;3399.3371292597953;3404.6254911959663;247800;259358;314520.4273978638;317221.82778172387;352821;45779.54220457753;50529.24206136911;51427;56125.71937140288;56643.71678141583;58541.82916341649;58756;59108.40891591029;59116.40883591195;59133.40866591279;15865.286062127232;15966.521004369655;16075.276612552463;16084;16130.596735081717;12578.81131783024;12644.683882903;12654.81017784734;12679.556215532411;12681.746365072831;12219.69450763738;12304.446299916524;15340.002899811476;15360.769588456182;15530;6467.353264673495;6485.383888530677;6537.182852143482;6589.308122647149;6593.967030164818;838.7106448275335;928.4475736936512;946.4605175050293;949.5157469690507;958.1903291718487;21844.78155218459;27657.170284891487;28888;29829;30437.695623043484;933.1601558597181;1005.7737009173023;1096.5230124895536;1120.3501968858043;1124.4771181400688;10979.505922233519;15468.381264749509;15510.534683959499;15806.762898556532;15823.971441856242;638652;650834;675366;686487;880180;49239;55995.44004559984;56556;57295.71352143296;57498.85002299931;1118.6843234504497;1211.9575814846614;1265.342022148496;1378.2213049626928;1399.8320201575673;29461.85269073641;30109;30979;31387.686123138476;31506;43350.56649433466;52539.47460525499;53025.73487132694;53142.46857531375;53148;599300.0034999797;606334;607828;608028;608472;25048.499030018935;25093.749062509873;25537.74462255428;25970.74029259683;26728.465430691667;43589.78205108954;46333.84165395892;46751.597452076494;47167.76416117897;47648.761756190994;30672;37600.81199594094;37695.49218031248;38597;39870.60129398669;31692.841535793097;37430;37903.43144852774;38139.61394439675;39571.80214098911;37695.81152094222;37866.8106659465;38029.42955855609;38438.80780596191;39130.80434597809;31428.842855785573;34058;34676.65323346734;34746.13134671653;35074.64925350714;22424.88787556117;25690.229293121236;25712.742872571034;25851.482970340865;26519.806608702267 06:31:50 INFO - PROCESS | 1661 | |2;jquery.html;331.60042149210204;377.6374680306907;379.4460088271124;384.9422586612008;406.34375483594005;20255.39233822986;20879.582408351824;21596.56806863862;21714.457138571524;21774;16867.66264674709;19176.90411547944;20144;20579.382618521468;20702.27542036029;5129.025485157827;5900.232969713931;6147.569670123094;6201.844953876167;6207.720652570645;5200.817971371002;6083.30042045166;6197.938020619804;6237.438630523252;6243.875122497548;5918.940810591904;6115.6330620162935;6121.204243448346;6149;6227.190465239512;5866.384029676865;6092.969535152318;6093.847653808668;6118.3269840317525;6144.5084393248435;6006.069059295816;6073.4533891949495;6103.176071230416;6107.236595425572;6120.510359171256;13324.800127998087;17710.645787084315;18996.67023308369;24425.022999080014;25386.74613253862;2205.558888222346;2292.6561015847587;2293.1629955066282;2336.4509340305017;2914.606528118698;9668.516574171263;9971.950140249251;10035.197184225317;10116.735398102117;10558.894411055868;1853.6107417442354;1856.58226898948;1887.4715079777684;1925.7303977443169;1985.4440756588178;116054.19729013515;131719;132309;133882;134226.32886835502;9415.15263626277;9958.053984871425;10153.796924061477;11458.255213411101;11774.411279435993;12735.490580376681;14611.123332600078;14636.19500927438;14641.48754793577;14697;8264.132266112092;8500.914990850013;8522.829543409222;8578.828423431496;8602;7727.802190660344;7842.921570784333;8345.457545259538;8386.748397548083;8537.871931921027;4442.6890117691455;4541.818327266872;4546.022605139845;4597.218472859622;4624.791884365211;1930.787613362529;1947.0070264165095;1972.2111155537614;1982.5440148765576;2007.6486614842345;918.237862574062;929;948.743839163422;986.4328011393477;1020.7346090016649;21168.470788230417;21218.04518796627;21280.680789788166;21303.041363138695;21351.14595416166;936.4942930817418;941.5998200764648;958.1711819276276;960.2653969713175;998.6005597760809;10731.89268107309;11151.944240278746;11228.887711122947;11259;11323.43382830855;532099;565498.9776071003;612841;618267;635859;83505.74741378763;130217;142773.28613356868;142874.5712542882;151397;915.6749353979375;976.9302613638055;1016.192127258831;1026.1893104447404;1051.7896420715888;14020.859791401956;18866.151023203714;19619.411417657495;19737.70393444071;19844.305449309206;52793.94412111813;52982.4701752993;53718.73140634272;54513.72743136259;55797.44202557922;61198.776024480154;77687;79718.60140699259;81407;83962.74055889044;7875.645595948311;7991.360691144579;8127.593620319079;8178.018637763506;8294.709685160991;11284.943575282072;12518.561850335194;12644.482662080609;12673;12707.110502264753;10810.837837432287;11082.833757493483;11125.554977801121;11156.497957591766;11169.542700605854;10418.947905260426;10705;10714.464276786286;10762.139028877515;10814.405207713651;10519.73700657459;10915.78168436611;11151.219414640897;11250.606228781953;11330.716732081764;7868.449208555347;7995.400344974034;8051.436399452216;8086.797830054295;8135.552544610104;8354.958225208835;10110.19118470506;10210.519474675983;10727.785444291227;11190.66428007161 06:31:50 INFO - PROCESS | 1661 | |3;mootools.html;1298.9870101298986;1528.3122594832325;1708.3764425984511;1848.4824249210226;1879.7274395212687;7796.259355361246;8032.116467188619;8250.504969701815;8783.516906570136;8808.77978050549;8258.050324212718;8568.65725370986;8588.871166932486;8634.179752923477;8651.091635378274;1805.7201133824278;1925.7207704882783;1926.6339395514876;1945.2608008956577;2063.9174433022663;2313.005407674699;2320.918767843126;2325.244295603927;2341.7072865891764;2348.659444380564;1897.383350411115;2298.1496846166942;2307.3885420363617;2311.3759284993043;2349.083857295656;1896.459509039917;2278.8063014643776;2298.7011688480475;2306.976930230693;2314.1900334882826;2279.2022792022826;2307.9423014424606;2309.90760369585;2317.3743089365944;2350.036485041142;8731.912680873236;8772.912270877274;8773.078826723166;8802.515861627608;8816.603252853636;5109.897802043975;5203.9219411708855;5274.7626356814035;5289.523942845162;5296.126139187029;3401.4387626041676;3482.077249528877;3605.94591081134;3608.891733248007;3610.4945307656685;1062.7024433158729;1070.1706177712258;1071.2180108520745;1073.7959787640323;1097.5938902606088;11197.496112674868;11200.887991120147;11272.66182014541;11277;11319.320840749499;4474.753888536096;4526.456825180933;4666.883327916829;4706.388169537938;4724.881877953078;9720.368176068532;9722.173615242784;9739.659111931049;9749.366291191192;9765.707028789147;4030.919381612351;4774.665773395898;5232.450592687789;5237.240600113038;5249.685018898878;4290.742555446684;4304.870853874389;4731.148393289241;4777.689450185796;4800.3279540864305;3830.157365379612;3886.358750806142;3973.304671682444;3974.6621537169085;4008.8797336079965;1265.9620211393674;1277.2272774971195;1278.5588971804711;1279.2324605236784;1292.3150730113055;847.6058632735684;849.2950850793826;893.5576889439769;927.3462209142539;939.9436033837992;5368.792021795143;5517.475839795213;5787.334456537468;5957.851053723605;5961.897049045941;951.528993148396;957.1337939165066;963.8072385522923;972.5040229483014;1015.4821041268858;3903.1608204236227;3994.6005399459823;4031.0930040741187;4139;4152.27335216342;9724.541318802094;10059.798804023878;10528.789424211473;10542;10579.84130238047;9646.951765241269;10512.789744205073;10516.1061309788;10539.84190237147;10591.099756520627;7992.160823113606;8134.633941472766;8139.023317201855;8149.918500815034;8175.3459723222;4468.977655111704;5657.4908258256955;5816.952948469316;5873.588848780544;5961.135635332766;9313.39462934907;9632.22942164611;9632.90367096348;9676.27427942893;9781.608735650494;9739.074787895139;9890.703278901645;9898.901010989797;9973.451460169761;10008.64969726056;5235.952809438051;6113.633182009094;6403.903941440789;6529.412352888263;6791.830204244933;7271.745488908075;8269.09040005611;8289.171082891662;8327.333813295043;8350.03974542911;7201.991721158937;7268.854622907618;7336.936144259159;7429.405647548291;7519.661615227437;6125.663088530174;6141.385861413823;6299.244090709144;7330.413566914741;7418.443616728875;6846.041554182319;6859.416949559144;6886.2769409213315;6942.06282151903;6957.652117394211;4975.800967961241;5021.924671129863;5087.313212716236;5138.5375316220225;5145.536901678867;5002.474740152232;5071.949280507295;5106.565941894832;5154.407243166934;5204.765785539736 06:31:50 INFO - PROCESS | 1661 | |4;prototype.html;301.85661810639937;309.73672378478295;317.1990723423356;322.79986408426777;323.96922292382214;5084.4661310562415;5299.999007118957;5532.336119665641;5687.772489100436;5723.799667011655;4986.501349865011;5377.946220537793;5499.312585926759;5520.558355331574;5555.666660000393;3489.825508724566;4137.2552940470705;4163.250614889319;4198.412222288882;4210.347396153586;3308.7261404359374;4180.059486615518;4203.5165955915;4208.537060923311;4221.493420789494;3852.3451013327804;3941.586133455989;4032.1330913853517;4113.506379234496;4136.110736191718;4128.236276288896;4129.545749967501;4133.441985331971;4161.271777438936;4166.999920019204;3597.6582224688873;3598.1904071583945;3603.6396360364015;3616.276744651054;3618.023133753898;4328.718633288826;4976.328195693572;5068.543831055223;5502.119660854284;5505.807296744635;4356.89107772305;4367.519572846984;4764.547368000034;4781.187198176319;4799.448063472675;5824.097264923944;5871.418434754796;5899.73451194693;5907.852303692399;5966.045432730785;3824.560175579816;3905.7070719696135;3938.960610393917;3940.862069827571;3966.186931678999;4945;5924.318703349127;6068.3021452533085;6154.522914500532;6158.445739883432;3277.7869438486423;3312.668733126668;3376.3584918865336;3474.6004209516227;3954.4859168307935;3273.8199399033283;3492.650734926487;3574.175632073708;4007.979960100239;4031.8185681644395;4711.764411779466;4759.0719809636785;4770.212914869077;4771.73755443447;4777.856664300077;5531.612787104864;5543.695096769717;5649.68926709035;5851.050540884886;5880.441358070976;1156.5547264303304;1314.5793346129337;1352.9661758456118;1377.6486995816203;1385.6951470676436;686.9141357330334;761.7105499909999;797.2983774278598;830.7372793354068;858.274757829633;4245.639120674778;4737.502562230985;4754.405699287589;4766.880827979328;4769.95230047702;4433.7118087324225;4998.30091750458;5091.461434303198;5114.8977020460125;5122.564582010496;4318.438602981592;4464.9107017860115;4575.1538021055285;4722.315264286659;4735.052989402134;2343.742188359279;2543.3768726661715;2597.7532134447197;2677.491276657429;2695.908157196339;4569.428821397325;4991.728763412639;5244.475552444801;5315.6013299002725;5329.493698098674;4794.328793968847;5191.39066889258;5198.662086964335;5257.76340064698;5685.317761868602;5427.6472029317965;5949.315828679671;6312.147860038928;6343.175387199727;6425.646589437626;5341.465853414783;5364.9731751341;5532.585056120726;6228.813135605939;6247.281562620356;5777.277840269966;6040.892193308592;6088.36072212429;6107.450329470369;6124.418180272867;4930.975345123395;4984.975075124747;5538.556915446835;6148.600340977822;6415.615063096229;3396.5205400057603;3834.041489627593;4038.333674943719;4163.604457576525;4176.540580536078;5332.253484512249;5483.890322193613;6059.182010428536;6091.4822240108315;6102.870968870773;4898.8775280618265;5159.716215608178;5261.8423946731655;5297.894042119059;5621.437856214346;5894.673698417993;5906.438888305604;5918.763249469973;5920.010394750796;5921.289445266596;4668.60316873056;5126.308318255042;5578.470045345685;5754.625949313281;5797.217375654402;5174.379074511083;5493.313335833021;5818.73815678304;5823.242978412779;5843.386444423274;5002.849914502571;5171.379434467888;5249.66646179671;5754.712264386848;5769.567107570989 06:31:50 INFO - PROCESS | 1661 | |5;yui.html;722.3751454991427;734.5188901269667;736.5764685305949;747.8691229034918;785.7328508307174;14981.625459363508;15883.364665413399;15965.680686386266;16017.839821601781;16027.118508482028;14373.712525749504;14498.275086245672;14513.564593062225;14522.346494407777;14531.636709082279;668.8261052126458;695.3984803145294;833.4291010657719;839.5424493650944;875.5009644502636;857.1428571428571;858.6179150278128;871.8517851965181;875.5184648443362;877.0965905117707;926.7173512078813;929.9860502092474;931.2829121576416;934.0799312677008;936.3585943628602;898.5597057441872;918;921.3090182363261;922.3128769067021;922.8338898998178;688.5627626457235;688.5662032919229;689.2005273882272;689.7068745783072;692.7817737412698;14170.078944868654;14328.92835535826;14373.353199106064;14387.856121438861;14395.856041439662;14527.128372297697;14587.416503339853;14597.489087881979;14625.268736563236;14720.705585888223;11849.111316651286;11947.641570752892;11952.163348565604;12173.756524869541;12405.75188496225;3811.4663947047434;3836.6547010768886;3894.53265608126;3993.3211354069585;4001.5398229203724;115342.42328788387;117096.41451792771;117320;117748.41125794401;119804;11085.057770089472;11273.492692828842;11324.773504529863;11385.601503947322;11437.714057148638;23029.654555181685;23102.960366783198;23131.306060818202;23133.88433057824;23162.53674926492;7740.954971078945;7861.646225919847;8001.919980800118;8112.351011919032;8116.513009219466;3721.5162028936606;4272.316429371285;4415.85707636397;4420.31485119807;4452.9109417812115;3530.947035794465;3652.908677283036;3657.140571965586;3659.524261845996;3662.8351724172476;645.6900687669851;651.2575663743337;661.3915198017835;670.6814263225027;672.0826072411221;533.701127368667;546.5136028934252;593.442164365495;649.8472858878159;669.4209508774875;7928.643211055516;8622.913770862211;9263.490508022123;9409.952950235342;9457.668981585612;543.418542159893;638.6423602782456;652.2759736692268;662.2450406536552;686.4439803758971;3783.7162212834146;4097.385392191195;4657.324687920301;4670.965690609414;4723.858284251478;106874.32814179707;149320;159013.2049339769;161019;166491;140423;141110;143559;143715.5628443723;144518;93689;121504.15834500808;123418;126929.36535317264;128200.99999999814;8659;8907.777305567413;8929.821403572023;8983.910160898307;9161.26709863196;66344;67726.66136669285;67840.6607966957;68916.6554167226;68947.65526172337;69295.3070469309;83533;86262.56868715616;91926.54036729774;96383;10950.890491095306;11282.379469128948;12520;12643.683907902376;13577.1853688779;14561.635959101108;14807.481738139113;15075.276943577166;15151;15386.384429635174;13724.93137534306;13791.793123103362;13995.291247819132;14216.928915355356;14405.279736013366;13079;13779.793303100661;13818.723625527635;13906.165630062229;14075.173540832484;13405.396757146147;13440.865591343962;13591.660208494866;13638.181709097486;13795.517156899861;11211.263111713977;11370.790328293033;11644.53421863116;11656.650300491;11974;9962.402255864672;10553;11423.485943132413;11576.710582235512;11748.236364636272 06:31:50 INFO - PROCESS | 1661 | __end_tp_report 06:31:50 INFO - PROCESS | 1661 | __start_cc_report 06:31:50 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,367 06:31:50 INFO - PROCESS | 1661 | __end_cc_report 06:31:50 INFO - PROCESS | 1661 | __startTimestamp1476106310846__endTimestamp 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | ------- Summary: start ------- 06:31:50 INFO - PROCESS | 1661 | Number of tests: 6 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5710.04 Median:5971.97 stddev:682.88 (11.4%) stddev-sans-first:659.00 06:31:50 INFO - PROCESS | 1661 | Values: 3331.9 3360.5 3384.9 3397.0 3412.6 5608.4 5683.3 5688.3 5725.1 5776.0 5654.4 5719.7 5748.8 5787.1 5890.0 5134.3 5212.0 5217.5 5233.2 5306.3 5181.7 5280.2 5291.2 5313.0 5361.2 5089.8 5155.6 5227.7 5262.4 5276.0 5190.5 5196.5 5231.9 5258.1 5289.0 5172.1 5182.8 5203.9 5205.9 5218.2 5573.8 5595.8 5621.7 5649.8 5737.7 5347.0 6077.9 6161.2 6242.3 6269.1 6238.1 6239.2 6258.9 6275.0 6293.7 4096.4 5644.5 5793.8 5833.9 5844.2 6181.3 6231.3 6239.8 6269.2 6294.6 6151.3 6154.0 6156.2 6181.2 6195.9 6112.3 6113.5 6256.8 6273.1 6315.2 5614.8 6098.6 6135.9 6142.2 6201.3 6183.1 6256.2 6269.0 6273.2 6295.4 3896.5 4951.3 4952.8 4967.5 5003.8 3506.7 4330.4 4351.1 4360.4 4451.2 5770.1 5872.5 5893.3 5907.2 5972.0 6248.5 6258.5 6259.2 6263.7 6273.9 5712.2 5801.3 5830.3 5862.9 5904.3 5443.2 5450.3 5464.5 5471.2 5503.9 6282.0 6282.2 6293.5 6320.0 6328.5 6112.3 6170.3 6203.3 6309.1 6346.9 6173.4 6227.3 6285.8 6287.9 6294.6 5494.7 6151.6 6166.9 6202.6 6205.2 6103.8 6147.0 6195.7 6241.4 6267.0 4862.3 6077.6 6109.7 6119.5 6149.2 6098.5 6127.0 6127.7 6130.3 6143.0 4363.5 5884.9 5923.9 5942.6 6061.7 6115.8 6118.5 6120.0 6127.7 6141.4 5973.9 6029.3 6036.3 6043.2 6051.7 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66848.27 Median:40031.30 stddev:152572.04 (381.1%) stddev-sans-first:152918.65 06:31:50 INFO - PROCESS | 1661 | Values: 472.2 480.6 528.9 538.3 542.1 39504.0 40030.8 40068.0 40075.0 40087.6 41315.2 41601.4 41667.0 41798.0 41847.8 9637.9 9807.3 9812.9 9823.2 9846.4 9755.5 9810.0 9839.8 9856.2 9876.6 9818.5 9867.5 9871.8 9881.1 9887.3 9796.9 9839.6 9840.0 9851.8 9879.4 9630.4 9709.3 9728.4 9732.9 9737.0 40031.8 40069.6 40226.6 40273.6 40320.4 3295.2 3361.6 3376.7 3455.0 3871.6 30602.8 31395.0 31486.5 31617.8 31769.7 3158.9 3255.3 3324.6 3399.3 3404.6 247800.0 259358.0 314520.4 317221.8 352821.0 45779.5 50529.2 51427.0 56125.7 56643.7 58541.8 58756.0 59108.4 59116.4 59133.4 15865.3 15966.5 16075.3 16084.0 16130.6 12578.8 12644.7 12654.8 12679.6 12681.7 12219.7 12304.4 15340.0 15360.8 15530.0 6467.4 6485.4 6537.2 6589.3 6594.0 838.7 928.4 946.5 949.5 958.2 21844.8 27657.2 28888.0 29829.0 30437.7 933.2 1005.8 1096.5 1120.4 1124.5 10979.5 15468.4 15510.5 15806.8 15824.0 638652.0 650834.0 675366.0 686487.0 880180.0 49239.0 55995.4 56556.0 57295.7 57498.9 1118.7 1212.0 1265.3 1378.2 1399.8 29461.9 30109.0 30979.0 31387.7 31506.0 43350.6 52539.5 53025.7 53142.5 53148.0 599300.0 606334.0 607828.0 608028.0 608472.0 25048.5 25093.7 25537.7 25970.7 26728.5 43589.8 46333.8 46751.6 47167.8 47648.8 30672.0 37600.8 37695.5 38597.0 39870.6 31692.8 37430.0 37903.4 38139.6 39571.8 37695.8 37866.8 38029.4 38438.8 39130.8 31428.8 34058.0 34676.7 34746.1 35074.6 22424.9 25690.2 25712.7 25851.5 26519.8 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35061.43 Median:24905.88 stddev:99679.62 (400.2%) stddev-sans-first:99925.14 06:31:50 INFO - PROCESS | 1661 | Values: 331.6 377.6 379.4 384.9 406.3 20255.4 20879.6 21596.6 21714.5 21774.0 16867.7 19176.9 20144.0 20579.4 20702.3 5129.0 5900.2 6147.6 6201.8 6207.7 5200.8 6083.3 6197.9 6237.4 6243.9 5918.9 6115.6 6121.2 6149.0 6227.2 5866.4 6093.0 6093.8 6118.3 6144.5 6006.1 6073.5 6103.2 6107.2 6120.5 13324.8 17710.6 18996.7 24425.0 25386.7 2205.6 2292.7 2293.2 2336.5 2914.6 9668.5 9972.0 10035.2 10116.7 10558.9 1853.6 1856.6 1887.5 1925.7 1985.4 116054.2 131719.0 132309.0 133882.0 134226.3 9415.2 9958.1 10153.8 11458.3 11774.4 12735.5 14611.1 14636.2 14641.5 14697.0 8264.1 8500.9 8522.8 8578.8 8602.0 7727.8 7842.9 8345.5 8386.7 8537.9 4442.7 4541.8 4546.0 4597.2 4624.8 1930.8 1947.0 1972.2 1982.5 2007.6 918.2 929.0 948.7 986.4 1020.7 21168.5 21218.0 21280.7 21303.0 21351.1 936.5 941.6 958.2 960.3 998.6 10731.9 11151.9 11228.9 11259.0 11323.4 532099.0 565499.0 612841.0 618267.0 635859.0 83505.7 130217.0 142773.3 142874.6 151397.0 915.7 976.9 1016.2 1026.2 1051.8 14020.9 18866.2 19619.4 19737.7 19844.3 52793.9 52982.5 53718.7 54513.7 55797.4 61198.8 77687.0 79718.6 81407.0 83962.7 7875.6 7991.4 8127.6 8178.0 8294.7 11284.9 12518.6 12644.5 12673.0 12707.1 10810.8 11082.8 11125.6 11156.5 11169.5 10418.9 10705.0 10714.5 10762.1 10814.4 10519.7 10915.8 11151.2 11250.6 11330.7 7868.4 7995.4 8051.4 8086.8 8135.6 8355.0 10110.2 10210.5 10727.8 11190.7 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5537.98 Median:5142.04 stddev:3099.57 (60.3%) stddev-sans-first:3091.89 06:31:50 INFO - PROCESS | 1661 | Values: 1299.0 1528.3 1708.4 1848.5 1879.7 7796.3 8032.1 8250.5 8783.5 8808.8 8258.1 8568.7 8588.9 8634.2 8651.1 1805.7 1925.7 1926.6 1945.3 2063.9 2313.0 2320.9 2325.2 2341.7 2348.7 1897.4 2298.1 2307.4 2311.4 2349.1 1896.5 2278.8 2298.7 2307.0 2314.2 2279.2 2307.9 2309.9 2317.4 2350.0 8731.9 8772.9 8773.1 8802.5 8816.6 5109.9 5203.9 5274.8 5289.5 5296.1 3401.4 3482.1 3605.9 3608.9 3610.5 1062.7 1070.2 1071.2 1073.8 1097.6 11197.5 11200.9 11272.7 11277.0 11319.3 4474.8 4526.5 4666.9 4706.4 4724.9 9720.4 9722.2 9739.7 9749.4 9765.7 4030.9 4774.7 5232.5 5237.2 5249.7 4290.7 4304.9 4731.1 4777.7 4800.3 3830.2 3886.4 3973.3 3974.7 4008.9 1266.0 1277.2 1278.6 1279.2 1292.3 847.6 849.3 893.6 927.3 939.9 5368.8 5517.5 5787.3 5957.9 5961.9 951.5 957.1 963.8 972.5 1015.5 3903.2 3994.6 4031.1 4139.0 4152.3 9724.5 10059.8 10528.8 10542.0 10579.8 9647.0 10512.8 10516.1 10539.8 10591.1 7992.2 8134.6 8139.0 8149.9 8175.3 4469.0 5657.5 5817.0 5873.6 5961.1 9313.4 9632.2 9632.9 9676.3 9781.6 9739.1 9890.7 9898.9 9973.5 10008.6 5236.0 6113.6 6403.9 6529.4 6791.8 7271.7 8269.1 8289.2 8327.3 8350.0 7202.0 7268.9 7336.9 7429.4 7519.7 6125.7 6141.4 6299.2 7330.4 7418.4 6846.0 6859.4 6886.3 6942.1 6957.7 4975.8 5021.9 5087.3 5138.5 5145.5 5002.5 5071.9 5106.6 5154.4 5204.8 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4552.28 Median:4989.12 stddev:1445.25 (29.0%) stddev-sans-first:1413.66 06:31:50 INFO - PROCESS | 1661 | Values: 301.9 309.7 317.2 322.8 324.0 5084.5 5300.0 5532.3 5687.8 5723.8 4986.5 5377.9 5499.3 5520.6 5555.7 3489.8 4137.3 4163.3 4198.4 4210.3 3308.7 4180.1 4203.5 4208.5 4221.5 3852.3 3941.6 4032.1 4113.5 4136.1 4128.2 4129.5 4133.4 4161.3 4167.0 3597.7 3598.2 3603.6 3616.3 3618.0 4328.7 4976.3 5068.5 5502.1 5505.8 4356.9 4367.5 4764.5 4781.2 4799.4 5824.1 5871.4 5899.7 5907.9 5966.0 3824.6 3905.7 3939.0 3940.9 3966.2 4945.0 5924.3 6068.3 6154.5 6158.4 3277.8 3312.7 3376.4 3474.6 3954.5 3273.8 3492.7 3574.2 4008.0 4031.8 4711.8 4759.1 4770.2 4771.7 4777.9 5531.6 5543.7 5649.7 5851.1 5880.4 1156.6 1314.6 1353.0 1377.6 1385.7 686.9 761.7 797.3 830.7 858.3 4245.6 4737.5 4754.4 4766.9 4770.0 4433.7 4998.3 5091.5 5114.9 5122.6 4318.4 4464.9 4575.2 4722.3 4735.1 2343.7 2543.4 2597.8 2677.5 2695.9 4569.4 4991.7 5244.5 5315.6 5329.5 4794.3 5191.4 5198.7 5257.8 5685.3 5427.6 5949.3 6312.1 6343.2 6425.6 5341.5 5365.0 5532.6 6228.8 6247.3 5777.3 6040.9 6088.4 6107.5 6124.4 4931.0 4985.0 5538.6 6148.6 6415.6 3396.5 3834.0 4038.3 4163.6 4176.5 5332.3 5483.9 6059.2 6091.5 6102.9 4898.9 5159.7 5261.8 5297.9 5621.4 5894.7 5906.4 5918.8 5920.0 5921.3 4668.6 5126.3 5578.5 5754.6 5797.2 5174.4 5493.3 5818.7 5823.2 5843.4 5002.8 5171.4 5249.7 5754.7 5769.6 06:31:50 INFO - PROCESS | 1661 | 06:31:50 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:25737.00 Median:3658.33 stddev:41714.38 (1140.3%) stddev-sans-first:41789.12 06:31:50 INFO - PROCESS | 1661 | Values: 722.4 734.5 736.6 747.9 785.7 14981.6 15883.4 15965.7 16017.8 16027.1 14373.7 14498.3 14513.6 14522.3 14531.6 668.8 695.4 833.4 839.5 875.5 857.1 858.6 871.9 875.5 877.1 926.7 930.0 931.3 934.1 936.4 898.6 918.0 921.3 922.3 922.8 688.6 688.6 689.2 689.7 692.8 14170.1 14328.9 14373.4 14387.9 14395.9 14527.1 14587.4 14597.5 14625.3 14720.7 11849.1 11947.6 11952.2 12173.8 12405.8 3811.5 3836.7 3894.5 3993.3 4001.5 115342.4 117096.4 117320.0 117748.4 119804.0 11085.1 11273.5 11324.8 11385.6 11437.7 23029.7 23103.0 23131.3 23133.9 23162.5 7741.0 7861.6 8001.9 8112.4 8116.5 3721.5 4272.3 4415.9 4420.3 4452.9 3530.9 3652.9 3657.1 3659.5 3662.8 645.7 651.3 661.4 670.7 672.1 533.7 546.5 593.4 649.8 669.4 7928.6 8622.9 9263.5 9410.0 9457.7 543.4 638.6 652.3 662.2 686.4 3783.7 4097.4 4657.3 4671.0 4723.9 106874.3 149320.0 159013.2 161019.0 166491.0 140423.0 141110.0 143559.0 143715.6 144518.0 93689.0 121504.2 123418.0 126929.4 128201.0 8659.0 8907.8 8929.8 8983.9 9161.3 66344.0 67726.7 67840.7 68916.7 68947.7 69295.3 83533.0 86262.6 91926.5 96383.0 10950.9 11282.4 12520.0 12643.7 13577.2 14561.6 14807.5 15075.3 15151.0 15386.4 13724.9 13791.8 13995.3 14216.9 14405.3 13079.0 13779.8 13818.7 13906.2 14075.2 13405.4 13440.9 13591.7 13638.2 13795.5 11211.3 11370.8 11644.5 11656.7 11974.0 9962.4 10553.0 11423.5 11576.7 11748.2 06:31:50 INFO - PROCESS | 1661 | -------- Summary: end -------- 06:31:50 INFO - PROCESS | 1661 | 06:31:51 INFO - TEST-INFO | 1661: exit 0 06:31:51 INFO - TEST-OK | dromaeo_css | took 1115109ms 06:31:51 INFO - TEST-START | kraken 06:31:51 INFO - operating with platform_type : mac_ 06:31:51 INFO - Initialising browser for kraken test... 06:31:51 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp9ibqpp/profile http://localhost:49273/getInfo.html) 06:31:54 INFO - PROCESS | 1669 | 2016-10-10 06:31:54.057 plugin-container[1670:10847] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.tsm.portname' 06:31:54 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:54 INFO - PROCESS | 1669 | 2016-10-10 06:31:54.060 plugin-container[1670:10847] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f2b, name = 'com.apple.CFPasteboardClient' 06:31:54 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:54 INFO - PROCESS | 1669 | 2016-10-10 06:31:54.061 plugin-container[1670:10847] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:31:54 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 06:31:54 INFO - PROCESS | 1669 | colorDepth:24 06:31:54 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 06:31:54 INFO - PROCESS | 1669 | __metrics 06:31:54 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:31:54 INFO - TEST-INFO | 1669: exit 0 06:31:54 INFO - Browser initialized. 06:31:54 INFO - Running cycle 1/1 for kraken test... 06:31:54 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp9ibqpp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:57 INFO - PROCESS | 1671 | 2016-10-10 06:31:57.056 plugin-container[1672:10957] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.tsm.portname' 06:31:57 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:57 INFO - PROCESS | 1671 | 2016-10-10 06:31:57.064 plugin-container[1672:10957] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e07, name = 'com.apple.CFPasteboardClient' 06:31:57 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:31:57 INFO - PROCESS | 1671 | 2016-10-10 06:31:57.064 plugin-container[1672:10957] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:32:06 INFO - PROCESS | 1671 | RSS: Main: 239427584 06:32:06 INFO - PROCESS | 1671 | 06:32:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 06:32:10 INFO - PROCESS | 1671 | RSS: Main: 252846080 06:32:10 INFO - PROCESS | 1671 | 06:32:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 06:32:14 INFO - PROCESS | 1671 | RSS: Main: 260280320 06:32:14 INFO - PROCESS | 1671 | 06:32:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 06:32:18 INFO - PROCESS | 1671 | RSS: Main: 260722688 06:32:18 INFO - PROCESS | 1671 | 06:32:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 06:32:20 INFO - PROCESS | 1671 | RSS: Main: 262922240 06:32:20 INFO - PROCESS | 1671 | 06:32:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:32:23 INFO - PROCESS | 1671 | RSS: Main: 263270400 06:32:23 INFO - PROCESS | 1671 | 06:32:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 06:32:27 INFO - PROCESS | 1671 | RSS: Main: 263909376 06:32:27 INFO - PROCESS | 1671 | 06:32:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 06:32:31 INFO - PROCESS | 1671 | RSS: Main: 264417280 06:32:31 INFO - PROCESS | 1671 | 06:32:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 06:32:34 INFO - PROCESS | 1671 | RSS: Main: 264429568 06:32:34 INFO - PROCESS | 1671 | 06:32:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:32:37 INFO - PROCESS | 1671 | RSS: Main: 264359936 06:32:37 INFO - PROCESS | 1671 | 06:32:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:32:39 INFO - PROCESS | 1671 | RSS: Main: 264404992 06:32:39 INFO - PROCESS | 1671 | 06:32:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:32:42 INFO - PROCESS | 1671 | RSS: Main: 264417280 06:32:42 INFO - PROCESS | 1671 | 06:32:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:32:46 INFO - PROCESS | 1671 | RSS: Main: 264761344 06:32:46 INFO - PROCESS | 1671 | 06:32:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:32:49 INFO - PROCESS | 1671 | RSS: Main: 264572928 06:32:49 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 06:32:51 INFO - PROCESS | 1671 | RSS: Main: 266350592 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | __start_tp_report 06:32:51 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 06:32:51 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 06:32:51 INFO - PROCESS | 1671 | |i|pagename|runs| 06:32:51 INFO - PROCESS | 1671 | |0;ai-astar;114;118;118;116;118;127;172;162;118;117 06:32:51 INFO - PROCESS | 1671 | |1;audio-beat-detection;143;115;120;171;102;150;101;97;177;151 06:32:51 INFO - PROCESS | 1671 | |2;audio-dft;200;223;212;217;185;211;194;251;202;274 06:32:51 INFO - PROCESS | 1671 | |3;audio-fft;83;64;53;76;51;58;79;83;108;83 06:32:51 INFO - PROCESS | 1671 | |4;audio-oscillator;89;71;87;73;69;69;88;72;73;86 06:32:51 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;88;107;133;79;133;136;89;89;87 06:32:51 INFO - PROCESS | 1671 | |6;imaging-darkroom;105;163;114;171;120;114;177;128;174;148 06:32:51 INFO - PROCESS | 1671 | |7;imaging-desaturate;146;150;102;154;153;93;92;144;91;91 06:32:51 INFO - PROCESS | 1671 | |8;json-parse-financial;56;55;54;56;58;60;58;56;57;64 06:32:51 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;67;68;76;80;80;94;100;102;66;69 06:32:51 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;90;89;84;88;86;88;89;89;87 06:32:51 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;148;149;148;146;142;151;174;167;226;163 06:32:51 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;172;237;227;176;176;174;175;176;175;175 06:32:51 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;69;71;71;67;71;69;69;71;71;67 06:32:51 INFO - PROCESS | 1671 | __end_tp_report 06:32:51 INFO - PROCESS | 1671 | __start_cc_report 06:32:51 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,944 06:32:51 INFO - PROCESS | 1671 | __end_cc_report 06:32:51 INFO - PROCESS | 1671 | __startTimestamp1476106371942__endTimestamp 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | ------- Summary: start ------- 06:32:51 INFO - PROCESS | 1671 | Number of tests: 14 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:128.00 Median:118.00 stddev:20.96 (17.8%) stddev-sans-first:21.61 06:32:51 INFO - PROCESS | 1671 | Values: 114.0 118.0 118.0 116.0 118.0 127.0 172.0 162.0 118.0 117.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:150.50 stddev:29.56 (19.6%) stddev-sans-first:31.12 06:32:51 INFO - PROCESS | 1671 | Values: 143.0 115.0 120.0 171.0 102.0 150.0 101.0 97.0 177.0 151.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:216.90 Median:214.50 stddev:27.02 (12.6%) stddev-sans-first:27.95 06:32:51 INFO - PROCESS | 1671 | Values: 200.0 223.0 212.0 217.0 185.0 211.0 194.0 251.0 202.0 274.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:73.80 Median:77.50 stddev:17.49 (22.6%) stddev-sans-first:18.23 06:32:51 INFO - PROCESS | 1671 | Values: 83.0 64.0 53.0 76.0 51.0 58.0 79.0 83.0 108.0 83.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:8.58 (10.8%) stddev-sans-first:8.06 06:32:51 INFO - PROCESS | 1671 | Values: 89.0 71.0 87.0 73.0 69.0 69.0 88.0 72.0 73.0 86.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:87.50 stddev:22.48 (25.7%) stddev-sans-first:23.27 06:32:51 INFO - PROCESS | 1671 | Values: 89.0 88.0 107.0 133.0 79.0 133.0 136.0 89.0 89.0 87.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:141.40 Median:155.50 stddev:28.25 (18.2%) stddev-sans-first:26.71 06:32:51 INFO - PROCESS | 1671 | Values: 105.0 163.0 114.0 171.0 120.0 114.0 177.0 128.0 174.0 148.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:121.60 Median:122.50 stddev:29.61 (24.2%) stddev-sans-first:30.06 06:32:51 INFO - PROCESS | 1671 | Values: 146.0 150.0 102.0 154.0 153.0 93.0 92.0 144.0 91.0 91.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:2.88 (5.0%) stddev-sans-first:3.00 06:32:51 INFO - PROCESS | 1671 | Values: 56.0 55.0 54.0 56.0 58.0 60.0 58.0 56.0 57.0 64.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:80.20 Median:72.50 stddev:13.85 (19.1%) stddev-sans-first:13.84 06:32:51 INFO - PROCESS | 1671 | Values: 67.0 68.0 76.0 80.0 80.0 94.0 100.0 102.0 66.0 69.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.50 stddev:1.84 (2.1%) stddev-sans-first:1.86 06:32:51 INFO - PROCESS | 1671 | Values: 86.0 90.0 89.0 84.0 88.0 86.0 88.0 89.0 89.0 87.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:161.40 Median:157.00 stddev:24.95 (15.9%) stddev-sans-first:25.98 06:32:51 INFO - PROCESS | 1671 | Values: 148.0 149.0 148.0 146.0 142.0 151.0 174.0 167.0 226.0 163.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:176.00 stddev:24.23 (13.8%) stddev-sans-first:25.14 06:32:51 INFO - PROCESS | 1671 | Values: 172.0 237.0 227.0 176.0 176.0 174.0 175.0 176.0 175.0 175.0 06:32:51 INFO - PROCESS | 1671 | 06:32:51 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:71.00 stddev:1.65 (2.3%) stddev-sans-first:1.73 06:32:51 INFO - PROCESS | 1671 | Values: 69.0 71.0 71.0 67.0 71.0 69.0 69.0 71.0 71.0 67.0 06:32:51 INFO - PROCESS | 1671 | -------- Summary: end -------- 06:32:51 INFO - PROCESS | 1671 | 06:32:52 INFO - TEST-INFO | 1671: exit 0 06:32:52 INFO - TEST-OK | kraken | took 61211ms 06:32:52 INFO - SUITE-END | took 1176s 06:32:53 INFO - Completed test suite (00:19:36) 06:32:53 INFO - javascript benchmark 06:32:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7293.274938163168, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3331.8667253309854, 3360.495925611158, 3384.8815291464803, 3396.9830150849243, 3412.6075501317323, 5608.383077861432, 5683.31800183978, 5688.317401911766, 5725.141228815674, 5775.971120144404, 5654.37801841797, 5719.656820590757, 5748.827535173941, 5787.13193021046, 5890.0, 5134.2812006319145, 5212.009718153538, 5217.47825217479, 5233.188855727369, 5306.336707911511, 5181.663191892534, 5280.234366016925, 5291.206319052154, 5313.043652142613, 5361.195820626898, 5089.821856235014, 5155.639105262633, 5227.686338819683, 5262.394824595163, 5275.973620131875, 5190.532852043297, 5196.480351964811, 5231.947680523184, 5258.07983602868, 5289.0, 5172.120739474299, 5182.844514664528, 5203.869903252449, 5205.947940520584, 5218.165093585008, 5573.777048918038, 5595.832125036215, 5621.690807005613, 5649.830505084813, 5737.7131143443075, 5347.0, 6077.939220607782, 6161.229846269216, 6242.313345532033, 6269.122322874801, 6238.095476155932, 6239.157713708682, 6258.937410625881, 6275.0, 6293.748250070037, 4096.365063415175, 5644.520215781622, 5793.81226848495, 5833.912491312633, 5844.152597873284, 6181.258249010058, 6231.3145553989025, 6239.812805615838, 6269.247690277105, 6294.622322660655, 6151.2618485781995, 6154.046122850965, 6156.230471191101, 6181.227346581677, 6195.938040619626, 6112.297085835097, 6113.510919126459, 6256.812295631138, 6273.0904018917, 6315.210598675166, 5614.775408983676, 6098.613770999398, 6135.937063216329, 6142.222533142175, 6201.348858369896, 6183.072539119078, 6256.217972753406, 6269.0, 6273.247210334698, 6295.401936815995, 3896.5129358830145, 4951.331570237971, 4952.801887924515, 4967.503249675004, 5003.799848006039, 3506.6668666476644, 4330.415393921843, 4351.108022855307, 4360.367746676778, 4451.243288640939, 5770.076787713946, 5872.530197584183, 5893.322267939242, 5907.232059832194, 5971.970140149271, 6248.50011999039, 6258.468030217391, 6259.217597800275, 6263.655498947602, 6273.9372606273355, 5712.171735098471, 5801.274840644919, 5830.329512106077, 5862.882742345129, 5904.261967254093, 5443.183522471661, 5450.345958485007, 5464.508194262536, 5471.23402723619, 5503.944960550423, 6282.026285925689, 6282.2147231596055, 6293.527985401113, 6319.999999999908, 6328.493720502441, 6112.290716697506, 6170.259568851767, 6203.31763506005, 6309.085182648582, 6346.90479642815, 6173.41352571505, 6227.252729672468, 6285.779997700059, 6287.937120628918, 6294.622322660655, 5494.670319780826, 6151.569390142647, 6166.876662466815, 6202.627842329474, 6205.193324867739, 6103.755849765959, 6147.0, 6195.721192546436, 6241.407066328691, 6266.968665156645, 4862.343583616308, 6077.604955677867, 6109.6639684817765, 6119.541283489692, 6149.200603921461, 6098.492741543504, 6127.036821038878, 6127.7393367763425, 6130.3369889931655, 6142.98993493194, 4363.520012798526, 5884.941150588439, 5923.851903702442, 5942.61373010753, 6061.6666083365835, 6115.848865095124, 6118.497354392036, 6120.0205129226715, 6127.6936153193055, 6141.393954534099, 5973.880522389441, 6029.276486821609, 6036.275646922221, 6043.214382130295, 6051.697415129138], "value": 5667.128837022836, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.1807663703474, 480.5554861752878, 528.9074411977903, 538.3324677400022, 542.0703493508634, 39504.0, 40030.7998460008, 40067.998300042476, 40074.99812504689, 40087.59912400872, 41315.17369652605, 41601.37597936033, 41667.0, 41798.0, 41847.79076104623, 9637.855432168522, 9807.31348805584, 9812.852807207897, 9823.165030972375, 9846.359986600848, 9755.463449510275, 9810.0, 9839.803203935917, 9856.211503079736, 9876.629608893849, 9818.45998470084, 9867.457289849055, 9871.753206169868, 9881.061299176567, 9887.258455615822, 9796.902030979705, 9839.55721992512, 9839.950800246024, 9851.753706157368, 9879.407235565888, 9630.422174669542, 9709.271804614611, 9728.367656102402, 9732.854007189897, 9737.026297370207, 40031.79984100061, 40069.59930400688, 40226.59773402258, 40273.59726402757, 40320.39519407211, 3295.2256219788333, 3361.6302206757236, 3376.7467439941856, 3454.963510946706, 3871.5741268460447, 30602.84698576493, 31395.0, 31486.527702084488, 31617.8419107903, 31769.682303177135, 3158.9052328430184, 3255.251292202783, 3324.6010478742464, 3399.3371292597953, 3404.6254911959663, 247800.0, 259358.0, 314520.4273978638, 317221.82778172387, 352821.0, 45779.54220457753, 50529.24206136911, 51427.0, 56125.71937140288, 56643.71678141583, 58541.82916341649, 58756.0, 59108.40891591029, 59116.40883591195, 59133.40866591279, 15865.286062127232, 15966.521004369655, 16075.276612552463, 16084.0, 16130.596735081717, 12578.81131783024, 12644.683882903, 12654.81017784734, 12679.556215532411, 12681.746365072831, 12219.69450763738, 12304.446299916524, 15340.002899811476, 15360.769588456182, 15530.0, 6467.353264673495, 6485.383888530677, 6537.182852143482, 6589.308122647149, 6593.967030164818, 838.7106448275335, 928.4475736936512, 946.4605175050293, 949.5157469690507, 958.1903291718487, 21844.78155218459, 27657.170284891487, 28888.0, 29829.0, 30437.695623043484, 933.1601558597181, 1005.7737009173023, 1096.5230124895536, 1120.3501968858043, 1124.4771181400688, 10979.505922233519, 15468.381264749509, 15510.534683959499, 15806.762898556532, 15823.971441856242, 638652.0, 650834.0, 675366.0, 686487.0, 880180.0, 49239.0, 55995.44004559984, 56556.0, 57295.71352143296, 57498.85002299931, 1118.6843234504497, 1211.9575814846614, 1265.342022148496, 1378.2213049626928, 1399.8320201575673, 29461.85269073641, 30109.0, 30979.0, 31387.686123138476, 31506.0, 43350.56649433466, 52539.47460525499, 53025.73487132694, 53142.46857531375, 53148.0, 599300.0034999797, 606334.0, 607828.0, 608028.0, 608472.0, 25048.499030018935, 25093.749062509873, 25537.74462255428, 25970.74029259683, 26728.465430691667, 43589.78205108954, 46333.84165395892, 46751.597452076494, 47167.76416117897, 47648.761756190994, 30672.0, 37600.81199594094, 37695.49218031248, 38597.0, 39870.60129398669, 31692.841535793097, 37430.0, 37903.43144852774, 38139.61394439675, 39571.80214098911, 37695.81152094222, 37866.8106659465, 38029.42955855609, 38438.80780596191, 39130.80434597809, 31428.842855785573, 34058.0, 34676.65323346734, 34746.13134671653, 35074.64925350714, 22424.88787556117, 25690.229293121236, 25712.742872571034, 25851.482970340865, 26519.806608702267], "value": 19307.592921179483, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.60042149210204, 377.6374680306907, 379.4460088271124, 384.9422586612008, 406.34375483594005, 20255.39233822986, 20879.582408351824, 21596.56806863862, 21714.457138571524, 21774.0, 16867.66264674709, 19176.90411547944, 20144.0, 20579.382618521468, 20702.27542036029, 5129.025485157827, 5900.232969713931, 6147.569670123094, 6201.844953876167, 6207.720652570645, 5200.817971371002, 6083.30042045166, 6197.938020619804, 6237.438630523252, 6243.875122497548, 5918.940810591904, 6115.6330620162935, 6121.204243448346, 6149.0, 6227.190465239512, 5866.384029676865, 6092.969535152318, 6093.847653808668, 6118.3269840317525, 6144.5084393248435, 6006.069059295816, 6073.4533891949495, 6103.176071230416, 6107.236595425572, 6120.510359171256, 13324.800127998087, 17710.645787084315, 18996.67023308369, 24425.022999080014, 25386.74613253862, 2205.558888222346, 2292.6561015847587, 2293.1629955066282, 2336.4509340305017, 2914.606528118698, 9668.516574171263, 9971.950140249251, 10035.197184225317, 10116.735398102117, 10558.894411055868, 1853.6107417442354, 1856.58226898948, 1887.4715079777684, 1925.7303977443169, 1985.4440756588178, 116054.19729013515, 131719.0, 132309.0, 133882.0, 134226.32886835502, 9415.15263626277, 9958.053984871425, 10153.796924061477, 11458.255213411101, 11774.411279435993, 12735.490580376681, 14611.123332600078, 14636.19500927438, 14641.48754793577, 14697.0, 8264.132266112092, 8500.914990850013, 8522.829543409222, 8578.828423431496, 8602.0, 7727.802190660344, 7842.921570784333, 8345.457545259538, 8386.748397548083, 8537.871931921027, 4442.6890117691455, 4541.818327266872, 4546.022605139845, 4597.218472859622, 4624.791884365211, 1930.787613362529, 1947.0070264165095, 1972.2111155537614, 1982.5440148765576, 2007.6486614842345, 918.237862574062, 929.0, 948.743839163422, 986.4328011393477, 1020.7346090016649, 21168.470788230417, 21218.04518796627, 21280.680789788166, 21303.041363138695, 21351.14595416166, 936.4942930817418, 941.5998200764648, 958.1711819276276, 960.2653969713175, 998.6005597760809, 10731.89268107309, 11151.944240278746, 11228.887711122947, 11259.0, 11323.43382830855, 532099.0, 565498.9776071003, 612841.0, 618267.0, 635859.0, 83505.74741378763, 130217.0, 142773.28613356868, 142874.5712542882, 151397.0, 915.6749353979375, 976.9302613638055, 1016.192127258831, 1026.1893104447404, 1051.7896420715888, 14020.859791401956, 18866.151023203714, 19619.411417657495, 19737.70393444071, 19844.305449309206, 52793.94412111813, 52982.4701752993, 53718.73140634272, 54513.72743136259, 55797.44202557922, 61198.776024480154, 77687.0, 79718.60140699259, 81407.0, 83962.74055889044, 7875.645595948311, 7991.360691144579, 8127.593620319079, 8178.018637763506, 8294.709685160991, 11284.943575282072, 12518.561850335194, 12644.482662080609, 12673.0, 12707.110502264753, 10810.837837432287, 11082.833757493483, 11125.554977801121, 11156.497957591766, 11169.542700605854, 10418.947905260426, 10705.0, 10714.464276786286, 10762.139028877515, 10814.405207713651, 10519.73700657459, 10915.78168436611, 11151.219414640897, 11250.606228781953, 11330.716732081764, 7868.449208555347, 7995.400344974034, 8051.436399452216, 8086.797830054295, 8135.552544610104, 8354.958225208835, 10110.19118470506, 10210.519474675983, 10727.785444291227, 11190.66428007161], "value": 9549.054755215211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.9870101298986, 1528.3122594832325, 1708.3764425984511, 1848.4824249210226, 1879.7274395212687, 7796.259355361246, 8032.116467188619, 8250.504969701815, 8783.516906570136, 8808.77978050549, 8258.050324212718, 8568.65725370986, 8588.871166932486, 8634.179752923477, 8651.091635378274, 1805.7201133824278, 1925.7207704882783, 1926.6339395514876, 1945.2608008956577, 2063.9174433022663, 2313.005407674699, 2320.918767843126, 2325.244295603927, 2341.7072865891764, 2348.659444380564, 1897.383350411115, 2298.1496846166942, 2307.3885420363617, 2311.3759284993043, 2349.083857295656, 1896.459509039917, 2278.8063014643776, 2298.7011688480475, 2306.976930230693, 2314.1900334882826, 2279.2022792022826, 2307.9423014424606, 2309.90760369585, 2317.3743089365944, 2350.036485041142, 8731.912680873236, 8772.912270877274, 8773.078826723166, 8802.515861627608, 8816.603252853636, 5109.897802043975, 5203.9219411708855, 5274.7626356814035, 5289.523942845162, 5296.126139187029, 3401.4387626041676, 3482.077249528877, 3605.94591081134, 3608.891733248007, 3610.4945307656685, 1062.7024433158729, 1070.1706177712258, 1071.2180108520745, 1073.7959787640323, 1097.5938902606088, 11197.496112674868, 11200.887991120147, 11272.66182014541, 11277.0, 11319.320840749499, 4474.753888536096, 4526.456825180933, 4666.883327916829, 4706.388169537938, 4724.881877953078, 9720.368176068532, 9722.173615242784, 9739.659111931049, 9749.366291191192, 9765.707028789147, 4030.919381612351, 4774.665773395898, 5232.450592687789, 5237.240600113038, 5249.685018898878, 4290.742555446684, 4304.870853874389, 4731.148393289241, 4777.689450185796, 4800.3279540864305, 3830.157365379612, 3886.358750806142, 3973.304671682444, 3974.6621537169085, 4008.8797336079965, 1265.9620211393674, 1277.2272774971195, 1278.5588971804711, 1279.2324605236784, 1292.3150730113055, 847.6058632735684, 849.2950850793826, 893.5576889439769, 927.3462209142539, 939.9436033837992, 5368.792021795143, 5517.475839795213, 5787.334456537468, 5957.851053723605, 5961.897049045941, 951.528993148396, 957.1337939165066, 963.8072385522923, 972.5040229483014, 1015.4821041268858, 3903.1608204236227, 3994.6005399459823, 4031.0930040741187, 4139.0, 4152.27335216342, 9724.541318802094, 10059.798804023878, 10528.789424211473, 10542.0, 10579.84130238047, 9646.951765241269, 10512.789744205073, 10516.1061309788, 10539.84190237147, 10591.099756520627, 7992.160823113606, 8134.633941472766, 8139.023317201855, 8149.918500815034, 8175.3459723222, 4468.977655111704, 5657.4908258256955, 5816.952948469316, 5873.588848780544, 5961.135635332766, 9313.39462934907, 9632.22942164611, 9632.90367096348, 9676.27427942893, 9781.608735650494, 9739.074787895139, 9890.703278901645, 9898.901010989797, 9973.451460169761, 10008.64969726056, 5235.952809438051, 6113.633182009094, 6403.903941440789, 6529.412352888263, 6791.830204244933, 7271.745488908075, 8269.09040005611, 8289.171082891662, 8327.333813295043, 8350.03974542911, 7201.991721158937, 7268.854622907618, 7336.936144259159, 7429.405647548291, 7519.661615227437, 6125.663088530174, 6141.385861413823, 6299.244090709144, 7330.413566914741, 7418.443616728875, 6846.041554182319, 6859.416949559144, 6886.2769409213315, 6942.06282151903, 6957.652117394211, 4975.800967961241, 5021.924671129863, 5087.313212716236, 5138.5375316220225, 5145.536901678867, 5002.474740152232, 5071.949280507295, 5106.565941894832, 5154.407243166934, 5204.765785539736], "value": 4464.521040645739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.85661810639937, 309.73672378478295, 317.1990723423356, 322.79986408426777, 323.96922292382214, 5084.4661310562415, 5299.999007118957, 5532.336119665641, 5687.772489100436, 5723.799667011655, 4986.501349865011, 5377.946220537793, 5499.312585926759, 5520.558355331574, 5555.666660000393, 3489.825508724566, 4137.2552940470705, 4163.250614889319, 4198.412222288882, 4210.347396153586, 3308.7261404359374, 4180.059486615518, 4203.5165955915, 4208.537060923311, 4221.493420789494, 3852.3451013327804, 3941.586133455989, 4032.1330913853517, 4113.506379234496, 4136.110736191718, 4128.236276288896, 4129.545749967501, 4133.441985331971, 4161.271777438936, 4166.999920019204, 3597.6582224688873, 3598.1904071583945, 3603.6396360364015, 3616.276744651054, 3618.023133753898, 4328.718633288826, 4976.328195693572, 5068.543831055223, 5502.119660854284, 5505.807296744635, 4356.89107772305, 4367.519572846984, 4764.547368000034, 4781.187198176319, 4799.448063472675, 5824.097264923944, 5871.418434754796, 5899.73451194693, 5907.852303692399, 5966.045432730785, 3824.560175579816, 3905.7070719696135, 3938.960610393917, 3940.862069827571, 3966.186931678999, 4945.0, 5924.318703349127, 6068.3021452533085, 6154.522914500532, 6158.445739883432, 3277.7869438486423, 3312.668733126668, 3376.3584918865336, 3474.6004209516227, 3954.4859168307935, 3273.8199399033283, 3492.650734926487, 3574.175632073708, 4007.979960100239, 4031.8185681644395, 4711.764411779466, 4759.0719809636785, 4770.212914869077, 4771.73755443447, 4777.856664300077, 5531.612787104864, 5543.695096769717, 5649.68926709035, 5851.050540884886, 5880.441358070976, 1156.5547264303304, 1314.5793346129337, 1352.9661758456118, 1377.6486995816203, 1385.6951470676436, 686.9141357330334, 761.7105499909999, 797.2983774278598, 830.7372793354068, 858.274757829633, 4245.639120674778, 4737.502562230985, 4754.405699287589, 4766.880827979328, 4769.95230047702, 4433.7118087324225, 4998.30091750458, 5091.461434303198, 5114.8977020460125, 5122.564582010496, 4318.438602981592, 4464.9107017860115, 4575.1538021055285, 4722.315264286659, 4735.052989402134, 2343.742188359279, 2543.3768726661715, 2597.7532134447197, 2677.491276657429, 2695.908157196339, 4569.428821397325, 4991.728763412639, 5244.475552444801, 5315.6013299002725, 5329.493698098674, 4794.328793968847, 5191.39066889258, 5198.662086964335, 5257.76340064698, 5685.317761868602, 5427.6472029317965, 5949.315828679671, 6312.147860038928, 6343.175387199727, 6425.646589437626, 5341.465853414783, 5364.9731751341, 5532.585056120726, 6228.813135605939, 6247.281562620356, 5777.277840269966, 6040.892193308592, 6088.36072212429, 6107.450329470369, 6124.418180272867, 4930.975345123395, 4984.975075124747, 5538.556915446835, 6148.600340977822, 6415.615063096229, 3396.5205400057603, 3834.041489627593, 4038.333674943719, 4163.604457576525, 4176.540580536078, 5332.253484512249, 5483.890322193613, 6059.182010428536, 6091.4822240108315, 6102.870968870773, 4898.8775280618265, 5159.716215608178, 5261.8423946731655, 5297.894042119059, 5621.437856214346, 5894.673698417993, 5906.438888305604, 5918.763249469973, 5920.010394750796, 5921.289445266596, 4668.60316873056, 5126.308318255042, 5578.470045345685, 5754.625949313281, 5797.217375654402, 5174.379074511083, 5493.313335833021, 5818.73815678304, 5823.242978412779, 5843.386444423274, 5002.849914502571, 5171.379434467888, 5249.66646179671, 5754.712264386848, 5769.567107570989], "value": 4085.8117371425305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.3751454991427, 734.5188901269667, 736.5764685305949, 747.8691229034918, 785.7328508307174, 14981.625459363508, 15883.364665413399, 15965.680686386266, 16017.839821601781, 16027.118508482028, 14373.712525749504, 14498.275086245672, 14513.564593062225, 14522.346494407777, 14531.636709082279, 668.8261052126458, 695.3984803145294, 833.4291010657719, 839.5424493650944, 875.5009644502636, 857.1428571428571, 858.6179150278128, 871.8517851965181, 875.5184648443362, 877.0965905117707, 926.7173512078813, 929.9860502092474, 931.2829121576416, 934.0799312677008, 936.3585943628602, 898.5597057441872, 918.0, 921.3090182363261, 922.3128769067021, 922.8338898998178, 688.5627626457235, 688.5662032919229, 689.2005273882272, 689.7068745783072, 692.7817737412698, 14170.078944868654, 14328.92835535826, 14373.353199106064, 14387.856121438861, 14395.856041439662, 14527.128372297697, 14587.416503339853, 14597.489087881979, 14625.268736563236, 14720.705585888223, 11849.111316651286, 11947.641570752892, 11952.163348565604, 12173.756524869541, 12405.75188496225, 3811.4663947047434, 3836.6547010768886, 3894.53265608126, 3993.3211354069585, 4001.5398229203724, 115342.42328788387, 117096.41451792771, 117320.0, 117748.41125794401, 119804.0, 11085.057770089472, 11273.492692828842, 11324.773504529863, 11385.601503947322, 11437.714057148638, 23029.654555181685, 23102.960366783198, 23131.306060818202, 23133.88433057824, 23162.53674926492, 7740.954971078945, 7861.646225919847, 8001.919980800118, 8112.351011919032, 8116.513009219466, 3721.5162028936606, 4272.316429371285, 4415.85707636397, 4420.31485119807, 4452.9109417812115, 3530.947035794465, 3652.908677283036, 3657.140571965586, 3659.524261845996, 3662.8351724172476, 645.6900687669851, 651.2575663743337, 661.3915198017835, 670.6814263225027, 672.0826072411221, 533.701127368667, 546.5136028934252, 593.442164365495, 649.8472858878159, 669.4209508774875, 7928.643211055516, 8622.913770862211, 9263.490508022123, 9409.952950235342, 9457.668981585612, 543.418542159893, 638.6423602782456, 652.2759736692268, 662.2450406536552, 686.4439803758971, 3783.7162212834146, 4097.385392191195, 4657.324687920301, 4670.965690609414, 4723.858284251478, 106874.32814179707, 149320.0, 159013.2049339769, 161019.0, 166491.0, 140423.0, 141110.0, 143559.0, 143715.5628443723, 144518.0, 93689.0, 121504.15834500808, 123418.0, 126929.36535317264, 128200.99999999814, 8659.0, 8907.777305567413, 8929.821403572023, 8983.910160898307, 9161.26709863196, 66344.0, 67726.66136669285, 67840.6607966957, 68916.6554167226, 68947.65526172337, 69295.3070469309, 83533.0, 86262.56868715616, 91926.54036729774, 96383.0, 10950.890491095306, 11282.379469128948, 12520.0, 12643.683907902376, 13577.1853688779, 14561.635959101108, 14807.481738139113, 15075.276943577166, 15151.0, 15386.384429635174, 13724.93137534306, 13791.793123103362, 13995.291247819132, 14216.928915355356, 14405.279736013366, 13079.0, 13779.793303100661, 13818.723625527635, 13906.165630062229, 14075.173540832484, 13405.396757146147, 13440.865591343962, 13591.660208494866, 13638.181709097486, 13795.517156899861, 11211.263111713977, 11370.790328293033, 11644.53421863116, 11656.650300491, 11974.0, 9962.402255864672, 10553.0, 11423.485943132413, 11576.710582235512, 11748.236364636272], "value": 7895.593822532441, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1637.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 118.0, 116.0, 118.0, 127.0, 172.0, 162.0, 118.0, 117.0], "value": 128.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 120.0, 171.0, 102.0, 150.0, 101.0, 97.0, 177.0, 151.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 223.0, 212.0, 217.0, 185.0, 211.0, 194.0, 251.0, 202.0, 274.0], "value": 216.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 64.0, 53.0, 76.0, 51.0, 58.0, 79.0, 83.0, 108.0, 83.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 87.0, 73.0, 69.0, 69.0, 88.0, 72.0, 73.0, 86.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 107.0, 133.0, 79.0, 133.0, 136.0, 89.0, 89.0, 87.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 163.0, 114.0, 171.0, 120.0, 114.0, 177.0, 128.0, 174.0, 148.0], "value": 141.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 102.0, 154.0, 153.0, 93.0, 92.0, 144.0, 91.0, 91.0], "value": 121.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 56.0, 58.0, 60.0, 58.0, 56.0, 57.0, 64.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 76.0, 80.0, 80.0, 94.0, 100.0, 102.0, 66.0, 69.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 89.0, 84.0, 88.0, 86.0, 88.0, 89.0, 89.0, 87.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 146.0, 142.0, 151.0, 174.0, 167.0, 226.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 237.0, 227.0, 176.0, 176.0, 174.0, 175.0, 176.0, 175.0, 175.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 71.0, 67.0, 71.0, 69.0, 69.0, 71.0, 71.0, 67.0], "value": 69.6, "unit": "score"}]}]} 06:32:53 INFO - Return code: 0 06:32:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:32:53 ERROR - # TBPL SUCCESS # 06:32:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:32:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:32:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:32:53 INFO - 2016-10-10 06:32:53.259 screenresolution[1676:11351] starting screenresolution argv=screenresolution get 06:32:53 INFO - 2016-10-10 06:32:53.262 screenresolution[1676:11351] Display 0: 1600x1200x32@60 06:32:53 INFO - 2016-10-10 06:32:53.268 screenresolution[1677:11354] starting screenresolution argv=screenresolution list 06:32:53 INFO - Available Modes on Display 0 06:32:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:32:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:32:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:32:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:32:53 INFO - Intel Iris: 06:32:53 INFO - Chipset Model: Intel Iris 06:32:53 INFO - Type: GPU 06:32:53 INFO - Bus: Built-In 06:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 06:32:53 INFO - Vendor: Intel (0x8086) 06:32:53 INFO - Device ID: 0x0a2e 06:32:53 INFO - Revision ID: 0x0009 06:32:53 INFO - Displays: 06:32:53 INFO - Display: 06:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:32:53 INFO - Display Serial Number: 1600x1200 60 06:32:53 INFO - Main Display: Yes 06:32:53 INFO - Mirror: Off 06:32:53 INFO - Online: Yes 06:32:53 INFO - Rotation: Supported 06:32:53 INFO - Return code: 0 06:32:53 INFO - Running post-action listener: _resource_record_post_action 06:32:53 INFO - [mozharness: 2016-10-10 13:32:53.505015Z] Finished run-tests step (success) 06:32:53 INFO - Running post-run listener: _resource_record_post_run 06:32:53 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 39781376; Write bytes: 713136640; Read time: 363; Write time: 2145 06:32:53 INFO - TinderboxPrint: CPU usage
54.6% 06:32:53 INFO - TinderboxPrint: I/O read bytes / time
39,781,376 / 363 06:32:53 INFO - TinderboxPrint: I/O write bytes / time
713,136,640 / 2,145 06:32:53 INFO - TinderboxPrint: CPU idle
2,198.6 (45.4%) 06:32:53 INFO - TinderboxPrint: CPU system
984.1 (20.3%) 06:32:53 INFO - TinderboxPrint: CPU user
1,663.0 (34.3%) 06:32:53 INFO - TinderboxPrint: Swap in / out
451,850,240 / 0 06:32:53 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396018176; Write bytes: 391579648; Read time: 29409; Write time: 723 06:32:53 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 37782528; Write bytes: 300507648; Read time: 343; Write time: 1379 06:32:53 INFO - Running post-run listener: _upload_blobber_files 06:32:53 INFO - Blob upload gear active. 06:32:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:32:53 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 06:32:53 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'] 06:32:53 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 06:32:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:55 INFO - (blobuploader) - INFO - Done attempting. 06:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:56 INFO - (blobuploader) - INFO - Done attempting. 06:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:32:58 INFO - (blobuploader) - INFO - Done attempting. 06:32:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:32:58 INFO - Return code: 0 06:32:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:32:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:32:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/389f327b1414693daabd20ce4b8285d423aba146fc9826cea99cc918c6108307b27755ea06c13f174e29c4c26b02222de6446c74a8544a5347b8302dbaf6e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41fc4b43c8304b4856c042c76fab0aafcfa570d7a356291dfdb2249dced8db868f885b1ce98e812f9e454b707d0fe368f81dad92c6022c9465724ca8583cde6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7cbdc7ba8f9d63749c47c9c0c66c45b3d0de26d97506ad31abbc96670f6254707add67ec960ad3368345803f601128832fc240b5d155467956c43b944a60635"} 06:32:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:32:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:32:58 INFO - Contents: 06:32:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/389f327b1414693daabd20ce4b8285d423aba146fc9826cea99cc918c6108307b27755ea06c13f174e29c4c26b02222de6446c74a8544a5347b8302dbaf6e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41fc4b43c8304b4856c042c76fab0aafcfa570d7a356291dfdb2249dced8db868f885b1ce98e812f9e454b707d0fe368f81dad92c6022c9465724ca8583cde6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7cbdc7ba8f9d63749c47c9c0c66c45b3d0de26d97506ad31abbc96670f6254707add67ec960ad3368345803f601128832fc240b5d155467956c43b944a60635"} 06:32:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:32:58 INFO - Copying logs to upload dir... 06:32:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:32:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.199056 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-10 06:32:58.740792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 06:32:58.744049) ========= 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.cpba9AAmOm/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.kKueAannhq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/389f327b1414693daabd20ce4b8285d423aba146fc9826cea99cc918c6108307b27755ea06c13f174e29c4c26b02222de6446c74a8544a5347b8302dbaf6e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41fc4b43c8304b4856c042c76fab0aafcfa570d7a356291dfdb2249dced8db868f885b1ce98e812f9e454b707d0fe368f81dad92c6022c9465724ca8583cde6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7cbdc7ba8f9d63749c47c9c0c66c45b3d0de26d97506ad31abbc96670f6254707add67ec960ad3368345803f601128832fc240b5d155467956c43b944a60635"} build_url:https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/TfBl3TumTeqS4AZg-lGO_g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/389f327b1414693daabd20ce4b8285d423aba146fc9826cea99cc918c6108307b27755ea06c13f174e29c4c26b02222de6446c74a8544a5347b8302dbaf6e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41fc4b43c8304b4856c042c76fab0aafcfa570d7a356291dfdb2249dced8db868f885b1ce98e812f9e454b707d0fe368f81dad92c6022c9465724ca8583cde6f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7cbdc7ba8f9d63749c47c9c0c66c45b3d0de26d97506ad31abbc96670f6254707add67ec960ad3368345803f601128832fc240b5d155467956c43b944a60635"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 06:32:58.776802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:32:58.777155) ========= 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.cpba9AAmOm/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.kKueAannhq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:32:58.825751) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 06:32:58.826144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 06:32:58.826488) ========= ========= Total master_lag: 0.17 =========