builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0098 starttime: 1475755838.72 results: success (0) buildid: 20161006030102 builduid: 89cef4394a5a4cb19a90251c4a6e7107 revision: 777fb63db8de8d78b64b8141d1a998397275dd03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.722937) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.723381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.723837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.757411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.757690) ========= 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.TMB2yUAw9x/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.FvD4up9hz1/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-06 05:10:38-- 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% 88.4M=0s 2016-10-06 05:10:38 (88.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099089 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.886091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.886470) ========= 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.TMB2yUAw9x/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.FvD4up9hz1/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.037531 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:38.943908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 05:10:38.944240) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 777fb63db8de8d78b64b8141d1a998397275dd03 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 777fb63db8de8d78b64b8141d1a998397275dd03 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TMB2yUAw9x/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.FvD4up9hz1/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-06 05:10:39,015 truncating revision to first 12 chars 2016-10-06 05:10:39,015 Setting DEBUG logging. 2016-10-06 05:10:39,015 attempt 1/10 2016-10-06 05:10:39,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/777fb63db8de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 05:10:40,468 unpacking tar archive at: mozilla-central-777fb63db8de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.729267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 05:10:40.695247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:40.695608) ========= script_repo_revision: 777fb63db8de8d78b64b8141d1a998397275dd03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:40.696072) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:40.696409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 05:10:40.715568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-06 05:10:40.715890) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TMB2yUAw9x/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.FvD4up9hz1/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:10:40 INFO - MultiFileLogger online at 20161006 05:10:40 in /builds/slave/test 05:10:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:10:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:40 INFO - {'append_to_log': False, 05:10:40 INFO - 'base_work_dir': '/builds/slave/test', 05:10:40 INFO - 'blob_upload_branch': 'Firefox', 05:10:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:40 INFO - 'branch': 'Firefox', 05:10:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:40 INFO - 'config_files': ('talos/mac_config.py',), 05:10:40 INFO - 'default_actions': ('clobber', 05:10:40 INFO - 'read-buildbot-config', 05:10:40 INFO - 'download-and-extract', 05:10:40 INFO - 'populate-webroot', 05:10:40 INFO - 'create-virtualenv', 05:10:40 INFO - 'install', 05:10:40 INFO - 'run-tests'), 05:10:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:40 INFO - 'download_minidump_stackwalk': True, 05:10:40 INFO - 'download_symbols': 'ondemand', 05:10:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:40 INFO - 'installer_path': 'installer.exe', 05:10:40 INFO - 'log_level': 'info', 05:10:40 INFO - 'log_name': 'talos', 05:10:40 INFO - 'log_to_console': True, 05:10:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:10:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:10:40 INFO - 'opt_config_files': (), 05:10:40 INFO - 'pip_index': False, 05:10:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:40 INFO - 'cmd': ('bash', 05:10:40 INFO - '-c', 05:10:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:40 INFO - 'enabled': True, 05:10:40 INFO - 'halt_on_failure': False, 05:10:40 INFO - 'name': 'check_screen_resolution'},), 05:10:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:10:40 INFO - 'cmd': ('bash', 05:10:40 INFO - '-c', 05:10:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:10:40 INFO - 'enabled': True, 05:10:40 INFO - 'halt_on_failure': False, 05:10:40 INFO - 'name': 'check_screen_resolution'},), 05:10:40 INFO - 'run_cmd_checks_enabled': True, 05:10:40 INFO - 'sps_profile': False, 05:10:40 INFO - 'sps_profile_interval': 0, 05:10:40 INFO - 'suite': 'dromaeojs-e10s', 05:10:40 INFO - 'system_bits': '32', 05:10:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:40 INFO - 'title': 't-yosemite-r7-0098', 05:10:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:40 INFO - 'use_talos_json': True, 05:10:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:40 INFO - 'work_dir': 'build'} 05:10:40 INFO - [mozharness: 2016-10-06 12:10:40.912797Z] Running clobber step. 05:10:40 INFO - Running pre-action listener: _resource_record_pre_action 05:10:40 INFO - Running main action method: clobber 05:10:40 INFO - rmtree: /builds/slave/test/build 05:10:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:43 INFO - Running post-action listener: _resource_record_post_action 05:10:43 INFO - [mozharness: 2016-10-06 12:10:43.013326Z] Finished clobber step (success) 05:10:43 INFO - [mozharness: 2016-10-06 12:10:43.013483Z] Running read-buildbot-config step. 05:10:43 INFO - Running pre-action listener: _resource_record_pre_action 05:10:43 INFO - Running main action method: read_buildbot_config 05:10:43 INFO - Using buildbot properties: 05:10:43 INFO - { 05:10:43 INFO - "project": "", 05:10:43 INFO - "product": "firefox", 05:10:43 INFO - "script_repo_revision": "production", 05:10:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:10:43 INFO - "repository": "", 05:10:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:10:43 INFO - "buildid": "20161006030102", 05:10:43 INFO - "pgo_build": "False", 05:10:43 INFO - "basedir": "/builds/slave/test", 05:10:43 INFO - "buildnumber": 7, 05:10:43 INFO - "slavename": "t-yosemite-r7-0098", 05:10:43 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:10:43 INFO - "platform": "yosemite_r7", 05:10:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:10:43 INFO - "branch": "mozilla-central", 05:10:43 INFO - "repo_path": "mozilla-central", 05:10:43 INFO - "revision": "777fb63db8de8d78b64b8141d1a998397275dd03", 05:10:43 INFO - "stage_platform": "macosx64", 05:10:43 INFO - "builduid": "89cef4394a5a4cb19a90251c4a6e7107", 05:10:43 INFO - "slavebuilddir": "test" 05:10:43 INFO - } 05:10:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:10:43 INFO - Running post-action listener: _resource_record_post_action 05:10:43 INFO - [mozharness: 2016-10-06 12:10:43.016869Z] Finished read-buildbot-config step (success) 05:10:43 INFO - [mozharness: 2016-10-06 12:10:43.017012Z] Running download-and-extract step. 05:10:43 INFO - Running pre-action listener: _resource_record_pre_action 05:10:43 INFO - Running main action method: download_and_extract 05:10:43 INFO - mkdir: /builds/slave/test/build/tests 05:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:43 INFO - trying https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/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 05:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/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 05:10:44 INFO - Downloaded 1199 bytes. 05:10:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:10:44 INFO - Using the following test package requirements: 05:10:44 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:10:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:10:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:10:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'jsshell-mac.zip'], 05:10:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:10:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:10:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:10:44 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:10:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:10:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:10:44 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:10:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:10:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:10:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:10:44 INFO - Http code: 200 05:10:44 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 05:10:44 INFO - x-amz-cf-id: wfl900yVSTOTuorpJ7pPiODNivC5g6VeAdIqaZJaxxj_B-QcVJUhcA== 05:10:44 INFO - x-amz-version-id: lPr47xsLbmHGUgS.KxowcCUE12QYRWi1 05:10:45 INFO - Expected file size: 16478289 05:10:45 INFO - Obtained file size: 16478289 05:10:51 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 05:10:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:10:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:10:52 INFO - Http code: 200 05:10:52 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 05:10:52 INFO - x-amz-cf-id: FQaQa3s7kpqy6KRFAy8HjAD9DsCDjC4yxALczFigs76gMjBq21uaiQ== 05:10:52 INFO - x-amz-version-id: lPr47xsLbmHGUgS.KxowcCUE12QYRWi1 05:10:52 INFO - Expected file size: 16478289 05:10:52 INFO - Obtained file size: 16478289 05:10:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:10:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:10:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:10:59 INFO - Http code: 200 05:10:59 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 05:10:59 INFO - x-amz-cf-id: uXu3BDGljYjKLYWsDVJdDNOHtKGYCpv0PzB2T0PFm3kxkrFZnxV3qA== 05:10:59 INFO - x-amz-version-id: jl5HpTJfqJPsO0RogK9MZA6C__L5jZ.E 05:10:59 INFO - Expected file size: 14409006 05:10:59 INFO - Obtained file size: 14409006 05:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:00 INFO - trying https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/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 05:11:02 INFO - Downloaded 111671154 bytes. 05:11:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:11:02 INFO - mkdir: /builds/slave/test/properties 05:11:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:02 INFO - Contents: 05:11:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:11:03 INFO - Running post-action listener: _resource_record_post_action 05:11:03 INFO - Running post-action listener: set_extra_try_arguments 05:11:03 INFO - [mozharness: 2016-10-06 12:11:03.590768Z] Finished download-and-extract step (success) 05:11:03 INFO - [mozharness: 2016-10-06 12:11:03.590884Z] Running populate-webroot step. 05:11:03 INFO - Running pre-action listener: _resource_record_pre_action 05:11:03 INFO - Running main action method: populate_webroot 05:11:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:03 INFO - '--tppagecycles', 05:11:03 INFO - '7'], 05:11:03 INFO - 'tests': ['tsvgm']}}, 05:11:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['damp', 'tps']}, 05:11:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'tests': ['damp', 'tps']}, 05:11:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['dromaeo_dom']}, 05:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['basic_compositor_video']}, 05:11:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['a11yr', 05:11:03 INFO - 'ts_paint', 05:11:03 INFO - 'tpaint', 05:11:03 INFO - 'sessionrestore', 05:11:03 INFO - 'sessionrestore_no_auto_restore', 05:11:03 INFO - 'tabpaint']}, 05:11:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:03 INFO - 'ts_paint', 05:11:03 INFO - 'tpaint', 05:11:03 INFO - 'sessionrestore', 05:11:03 INFO - 'sessionrestore_no_auto_restore', 05:11:03 INFO - 'tabpaint']}, 05:11:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:03 INFO - 'ts_paint', 05:11:03 INFO - 'tpaint', 05:11:03 INFO - 'sessionrestore', 05:11:03 INFO - 'sessionrestore_no_auto_restore', 05:11:03 INFO - 'tabpaint']}, 05:11:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:03 INFO - 'ts_paint', 05:11:03 INFO - 'tpaint', 05:11:03 INFO - 'sessionrestore', 05:11:03 INFO - 'sessionrestore_no_auto_restore', 05:11:03 INFO - 'tabpaint']}, 05:11:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['a11yr', 05:11:03 INFO - 'ts_paint', 05:11:03 INFO - 'tpaint', 05:11:03 INFO - 'sessionrestore', 05:11:03 INFO - 'sessionrestore_no_auto_restore', 05:11:03 INFO - 'tabpaint']}, 05:11:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['a11yr', 05:11:03 INFO - 'ts_paint', 05:11:03 INFO - 'tpaint', 05:11:03 INFO - 'sessionrestore', 05:11:03 INFO - 'sessionrestore_no_auto_restore', 05:11:03 INFO - 'tabpaint']}, 05:11:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['tsvgx', 05:11:03 INFO - 'tsvgr_opacity', 05:11:03 INFO - 'tart', 05:11:03 INFO - 'tscrollx', 05:11:03 INFO - 'cart']}, 05:11:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:03 INFO - 'tsvgr_opacity', 05:11:03 INFO - 'tart', 05:11:03 INFO - 'tscrollx', 05:11:03 INFO - 'cart']}, 05:11:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'talos_options': ['--disable-e10s'], 05:11:03 INFO - 'tests': ['tp5o']}, 05:11:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'tests': ['tp5o']}, 05:11:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'talos_options': ['--disable-e10s', 05:11:03 INFO - '--xperf_path', 05:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:03 INFO - 'tests': ['tp5n']}, 05:11:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:03 INFO - 'talos_options': ['--xperf_path', 05:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:03 INFO - 'tests': ['tp5n']}}, 05:11:03 INFO - 'talos.zip': {'path': '', 05:11:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:03 INFO - Running post-action listener: _resource_record_post_action 05:11:03 INFO - [mozharness: 2016-10-06 12:11:03.609428Z] Finished populate-webroot step (success) 05:11:03 INFO - [mozharness: 2016-10-06 12:11:03.609551Z] Running create-virtualenv step. 05:11:03 INFO - Running pre-action listener: _resource_record_pre_action 05:11:03 INFO - Running main action method: create_virtualenv 05:11:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:03 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 05:11:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:03 INFO - Using real prefix '/tools/python27' 05:11:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:07 INFO - Installing pip.................done. 05:11:07 INFO - Return code: 0 05:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:07 INFO - Reading from file tmpfile_stdout 05:11:07 INFO - Output received: 05:11:07 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) 05:11:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:07 INFO - 'HOME': '/Users/cltbld', 05:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:07 INFO - 'LOGNAME': 'cltbld', 05:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:07 INFO - 'MOZ_NO_REMOTE': '1', 05:11:07 INFO - 'NO_EM_RESTART': '1', 05:11:07 INFO - 'PAGER': '/bin/cat', 05:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:07 INFO - 'PWD': '/builds/slave/test', 05:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:07 INFO - 'SHELL': '/bin/bash', 05:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:07 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:07 INFO - 'USER': 'cltbld', 05:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:07 INFO - 'XPC_FLAGS': '0x0', 05:11:07 INFO - 'XPC_SERVICE_NAME': '0', 05:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:11:07 INFO - Cleaning up... 05:11:07 INFO - Return code: 0 05:11:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:07 INFO - 'HOME': '/Users/cltbld', 05:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:07 INFO - 'LOGNAME': 'cltbld', 05:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:07 INFO - 'MOZ_NO_REMOTE': '1', 05:11:07 INFO - 'NO_EM_RESTART': '1', 05:11:07 INFO - 'PAGER': '/bin/cat', 05:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:07 INFO - 'PWD': '/builds/slave/test', 05:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:07 INFO - 'SHELL': '/bin/bash', 05:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:07 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:07 INFO - 'USER': 'cltbld', 05:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:07 INFO - 'XPC_FLAGS': '0x0', 05:11:07 INFO - 'XPC_SERVICE_NAME': '0', 05:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:08 INFO - Downloading/unpacking psutil>=3.1.1 05:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:11 INFO - Installing collected packages: psutil 05:11:11 INFO - Running setup.py install for psutil 05:11:11 INFO - building 'psutil._psutil_osx' extension 05:11:11 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 05:11:12 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 05:11:12 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 05:11:12 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 05:11:12 INFO - building 'psutil._psutil_posix' extension 05:11:12 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 05:11:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:11:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:11:12 INFO - ^ 05:11:12 INFO - 1 warning generated. 05:11:12 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 05:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:12 INFO - Successfully installed psutil 05:11:12 INFO - Cleaning up... 05:11:12 INFO - Return code: 0 05:11:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:12 INFO - 'HOME': '/Users/cltbld', 05:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:12 INFO - 'LOGNAME': 'cltbld', 05:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:12 INFO - 'MOZ_NO_REMOTE': '1', 05:11:12 INFO - 'NO_EM_RESTART': '1', 05:11:12 INFO - 'PAGER': '/bin/cat', 05:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:12 INFO - 'PWD': '/builds/slave/test', 05:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:12 INFO - 'SHELL': '/bin/bash', 05:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:12 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:12 INFO - 'USER': 'cltbld', 05:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:12 INFO - 'XPC_FLAGS': '0x0', 05:11:12 INFO - 'XPC_SERVICE_NAME': '0', 05:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:12 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 05:11:12 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 05:11:12 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 05:11:12 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 05:11:12 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 05:11:12 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 05:11:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:15 INFO - Installing collected packages: mozsystemmonitor 05:11:15 INFO - Running setup.py install for mozsystemmonitor 05:11:15 INFO - Successfully installed mozsystemmonitor 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:15 INFO - 'HOME': '/Users/cltbld', 05:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PAGER': '/bin/cat', 05:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:15 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - 'XPC_FLAGS': '0x0', 05:11:15 INFO - 'XPC_SERVICE_NAME': '0', 05:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:15 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:18 INFO - warning: no files found matching '*.txt' 05:11:18 INFO - no previously-included directories found matching 'build' 05:11:18 INFO - no previously-included directories found matching 'dist' 05:11:18 INFO - no previously-included directories found matching '.git*' 05:11:18 INFO - Installing collected packages: jsonschema, functools32 05:11:18 INFO - Running setup.py install for functools32 05:11:19 INFO - warning: no files found matching '*.txt' 05:11:19 INFO - no previously-included directories found matching 'build' 05:11:19 INFO - no previously-included directories found matching 'dist' 05:11:19 INFO - no previously-included directories found matching '.git*' 05:11:19 INFO - Successfully installed jsonschema functools32 05:11:19 INFO - Cleaning up... 05:11:19 INFO - Return code: 0 05:11:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:11: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 functools32==3.2.3-2 05:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:19 INFO - 'HOME': '/Users/cltbld', 05:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:19 INFO - 'LOGNAME': 'cltbld', 05:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:19 INFO - 'MOZ_NO_REMOTE': '1', 05:11:19 INFO - 'NO_EM_RESTART': '1', 05:11:19 INFO - 'PAGER': '/bin/cat', 05:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:19 INFO - 'PWD': '/builds/slave/test', 05:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:19 INFO - 'SHELL': '/bin/bash', 05:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:19 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:19 INFO - 'USER': 'cltbld', 05:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:19 INFO - 'XPC_FLAGS': '0x0', 05:11:19 INFO - 'XPC_SERVICE_NAME': '0', 05:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:11:19 INFO - Cleaning up... 05:11:19 INFO - Return code: 0 05:11:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11: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 blobuploader==1.2.4 05:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:19 INFO - 'HOME': '/Users/cltbld', 05:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:19 INFO - 'LOGNAME': 'cltbld', 05:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:19 INFO - 'MOZ_NO_REMOTE': '1', 05:11:19 INFO - 'NO_EM_RESTART': '1', 05:11:19 INFO - 'PAGER': '/bin/cat', 05:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:19 INFO - 'PWD': '/builds/slave/test', 05:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:19 INFO - 'SHELL': '/bin/bash', 05:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:19 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:19 INFO - 'USER': 'cltbld', 05:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:19 INFO - 'XPC_FLAGS': '0x0', 05:11:19 INFO - 'XPC_SERVICE_NAME': '0', 05:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:23 INFO - Downloading docopt-0.6.1.tar.gz 05:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:23 INFO - Running setup.py install for blobuploader 05:11:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:23 INFO - Running setup.py install for requests 05:11:24 INFO - Running setup.py install for docopt 05:11:24 INFO - Successfully installed blobuploader requests docopt 05:11:24 INFO - Cleaning up... 05:11:24 INFO - Return code: 0 05:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:24 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')]} 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 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')]} 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:24 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 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:24 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 05:11:24 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 05:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:24 INFO - 'HOME': '/Users/cltbld', 05:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:24 INFO - 'LOGNAME': 'cltbld', 05:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:24 INFO - 'MOZ_NO_REMOTE': '1', 05:11:24 INFO - 'NO_EM_RESTART': '1', 05:11:24 INFO - 'PAGER': '/bin/cat', 05:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:24 INFO - 'PWD': '/builds/slave/test', 05:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:24 INFO - 'SHELL': '/bin/bash', 05:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:24 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:24 INFO - 'USER': 'cltbld', 05:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:24 INFO - 'XPC_FLAGS': '0x0', 05:11:24 INFO - 'XPC_SERVICE_NAME': '0', 05:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-VTW_Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-sSuptO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-w9XZzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-sX_Pab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:24 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-h9bkM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-61EIdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-rfsEP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-hhAqSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-KmH9_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-t0aTjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-hF8mdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-datFnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-a65Sbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-iKN3nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:25 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-dDQe96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-eW4sqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:26 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-hRd0OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:26 INFO - Running setup.py install for manifestparser 05:11:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:26 INFO - Running setup.py install for mozcrash 05:11:26 INFO - Running setup.py install for mozdebug 05:11:26 INFO - Running setup.py install for mozdevice 05:11:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:26 INFO - Running setup.py install for mozfile 05:11:27 INFO - Running setup.py install for mozhttpd 05:11:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Running setup.py install for mozinfo 05:11:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Running setup.py install for mozInstall 05:11:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Running setup.py install for mozleak 05:11:27 INFO - Running setup.py install for mozlog 05:11:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Running setup.py install for moznetwork 05:11:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:27 INFO - Running setup.py install for mozprocess 05:11:28 INFO - Running setup.py install for mozprofile 05:11:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:28 INFO - Running setup.py install for mozrunner 05:11:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:28 INFO - Running setup.py install for mozscreenshot 05:11:28 INFO - Running setup.py install for moztest 05:11:28 INFO - Running setup.py install for mozversion 05:11:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:28 INFO - Cleaning up... 05:11:28 INFO - Return code: 0 05:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:28 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 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:28 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 05:11:28 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 05:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:28 INFO - 'HOME': '/Users/cltbld', 05:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:28 INFO - 'LOGNAME': 'cltbld', 05:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:28 INFO - 'MOZ_NO_REMOTE': '1', 05:11:28 INFO - 'NO_EM_RESTART': '1', 05:11:28 INFO - 'PAGER': '/bin/cat', 05:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:28 INFO - 'PWD': '/builds/slave/test', 05:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:28 INFO - 'SHELL': '/bin/bash', 05:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:28 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:28 INFO - 'USER': 'cltbld', 05:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:28 INFO - 'XPC_FLAGS': '0x0', 05:11:28 INFO - 'XPC_SERVICE_NAME': '0', 05:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-2NpJod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-HEm_v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-0IiCRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-DWHFce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-G6Kuw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-7NaSoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-zeOyXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xzaet6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:29 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)) 05:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:29 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-RTbXRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-yJvl7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-pFD9UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-GpslWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JrYsYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-K8nOwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xAZB2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-wGgyE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:30 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)) 05:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:30 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xtC7G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:30 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)) 05:11:30 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)) 05:11:30 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)) 05:11:30 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)) 05:11:30 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)) 05:11:30 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)) 05:11:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:30 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 05:11:30 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 05:11:30 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 05:11:30 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 05:11:30 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 05:11:30 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 05:11:33 INFO - Downloading blessings-1.6.tar.gz 05:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:33 INFO - Installing collected packages: blessings 05:11:33 INFO - Running setup.py install for blessings 05:11:33 INFO - Successfully installed blessings 05:11:33 INFO - Cleaning up... 05:11:33 INFO - Return code: 0 05:11:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:34 INFO - Reading from file tmpfile_stdout 05:11:34 INFO - Current package versions: 05:11:34 INFO - blessings == 1.6 05:11:34 INFO - blobuploader == 1.2.4 05:11:34 INFO - docopt == 0.6.1 05:11:34 INFO - functools32 == 3.2.3-2 05:11:34 INFO - jsonschema == 2.5.1 05:11:34 INFO - manifestparser == 1.1 05:11:34 INFO - mozInstall == 1.12 05:11:34 INFO - mozcrash == 0.17 05:11:34 INFO - mozdebug == 0.1 05:11:34 INFO - mozdevice == 0.48 05:11:34 INFO - mozfile == 1.2 05:11:34 INFO - mozhttpd == 0.7 05:11:34 INFO - mozinfo == 0.9 05:11:34 INFO - mozleak == 0.1 05:11:34 INFO - mozlog == 3.4 05:11:34 INFO - moznetwork == 0.27 05:11:34 INFO - mozprocess == 0.23 05:11:34 INFO - mozprofile == 0.28 05:11:34 INFO - mozrunner == 6.12 05:11:34 INFO - mozscreenshot == 0.1 05:11:34 INFO - mozsystemmonitor == 0.3 05:11:34 INFO - moztest == 0.7 05:11:34 INFO - mozversion == 1.4 05:11:34 INFO - psutil == 3.1.1 05:11:34 INFO - requests == 1.2.3 05:11:34 INFO - wsgiref == 0.1.2 05:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:34 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')]} 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:34 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')]} 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:34 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 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:34 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 05:11:34 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 05:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:34 INFO - 'HOME': '/Users/cltbld', 05:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:34 INFO - 'LOGNAME': 'cltbld', 05:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:34 INFO - 'MOZ_NO_REMOTE': '1', 05:11:34 INFO - 'NO_EM_RESTART': '1', 05:11:34 INFO - 'PAGER': '/bin/cat', 05:11:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:34 INFO - 'PWD': '/builds/slave/test', 05:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:34 INFO - 'SHELL': '/bin/bash', 05:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:34 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:34 INFO - 'USER': 'cltbld', 05:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:34 INFO - 'XPC_FLAGS': '0x0', 05:11:34 INFO - 'XPC_SERVICE_NAME': '0', 05:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 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)) 05:11:35 INFO - Cleaning up... 05:11:35 INFO - Return code: 0 05:11:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a74490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84685c9f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, '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.TMB2yUAw9x/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.FvD4up9hz1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 05:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:35 INFO - 'HOME': '/Users/cltbld', 05:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:35 INFO - 'LOGNAME': 'cltbld', 05:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:35 INFO - 'MOZ_NO_REMOTE': '1', 05:11:35 INFO - 'NO_EM_RESTART': '1', 05:11:35 INFO - 'PAGER': '/bin/cat', 05:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:35 INFO - 'PWD': '/builds/slave/test', 05:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:35 INFO - 'SHELL': '/bin/bash', 05:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:11:35 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:35 INFO - 'USER': 'cltbld', 05:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:35 INFO - 'XPC_FLAGS': '0x0', 05:11:35 INFO - 'XPC_SERVICE_NAME': '0', 05:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:35 INFO - Cleaning up... 05:11:35 INFO - Return code: 0 05:11:35 INFO - Running post-action listener: _resource_record_post_action 05:11:35 INFO - Running post-action listener: _start_resource_monitoring 05:11:35 INFO - Starting resource monitoring. 05:11:35 INFO - [mozharness: 2016-10-06 12:11:35.763489Z] Finished create-virtualenv step (success) 05:11:35 INFO - [mozharness: 2016-10-06 12:11:35.764463Z] Running install step. 05:11:35 INFO - Running pre-action listener: _resource_record_pre_action 05:11:35 INFO - Running main action method: install 05:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:36 INFO - Reading from file tmpfile_stdout 05:11:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:36 INFO - Reading from file tmpfile_stdout 05:11:36 INFO - Output received: 05:11:36 INFO - Usage: mozinstall [options] installer 05:11:36 INFO - Options: 05:11:36 INFO - -h, --help show this help message and exit 05:11:36 INFO - -d DEST, --destination=DEST 05:11:36 INFO - Directory to install application into. [default: 05:11:36 INFO - "/builds/slave/test"] 05:11:36 INFO - --app=APP Application being installed. [default: firefox] 05:11:36 INFO - mkdir: /builds/slave/test/build/application 05:11:36 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'] 05:11:36 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 05:12:10 INFO - Reading from file tmpfile_stdout 05:12:10 INFO - Output received: 05:12:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:12:10 INFO - Running post-action listener: _resource_record_post_action 05:12:10 INFO - [mozharness: 2016-10-06 12:12:10.512725Z] Finished install step (success) 05:12:10 INFO - [mozharness: 2016-10-06 12:12:10.512876Z] Running run-tests step. 05:12:10 INFO - Running pre-action listener: _resource_record_pre_action 05:12:10 INFO - Running main action method: run_tests 05:12:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:12:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:12:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:12:10 INFO - 2016-10-06 05:12:10.527 screenresolution[1642:7609] starting screenresolution argv=screenresolution get 05:12:10 INFO - 2016-10-06 05:12:10.530 screenresolution[1642:7609] Display 0: 1600x1200x32@60 05:12:10 INFO - 2016-10-06 05:12:10.535 screenresolution[1643:7611] starting screenresolution argv=screenresolution list 05:12:10 INFO - Available Modes on Display 0 05:12:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:12:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:12:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:12:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:12:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:12:10 INFO - Intel Iris: 05:12:10 INFO - Chipset Model: Intel Iris 05:12:10 INFO - Type: GPU 05:12:10 INFO - Bus: Built-In 05:12:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:12:10 INFO - Vendor: Intel (0x8086) 05:12:10 INFO - Device ID: 0x0a2e 05:12:10 INFO - Revision ID: 0x0009 05:12:10 INFO - Displays: 05:12:10 INFO - Display: 05:12:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:12:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:12:10 INFO - Display Serial Number: 1600x1200 60 05:12:10 INFO - Main Display: Yes 05:12:10 INFO - Mirror: Off 05:12:10 INFO - Online: Yes 05:12:10 INFO - Rotation: Supported 05:12:10 INFO - Return code: 0 05:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:10 INFO - Python 2.7.3 05:12:10 INFO - Return code: 0 05:12:10 INFO - grabbing minidump binary from tooltool 05:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:10 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 0x100888d30>, '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 0x1006aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100880b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:10 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 05:12:10 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 05:12:10 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 05:12:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:10 INFO - Return code: 0 05:12:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:12:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:12:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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 05:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --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 05:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TMB2yUAw9x/Render', 05:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:12:10 INFO - 'HOME': '/Users/cltbld', 05:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:12:10 INFO - 'LOGNAME': 'cltbld', 05:12:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:10 INFO - 'MOZ_NO_REMOTE': '1', 05:12:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:10 INFO - 'NO_EM_RESTART': '1', 05:12:10 INFO - 'PAGER': '/bin/cat', 05:12:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:10 INFO - 'PWD': '/builds/slave/test', 05:12:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:12:10 INFO - 'SHELL': '/bin/bash', 05:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FvD4up9hz1/Listeners', 05:12:10 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 05:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:12:10 INFO - 'USER': 'cltbld', 05:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:10 INFO - 'XPC_FLAGS': '0x0', 05:12:10 INFO - 'XPC_SERVICE_NAME': '0', 05:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:12:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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 05:12:11 INFO - mozversion application_buildid: 20161006030102 05:12:11 INFO - mozversion application_changeset: 777fb63db8de8d78b64b8141d1a998397275dd03 05:12:11 INFO - mozversion application_display_name: Nightly 05:12:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:11 INFO - mozversion application_name: Firefox 05:12:11 INFO - mozversion application_remotingname: firefox 05:12:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:12:11 INFO - mozversion application_vendor: Mozilla 05:12:11 INFO - mozversion application_version: 52.0a1 05:12:11 INFO - mozversion platform_buildid: 20161006030102 05:12:11 INFO - mozversion platform_changeset: 777fb63db8de8d78b64b8141d1a998397275dd03 05:12:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:12:11 INFO - mozversion platform_version: 52.0a1 05:12:11 INFO - using testdate: 1475755931 05:12:11 INFO - actual date: 1475755931 05:12:11 INFO - starting webserver on 'localhost:49273' 05:12:11 INFO - SUITE-START | Running 2 tests 05:12:11 INFO - TEST-START | dromaeo_css 05:12:11 INFO - operating with platform_type : mac_ 05:12:11 INFO - Initialising browser for dromaeo_css test... 05:12:11 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpbbl2h_/profile http://localhost:49273/getInfo.html) 05:12:13 INFO - PROCESS | 1653 | 2016-10-06 05:12:13.774 plugin-container[1655:7777] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a53, name = 'com.apple.tsm.portname' 05:12:13 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:13 INFO - PROCESS | 1653 | 2016-10-06 05:12:13.776 plugin-container[1655:7777] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 05:12:13 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:13 INFO - PROCESS | 1653 | 2016-10-06 05:12:13.776 plugin-container[1655:7777] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:13 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 05:12:13 INFO - PROCESS | 1653 | colorDepth:24 05:12:13 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 05:12:13 INFO - PROCESS | 1653 | __metrics 05:12:13 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 05:12:14 INFO - TEST-INFO | 1653: exit 0 05:12:14 INFO - Browser initialized. 05:12:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:14 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpbbl2h_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:17 INFO - PROCESS | 1656 | 2016-10-06 05:12:17.083 plugin-container[1657:7902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a2f, name = 'com.apple.tsm.portname' 05:12:17 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:17 INFO - PROCESS | 1656 | 2016-10-06 05:12:17.085 plugin-container[1657:7902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 05:12:17 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:17 INFO - PROCESS | 1656 | 2016-10-06 05:12:17.085 plugin-container[1657:7902] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:26 INFO - PROCESS | 1656 | RSS: Main: 240410624 05:12:26 INFO - PROCESS | 1656 | 05:13:16 INFO - PROCESS | 1656 | 1475755996434 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] 05:15:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:15:31 INFO - PROCESS | 1656 | RSS: Main: 251817984 05:15:31 INFO - PROCESS | 1656 | 05:18:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:18:33 INFO - PROCESS | 1656 | RSS: Main: 265093120 05:18:33 INFO - PROCESS | 1656 | 05:21:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:21:36 INFO - PROCESS | 1656 | RSS: Main: 270774272 05:21:36 INFO - PROCESS | 1656 | 05:24:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:24:38 INFO - PROCESS | 1656 | RSS: Main: 270561280 05:24:38 INFO - PROCESS | 1656 | 05:27:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:27:42 INFO - PROCESS | 1656 | RSS: Main: 275992576 05:27:42 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:30:45 INFO - PROCESS | 1656 | RSS: Main: 278675456 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | __start_tp_report 05:30:45 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 05:30:45 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 05:30:45 INFO - PROCESS | 1656 | |i|pagename|runs| 05:30:45 INFO - PROCESS | 1656 | |0;dojo.html;3113.8598763055666;3376.8480418381187;3392.677695618917;3397.660233976601;3464.3937310970573;4377.430933978586;5498.3127109111365;5632.943670563293;5687.886242275157;5770.538356931441;5658.745356458959;5683.460071293231;5721.34204566475;5809.7385617647205;5842.620229685068;5155.149400348957;5179.741012949356;5255.0803609368395;5269.077911365515;5357.49103835137;5329.920051199235;5351;5362.7050512222;5368.436314187013;5370.731463426813;5147.742612869341;5304.92042619361;5348.465153484659;5355.544778693816;5376.865578360553;5170.250313704491;5178.042062218502;5192.584593232532;5236.6857988520815;5357.7589008494715;5178;5234.057869583474;5236.528712415863;5245.632805703603;5285.973570132163;4994.850154495371;5575.080111781551;5593.713445907464;5611.354694210137;5869.7652093916195;4654.534546545352;5078;5525.281713377275;6205.22434695663;6232.002879539252;6234.501239900797;6245.437910588023;6251.968740156316;6262.342454042351;6277.246730392382;5415.268938693265;5791.362950075489;5898.469137777621;5901.495118744736;5930.851728706773;5235.424103348629;5525.861853453695;5973.835102155038;6157.568970172045;6210.254769427697;4617.076584683077;5079.390473143172;6189.96905015472;6202.317745048132;6231.9688401557705;5365;6096.29892562361;6244.438000579969;6247.875042499125;6261.592996455216;6131.009681329197;6152.0156774915795;6195.938040619536;6197.070439434121;6248.843778905472;5381.273528073738;6151.938480615226;6234.470070044006;6263.4362907337645;6290.496760259169;4964.35463389757;4971.154903666313;4982.483845657992;4998.90002199954;4999.825006124768;3810.40938654509;4371.388005679208;4385.934210986838;4449.710768800018;4517.186906356822;5874.73563689635;5937.2578427696535;5965.194698715618;5969.104634304802;6049.516038716892;6200.689965501707;6250.749970001149;6256;6267.655278959701;6270.404311590391;5722.685252311163;5810.970945145247;5818.330891947396;5900.468957793733;5947.910781338283;5472.835814925558;5492.69790161537;5499.257600223998;5509.779608815683;5540.889182216414;6366.108744775643;6400.935990640034;6410.711517981796;6432.163818703632;6436.485081193399;6139.798803208702;6211.099390588249;6226.533010024357;6263.906041409291;6277.2781130170615;5213.60897932649;6455.0962865199845;6475.611463312216;6484.221893372825;6514.804555863332;6211.472024877755;6213.875722485615;6215.906761398493;6221.2845522765465;6231.376862313732;6142.682951206477;6210.658413787285;6256.217972753406;6265.655388953652;6280;5544.390117087037;6100.974805932192;6136.20229370179;6148.661823599745;6201.379862013762;6178.845528861814;6207.224096987877;6226.501879849692;6247.219097612799;6257.4681152102585;4935.383077115361;5763.769449222152;5972.522198224218;5977.760889564543;6062.151298818081;6171.290301615371;6201.844953876189;6202.596831205957;6225.159603453476;6241.78153764616;6062.151298818081;6126.571140020156;6138.294096178996;6147.784827531015;6150.753969841336 05:30:45 INFO - PROCESS | 1656 | |1;ext.html;475.53160137264786;495.9801607935683;525.2698748739256;531.7899429725259;535.7374886305712;39763.80118099409;41249.58750412495;41316.76049718506;41432.79283603581;42880.571194288044;42830.57169428305;43261.56738432615;43294.56705432945;43366.783166084206;43546.346804797875;9867.703968880927;10026.147777438926;10034.347767395133;10038.648647297347;10096.84854727176;9926.602935882556;10044.14624756893;10045.949770251138;10047.799044019152;10059.69820905374;7795.649195786204;9250.629974801;10010.34932729374;10059.094681478666;10094.242931780109;8044.6782128714785;8820.221630186503;9750.366226195274;9982.201423886072;9988.650397236062;8393.412461127724;9838.409695418226;9904.257180711404;9905.35615185018;9937.552810123561;36790.44814327787;40798.79600602008;40931;41066;41091.178176436304;2686.9596956045675;3088.9034392790686;3443.1736383268085;3451.0682115828836;3629.709623230135;26235.344116397242;30172.698273017428;30643.927462538704;31249.687503124904;31767;3209.293955329847;3256.267339848539;3261.6575259597876;3341.064501939461;3342.080927744865;498966;501128.4943575295;502903;503920.9607903911;504955;50064;62131.68934155391;62645.74708505804;62804.74390512164;63142.68428657919;55805.32584022486;63987.680061600324;65132;65341;65416;16379;16568.17159142038;16650.16749162537;16659.25033373501;16672.49982500527;12795.552155674693;12806.167599106027;12865.97072234219;12887.226766394046;12901.612951611467;16832.831671683372;17469.24494939986;19026.524336891413;19042.238310467426;19079.80920190808;3247.4316994526334;7265.600391978492;7516.624168791539;8168.509889406536;8428.8314233715;848.3679658654343;867.509856930832;905.5743800413795;1031.417249254169;1095.9342439453658;24355.634665480033;29910.252243693645;29970.55044174339;30820.691793081784;30839.845800770854;986.8371718666483;1038.4963292802984;1040.921930855189;1044.5769463367349;1064.3135177810425;14958.626034349229;15479.5356139316;15533.922330388501;15731.056136631838;15846.286917088759;597147;676427;677659;682922;689133;39578;44123;52645.94708105816;56424.71787641035;57870.553236169435;1064.9467526623637;1312.8490223624215;1369.4111532041118;1372.0532832345848;1374.615107769806;29170;29283.414331713673;29343.85328073346;29807.701922980494;30081.699183008765;41109;49547.752261238464;50243.49756502535;50360.49639503558;50421.24368134554;589594;593543;594612;594663;594792.0260398671;26654.600180996913;26679;27559.31101722393;27617.171484855488;28474.715252848036;38030.619693802706;47347.81630459266;47401;48712;48833;39161;39239;39324.410133848585;40785.59214407818;40797;38990.80504597572;39082.80458597689;39265.411018834166;40438.59561404466;40481;37888.62111378961;38825.6117438822;39021.80489097536;39144.80427597844;39246.803765980985;31267.84366078155;33146.5028024575;34465.48301775526;34948.65051349454;35004;25406.872965635055;25411.491770164863;25785.006647939197;25831;25848 05:30:45 INFO - PROCESS | 1656 | |2;jquery.html;317.23071551487635;342.6693241022414;382.68046181438496;387.62787723785164;401.924851023512;19134.42596722097;19409.805901940977;20735.896320518394;20756.96215189242;21020.36938891832;20029.599408011833;20102.59794804103;20404.183832646675;20469.38591842247;20494.385168444933;5735.340435849878;5831.679257640828;5849.298084229898;5907.143464197688;5996.16053752475;5852.473277405054;5891.764329426818;5974.074018527113;5982.371850955652;5982.581219314649;4830;5798.362180160179;5853.209816674737;5891.322497912731;5918.704064796743;5839.386864379243;5897.233359663259;5906.911396329058;5907.2615923009835;5914.201582786333;4901.754912254409;5083.237514372874;5154.355705536808;5163.044836705221;5170.353705786777;19494.902525487425;24984.750152498425;25404.237872863843;25460.745392546207;25590.87204563984;2259.53679495703;2273.7253962550467;2311.3528212100637;2445.9510809783883;2467.383154211447;14895.702085958328;15527.456539021194;15538.766918496232;15892.179422048242;16375.344986200538;1823.0674445879636;1896.042498538243;1916.319706504185;1928.7396201512756;1938.0697265312729;120156;133747;138367;140572.1885562283;142431;11245.15661325404;11592.594259201056;11703.180777345504;11720.765584688259;12100.213486123374;14554.490592829201;14615.415383384758;14618.561443156723;14631.780523292158;14638.341274642667;7815.452918295665;8078.596070196467;8417.326613870875;8648.654053837776;8722.433041852259;8646.410341300425;8662.263707584925;8668.826623467496;8771.517566533774;8818.51498167607;4489.506154323022;4560.840370587013;4600.53994600544;4638.165130276582;4684.344191813081;1963.7545306836646;1969.5076230942263;1976.6244413561378;1981.6135853508715;2012.2152360579387;844.2612713875359;883.8983516895511;910.6994691751706;927.2998885841147;971.883373995111;18919.905400472908;19056.047197640062;19711.408657740005;21880.562388752136;22766.772332276796;845.2629845667091;929.5863340813273;933.0995589256264;965.1940629574244;1040.2250323508883;10014.699559013241;11083.178817214377;11107.333559986266;11110.05564527008;11121.165912556591;502549;598292;611952.9402353049;615981;631944;39390.80304598516;109119;122346.38826805809;129086.7728306781;134837.3258133703;1001.839705647093;1064.8136576099153;1106.9225154239125;1108.2353176308482;1113.4989254835357;15712.371505139667;17519.21163547618;17996.460106196835;18217.726734098735;18550.814491854908;43489.78255108704;46522.6043218704;52648.9470210586;54473;55531.999999998385;71363.57272854618;79616.80574791267;80468;80961;81047.18952810396;5909.409059094056;6200.81397558074;7964.482308649919;8141.674333026849;8219.931408917042;11393;12267.69330766738;12396.628101156979;12610.243385396905;12911.418986145458;10423;10881.510332034919;10910.781784364426;10985.505652245827;11114.777704446027;8463.449875758302;10536.57853685844;10560;10975.945120274348;11128.888711112786;8582.46573701602;10661;10844.861289564798;10895.509702063584;11173.050290725054;6956.8956465652045;7000.61496617691;7357.77926662201;7363.410927125924;7390.852182956418;9853.507324633883;10025.398476091457;10829;11003.724906877072;11413.942930285295 05:30:45 INFO - PROCESS | 1656 | |3;mootools.html;1472.8968972171947;1481.281578434459;1710.6236627941848;1822.6901426757458;1830.2404502131617;8019.077806052306;8271.214234647714;8487.321014318855;9049.773755656104;9075.591598378072;8429.241368276855;8754.3871928965;8759.649614015432;8845.734627961156;8846.248068914134;2319.7564255753155;2348.635961425982;2351.247600767755;2355.5524450354465;2361.89371478283;1966.587016726489;2305.4812667149927;2318.814494840417;2337.1002164166835;2347.835651504395;2311.410590299471;2314.7569505201964;2326.5928462519078;2347.6830627865193;2350.095213342867;2294.1740973249616;2304.8847557622053;2304.9539009219807;2310.6880571122933;2311.191083120911;2306.5386922615544;2312.387217387394;2312.757160498157;2323.1984965186984;2324.0239099578216;8837.204651581324;8851.911480885174;8901.243394311427;8917.866232006525;8969.865452018224;5203.427622961472;5350.063738845725;5367.570594352443;5377.489138531833;5385.703786291752;3427.211741299515;3480.0255928340107;3600.765950213228;3601.549806274216;3617.385044542434;1024.7233247023262;1051.8948105189497;1055.4511653939908;1066.7173199102244;1081.605214096849;10067.848982265272;10857;11511;11731.648050558497;11891.702707432298;4515.616172625298;4584.679072464962;4759.6201899050475;4784.330193772875;4805.231163013901;9942.30403871722;9969.305218112939;10047.748806279902;10073.748156296004;10090.192784577217;5291.153415453509;5296.443873393316;5327.627066105413;5331.546818520392;5332.626716129834;3887.455756194135;4378.277584198571;4684.882877928011;4831.347768051268;4877.097736918681;3410;3721.4789929409903;3885.514310711161;3936.724429289922;3977.5823538528616;1245.2341809786915;1254.2411840836162;1267.0876968582606;1269.2384569258556;1277.5464710027993;883.6597909804643;886.4459712679575;893.2362829780574;903.20969151992;934.3552948465536;5666.546676265889;5824.79613213544;5887.234659494238;6118.663473508911;6185.443310102022;412.65337116822013;421.98945026373974;423.63355697321595;762.4777027736019;1022.4362460570966;3874.593167717349;3976.741511801724;4053.6959728020515;4070.7354021989067;4092.4475195848777;10657;10841.945790271157;10959.945200274107;10983.231173817916;11014.944925275322;10877.728056798644;10939;10943.616973405893;10969.286996345212;11025.889741102646;7809.921900781033;8229.670813167406;8243.546604936666;8336.374771892133;8399.95800020996;5963.0955276783125;5979.940200597938;6005.099235114768;6031.487323577545;6132.264128304632;10097.242706797166;10137.746556336151;10217.080462758388;10272.691819245434;10283;9128.589213485542;10226.079652830984;10315.48422578853;10380.273380863267;10389.844152337871;6939.271376505394;7148.499605027599;7260.310270524292;7316.195218526064;7492.51298665585;8231.382646301432;8313.251807337369;8325.458845175044;8345.916540834756;8438.746837594881;7334.559926404433;7486.326230639269;7567;7602.6198690066385;7761.650725717243;7395.556266624019;7436.256374362521;7479.364254038468;7543.7736867894055;7595.924040759522;6957.2694867038235;7095.219525852049;7107.466939979418;7110.822229444305;7131.286871313035;4915.090708218991;4998.700077995332;5058.747062646927;5075.441701412916;5103.897922041612;5036.496350364934;5121.8463446096675;5185.688858668492;5276.39321478035;5287.867803304948 05:30:45 INFO - PROCESS | 1656 | |4;prototype.html;301.5250979706961;303.84503903009465;311.4005539336776;314.58003565240404;317.63313373054115;4664.626829853612;5498.395176530578;5562.3047119110115;5676.432356764327;5695.326514398216;4790.568848803607;5240.305584562883;5440.347158340995;5528.396764938163;5531.1426728856995;3427.777194482363;3775.5658099318657;4170.601903905252;4213.894652633678;4221.303484924999;3471.739619528533;3951.8221680024467;4032.7983600819844;4230.788460576974;4238.554951730071;4182.581741825824;4192.2121789010425;4202.579742025803;4209.473815773028;4223.936640950388;3848.730588858781;4160.8959776005695;4172.666186705056;4184.8744537663915;4187.330027195634;3092.9690703092906;3178.507331363642;3598.5321908152036;3660.3228402745576;3681.6134305897763;4832;4957.355543779322;5293.3647962244395;5304.92042619361;5380.435054319319;4754.572088512051;4764.571188593043;4801.1117943180625;4818.397700287464;4830.927536086926;4593.701409408378;5778.133280007991;5860.501857342131;5872.354041055481;5873.2658417697785;3341.899743007714;3419.6409377015552;3457.4640930655537;3954.228925359556;4003.459532963071;4954.60363170949;5355.955588660213;5709.571782116316;6058.697694875963;6181.300142460859;4007.6593489553134;4016.6987475938836;4028.073543085107;4039.1315867088715;4052.1085361220485;3915.611476999028;4061.3704875744306;4066.3900414938;4080.2655522006326;4080.2859499587453;4215.957840421618;4808.567228949411;4822.373091498082;4824.855254342376;4831.323614693945;5424.403315635277;5681.829535123018;5852.209951656557;5965.508622844289;5984.820455386258;1090.4275255490772;1092.563279287734;1116.1684545014016;1338.795084424026;1366.0164681429355;718.928107189277;756.5725365168772;821.5809936932088;838.1995194589152;850.2432834777053;4034.8184331704556;4127.656598155444;4302.741835489881;4578.656600754956;4592.288195329729;4202.6551503519195;4546.795394207203;4632.86101416958;4660.46404663468;5036.597072234213;3725.3108174987715;3790.639889210521;4242.993267943856;4576.773374770779;4577.543954314471;2246.9662955055687;2361.7868199911613;2598.9090381836545;2675.3712877473777;2720.442309326583;4617.792199351037;5072.757174492273;5211.296474975906;5232.979568984011;5287.519494541534;4344.263114238073;4754.833580824724;5050.090983622983;5138.203578445347;5167;4256.893577660583;5198.688078715213;5773.538116950718;6323.905141422974;6434.549581529248;5980.501406676969;6168.753249870135;6181.196444462371;6207.317195108625;6243.562950593415;5717.37108918027;6081.422264884829;6086.817395478142;6156.5998210116195;6157.538184636081;6295.087212354275;6324.367563243823;6365.713542890674;6445.646414253059;6477.481801455778;4005.9799701001307;4079.347304431277;4108.568600297045;4114.19773144234;4116.6912481564605;5039.118154323052;5294.549963253013;5871.6183448077445;6059.515238780975;6237.844053898507;5279.462759950766;5638.520725738358;5779.508741756829;5989.251343582052;6019.307779605401;4683.243783581157;5089.821856235014;5199.55803756685;6013.248343957005;6037.215162028908;5529.557635389239;5767.884642307046;5802.649926779661;5823.253024092671;5865.618734782225;5260.500252476008;5909.674967876808;5913.763449461973;5949.702514874326;5998.700064996646;4938.9259161111895;5249.527542521191;5827.892700387082;5843.357230704704;5936.643801371932 05:30:45 INFO - PROCESS | 1656 | |5;yui.html;702.6627218934912;709.6593635055174;760.5588758520059;775.0892701076234;797.1988151907332;15305.617359566002;16437.09595972221;16454.917725411386;16454.93042952207;16508.752368714464;14900.254987250648;15035.248237588132;15041;15055.698886022274;15073.2463376831;654.7675575170817;685.4276678973039;798.8562058829408;828.1470085811624;848.1391387741447;657.5890068707058;836.2473773603745;838.4550042472412;847.555033607358;853.0232883348563;899.9055099214586;900.7973206028624;900.9369344145913;901.7970956534792;902.5351943748974;866.2723312417568;877.9429337093133;881.9029906710257;894.9910500894973;897.6140259688332;671.6104659297596;673.2594146438927;673.3468535520537;674.956127851688;677.3666621708718;15650.608734781608;15663.68672626541;15844.76232856508;15846.920765396215;15883.36466541337;12111.818322725167;14648.853511464855;14827.332770025374;14829.925850370679;14905.627359315995;11930.522779088826;12087.818682719766;12317.384130793514;12370.886620204135;12574.559890403792;3790.450384694204;3821.48409964654;3978.0452691353867;4013.478247827793;4021.396790481422;123739;124491.37754311261;125455;125916;127974.72025279814;11236.044936180353;11353.37556434404;11368.886311136948;11394.487248073856;11421.200515963968;23817.642735358982;23821.404464888168;23922.28233153008;23925.401864953514;23942.88028559846;7317.634118294064;7624.923750762421;7669.769906902802;7804.765857024185;7871.921280787234;4370.2352088384405;4416.734995900256;4428.579284967923;4613.308003799457;4677.64917631179;2578.4585237100046;3473.9826300868335;3479.095435186819;3486.18074752433;3486.2678837443914;643.9259485159266;647.2718192033961;654.5745265577318;656.0585559721815;657.7960832141955;602.193061297863;608.7382425556964;614.8247749391402;627.5826575327447;634.9619022858643;8330.62512186953;8377.832443351099;8401.621927013299;9095.81808363829;9103.042845788055;495.82695441750354;500.9448960614329;572.6506830833189;575.0770014127265;605.5397897597858;4037.899052523652;4401.603855652943;4429.247028005247;4450.6439484841785;4581.839635612738;107292;123319.76680233082;154635;171550;173599;145079.2746036263;147625;149652;152010.63941483104;153231;95601;117935.04798158526;121468.39265803614;122560.38719806522;127569.99999999814;8237.382196335418;8334.458260213067;8366.539840308842;8396.664133434595;8508.659653613786;68614.3138568608;68744;68792.21642809693;70860;72539.91190132046;63061;63706;90529;92276;92710.53644731732;13470.865291346961;13538.120022198525;13540.661483462993;13608.93195534016;13979.510717124851;14359.539517774203;14420.423183072979;14532.418703251751;15353;15411.460598878986;11187.496562654864;13731.382087805872;14111.788323174955;14333.498327558485;14585.124892506483;13109;13340.466381344637;13684;13703.657408564466;13974.371153298329;13401.53094641683;13972.231527266098;13979.510717124851;14029.01796874209;14179.14925104497;11260.15548833857;11358.375289359165;11540.653780386601;11737.413129343327;11748.941255293668;10663.253572249869;11351.772964540829;11637.592684256011;11646.592369267035;11668.824967625322 05:30:45 INFO - PROCESS | 1656 | __end_tp_report 05:30:45 INFO - PROCESS | 1656 | __start_cc_report 05:30:45 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,359 05:30:45 INFO - PROCESS | 1656 | __end_cc_report 05:30:45 INFO - PROCESS | 1656 | __startTimestamp1475757045854__endTimestamp 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | ------- Summary: start ------- 05:30:45 INFO - PROCESS | 1656 | Number of tests: 6 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5703.67 Median:5930.85 stddev:675.19 (11.4%) stddev-sans-first:645.97 05:30:45 INFO - PROCESS | 1656 | Values: 3113.9 3376.8 3392.7 3397.7 3464.4 4377.4 5498.3 5632.9 5687.9 5770.5 5658.7 5683.5 5721.3 5809.7 5842.6 5155.1 5179.7 5255.1 5269.1 5357.5 5329.9 5351.0 5362.7 5368.4 5370.7 5147.7 5304.9 5348.5 5355.5 5376.9 5170.3 5178.0 5192.6 5236.7 5357.8 5178.0 5234.1 5236.5 5245.6 5286.0 4994.9 5575.1 5593.7 5611.4 5869.8 4654.5 5078.0 5525.3 6205.2 6232.0 6234.5 6245.4 6252.0 6262.3 6277.2 5415.3 5791.4 5898.5 5901.5 5930.9 5235.4 5525.9 5973.8 6157.6 6210.3 4617.1 5079.4 6190.0 6202.3 6232.0 5365.0 6096.3 6244.4 6247.9 6261.6 6131.0 6152.0 6195.9 6197.1 6248.8 5381.3 6151.9 6234.5 6263.4 6290.5 4964.4 4971.2 4982.5 4998.9 4999.8 3810.4 4371.4 4385.9 4449.7 4517.2 5874.7 5937.3 5965.2 5969.1 6049.5 6200.7 6250.7 6256.0 6267.7 6270.4 5722.7 5811.0 5818.3 5900.5 5947.9 5472.8 5492.7 5499.3 5509.8 5540.9 6366.1 6400.9 6410.7 6432.2 6436.5 6139.8 6211.1 6226.5 6263.9 6277.3 5213.6 6455.1 6475.6 6484.2 6514.8 6211.5 6213.9 6215.9 6221.3 6231.4 6142.7 6210.7 6256.2 6265.7 6280.0 5544.4 6101.0 6136.2 6148.7 6201.4 6178.8 6207.2 6226.5 6247.2 6257.5 4935.4 5763.8 5972.5 5977.8 6062.2 6171.3 6201.8 6202.6 6225.2 6241.8 6062.2 6126.6 6138.3 6147.8 6150.8 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:71550.11 Median:39152.90 stddev:158069.81 (403.7%) stddev-sans-first:158423.16 05:30:45 INFO - PROCESS | 1656 | Values: 475.5 496.0 525.3 531.8 535.7 39763.8 41249.6 41316.8 41432.8 42880.6 42830.6 43261.6 43294.6 43366.8 43546.3 9867.7 10026.1 10034.3 10038.6 10096.8 9926.6 10044.1 10045.9 10047.8 10059.7 7795.6 9250.6 10010.3 10059.1 10094.2 8044.7 8820.2 9750.4 9982.2 9988.7 8393.4 9838.4 9904.3 9905.4 9937.6 36790.4 40798.8 40931.0 41066.0 41091.2 2687.0 3088.9 3443.2 3451.1 3629.7 26235.3 30172.7 30643.9 31249.7 31767.0 3209.3 3256.3 3261.7 3341.1 3342.1 498966.0 501128.5 502903.0 503921.0 504955.0 50064.0 62131.7 62645.7 62804.7 63142.7 55805.3 63987.7 65132.0 65341.0 65416.0 16379.0 16568.2 16650.2 16659.3 16672.5 12795.6 12806.2 12866.0 12887.2 12901.6 16832.8 17469.2 19026.5 19042.2 19079.8 3247.4 7265.6 7516.6 8168.5 8428.8 848.4 867.5 905.6 1031.4 1095.9 24355.6 29910.3 29970.6 30820.7 30839.8 986.8 1038.5 1040.9 1044.6 1064.3 14958.6 15479.5 15533.9 15731.1 15846.3 597147.0 676427.0 677659.0 682922.0 689133.0 39578.0 44123.0 52645.9 56424.7 57870.6 1064.9 1312.8 1369.4 1372.1 1374.6 29170.0 29283.4 29343.9 29807.7 30081.7 41109.0 49547.8 50243.5 50360.5 50421.2 589594.0 593543.0 594612.0 594663.0 594792.0 26654.6 26679.0 27559.3 27617.2 28474.7 38030.6 47347.8 47401.0 48712.0 48833.0 39161.0 39239.0 39324.4 40785.6 40797.0 38990.8 39082.8 39265.4 40438.6 40481.0 37888.6 38825.6 39021.8 39144.8 39246.8 31267.8 33146.5 34465.5 34948.7 35004.0 25406.9 25411.5 25785.0 25831.0 25848.0 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34656.96 Median:2378.65 stddev:99322.53 (4175.6%) stddev-sans-first:99567.69 05:30:45 INFO - PROCESS | 1656 | Values: 317.2 342.7 382.7 387.6 401.9 19134.4 19409.8 20735.9 20757.0 21020.4 20029.6 20102.6 20404.2 20469.4 20494.4 5735.3 5831.7 5849.3 5907.1 5996.2 5852.5 5891.8 5974.1 5982.4 5982.6 4830.0 5798.4 5853.2 5891.3 5918.7 5839.4 5897.2 5906.9 5907.3 5914.2 4901.8 5083.2 5154.4 5163.0 5170.4 19494.9 24984.8 25404.2 25460.7 25590.9 2259.5 2273.7 2311.4 2446.0 2467.4 14895.7 15527.5 15538.8 15892.2 16375.3 1823.1 1896.0 1916.3 1928.7 1938.1 120156.0 133747.0 138367.0 140572.2 142431.0 11245.2 11592.6 11703.2 11720.8 12100.2 14554.5 14615.4 14618.6 14631.8 14638.3 7815.5 8078.6 8417.3 8648.7 8722.4 8646.4 8662.3 8668.8 8771.5 8818.5 4489.5 4560.8 4600.5 4638.2 4684.3 1963.8 1969.5 1976.6 1981.6 2012.2 844.3 883.9 910.7 927.3 971.9 18919.9 19056.0 19711.4 21880.6 22766.8 845.3 929.6 933.1 965.2 1040.2 10014.7 11083.2 11107.3 11110.1 11121.2 502549.0 598292.0 611952.9 615981.0 631944.0 39390.8 109119.0 122346.4 129086.8 134837.3 1001.8 1064.8 1106.9 1108.2 1113.5 15712.4 17519.2 17996.5 18217.7 18550.8 43489.8 46522.6 52648.9 54473.0 55532.0 71363.6 79616.8 80468.0 80961.0 81047.2 5909.4 6200.8 7964.5 8141.7 8219.9 11393.0 12267.7 12396.6 12610.2 12911.4 10423.0 10881.5 10910.8 10985.5 11114.8 8463.4 10536.6 10560.0 10975.9 11128.9 8582.5 10661.0 10844.9 10895.5 11173.1 6956.9 7000.6 7357.8 7363.4 7390.9 9853.5 10025.4 10829.0 11003.7 11413.9 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5719.29 Median:4722.25 stddev:3236.02 (68.5%) stddev-sans-first:3229.37 05:30:45 INFO - PROCESS | 1656 | Values: 1472.9 1481.3 1710.6 1822.7 1830.2 8019.1 8271.2 8487.3 9049.8 9075.6 8429.2 8754.4 8759.6 8845.7 8846.2 2319.8 2348.6 2351.2 2355.6 2361.9 1966.6 2305.5 2318.8 2337.1 2347.8 2311.4 2314.8 2326.6 2347.7 2350.1 2294.2 2304.9 2305.0 2310.7 2311.2 2306.5 2312.4 2312.8 2323.2 2324.0 8837.2 8851.9 8901.2 8917.9 8969.9 5203.4 5350.1 5367.6 5377.5 5385.7 3427.2 3480.0 3600.8 3601.5 3617.4 1024.7 1051.9 1055.5 1066.7 1081.6 10067.8 10857.0 11511.0 11731.6 11891.7 4515.6 4584.7 4759.6 4784.3 4805.2 9942.3 9969.3 10047.7 10073.7 10090.2 5291.2 5296.4 5327.6 5331.5 5332.6 3887.5 4378.3 4684.9 4831.3 4877.1 3410.0 3721.5 3885.5 3936.7 3977.6 1245.2 1254.2 1267.1 1269.2 1277.5 883.7 886.4 893.2 903.2 934.4 5666.5 5824.8 5887.2 6118.7 6185.4 412.7 422.0 423.6 762.5 1022.4 3874.6 3976.7 4053.7 4070.7 4092.4 10657.0 10841.9 10959.9 10983.2 11014.9 10877.7 10939.0 10943.6 10969.3 11025.9 7809.9 8229.7 8243.5 8336.4 8400.0 5963.1 5979.9 6005.1 6031.5 6132.3 10097.2 10137.7 10217.1 10272.7 10283.0 9128.6 10226.1 10315.5 10380.3 10389.8 6939.3 7148.5 7260.3 7316.2 7492.5 8231.4 8313.3 8325.5 8345.9 8438.7 7334.6 7486.3 7567.0 7602.6 7761.7 7395.6 7436.3 7479.4 7543.8 7595.9 6957.3 7095.2 7107.5 7110.8 7131.3 4915.1 4998.7 5058.7 5075.4 5103.9 5036.5 5121.8 5185.7 5276.4 5287.9 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4554.72 Median:4831.13 stddev:1469.42 (30.4%) stddev-sans-first:1438.45 05:30:45 INFO - PROCESS | 1656 | Values: 301.5 303.8 311.4 314.6 317.6 4664.6 5498.4 5562.3 5676.4 5695.3 4790.6 5240.3 5440.3 5528.4 5531.1 3427.8 3775.6 4170.6 4213.9 4221.3 3471.7 3951.8 4032.8 4230.8 4238.6 4182.6 4192.2 4202.6 4209.5 4223.9 3848.7 4160.9 4172.7 4184.9 4187.3 3093.0 3178.5 3598.5 3660.3 3681.6 4832.0 4957.4 5293.4 5304.9 5380.4 4754.6 4764.6 4801.1 4818.4 4830.9 4593.7 5778.1 5860.5 5872.4 5873.3 3341.9 3419.6 3457.5 3954.2 4003.5 4954.6 5356.0 5709.6 6058.7 6181.3 4007.7 4016.7 4028.1 4039.1 4052.1 3915.6 4061.4 4066.4 4080.3 4080.3 4216.0 4808.6 4822.4 4824.9 4831.3 5424.4 5681.8 5852.2 5965.5 5984.8 1090.4 1092.6 1116.2 1338.8 1366.0 718.9 756.6 821.6 838.2 850.2 4034.8 4127.7 4302.7 4578.7 4592.3 4202.7 4546.8 4632.9 4660.5 5036.6 3725.3 3790.6 4243.0 4576.8 4577.5 2247.0 2361.8 2598.9 2675.4 2720.4 4617.8 5072.8 5211.3 5233.0 5287.5 4344.3 4754.8 5050.1 5138.2 5167.0 4256.9 5198.7 5773.5 6323.9 6434.5 5980.5 6168.8 6181.2 6207.3 6243.6 5717.4 6081.4 6086.8 6156.6 6157.5 6295.1 6324.4 6365.7 6445.6 6477.5 4006.0 4079.3 4108.6 4114.2 4116.7 5039.1 5294.5 5871.6 6059.5 6237.8 5279.5 5638.5 5779.5 5989.3 6019.3 4683.2 5089.8 5199.6 6013.2 6037.2 5529.6 5767.9 5802.6 5823.3 5865.6 5260.5 5909.7 5913.8 5949.7 5998.7 4938.9 5249.5 5827.9 5843.4 5936.6 05:30:45 INFO - PROCESS | 1656 | 05:30:45 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:26031.21 Median:3476.54 stddev:42427.46 (1220.4%) stddev-sans-first:42503.86 05:30:45 INFO - PROCESS | 1656 | Values: 702.7 709.7 760.6 775.1 797.2 15305.6 16437.1 16454.9 16454.9 16508.8 14900.3 15035.2 15041.0 15055.7 15073.2 654.8 685.4 798.9 828.1 848.1 657.6 836.2 838.5 847.6 853.0 899.9 900.8 900.9 901.8 902.5 866.3 877.9 881.9 895.0 897.6 671.6 673.3 673.3 675.0 677.4 15650.6 15663.7 15844.8 15846.9 15883.4 12111.8 14648.9 14827.3 14829.9 14905.6 11930.5 12087.8 12317.4 12370.9 12574.6 3790.5 3821.5 3978.0 4013.5 4021.4 123739.0 124491.4 125455.0 125916.0 127974.7 11236.0 11353.4 11368.9 11394.5 11421.2 23817.6 23821.4 23922.3 23925.4 23942.9 7317.6 7624.9 7669.8 7804.8 7871.9 4370.2 4416.7 4428.6 4613.3 4677.6 2578.5 3474.0 3479.1 3486.2 3486.3 643.9 647.3 654.6 656.1 657.8 602.2 608.7 614.8 627.6 635.0 8330.6 8377.8 8401.6 9095.8 9103.0 495.8 500.9 572.7 575.1 605.5 4037.9 4401.6 4429.2 4450.6 4581.8 107292.0 123319.8 154635.0 171550.0 173599.0 145079.3 147625.0 149652.0 152010.6 153231.0 95601.0 117935.0 121468.4 122560.4 127570.0 8237.4 8334.5 8366.5 8396.7 8508.7 68614.3 68744.0 68792.2 70860.0 72539.9 63061.0 63706.0 90529.0 92276.0 92710.5 13470.9 13538.1 13540.7 13608.9 13979.5 14359.5 14420.4 14532.4 15353.0 15411.5 11187.5 13731.4 14111.8 14333.5 14585.1 13109.0 13340.5 13684.0 13703.7 13974.4 13401.5 13972.2 13979.5 14029.0 14179.1 11260.2 11358.4 11540.7 11737.4 11748.9 10663.3 11351.8 11637.6 11646.6 11668.8 05:30:45 INFO - PROCESS | 1656 | -------- Summary: end -------- 05:30:45 INFO - PROCESS | 1656 | 05:30:46 INFO - TEST-INFO | 1656: exit 0 05:30:46 INFO - TEST-OK | dromaeo_css | took 1115371ms 05:30:46 INFO - TEST-START | kraken 05:30:46 INFO - operating with platform_type : mac_ 05:30:46 INFO - Initialising browser for kraken test... 05:30:46 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpPIuYBj/profile http://localhost:49273/getInfo.html) 05:30:49 INFO - PROCESS | 1669 | 2016-10-06 05:30:49.141 plugin-container[1670:10302] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.tsm.portname' 05:30:49 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:30:49 INFO - PROCESS | 1669 | 2016-10-06 05:30:49.144 plugin-container[1670:10302] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 05:30:49 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:30:49 INFO - PROCESS | 1669 | 2016-10-06 05:30:49.144 plugin-container[1670:10302] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:30:49 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:30:49 INFO - PROCESS | 1669 | colorDepth:24 05:30:49 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:30:49 INFO - PROCESS | 1669 | __metrics 05:30:49 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 05:30:49 INFO - TEST-INFO | 1669: exit 0 05:30:49 INFO - Browser initialized. 05:30:49 INFO - Running cycle 1/1 for kraken test... 05:30:49 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpPIuYBj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:52 INFO - PROCESS | 1671 | 2016-10-06 05:30:52.371 plugin-container[1672:10411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b23, name = 'com.apple.tsm.portname' 05:30:52 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:30:52 INFO - PROCESS | 1671 | 2016-10-06 05:30:52.374 plugin-container[1672:10411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 05:30:52 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:30:52 INFO - PROCESS | 1671 | 2016-10-06 05:30:52.374 plugin-container[1672:10411] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:31:02 INFO - PROCESS | 1671 | RSS: Main: 240250880 05:31:02 INFO - PROCESS | 1671 | 05:31:05 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) 05:31:06 INFO - PROCESS | 1671 | RSS: Main: 253607936 05:31:06 INFO - PROCESS | 1671 | 05:31:09 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) 05:31:09 INFO - PROCESS | 1671 | RSS: Main: 261095424 05:31:09 INFO - PROCESS | 1671 | 05:31:12 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) 05:31:13 INFO - PROCESS | 1671 | RSS: Main: 261935104 05:31:13 INFO - PROCESS | 1671 | 05:31:15 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) 05:31:16 INFO - PROCESS | 1671 | RSS: Main: 263180288 05:31:16 INFO - PROCESS | 1671 | 05:31:17 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) 05:31:18 INFO - PROCESS | 1671 | RSS: Main: 264761344 05:31:18 INFO - PROCESS | 1671 | 05:31:21 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) 05:31:22 INFO - PROCESS | 1671 | RSS: Main: 265428992 05:31:22 INFO - PROCESS | 1671 | 05:31:25 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) 05:31:25 INFO - PROCESS | 1671 | RSS: Main: 265617408 05:31:25 INFO - PROCESS | 1671 | 05:31:28 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) 05:31:29 INFO - PROCESS | 1671 | RSS: Main: 265830400 05:31:29 INFO - PROCESS | 1671 | 05:31:31 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) 05:31:31 INFO - PROCESS | 1671 | RSS: Main: 265498624 05:31:31 INFO - PROCESS | 1671 | 05:31:33 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) 05:31:34 INFO - PROCESS | 1671 | RSS: Main: 265551872 05:31:34 INFO - PROCESS | 1671 | 05:31:36 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) 05:31:37 INFO - PROCESS | 1671 | RSS: Main: 265682944 05:31:37 INFO - PROCESS | 1671 | 05:31:40 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) 05:31:40 INFO - PROCESS | 1671 | RSS: Main: 266108928 05:31:40 INFO - PROCESS | 1671 | 05:31:43 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) 05:31:44 INFO - PROCESS | 1671 | RSS: Main: 265818112 05:31:44 INFO - PROCESS | 1671 | 05:31:46 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) 05:31:46 INFO - PROCESS | 1671 | RSS: Main: 267378688 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | __start_tp_report 05:31:46 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:31:46 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:31:46 INFO - PROCESS | 1671 | |i|pagename|runs| 05:31:46 INFO - PROCESS | 1671 | |0;ai-astar;113;97;174;117;117;99;176;177;168;119 05:31:46 INFO - PROCESS | 1671 | |1;audio-beat-detection;155;141;104;178;144;140;116;115;140;129 05:31:46 INFO - PROCESS | 1671 | |2;audio-dft;209;209;197;196;194;194;207;197;195;194 05:31:46 INFO - PROCESS | 1671 | |3;audio-fft;82;62;62;83;61;61;57;58;80;61 05:31:46 INFO - PROCESS | 1671 | |4;audio-oscillator;80;71;87;71;70;71;87;72;71;87 05:31:46 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;79;136;130;88;85;91;85;88;87 05:31:46 INFO - PROCESS | 1671 | |6;imaging-darkroom;153;95;94;94;96;98;95;97;130;94 05:31:46 INFO - PROCESS | 1671 | |7;imaging-desaturate;92;135;151;123;91;116;76;144;144;132 05:31:46 INFO - PROCESS | 1671 | |8;json-parse-financial;55;56;55;55;57;56;58;55;55;66 05:31:46 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;69;68;77;77;76;69;68;71;87;62 05:31:46 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;93;99;114;108;102;102;110;76;105;109 05:31:46 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;142;159;159;161;149;150;149;148;184;149 05:31:46 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;173;175;173;175;195;191;175;178;176;177 05:31:46 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;80;93;90;87;90;71;67;70;71;71 05:31:46 INFO - PROCESS | 1671 | __end_tp_report 05:31:46 INFO - PROCESS | 1671 | __start_cc_report 05:31:46 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,945 05:31:46 INFO - PROCESS | 1671 | __end_cc_report 05:31:46 INFO - PROCESS | 1671 | __startTimestamp1475757106564__endTimestamp 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:31:46 INFO - PROCESS | 1671 | Number of tests: 14 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:135.70 Median:175.00 stddev:33.63 (19.2%) stddev-sans-first:34.65 05:31:46 INFO - PROCESS | 1671 | Values: 113.0 97.0 174.0 117.0 117.0 99.0 176.0 177.0 168.0 119.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:140.50 stddev:21.50 (15.3%) stddev-sans-first:21.70 05:31:46 INFO - PROCESS | 1671 | Values: 155.0 141.0 104.0 178.0 144.0 140.0 116.0 115.0 140.0 129.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:199.20 Median:197.00 stddev:6.43 (3.3%) stddev-sans-first:5.75 05:31:46 INFO - PROCESS | 1671 | Values: 209.0 209.0 197.0 196.0 194.0 194.0 207.0 197.0 195.0 194.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:66.70 Median:62.00 stddev:10.48 (16.9%) stddev-sans-first:9.54 05:31:46 INFO - PROCESS | 1671 | Values: 82.0 62.0 62.0 83.0 61.0 61.0 57.0 58.0 80.0 61.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:76.00 stddev:7.65 (10.1%) stddev-sans-first:8.02 05:31:46 INFO - PROCESS | 1671 | Values: 80.0 71.0 87.0 71.0 70.0 71.0 87.0 72.0 71.0 87.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:87.50 stddev:19.92 (22.8%) stddev-sans-first:20.97 05:31:46 INFO - PROCESS | 1671 | Values: 89.0 79.0 136.0 130.0 88.0 85.0 91.0 85.0 88.0 87.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:95.00 stddev:20.23 (21.3%) stddev-sans-first:11.63 05:31:46 INFO - PROCESS | 1671 | Values: 153.0 95.0 94.0 94.0 96.0 98.0 95.0 97.0 130.0 94.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:120.40 Median:147.50 stddev:25.96 (17.6%) stddev-sans-first:25.42 05:31:46 INFO - PROCESS | 1671 | Values: 92.0 135.0 151.0 123.0 91.0 116.0 76.0 144.0 144.0 132.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:3.39 (6.1%) stddev-sans-first:3.54 05:31:46 INFO - PROCESS | 1671 | Values: 55.0 56.0 55.0 55.0 57.0 56.0 58.0 55.0 55.0 66.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.50 stddev:7.00 (9.5%) stddev-sans-first:7.31 05:31:46 INFO - PROCESS | 1671 | Values: 69.0 68.0 77.0 77.0 76.0 69.0 68.0 71.0 87.0 62.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:101.80 Median:112.00 stddev:10.89 (9.7%) stddev-sans-first:11.08 05:31:46 INFO - PROCESS | 1671 | Values: 93.0 99.0 114.0 108.0 102.0 102.0 110.0 76.0 105.0 109.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:155.00 Median:154.50 stddev:11.83 (7.7%) stddev-sans-first:11.58 05:31:46 INFO - PROCESS | 1671 | Values: 142.0 159.0 159.0 161.0 149.0 150.0 149.0 148.0 184.0 149.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:176.50 stddev:7.70 (4.4%) stddev-sans-first:7.88 05:31:46 INFO - PROCESS | 1671 | Values: 173.0 175.0 173.0 175.0 195.0 191.0 175.0 178.0 176.0 177.0 05:31:46 INFO - PROCESS | 1671 | 05:31:46 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.00 Median:83.50 stddev:10.11 (12.1%) stddev-sans-first:10.72 05:31:46 INFO - PROCESS | 1671 | Values: 80.0 93.0 90.0 87.0 90.0 71.0 67.0 70.0 71.0 71.0 05:31:46 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:31:46 INFO - PROCESS | 1671 | 05:31:47 INFO - TEST-INFO | 1671: exit 0 05:31:47 INFO - TEST-OK | kraken | took 60909ms 05:31:47 INFO - SUITE-END | took 1176s 05:31:47 INFO - Completed test suite (00:19:36) 05:31:47 INFO - javascript benchmark 05:31:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7337.598029374458, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.8598763055666, 3376.8480418381187, 3392.677695618917, 3397.660233976601, 3464.3937310970573, 4377.430933978586, 5498.3127109111365, 5632.943670563293, 5687.886242275157, 5770.538356931441, 5658.745356458959, 5683.460071293231, 5721.34204566475, 5809.7385617647205, 5842.620229685068, 5155.149400348957, 5179.741012949356, 5255.0803609368395, 5269.077911365515, 5357.49103835137, 5329.920051199235, 5351.0, 5362.7050512222, 5368.436314187013, 5370.731463426813, 5147.742612869341, 5304.92042619361, 5348.465153484659, 5355.544778693816, 5376.865578360553, 5170.250313704491, 5178.042062218502, 5192.584593232532, 5236.6857988520815, 5357.7589008494715, 5178.0, 5234.057869583474, 5236.528712415863, 5245.632805703603, 5285.973570132163, 4994.850154495371, 5575.080111781551, 5593.713445907464, 5611.354694210137, 5869.7652093916195, 4654.534546545352, 5078.0, 5525.281713377275, 6205.22434695663, 6232.002879539252, 6234.501239900797, 6245.437910588023, 6251.968740156316, 6262.342454042351, 6277.246730392382, 5415.268938693265, 5791.362950075489, 5898.469137777621, 5901.495118744736, 5930.851728706773, 5235.424103348629, 5525.861853453695, 5973.835102155038, 6157.568970172045, 6210.254769427697, 4617.076584683077, 5079.390473143172, 6189.96905015472, 6202.317745048132, 6231.9688401557705, 5365.0, 6096.29892562361, 6244.438000579969, 6247.875042499125, 6261.592996455216, 6131.009681329197, 6152.0156774915795, 6195.938040619536, 6197.070439434121, 6248.843778905472, 5381.273528073738, 6151.938480615226, 6234.470070044006, 6263.4362907337645, 6290.496760259169, 4964.35463389757, 4971.154903666313, 4982.483845657992, 4998.90002199954, 4999.825006124768, 3810.40938654509, 4371.388005679208, 4385.934210986838, 4449.710768800018, 4517.186906356822, 5874.73563689635, 5937.2578427696535, 5965.194698715618, 5969.104634304802, 6049.516038716892, 6200.689965501707, 6250.749970001149, 6256.0, 6267.655278959701, 6270.404311590391, 5722.685252311163, 5810.970945145247, 5818.330891947396, 5900.468957793733, 5947.910781338283, 5472.835814925558, 5492.69790161537, 5499.257600223998, 5509.779608815683, 5540.889182216414, 6366.108744775643, 6400.935990640034, 6410.711517981796, 6432.163818703632, 6436.485081193399, 6139.798803208702, 6211.099390588249, 6226.533010024357, 6263.906041409291, 6277.2781130170615, 5213.60897932649, 6455.0962865199845, 6475.611463312216, 6484.221893372825, 6514.804555863332, 6211.472024877755, 6213.875722485615, 6215.906761398493, 6221.2845522765465, 6231.376862313732, 6142.682951206477, 6210.658413787285, 6256.217972753406, 6265.655388953652, 6280.0, 5544.390117087037, 6100.974805932192, 6136.20229370179, 6148.661823599745, 6201.379862013762, 6178.845528861814, 6207.224096987877, 6226.501879849692, 6247.219097612799, 6257.4681152102585, 4935.383077115361, 5763.769449222152, 5972.522198224218, 5977.760889564543, 6062.151298818081, 6171.290301615371, 6201.844953876189, 6202.596831205957, 6225.159603453476, 6241.78153764616, 6062.151298818081, 6126.571140020156, 6138.294096178996, 6147.784827531015, 6150.753969841336], "value": 5663.2916000703735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.53160137264786, 495.9801607935683, 525.2698748739256, 531.7899429725259, 535.7374886305712, 39763.80118099409, 41249.58750412495, 41316.76049718506, 41432.79283603581, 42880.571194288044, 42830.57169428305, 43261.56738432615, 43294.56705432945, 43366.783166084206, 43546.346804797875, 9867.703968880927, 10026.147777438926, 10034.347767395133, 10038.648647297347, 10096.84854727176, 9926.602935882556, 10044.14624756893, 10045.949770251138, 10047.799044019152, 10059.69820905374, 7795.649195786204, 9250.629974801, 10010.34932729374, 10059.094681478666, 10094.242931780109, 8044.6782128714785, 8820.221630186503, 9750.366226195274, 9982.201423886072, 9988.650397236062, 8393.412461127724, 9838.409695418226, 9904.257180711404, 9905.35615185018, 9937.552810123561, 36790.44814327787, 40798.79600602008, 40931.0, 41066.0, 41091.178176436304, 2686.9596956045675, 3088.9034392790686, 3443.1736383268085, 3451.0682115828836, 3629.709623230135, 26235.344116397242, 30172.698273017428, 30643.927462538704, 31249.687503124904, 31767.0, 3209.293955329847, 3256.267339848539, 3261.6575259597876, 3341.064501939461, 3342.080927744865, 498966.0, 501128.4943575295, 502903.0, 503920.9607903911, 504955.0, 50064.0, 62131.68934155391, 62645.74708505804, 62804.74390512164, 63142.68428657919, 55805.32584022486, 63987.680061600324, 65132.0, 65341.0, 65416.0, 16379.0, 16568.17159142038, 16650.16749162537, 16659.25033373501, 16672.49982500527, 12795.552155674693, 12806.167599106027, 12865.97072234219, 12887.226766394046, 12901.612951611467, 16832.831671683372, 17469.24494939986, 19026.524336891413, 19042.238310467426, 19079.80920190808, 3247.4316994526334, 7265.600391978492, 7516.624168791539, 8168.509889406536, 8428.8314233715, 848.3679658654343, 867.509856930832, 905.5743800413795, 1031.417249254169, 1095.9342439453658, 24355.634665480033, 29910.252243693645, 29970.55044174339, 30820.691793081784, 30839.845800770854, 986.8371718666483, 1038.4963292802984, 1040.921930855189, 1044.5769463367349, 1064.3135177810425, 14958.626034349229, 15479.5356139316, 15533.922330388501, 15731.056136631838, 15846.286917088759, 597147.0, 676427.0, 677659.0, 682922.0, 689133.0, 39578.0, 44123.0, 52645.94708105816, 56424.71787641035, 57870.553236169435, 1064.9467526623637, 1312.8490223624215, 1369.4111532041118, 1372.0532832345848, 1374.615107769806, 29170.0, 29283.414331713673, 29343.85328073346, 29807.701922980494, 30081.699183008765, 41109.0, 49547.752261238464, 50243.49756502535, 50360.49639503558, 50421.24368134554, 589594.0, 593543.0, 594612.0, 594663.0, 594792.0260398671, 26654.600180996913, 26679.0, 27559.31101722393, 27617.171484855488, 28474.715252848036, 38030.619693802706, 47347.81630459266, 47401.0, 48712.0, 48833.0, 39161.0, 39239.0, 39324.410133848585, 40785.59214407818, 40797.0, 38990.80504597572, 39082.80458597689, 39265.411018834166, 40438.59561404466, 40481.0, 37888.62111378961, 38825.6117438822, 39021.80489097536, 39144.80427597844, 39246.803765980985, 31267.84366078155, 33146.5028024575, 34465.48301775526, 34948.65051349454, 35004.0, 25406.872965635055, 25411.491770164863, 25785.006647939197, 25831.0, 25848.0], "value": 19893.83363398281, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.23071551487635, 342.6693241022414, 382.68046181438496, 387.62787723785164, 401.924851023512, 19134.42596722097, 19409.805901940977, 20735.896320518394, 20756.96215189242, 21020.36938891832, 20029.599408011833, 20102.59794804103, 20404.183832646675, 20469.38591842247, 20494.385168444933, 5735.340435849878, 5831.679257640828, 5849.298084229898, 5907.143464197688, 5996.16053752475, 5852.473277405054, 5891.764329426818, 5974.074018527113, 5982.371850955652, 5982.581219314649, 4830.0, 5798.362180160179, 5853.209816674737, 5891.322497912731, 5918.704064796743, 5839.386864379243, 5897.233359663259, 5906.911396329058, 5907.2615923009835, 5914.201582786333, 4901.754912254409, 5083.237514372874, 5154.355705536808, 5163.044836705221, 5170.353705786777, 19494.902525487425, 24984.750152498425, 25404.237872863843, 25460.745392546207, 25590.87204563984, 2259.53679495703, 2273.7253962550467, 2311.3528212100637, 2445.9510809783883, 2467.383154211447, 14895.702085958328, 15527.456539021194, 15538.766918496232, 15892.179422048242, 16375.344986200538, 1823.0674445879636, 1896.042498538243, 1916.319706504185, 1928.7396201512756, 1938.0697265312729, 120156.0, 133747.0, 138367.0, 140572.1885562283, 142431.0, 11245.15661325404, 11592.594259201056, 11703.180777345504, 11720.765584688259, 12100.213486123374, 14554.490592829201, 14615.415383384758, 14618.561443156723, 14631.780523292158, 14638.341274642667, 7815.452918295665, 8078.596070196467, 8417.326613870875, 8648.654053837776, 8722.433041852259, 8646.410341300425, 8662.263707584925, 8668.826623467496, 8771.517566533774, 8818.51498167607, 4489.506154323022, 4560.840370587013, 4600.53994600544, 4638.165130276582, 4684.344191813081, 1963.7545306836646, 1969.5076230942263, 1976.6244413561378, 1981.6135853508715, 2012.2152360579387, 844.2612713875359, 883.8983516895511, 910.6994691751706, 927.2998885841147, 971.883373995111, 18919.905400472908, 19056.047197640062, 19711.408657740005, 21880.562388752136, 22766.772332276796, 845.2629845667091, 929.5863340813273, 933.0995589256264, 965.1940629574244, 1040.2250323508883, 10014.699559013241, 11083.178817214377, 11107.333559986266, 11110.05564527008, 11121.165912556591, 502549.0, 598292.0, 611952.9402353049, 615981.0, 631944.0, 39390.80304598516, 109119.0, 122346.38826805809, 129086.7728306781, 134837.3258133703, 1001.839705647093, 1064.8136576099153, 1106.9225154239125, 1108.2353176308482, 1113.4989254835357, 15712.371505139667, 17519.21163547618, 17996.460106196835, 18217.726734098735, 18550.814491854908, 43489.78255108704, 46522.6043218704, 52648.9470210586, 54473.0, 55531.999999998385, 71363.57272854618, 79616.80574791267, 80468.0, 80961.0, 81047.18952810396, 5909.409059094056, 6200.81397558074, 7964.482308649919, 8141.674333026849, 8219.931408917042, 11393.0, 12267.69330766738, 12396.628101156979, 12610.243385396905, 12911.418986145458, 10423.0, 10881.510332034919, 10910.781784364426, 10985.505652245827, 11114.777704446027, 8463.449875758302, 10536.57853685844, 10560.0, 10975.945120274348, 11128.888711112786, 8582.46573701602, 10661.0, 10844.861289564798, 10895.509702063584, 11173.050290725054, 6956.8956465652045, 7000.61496617691, 7357.77926662201, 7363.410927125924, 7390.852182956418, 9853.507324633883, 10025.398476091457, 10829.0, 11003.724906877072, 11413.942930285295], "value": 9518.468065718274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.8968972171947, 1481.281578434459, 1710.6236627941848, 1822.6901426757458, 1830.2404502131617, 8019.077806052306, 8271.214234647714, 8487.321014318855, 9049.773755656104, 9075.591598378072, 8429.241368276855, 8754.3871928965, 8759.649614015432, 8845.734627961156, 8846.248068914134, 2319.7564255753155, 2348.635961425982, 2351.247600767755, 2355.5524450354465, 2361.89371478283, 1966.587016726489, 2305.4812667149927, 2318.814494840417, 2337.1002164166835, 2347.835651504395, 2311.410590299471, 2314.7569505201964, 2326.5928462519078, 2347.6830627865193, 2350.095213342867, 2294.1740973249616, 2304.8847557622053, 2304.9539009219807, 2310.6880571122933, 2311.191083120911, 2306.5386922615544, 2312.387217387394, 2312.757160498157, 2323.1984965186984, 2324.0239099578216, 8837.204651581324, 8851.911480885174, 8901.243394311427, 8917.866232006525, 8969.865452018224, 5203.427622961472, 5350.063738845725, 5367.570594352443, 5377.489138531833, 5385.703786291752, 3427.211741299515, 3480.0255928340107, 3600.765950213228, 3601.549806274216, 3617.385044542434, 1024.7233247023262, 1051.8948105189497, 1055.4511653939908, 1066.7173199102244, 1081.605214096849, 10067.848982265272, 10857.0, 11511.0, 11731.648050558497, 11891.702707432298, 4515.616172625298, 4584.679072464962, 4759.6201899050475, 4784.330193772875, 4805.231163013901, 9942.30403871722, 9969.305218112939, 10047.748806279902, 10073.748156296004, 10090.192784577217, 5291.153415453509, 5296.443873393316, 5327.627066105413, 5331.546818520392, 5332.626716129834, 3887.455756194135, 4378.277584198571, 4684.882877928011, 4831.347768051268, 4877.097736918681, 3410.0, 3721.4789929409903, 3885.514310711161, 3936.724429289922, 3977.5823538528616, 1245.2341809786915, 1254.2411840836162, 1267.0876968582606, 1269.2384569258556, 1277.5464710027993, 883.6597909804643, 886.4459712679575, 893.2362829780574, 903.20969151992, 934.3552948465536, 5666.546676265889, 5824.79613213544, 5887.234659494238, 6118.663473508911, 6185.443310102022, 412.65337116822013, 421.98945026373974, 423.63355697321595, 762.4777027736019, 1022.4362460570966, 3874.593167717349, 3976.741511801724, 4053.6959728020515, 4070.7354021989067, 4092.4475195848777, 10657.0, 10841.945790271157, 10959.945200274107, 10983.231173817916, 11014.944925275322, 10877.728056798644, 10939.0, 10943.616973405893, 10969.286996345212, 11025.889741102646, 7809.921900781033, 8229.670813167406, 8243.546604936666, 8336.374771892133, 8399.95800020996, 5963.0955276783125, 5979.940200597938, 6005.099235114768, 6031.487323577545, 6132.264128304632, 10097.242706797166, 10137.746556336151, 10217.080462758388, 10272.691819245434, 10283.0, 9128.589213485542, 10226.079652830984, 10315.48422578853, 10380.273380863267, 10389.844152337871, 6939.271376505394, 7148.499605027599, 7260.310270524292, 7316.195218526064, 7492.51298665585, 8231.382646301432, 8313.251807337369, 8325.458845175044, 8345.916540834756, 8438.746837594881, 7334.559926404433, 7486.326230639269, 7567.0, 7602.6198690066385, 7761.650725717243, 7395.556266624019, 7436.256374362521, 7479.364254038468, 7543.7736867894055, 7595.924040759522, 6957.2694867038235, 7095.219525852049, 7107.466939979418, 7110.822229444305, 7131.286871313035, 4915.090708218991, 4998.700077995332, 5058.747062646927, 5075.441701412916, 5103.897922041612, 5036.496350364934, 5121.8463446096675, 5185.688858668492, 5276.39321478035, 5287.867803304948], "value": 4537.549988719651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.5250979706961, 303.84503903009465, 311.4005539336776, 314.58003565240404, 317.63313373054115, 4664.626829853612, 5498.395176530578, 5562.3047119110115, 5676.432356764327, 5695.326514398216, 4790.568848803607, 5240.305584562883, 5440.347158340995, 5528.396764938163, 5531.1426728856995, 3427.777194482363, 3775.5658099318657, 4170.601903905252, 4213.894652633678, 4221.303484924999, 3471.739619528533, 3951.8221680024467, 4032.7983600819844, 4230.788460576974, 4238.554951730071, 4182.581741825824, 4192.2121789010425, 4202.579742025803, 4209.473815773028, 4223.936640950388, 3848.730588858781, 4160.8959776005695, 4172.666186705056, 4184.8744537663915, 4187.330027195634, 3092.9690703092906, 3178.507331363642, 3598.5321908152036, 3660.3228402745576, 3681.6134305897763, 4832.0, 4957.355543779322, 5293.3647962244395, 5304.92042619361, 5380.435054319319, 4754.572088512051, 4764.571188593043, 4801.1117943180625, 4818.397700287464, 4830.927536086926, 4593.701409408378, 5778.133280007991, 5860.501857342131, 5872.354041055481, 5873.2658417697785, 3341.899743007714, 3419.6409377015552, 3457.4640930655537, 3954.228925359556, 4003.459532963071, 4954.60363170949, 5355.955588660213, 5709.571782116316, 6058.697694875963, 6181.300142460859, 4007.6593489553134, 4016.6987475938836, 4028.073543085107, 4039.1315867088715, 4052.1085361220485, 3915.611476999028, 4061.3704875744306, 4066.3900414938, 4080.2655522006326, 4080.2859499587453, 4215.957840421618, 4808.567228949411, 4822.373091498082, 4824.855254342376, 4831.323614693945, 5424.403315635277, 5681.829535123018, 5852.209951656557, 5965.508622844289, 5984.820455386258, 1090.4275255490772, 1092.563279287734, 1116.1684545014016, 1338.795084424026, 1366.0164681429355, 718.928107189277, 756.5725365168772, 821.5809936932088, 838.1995194589152, 850.2432834777053, 4034.8184331704556, 4127.656598155444, 4302.741835489881, 4578.656600754956, 4592.288195329729, 4202.6551503519195, 4546.795394207203, 4632.86101416958, 4660.46404663468, 5036.597072234213, 3725.3108174987715, 3790.639889210521, 4242.993267943856, 4576.773374770779, 4577.543954314471, 2246.9662955055687, 2361.7868199911613, 2598.9090381836545, 2675.3712877473777, 2720.442309326583, 4617.792199351037, 5072.757174492273, 5211.296474975906, 5232.979568984011, 5287.519494541534, 4344.263114238073, 4754.833580824724, 5050.090983622983, 5138.203578445347, 5167.0, 4256.893577660583, 5198.688078715213, 5773.538116950718, 6323.905141422974, 6434.549581529248, 5980.501406676969, 6168.753249870135, 6181.196444462371, 6207.317195108625, 6243.562950593415, 5717.37108918027, 6081.422264884829, 6086.817395478142, 6156.5998210116195, 6157.538184636081, 6295.087212354275, 6324.367563243823, 6365.713542890674, 6445.646414253059, 6477.481801455778, 4005.9799701001307, 4079.347304431277, 4108.568600297045, 4114.19773144234, 4116.6912481564605, 5039.118154323052, 5294.549963253013, 5871.6183448077445, 6059.515238780975, 6237.844053898507, 5279.462759950766, 5638.520725738358, 5779.508741756829, 5989.251343582052, 6019.307779605401, 4683.243783581157, 5089.821856235014, 5199.55803756685, 6013.248343957005, 6037.215162028908, 5529.557635389239, 5767.884642307046, 5802.649926779661, 5823.253024092671, 5865.618734782225, 5260.500252476008, 5909.674967876808, 5913.763449461973, 5949.702514874326, 5998.700064996646, 4938.9259161111895, 5249.527542521191, 5827.892700387082, 5843.357230704704, 5936.643801371932], "value": 4077.601332387756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.6627218934912, 709.6593635055174, 760.5588758520059, 775.0892701076234, 797.1988151907332, 15305.617359566002, 16437.09595972221, 16454.917725411386, 16454.93042952207, 16508.752368714464, 14900.254987250648, 15035.248237588132, 15041.0, 15055.698886022274, 15073.2463376831, 654.7675575170817, 685.4276678973039, 798.8562058829408, 828.1470085811624, 848.1391387741447, 657.5890068707058, 836.2473773603745, 838.4550042472412, 847.555033607358, 853.0232883348563, 899.9055099214586, 900.7973206028624, 900.9369344145913, 901.7970956534792, 902.5351943748974, 866.2723312417568, 877.9429337093133, 881.9029906710257, 894.9910500894973, 897.6140259688332, 671.6104659297596, 673.2594146438927, 673.3468535520537, 674.956127851688, 677.3666621708718, 15650.608734781608, 15663.68672626541, 15844.76232856508, 15846.920765396215, 15883.36466541337, 12111.818322725167, 14648.853511464855, 14827.332770025374, 14829.925850370679, 14905.627359315995, 11930.522779088826, 12087.818682719766, 12317.384130793514, 12370.886620204135, 12574.559890403792, 3790.450384694204, 3821.48409964654, 3978.0452691353867, 4013.478247827793, 4021.396790481422, 123739.0, 124491.37754311261, 125455.0, 125916.0, 127974.72025279814, 11236.044936180353, 11353.37556434404, 11368.886311136948, 11394.487248073856, 11421.200515963968, 23817.642735358982, 23821.404464888168, 23922.28233153008, 23925.401864953514, 23942.88028559846, 7317.634118294064, 7624.923750762421, 7669.769906902802, 7804.765857024185, 7871.921280787234, 4370.2352088384405, 4416.734995900256, 4428.579284967923, 4613.308003799457, 4677.64917631179, 2578.4585237100046, 3473.9826300868335, 3479.095435186819, 3486.18074752433, 3486.2678837443914, 643.9259485159266, 647.2718192033961, 654.5745265577318, 656.0585559721815, 657.7960832141955, 602.193061297863, 608.7382425556964, 614.8247749391402, 627.5826575327447, 634.9619022858643, 8330.62512186953, 8377.832443351099, 8401.621927013299, 9095.81808363829, 9103.042845788055, 495.82695441750354, 500.9448960614329, 572.6506830833189, 575.0770014127265, 605.5397897597858, 4037.899052523652, 4401.603855652943, 4429.247028005247, 4450.6439484841785, 4581.839635612738, 107292.0, 123319.76680233082, 154635.0, 171550.0, 173599.0, 145079.2746036263, 147625.0, 149652.0, 152010.63941483104, 153231.0, 95601.0, 117935.04798158526, 121468.39265803614, 122560.38719806522, 127569.99999999814, 8237.382196335418, 8334.458260213067, 8366.539840308842, 8396.664133434595, 8508.659653613786, 68614.3138568608, 68744.0, 68792.21642809693, 70860.0, 72539.91190132046, 63061.0, 63706.0, 90529.0, 92276.0, 92710.53644731732, 13470.865291346961, 13538.120022198525, 13540.661483462993, 13608.93195534016, 13979.510717124851, 14359.539517774203, 14420.423183072979, 14532.418703251751, 15353.0, 15411.460598878986, 11187.496562654864, 13731.382087805872, 14111.788323174955, 14333.498327558485, 14585.124892506483, 13109.0, 13340.466381344637, 13684.0, 13703.657408564466, 13974.371153298329, 13401.53094641683, 13972.231527266098, 13979.510717124851, 14029.01796874209, 14179.14925104497, 11260.15548833857, 11358.375289359165, 11540.653780386601, 11737.413129343327, 11748.941255293668, 10663.253572249869, 11351.772964540829, 11637.592684256011, 11646.592369267035, 11668.824967625322], "value": 7864.958007009423, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 97.0, 174.0, 117.0, 117.0, 99.0, 176.0, 177.0, 168.0, 119.0], "value": 135.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 141.0, 104.0, 178.0, 144.0, 140.0, 116.0, 115.0, 140.0, 129.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 209.0, 197.0, 196.0, 194.0, 194.0, 207.0, 197.0, 195.0, 194.0], "value": 199.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 62.0, 83.0, 61.0, 61.0, 57.0, 58.0, 80.0, 61.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 71.0, 87.0, 71.0, 70.0, 71.0, 87.0, 72.0, 71.0, 87.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 79.0, 136.0, 130.0, 88.0, 85.0, 91.0, 85.0, 88.0, 87.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 95.0, 94.0, 94.0, 96.0, 98.0, 95.0, 97.0, 130.0, 94.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 135.0, 151.0, 123.0, 91.0, 116.0, 76.0, 144.0, 144.0, 132.0], "value": 120.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 57.0, 56.0, 58.0, 55.0, 55.0, 66.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 77.0, 77.0, 76.0, 69.0, 68.0, 71.0, 87.0, 62.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 114.0, 108.0, 102.0, 102.0, 110.0, 76.0, 105.0, 109.0], "value": 101.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 159.0, 159.0, 161.0, 149.0, 150.0, 149.0, 148.0, 184.0, 149.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 175.0, 195.0, 191.0, 175.0, 178.0, 176.0, 177.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 93.0, 90.0, 87.0, 90.0, 71.0, 67.0, 70.0, 71.0, 71.0], "value": 79.0, "unit": "score"}]}]} 05:31:47 INFO - Return code: 0 05:31:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:47 ERROR - # TBPL SUCCESS # 05:31:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:47 INFO - 2016-10-06 05:31:47.901 screenresolution[1676:10789] starting screenresolution argv=screenresolution get 05:31:47 INFO - 2016-10-06 05:31:47.904 screenresolution[1676:10789] Display 0: 1600x1200x32@60 05:31:47 INFO - 2016-10-06 05:31:47.910 screenresolution[1677:10792] starting screenresolution argv=screenresolution list 05:31:47 INFO - Available Modes on Display 0 05:31:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:48 INFO - Intel Iris: 05:31:48 INFO - Chipset Model: Intel Iris 05:31:48 INFO - Type: GPU 05:31:48 INFO - Bus: Built-In 05:31:48 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:48 INFO - Vendor: Intel (0x8086) 05:31:48 INFO - Device ID: 0x0a2e 05:31:48 INFO - Revision ID: 0x0009 05:31:48 INFO - Displays: 05:31:48 INFO - Display: 05:31:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:48 INFO - Display Serial Number: 1600x1200 60 05:31:48 INFO - Main Display: Yes 05:31:48 INFO - Mirror: Off 05:31:48 INFO - Online: Yes 05:31:48 INFO - Rotation: Supported 05:31:48 INFO - Return code: 0 05:31:48 INFO - Running post-action listener: _resource_record_post_action 05:31:48 INFO - [mozharness: 2016-10-06 12:31:48.154784Z] Finished run-tests step (success) 05:31:48 INFO - Running post-run listener: _resource_record_post_run 05:31:48 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 39127552; Write bytes: 708987392; Read time: 382; Write time: 1996 05:31:48 INFO - TinderboxPrint: CPU usage
54.5% 05:31:48 INFO - TinderboxPrint: I/O read bytes / time
39,127,552 / 382 05:31:48 INFO - TinderboxPrint: I/O write bytes / time
708,987,392 / 1,996 05:31:48 INFO - TinderboxPrint: CPU idle
2,207.0 (45.5%) 05:31:48 INFO - TinderboxPrint: CPU system
976.0 (20.1%) 05:31:48 INFO - TinderboxPrint: CPU user
1,662.7 (34.3%) 05:31:48 INFO - TinderboxPrint: Swap in / out
447,344,640 / 0 05:31:48 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391825920; Write bytes: 385320448; Read time: 29048; Write time: 671 05:31:48 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38156800; Write bytes: 299324416; Read time: 367; Write time: 1273 05:31:48 INFO - Running post-run listener: _upload_blobber_files 05:31:48 INFO - Blob upload gear active. 05:31:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:48 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 05:31:48 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:48 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:50 INFO - (blobuploader) - INFO - Done attempting. 05:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:51 INFO - (blobuploader) - INFO - Done attempting. 05:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:54 INFO - (blobuploader) - INFO - Done attempting. 05:31:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:54 INFO - Return code: 0 05:31:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20b6dff1cc7d0694e243ca6fd0a4bce037f23bb94c35fe12d0fbc8d471b25b281bae444dfd1716d6a9db2d8491e4bcce1dcfef79d51fe3735fafe32630cd1e6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9d18ae8b0eddcf5c12587b5ee166b5bacd4efccde73cc4b73bf665b0fcd3c7fb15720a561a83afb9ef3c37a7fae8652cd612e8fa077081fb1a017623c28606", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e8ed459bc237f71d126c431ca0fb4707dd6c62e9b61e2ad06a8ae4f2be62eb13ba2d27f6d12af3e4599ef820c0f545f0c215e5c4b213a23d423077c7e674a0"} 05:31:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:54 INFO - Contents: 05:31:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20b6dff1cc7d0694e243ca6fd0a4bce037f23bb94c35fe12d0fbc8d471b25b281bae444dfd1716d6a9db2d8491e4bcce1dcfef79d51fe3735fafe32630cd1e6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9d18ae8b0eddcf5c12587b5ee166b5bacd4efccde73cc4b73bf665b0fcd3c7fb15720a561a83afb9ef3c37a7fae8652cd612e8fa077081fb1a017623c28606", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e8ed459bc237f71d126c431ca0fb4707dd6c62e9b61e2ad06a8ae4f2be62eb13ba2d27f6d12af3e4599ef820c0f545f0c215e5c4b213a23d423077c7e674a0"} 05:31:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:54 INFO - Copying logs to upload dir... 05:31:54 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.426386 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-06 05:31:54.183142) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 05:31:54.186621) ========= 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.TMB2yUAw9x/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.FvD4up9hz1/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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/Firefox/sha512/20b6dff1cc7d0694e243ca6fd0a4bce037f23bb94c35fe12d0fbc8d471b25b281bae444dfd1716d6a9db2d8491e4bcce1dcfef79d51fe3735fafe32630cd1e6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9d18ae8b0eddcf5c12587b5ee166b5bacd4efccde73cc4b73bf665b0fcd3c7fb15720a561a83afb9ef3c37a7fae8652cd612e8fa077081fb1a017623c28606", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e8ed459bc237f71d126c431ca0fb4707dd6c62e9b61e2ad06a8ae4f2be62eb13ba2d27f6d12af3e4599ef820c0f545f0c215e5c4b213a23d423077c7e674a0"} build_url:https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011003 build_url: 'https://queue.taskcluster.net/v1/task/ZKLQYNY2T0qMHQx_4lrxXA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20b6dff1cc7d0694e243ca6fd0a4bce037f23bb94c35fe12d0fbc8d471b25b281bae444dfd1716d6a9db2d8491e4bcce1dcfef79d51fe3735fafe32630cd1e6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9d18ae8b0eddcf5c12587b5ee166b5bacd4efccde73cc4b73bf665b0fcd3c7fb15720a561a83afb9ef3c37a7fae8652cd612e8fa077081fb1a017623c28606", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9e8ed459bc237f71d126c431ca0fb4707dd6c62e9b61e2ad06a8ae4f2be62eb13ba2d27f6d12af3e4599ef820c0f545f0c215e5c4b213a23d423077c7e674a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 05:31:54.218530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:31:54.218854) ========= 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.TMB2yUAw9x/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.FvD4up9hz1/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005284 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 05:31:54.269633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 05:31:54.270311) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 05:31:54.270960) ========= ========= Total master_lag: 0.18 =========