builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0328 starttime: 1480156859.82 results: success (0) buildid: 20161126004005 builduid: 2dd85c114d6048d08be196af4bcca96f revision: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 02:40:59.822274) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 02:40:59.823020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 02:40:59.823297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:00.030973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:00.031334) ========= 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.WyhCf2ajy2/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.iwb97QDHjc/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-11-26 02:41:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.7M=0.001s 2016-11-26 02:41:00 (10.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.649447 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:00.756211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:00.756506) ========= 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.WyhCf2ajy2/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.iwb97QDHjc/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.024039 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:00.822788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 02:41:00.823108) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d87b17a47f600b30cad7e7a48dfaa42d3faa7678 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d87b17a47f600b30cad7e7a48dfaa42d3faa7678 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WyhCf2ajy2/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.iwb97QDHjc/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-11-26 02:41:00,955 truncating revision to first 12 chars 2016-11-26 02:41:00,955 Setting DEBUG logging. 2016-11-26 02:41:00,955 attempt 1/10 2016-11-26 02:41:00,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d87b17a47f60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 02:41:02,380 unpacking tar archive at: mozilla-aurora-d87b17a47f60/testing/mozharness/ program finished with exit code 0 elapsedTime=1.708530 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-26 02:41:02.595743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:02.596072) ========= script_repo_revision: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:02.596477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:02.596769) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 02:41:02.619652) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-26 02:41:02.620070) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WyhCf2ajy2/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.iwb97QDHjc/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:41:02 INFO - MultiFileLogger online at 20161126 02:41:02 in /builds/slave/test 02:41:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:41:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:41:02 INFO - {'append_to_log': False, 02:41:02 INFO - 'base_work_dir': '/builds/slave/test', 02:41:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:41:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:41:02 INFO - 'branch': 'Mozilla-Aurora', 02:41:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:02 INFO - 'config_files': ('talos/mac_config.py',), 02:41:02 INFO - 'default_actions': ('clobber', 02:41:02 INFO - 'read-buildbot-config', 02:41:02 INFO - 'download-and-extract', 02:41:02 INFO - 'populate-webroot', 02:41:02 INFO - 'create-virtualenv', 02:41:02 INFO - 'install', 02:41:02 INFO - 'run-tests'), 02:41:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:02 INFO - 'download_minidump_stackwalk': True, 02:41:02 INFO - 'download_symbols': 'ondemand', 02:41:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:02 INFO - 'installer_path': 'installer.exe', 02:41:02 INFO - 'log_level': 'info', 02:41:02 INFO - 'log_name': 'talos', 02:41:02 INFO - 'log_to_console': True, 02:41:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:41:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:41:02 INFO - 'opt_config_files': (), 02:41:02 INFO - 'pip_index': False, 02:41:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:41:02 INFO - 'cmd': ('bash', 02:41:02 INFO - '-c', 02:41:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:41:02 INFO - 'enabled': True, 02:41:02 INFO - 'halt_on_failure': False, 02:41:02 INFO - 'name': 'check_screen_resolution'},), 02:41:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:41:02 INFO - 'cmd': ('bash', 02:41:02 INFO - '-c', 02:41:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:41:02 INFO - 'enabled': True, 02:41:02 INFO - 'halt_on_failure': False, 02:41:02 INFO - 'name': 'check_screen_resolution'},), 02:41:02 INFO - 'run_cmd_checks_enabled': True, 02:41:02 INFO - 'sps_profile': False, 02:41:02 INFO - 'sps_profile_interval': 0, 02:41:02 INFO - 'suite': 'dromaeojs-e10s', 02:41:02 INFO - 'system_bits': '32', 02:41:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:02 INFO - 'title': 't-yosemite-r7-0328', 02:41:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:02 INFO - 'use_talos_json': True, 02:41:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:41:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:02 INFO - 'work_dir': 'build'} 02:41:02 INFO - [mozharness: 2016-11-26 10:41:02.815369Z] Running clobber step. 02:41:02 INFO - Running pre-action listener: _resource_record_pre_action 02:41:02 INFO - Running main action method: clobber 02:41:02 INFO - rmtree: /builds/slave/test/build 02:41:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:05 INFO - Running post-action listener: _resource_record_post_action 02:41:05 INFO - [mozharness: 2016-11-26 10:41:05.259802Z] Finished clobber step (success) 02:41:05 INFO - [mozharness: 2016-11-26 10:41:05.259979Z] Running read-buildbot-config step. 02:41:05 INFO - Running pre-action listener: _resource_record_pre_action 02:41:05 INFO - Running main action method: read_buildbot_config 02:41:05 INFO - Using buildbot properties: 02:41:05 INFO - { 02:41:05 INFO - "project": "", 02:41:05 INFO - "product": "firefox", 02:41:05 INFO - "script_repo_revision": "production", 02:41:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:41:05 INFO - "repository": "", 02:41:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:41:05 INFO - "buildid": "20161126004005", 02:41:05 INFO - "stage_platform": "macosx64", 02:41:05 INFO - "basedir": "/builds/slave/test", 02:41:05 INFO - "nightly_build": "True", 02:41:05 INFO - "buildnumber": 32, 02:41:05 INFO - "slavename": "t-yosemite-r7-0328", 02:41:05 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:41:05 INFO - "platform": "yosemite_r7", 02:41:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:41:05 INFO - "branch": "mozilla-aurora", 02:41:05 INFO - "repo_path": "releases/mozilla-aurora", 02:41:05 INFO - "revision": "d87b17a47f600b30cad7e7a48dfaa42d3faa7678", 02:41:05 INFO - "pgo_build": "False", 02:41:05 INFO - "builduid": "2dd85c114d6048d08be196af4bcca96f", 02:41:05 INFO - "slavebuilddir": "test" 02:41:05 INFO - } 02:41:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:41:05 INFO - Running post-action listener: _resource_record_post_action 02:41:05 INFO - [mozharness: 2016-11-26 10:41:05.265616Z] Finished read-buildbot-config step (success) 02:41:05 INFO - [mozharness: 2016-11-26 10:41:05.265834Z] Running download-and-extract step. 02:41:05 INFO - Running pre-action listener: _resource_record_pre_action 02:41:05 INFO - Running main action method: download_and_extract 02:41:05 INFO - mkdir: /builds/slave/test/build/tests 02:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:05 INFO - trying https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:41:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:41:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:41:06 INFO - Downloaded 1199 bytes. 02:41:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:41:06 INFO - Using the following test package requirements: 02:41:06 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:41:06 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:41:06 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:41:06 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'jsshell-mac.zip'], 02:41:06 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:41:06 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:41:06 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:41:06 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:41:06 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:41:06 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:41:06 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:41:06 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:41:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:41:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:41:06 INFO - Fetch https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:41:07 INFO - Http code: 200 02:41:07 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 02:41:07 INFO - x-amz-cf-id: 2e-UcqnBQnxLSrjgjUXjlBjSrjb27q6lYDTdBF_0z4y1-9j8KvPNZw== 02:41:07 INFO - x-amz-version-id: OZciowVam0qopmCdSsIDeugx6YAr9QHk 02:41:07 INFO - Expected file size: 16278980 02:41:07 INFO - Obtained file size: 16278980 02:41:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:41:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:41:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:41:13 INFO - Fetch https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:41:14 INFO - Http code: 200 02:41:14 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 02:41:14 INFO - x-amz-cf-id: _iyILoIeWkRBZ_BLr7qjDIa2tDrHo1D0Fe5nN6sCNL56aUtEHGA2GQ== 02:41:14 INFO - x-amz-version-id: OZciowVam0qopmCdSsIDeugx6YAr9QHk 02:41:14 INFO - Expected file size: 16278980 02:41:14 INFO - Obtained file size: 16278980 02:41:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:41:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:41:20 INFO - Fetch https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:41:21 INFO - Http code: 200 02:41:21 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 02:41:21 INFO - x-amz-cf-id: xdVBDyGoNjkGNjNWQ77VQO6GgrwxRqb02ydko85wR3oDiqaaIwYQnw== 02:41:21 INFO - x-amz-version-id: F1nC2HgKaGMrp0X6P8lH4Nce0SQgZV3q 02:41:22 INFO - Expected file size: 14409038 02:41:22 INFO - Obtained file size: 14409038 02:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:22 INFO - trying https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:41:22 INFO - Downloading https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:41:26 INFO - Downloaded 109741947 bytes. 02:41:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:41:26 INFO - mkdir: /builds/slave/test/properties 02:41:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:26 INFO - Contents: 02:41:26 INFO - build_url:https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:41:26 INFO - Running post-action listener: _resource_record_post_action 02:41:26 INFO - Running post-action listener: set_extra_try_arguments 02:41:26 INFO - [mozharness: 2016-11-26 10:41:26.724427Z] Finished download-and-extract step (success) 02:41:26 INFO - [mozharness: 2016-11-26 10:41:26.724526Z] Running populate-webroot step. 02:41:26 INFO - Running pre-action listener: _resource_record_pre_action 02:41:26 INFO - Running main action method: populate_webroot 02:41:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:26 INFO - '--tppagecycles', 02:41:26 INFO - '7'], 02:41:26 INFO - 'tests': ['tsvgm']}}, 02:41:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['damp', 'tps']}, 02:41:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'tests': ['damp', 'tps']}, 02:41:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['dromaeo_dom']}, 02:41:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['basic_compositor_video']}, 02:41:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:41:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['a11yr', 02:41:26 INFO - 'ts_paint', 02:41:26 INFO - 'tpaint', 02:41:26 INFO - 'sessionrestore', 02:41:26 INFO - 'sessionrestore_no_auto_restore', 02:41:26 INFO - 'tabpaint']}, 02:41:26 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:26 INFO - 'ts_paint', 02:41:26 INFO - 'tpaint', 02:41:26 INFO - 'sessionrestore', 02:41:26 INFO - 'sessionrestore_no_auto_restore', 02:41:26 INFO - 'tabpaint']}, 02:41:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:41:26 INFO - 'ts_paint', 02:41:26 INFO - 'tpaint', 02:41:26 INFO - 'sessionrestore', 02:41:26 INFO - 'sessionrestore_no_auto_restore', 02:41:26 INFO - 'tabpaint']}, 02:41:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:41:26 INFO - 'ts_paint', 02:41:26 INFO - 'tpaint', 02:41:26 INFO - 'sessionrestore', 02:41:26 INFO - 'sessionrestore_no_auto_restore', 02:41:26 INFO - 'tabpaint']}, 02:41:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['a11yr', 02:41:26 INFO - 'ts_paint', 02:41:26 INFO - 'tpaint', 02:41:26 INFO - 'sessionrestore', 02:41:26 INFO - 'sessionrestore_no_auto_restore', 02:41:26 INFO - 'tabpaint']}, 02:41:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['a11yr', 02:41:26 INFO - 'ts_paint', 02:41:26 INFO - 'tpaint', 02:41:26 INFO - 'sessionrestore', 02:41:26 INFO - 'sessionrestore_no_auto_restore', 02:41:26 INFO - 'tabpaint']}, 02:41:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['tsvgx', 02:41:26 INFO - 'tsvgr_opacity', 02:41:26 INFO - 'tart', 02:41:26 INFO - 'tscrollx', 02:41:26 INFO - 'cart']}, 02:41:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:26 INFO - 'tsvgr_opacity', 02:41:26 INFO - 'tart', 02:41:26 INFO - 'tscrollx', 02:41:26 INFO - 'cart']}, 02:41:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'talos_options': ['--disable-e10s'], 02:41:26 INFO - 'tests': ['tp5o']}, 02:41:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'tests': ['tp5o']}, 02:41:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'talos_options': ['--disable-e10s', 02:41:26 INFO - '--xperf_path', 02:41:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:26 INFO - 'tests': ['tp5n']}, 02:41:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:41:26 INFO - 'talos_options': ['--xperf_path', 02:41:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:26 INFO - 'tests': ['tp5n']}}, 02:41:26 INFO - 'talos.zip': {'path': '', 02:41:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:26 INFO - Running post-action listener: _resource_record_post_action 02:41:26 INFO - [mozharness: 2016-11-26 10:41:26.743474Z] Finished populate-webroot step (success) 02:41:26 INFO - [mozharness: 2016-11-26 10:41:26.743613Z] Running create-virtualenv step. 02:41:26 INFO - Running pre-action listener: _resource_record_pre_action 02:41:26 INFO - Running main action method: create_virtualenv 02:41:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:41:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:41:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:26 INFO - Using real prefix '/tools/python27' 02:41:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:30 INFO - Installing pip.................done. 02:41:30 INFO - Return code: 0 02:41:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:41:30 INFO - Reading from file tmpfile_stdout 02:41:30 INFO - Output received: 02:41:30 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) 02:41:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:30 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:41:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:30 INFO - 'HOME': '/Users/cltbld', 02:41:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:30 INFO - 'LOGNAME': 'cltbld', 02:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:30 INFO - 'MOZ_NO_REMOTE': '1', 02:41:30 INFO - 'NO_EM_RESTART': '1', 02:41:30 INFO - 'PAGER': '/bin/cat', 02:41:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:30 INFO - 'PWD': '/builds/slave/test', 02:41:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:30 INFO - 'SHELL': '/bin/bash', 02:41:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:30 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:30 INFO - 'USER': 'cltbld', 02:41:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:30 INFO - 'XPC_FLAGS': '0x0', 02:41:30 INFO - 'XPC_SERVICE_NAME': '0', 02:41:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:41:31 INFO - Cleaning up... 02:41:31 INFO - Return code: 0 02:41:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:31 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:31 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 02:41:31 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 02:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:31 INFO - 'HOME': '/Users/cltbld', 02:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:31 INFO - 'LOGNAME': 'cltbld', 02:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:31 INFO - 'MOZ_NO_REMOTE': '1', 02:41:31 INFO - 'NO_EM_RESTART': '1', 02:41:31 INFO - 'PAGER': '/bin/cat', 02:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:31 INFO - 'PWD': '/builds/slave/test', 02:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:31 INFO - 'SHELL': '/bin/bash', 02:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:31 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:31 INFO - 'USER': 'cltbld', 02:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:31 INFO - 'XPC_FLAGS': '0x0', 02:41:31 INFO - 'XPC_SERVICE_NAME': '0', 02:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:31 INFO - Downloading/unpacking psutil>=3.1.1 02:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:41:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:36 INFO - Installing collected packages: psutil 02:41:36 INFO - Running setup.py install for psutil 02:41:36 INFO - building 'psutil._psutil_osx' extension 02:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:41:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:41:36 INFO - building 'psutil._psutil_posix' extension 02:41:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:41:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:41:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:41:37 INFO - ^ 02:41:37 INFO - 1 warning generated. 02:41:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:41:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:41:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:41:37 INFO - Successfully installed psutil 02:41:37 INFO - Cleaning up... 02:41:37 INFO - Return code: 0 02:41:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:41:37 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')]} 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:37 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')]} 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:37 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:37 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 02:41:37 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 02:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:37 INFO - 'HOME': '/Users/cltbld', 02:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:37 INFO - 'LOGNAME': 'cltbld', 02:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:37 INFO - 'MOZ_NO_REMOTE': '1', 02:41:37 INFO - 'NO_EM_RESTART': '1', 02:41:37 INFO - 'PAGER': '/bin/cat', 02:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:37 INFO - 'PWD': '/builds/slave/test', 02:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:37 INFO - 'SHELL': '/bin/bash', 02:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:37 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:37 INFO - 'USER': 'cltbld', 02:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:37 INFO - 'XPC_FLAGS': '0x0', 02:41:37 INFO - 'XPC_SERVICE_NAME': '0', 02:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:41:41 INFO - Installing collected packages: mozsystemmonitor 02:41:41 INFO - Running setup.py install for mozsystemmonitor 02:41:41 INFO - Successfully installed mozsystemmonitor 02:41:41 INFO - Cleaning up... 02:41:41 INFO - Return code: 0 02:41:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:41 INFO - 'HOME': '/Users/cltbld', 02:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:41 INFO - 'LOGNAME': 'cltbld', 02:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:41 INFO - 'MOZ_NO_REMOTE': '1', 02:41:41 INFO - 'NO_EM_RESTART': '1', 02:41:41 INFO - 'PAGER': '/bin/cat', 02:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:41 INFO - 'PWD': '/builds/slave/test', 02:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:41 INFO - 'SHELL': '/bin/bash', 02:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:41 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:41 INFO - 'USER': 'cltbld', 02:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:41 INFO - 'XPC_FLAGS': '0x0', 02:41:41 INFO - 'XPC_SERVICE_NAME': '0', 02:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:41 INFO - Downloading/unpacking jsonschema==2.5.1 02:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:41:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:44 INFO - Downloading functools32-3.2.3-2.tar.gz 02:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:41:44 INFO - warning: no files found matching '*.txt' 02:41:44 INFO - no previously-included directories found matching 'build' 02:41:44 INFO - no previously-included directories found matching 'dist' 02:41:44 INFO - no previously-included directories found matching '.git*' 02:41:44 INFO - Installing collected packages: jsonschema, functools32 02:41:44 INFO - Running setup.py install for functools32 02:41:44 INFO - warning: no files found matching '*.txt' 02:41:44 INFO - no previously-included directories found matching 'build' 02:41:44 INFO - no previously-included directories found matching 'dist' 02:41:44 INFO - no previously-included directories found matching '.git*' 02:41:44 INFO - Successfully installed jsonschema functools32 02:41:44 INFO - Cleaning up... 02:41:45 INFO - Return code: 0 02:41:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:45 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:45 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 02:41:45 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 02:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:45 INFO - 'HOME': '/Users/cltbld', 02:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:45 INFO - 'LOGNAME': 'cltbld', 02:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:45 INFO - 'MOZ_NO_REMOTE': '1', 02:41:45 INFO - 'NO_EM_RESTART': '1', 02:41:45 INFO - 'PAGER': '/bin/cat', 02:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:45 INFO - 'PWD': '/builds/slave/test', 02:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:45 INFO - 'SHELL': '/bin/bash', 02:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:45 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:45 INFO - 'USER': 'cltbld', 02:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:45 INFO - 'XPC_FLAGS': '0x0', 02:41:45 INFO - 'XPC_SERVICE_NAME': '0', 02:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:41:45 INFO - Cleaning up... 02:41:45 INFO - Return code: 0 02:41:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:45 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:45 INFO - 'HOME': '/Users/cltbld', 02:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:45 INFO - 'LOGNAME': 'cltbld', 02:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:45 INFO - 'MOZ_NO_REMOTE': '1', 02:41:45 INFO - 'NO_EM_RESTART': '1', 02:41:45 INFO - 'PAGER': '/bin/cat', 02:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:45 INFO - 'PWD': '/builds/slave/test', 02:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:45 INFO - 'SHELL': '/bin/bash', 02:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:45 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:45 INFO - 'USER': 'cltbld', 02:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:45 INFO - 'XPC_FLAGS': '0x0', 02:41:45 INFO - 'XPC_SERVICE_NAME': '0', 02:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:41:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:41:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:50 INFO - Downloading docopt-0.6.1.tar.gz 02:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:41:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:41:50 INFO - Running setup.py install for blobuploader 02:41:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:41:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:41:50 INFO - Running setup.py install for requests 02:41:50 INFO - Running setup.py install for docopt 02:41:51 INFO - Successfully installed blobuploader requests docopt 02:41:51 INFO - Cleaning up... 02:41:51 INFO - Return code: 0 02:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:51 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')]} 02:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:51 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')]} 02:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:51 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:51 INFO - 'HOME': '/Users/cltbld', 02:41:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:51 INFO - 'LOGNAME': 'cltbld', 02:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:51 INFO - 'MOZ_NO_REMOTE': '1', 02:41:51 INFO - 'NO_EM_RESTART': '1', 02:41:51 INFO - 'PAGER': '/bin/cat', 02:41:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:51 INFO - 'PWD': '/builds/slave/test', 02:41:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:51 INFO - 'SHELL': '/bin/bash', 02:41:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:51 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:51 INFO - 'USER': 'cltbld', 02:41:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:51 INFO - 'XPC_FLAGS': '0x0', 02:41:51 INFO - 'XPC_SERVICE_NAME': '0', 02:41:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-z9iBhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-2A7eA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-HPwnA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-cImPWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-8lMPIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-tyOwsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:51 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-AKyGOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-tP7bBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-TJtLeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-vCKax8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Yf_JHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-0l8jL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-hiFPf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-6Uxsqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-L5UTbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:52 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-2O9d8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:53 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-6yZ6Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:41:53 INFO - Running setup.py install for manifestparser 02:41:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:41:53 INFO - Running setup.py install for mozcrash 02:41:53 INFO - Running setup.py install for mozdebug 02:41:53 INFO - Running setup.py install for mozdevice 02:41:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:41:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:41:53 INFO - Running setup.py install for mozfile 02:41:53 INFO - Running setup.py install for mozhttpd 02:41:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Running setup.py install for mozinfo 02:41:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Running setup.py install for mozInstall 02:41:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Running setup.py install for mozleak 02:41:54 INFO - Running setup.py install for mozlog 02:41:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Running setup.py install for moznetwork 02:41:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:41:54 INFO - Running setup.py install for mozprocess 02:41:54 INFO - Running setup.py install for mozprofile 02:41:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:41:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:41:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:41:55 INFO - Running setup.py install for mozrunner 02:41:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:41:55 INFO - Running setup.py install for mozscreenshot 02:41:55 INFO - Running setup.py install for moztest 02:41:55 INFO - Running setup.py install for mozversion 02:41:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:41:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:41:55 INFO - Cleaning up... 02:41:55 INFO - Return code: 0 02:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:41:55 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')]} 02:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:55 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')]} 02:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:55 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:55 INFO - 'HOME': '/Users/cltbld', 02:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:55 INFO - 'LOGNAME': 'cltbld', 02:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:55 INFO - 'MOZ_NO_REMOTE': '1', 02:41:55 INFO - 'NO_EM_RESTART': '1', 02:41:55 INFO - 'PAGER': '/bin/cat', 02:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:55 INFO - 'PWD': '/builds/slave/test', 02:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:55 INFO - 'SHELL': '/bin/bash', 02:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:41:55 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:55 INFO - 'USER': 'cltbld', 02:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:55 INFO - 'XPC_FLAGS': '0x0', 02:41:55 INFO - 'XPC_SERVICE_NAME': '0', 02:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:41:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-cemQ44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-W3pelP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-GxblND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-pDY4xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Fc20oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-XWDPd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-S3brtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-vGeC0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-xPnqbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:41:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-iEz_3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:41:57 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)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-gywHZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-pT9cjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:41:57 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)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-jm_p8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-ZBBzsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-OQIxoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-MMf_CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:41:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Rqm1Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:41:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:00 INFO - Downloading blessings-1.6.tar.gz 02:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:00 INFO - Installing collected packages: blessings 02:42:00 INFO - Running setup.py install for blessings 02:42:00 INFO - Successfully installed blessings 02:42:00 INFO - Cleaning up... 02:42:00 INFO - Return code: 0 02:42:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:00 INFO - Reading from file tmpfile_stdout 02:42:00 INFO - Current package versions: 02:42:00 INFO - blessings == 1.6 02:42:00 INFO - blobuploader == 1.2.4 02:42:00 INFO - docopt == 0.6.1 02:42:00 INFO - functools32 == 3.2.3-2 02:42:00 INFO - jsonschema == 2.5.1 02:42:00 INFO - manifestparser == 1.1 02:42:00 INFO - mozInstall == 1.12 02:42:00 INFO - mozcrash == 1.0 02:42:00 INFO - mozdebug == 0.1 02:42:00 INFO - mozdevice == 0.48 02:42:00 INFO - mozfile == 1.2 02:42:00 INFO - mozhttpd == 0.7 02:42:00 INFO - mozinfo == 0.9 02:42:00 INFO - mozleak == 0.1 02:42:00 INFO - mozlog == 3.4 02:42:00 INFO - moznetwork == 0.27 02:42:00 INFO - mozprocess == 0.23 02:42:00 INFO - mozprofile == 0.28 02:42:00 INFO - mozrunner == 6.13 02:42:00 INFO - mozscreenshot == 0.1 02:42:00 INFO - mozsystemmonitor == 0.3 02:42:00 INFO - moztest == 0.7 02:42:00 INFO - mozversion == 1.4 02:42:00 INFO - psutil == 3.1.1 02:42:00 INFO - requests == 1.2.3 02:42:00 INFO - wsgiref == 0.1.2 02:42:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:00 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:00 INFO - 'HOME': '/Users/cltbld', 02:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:00 INFO - 'LOGNAME': 'cltbld', 02:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:00 INFO - 'MOZ_NO_REMOTE': '1', 02:42:00 INFO - 'NO_EM_RESTART': '1', 02:42:00 INFO - 'PAGER': '/bin/cat', 02:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:00 INFO - 'PWD': '/builds/slave/test', 02:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:00 INFO - 'SHELL': '/bin/bash', 02:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:42:00 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:00 INFO - 'USER': 'cltbld', 02:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:00 INFO - 'XPC_FLAGS': '0x0', 02:42:00 INFO - 'XPC_SERVICE_NAME': '0', 02:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:42:01 INFO - Cleaning up... 02:42:01 INFO - Return code: 0 02:42:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42:01 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')]} 02:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:01 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')]} 02:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:01 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 0x1088ab490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108821570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b5349f9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, '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.WyhCf2ajy2/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.iwb97QDHjc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:01 INFO - 'HOME': '/Users/cltbld', 02:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:01 INFO - 'LOGNAME': 'cltbld', 02:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:01 INFO - 'MOZ_NO_REMOTE': '1', 02:42:01 INFO - 'NO_EM_RESTART': '1', 02:42:01 INFO - 'PAGER': '/bin/cat', 02:42:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:01 INFO - 'PWD': '/builds/slave/test', 02:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:01 INFO - 'SHELL': '/bin/bash', 02:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:42:01 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:01 INFO - 'USER': 'cltbld', 02:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:01 INFO - 'XPC_FLAGS': '0x0', 02:42:01 INFO - 'XPC_SERVICE_NAME': '0', 02:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:42:01 INFO - Cleaning up... 02:42:01 INFO - Return code: 0 02:42:01 INFO - Running post-action listener: _resource_record_post_action 02:42:01 INFO - Running post-action listener: _start_resource_monitoring 02:42:01 INFO - Starting resource monitoring. 02:42:01 INFO - [mozharness: 2016-11-26 10:42:01.538799Z] Finished create-virtualenv step (success) 02:42:01 INFO - [mozharness: 2016-11-26 10:42:01.539856Z] Running install step. 02:42:01 INFO - Running pre-action listener: _resource_record_pre_action 02:42:01 INFO - Running main action method: install 02:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:01 INFO - Reading from file tmpfile_stdout 02:42:01 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:01 INFO - Reading from file tmpfile_stdout 02:42:01 INFO - Output received: 02:42:01 INFO - Usage: mozinstall [options] installer 02:42:01 INFO - Options: 02:42:01 INFO - -h, --help show this help message and exit 02:42:01 INFO - -d DEST, --destination=DEST 02:42:01 INFO - Directory to install application into. [default: 02:42:01 INFO - "/builds/slave/test"] 02:42:01 INFO - --app=APP Application being installed. [default: firefox] 02:42:01 INFO - mkdir: /builds/slave/test/build/application 02:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:42:32 INFO - Reading from file tmpfile_stdout 02:42:32 INFO - Output received: 02:42:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:42:32 INFO - Running post-action listener: _resource_record_post_action 02:42:32 INFO - [mozharness: 2016-11-26 10:42:32.578817Z] Finished install step (success) 02:42:32 INFO - [mozharness: 2016-11-26 10:42:32.578971Z] Running run-tests step. 02:42:32 INFO - Running pre-action listener: _resource_record_pre_action 02:42:32 INFO - Running main action method: run_tests 02:42:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:42:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:42:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:42:32 INFO - 2016-11-26 02:42:32.593 screenresolution[1638:11793] starting screenresolution argv=screenresolution get 02:42:32 INFO - 2016-11-26 02:42:32.596 screenresolution[1638:11793] Display 0: 1600x1200x32@60 02:42:32 INFO - 2016-11-26 02:42:32.602 screenresolution[1639:11796] starting screenresolution argv=screenresolution list 02:42:32 INFO - Available Modes on Display 0 02:42:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:42:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:42:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:42:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:42:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:42:32 INFO - Intel Iris: 02:42:32 INFO - Chipset Model: Intel Iris 02:42:32 INFO - Type: GPU 02:42:32 INFO - Bus: Built-In 02:42:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:42:32 INFO - Vendor: Intel (0x8086) 02:42:32 INFO - Device ID: 0x0a2e 02:42:32 INFO - Revision ID: 0x0009 02:42:32 INFO - Displays: 02:42:32 INFO - Display: 02:42:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:42:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:42:32 INFO - Display Serial Number: 1600x1200 60 02:42:32 INFO - Main Display: Yes 02:42:32 INFO - Mirror: Off 02:42:32 INFO - Online: Yes 02:42:32 INFO - Rotation: Supported 02:42:32 INFO - Return code: 0 02:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:32 INFO - Python 2.7.3 02:42:32 INFO - Return code: 0 02:42:32 INFO - grabbing minidump binary from tooltool 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086bfd30>, '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 0x108525db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086b7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:42:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:42:32 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 02:42:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:32 INFO - Return code: 0 02:42:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:42:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:42:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 02:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0328 --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 02:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WyhCf2ajy2/Render', 02:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:32 INFO - 'HOME': '/Users/cltbld', 02:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:32 INFO - 'LOGNAME': 'cltbld', 02:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:32 INFO - 'MOZ_NO_REMOTE': '1', 02:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:32 INFO - 'NO_EM_RESTART': '1', 02:42:32 INFO - 'PAGER': '/bin/cat', 02:42:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:32 INFO - 'PWD': '/builds/slave/test', 02:42:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:32 INFO - 'SHELL': '/bin/bash', 02:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwb97QDHjc/Listeners', 02:42:32 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 02:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:32 INFO - 'USER': 'cltbld', 02:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:32 INFO - 'XPC_FLAGS': '0x0', 02:42:32 INFO - 'XPC_SERVICE_NAME': '0', 02:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 02:42:33 INFO - mozversion application_buildid: 20161126004005 02:42:33 INFO - mozversion application_changeset: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 02:42:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:42:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:33 INFO - mozversion application_name: Firefox 02:42:33 INFO - mozversion application_remotingname: firefox-dev 02:42:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:33 INFO - mozversion application_vendor: Mozilla 02:42:33 INFO - mozversion application_version: 52.0a2 02:42:33 INFO - mozversion platform_buildid: 20161126004005 02:42:33 INFO - mozversion platform_changeset: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 02:42:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:33 INFO - mozversion platform_version: 52.0a2 02:42:33 INFO - using testdate: 1480156953 02:42:33 INFO - actual date: 1480156953 02:42:33 INFO - starting webserver on 'localhost:49243' 02:42:33 INFO - SUITE-START | Running 2 tests 02:42:33 INFO - TEST-START | dromaeo_css 02:42:33 INFO - operating with platform_type : mac_ 02:42:33 INFO - Initialising browser for dromaeo_css test... 02:42:33 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpRfRFjn/profile http://localhost:49243/getInfo.html) 02:42:36 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 02:42:36 INFO - PROCESS | 1649 | colorDepth:24 02:42:36 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 02:42:36 INFO - PROCESS | 1649 | __metrics 02:42:36 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:42:37 INFO - TEST-INFO | 1649: exit 0 02:42:37 INFO - Browser initialized. 02:42:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:42:37 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpRfRFjn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:49 INFO - PROCESS | 1654 | RSS: Main: 229769216 02:42:49 INFO - PROCESS | 1654 | 02:43:39 INFO - PROCESS | 1654 | 1480157019443 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:45:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 02:45:55 INFO - PROCESS | 1654 | RSS: Main: 232513536 02:45:55 INFO - PROCESS | 1654 | 02:48:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 02:48:58 INFO - PROCESS | 1654 | RSS: Main: 243294208 02:48:58 INFO - PROCESS | 1654 | 02:52:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 02:52:01 INFO - PROCESS | 1654 | RSS: Main: 246247424 02:52:01 INFO - PROCESS | 1654 | 02:55:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 02:55:03 INFO - PROCESS | 1654 | RSS: Main: 249761792 02:55:03 INFO - PROCESS | 1654 | 02:58:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 02:58:07 INFO - PROCESS | 1654 | RSS: Main: 254197760 02:58:07 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 03:01:09 INFO - PROCESS | 1654 | RSS: Main: 255569920 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | __start_tp_report 03:01:09 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 03:01:09 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 03:01:09 INFO - PROCESS | 1654 | |i|pagename|runs| 03:01:09 INFO - PROCESS | 1654 | |0;dojo.html;3404.4893266010113;3415.5559777228955;3427.263138425238;3432.5537680101584;3454.0501362125406;5880.882382352351;5890.087036509342;5947.316058653256;5962.165296858432;5971.283445986483;5949.018411962021;5971.761129554812;5974.163617093611;6009.75960961561;6015.879682406349;5359;5359.08895487766;5398.595105367093;5430.511253987141;5435.728213589325;5417.349918009844;5428.782848686048;5432.837014889559;5436.565074794027;5474.534664553517;5279.9208011879855;5285.656432331886;5441.020616289066;5451.073317536008;5477.808276710316;5296.073187192226;5318.388385335697;5333.173358129496;5344.251804747339;5352.57179425645;5243.2659427680155;5317.388500322474;5377.865553361158;5378.112611419111;5383.00414423329;4957.900841983176;5998.1602575639445;6024.277086749618;6060.878782424327;6087.726052327612;6154.323024467305;6172.938270617281;6176.135341052256;6234.844128896769;6264.749410023594;6287.622742635456;6296.87406251877;6300.338464461257;6306.274778400497;6309.274433440121;6057.697115144225;6070.908936365958;6081.452669259744;6093.451589356979;6100;6167.229096362955;6204;6217.906731399033;6231.657258850716;6241.563090583706;6125.944885418659;6140.478059364915;6207.689615519206;6207.844803879939;6216.937830621727;6222.688865556704;6239.157713708682;6251.218597675291;6269.5611307208055;6282.717277722513;5037.269595908573;5787.305523337142;6114.021756518936;6219.378062193835;6226.906596401058;6177.938220617826;6219.346968568326;6231.470325022333;6249.78125765596;6261.624302541862;4436.733795972252;4890.364252647204;5015.749212539358;5017.247412888023;5024.874378140503;4452.354408610733;4480.4623445186135;4530.388397566287;4541.636669066466;4564.018735971782;5790.855228619234;6027.487663548647;6098.14625952367;6138.846528836725;6145.293291271471;5787.536997040227;5791.449812267828;6259.311475737665;6272.40412160844;6277;5917.053271476543;5949.524038076944;5985.281766188085;6025.9096113558335;6136.079588061826;4958.76030992252;5419.566434685215;5489.066858634042;5526.392096869341;5537.695426751487;6322.999999999908;6351.650659213788;6379.106925030406;6382.968085159545;6410.358964103739;6119.197913140417;6214.5960512566535;6226.782062627967;6259.96870015647;6280.811575652738;6273.52948528853;6370.267419246846;6383.776567820104;6387.744490220525;6580.5064620152725;6240.063990401476;6246.843828904313;6256.155419018556;6260.968695156495;6293.622382657055;5154.768035438339;6085.4523092921845;6239;6265;6265.749370025148;6124.2588809726185;6126.181801870855;6205.565610407409;6214.658193799384;6222.844428889314;6223.751049957951;6233.127362169391;6258.655773932477;6287.402696743802;6298.401651843067;6026.578139530191;6051.394860513913;6105.84735381619;6212.627242365473;6220.844478888064;6095.085737139465;6141.915626108588;6144.880016394337;6230.875382492415;6249.125122482947;6045.153678484928;6089.512838972783;6130.448259656652;6131.590761709946;6189.04069869171 03:01:09 INFO - PROCESS | 1654 | |1;ext.html;477.098284242781;511.2944137090814;511.6904272914886;514.66546744616;543.9972800135998;32657.51013734793;38546.80726596367;40577;40867.59132408675;40913.7954310228;41190.17619647605;41379.586204138024;41560.79219603905;41679.374809377885;41759.16481670365;9338.25293976482;9474.952625236865;9478.715638530855;9483.620655173785;9497.430154190735;9309.069093090704;9375.203107735852;9382.061793820632;9385.671501497449;9417.576209070608;9395.154436100784;9400.482973436458;9403.341766076377;9443.244540436748;9443.905560944371;9328.300377471684;9361.953190234039;9404.858927116098;9434.811303773955;9435.05649435051;9338.299627527962;9363.953180234123;9426.387284826533;9446.716598502057;9455.101765332283;39134;39368.409473857915;39441.21117577633;39579.40630890539;39590.802045989585;3136.7176954074243;3322.318924620471;3330.8667653293837;3333.4833100869405;3352.2960178362327;25066.122685705912;26796.928122875062;27200.727992720018;27348;28425.289367765763;3162.936741265162;3229.1281354034513;3244.4160051190775;3254.869805207789;3259.3481303739345;515799;517052;524716;525141;526187.3690631561;51615.48384516182;53256;61446.385536144066;61865;61925;63429.36570634327;63858.0421293681;64336;64445.67777161178;64486;16143.596410089842;16167.110808905389;16307.59231019234;16329.428470003493;16429;12627.5580354689;12632.621021369374;12638.05214608908;12640.11519193666;12653.430595623218;18104.77095053711;18609.44171674852;18824.905875470537;18843.623127537372;18986.240550377832;3150.5904232449634;3251.365983633169;6611.008348747726;7180.281971802882;7412.96293518529;834.2866848844272;840.9915900840913;880.2341962492673;978.5400861595039;1051.4374809476892;25266;29152.562711559345;30258.697413026028;30458.238544036132;30898.22754431112;1037.113268155731;1056.5932116135189;1070.0155856611937;1101.058594901364;1194.1223200947297;15380.538583842503;15505.224738763016;15610.29753661088;15914.92042539803;16000.839991599934;642737;643227;645286;647847;650087;57297.427025730045;57506;57969.42030579725;58077.70961145252;58400;1339;1358.3887250737207;1371.060823336018;1372.7117305365784;1375.5254437219144;29032.12903612895;29750.553741694326;29856.10431687053;29967.100986970425;30314.545281821232;50262.74868625634;50593.494065058876;50622.2406663893;50758;50833;609553;610010;611607;612243;614695;26057.869710652085;26296;26500.867495662398;26523.673816309492;26568.468630626892;44554.662523528925;45061.549384505735;45156.32265516085;45368.31947520856;45413.54586454093;38282;38324.42513362246;40025.59974400335;40456.39315410212;41736;37426.31581578781;38496.03759906025;38864.02839929024;39539;39909.60090399059;34647.82676086603;37699;38571;38627.80686096552;38710.612893870704;33087.84192553249;34081.65918340884;34303.65696343005;34756.43596038235;34760.13099672528;24027.879860600584;24101.91541380607;24261.393465163514;24352.51294974126;24392 03:01:09 INFO - PROCESS | 1654 | |2;jquery.html;310.9005118362124;370.96846768024716;379.7987066854567;384.4118498696991;399.9461419160511;13457.596272111829;15410.61473463164;20072.89963550182;20245.797542024575;20300.89849550754;11513.424328783549;16918.900271482344;17798.555036124104;18443;18605.906970465163;5144.61415393846;5379.408265090837;5405.7567409466665;5406.378266499344;5468.91796623051;5279.868003299929;5348.3849357323825;5634.436556344353;5955.166276721263;6001.9699901500435;5994.760209591611;6022.337542870281;6032.125341825433;6036.094585812141;6045.425684559959;5889.64662120272;5923.904077745631;5954.285485741717;6039.275286965549;6048.516118710492;5245.239440281176;5852.824415267549;5857.062869940789;5861.120831875211;5879.617824841372;12726;13218;13261;13302.268375239359;13303;2046.9078891449772;2261.2650888461153;2354.2466410748566;2477.355887469253;3007.9800523427984;9678.17735492484;9861.013898610081;10029.047240512213;10115.241356898263;10244.846327305022;1752.896524170987;1817.6273863857878;1827.0955876840917;1889.2254175787998;1913.320771126258;120059.19911201339;122957.15564266543;125769;132220.33889830587;132893.33553332268;11282.605108821315;11636.825447618292;11775.823362649568;11994.88005119955;11999.145897577244;14800.333984970703;14837.258137093102;14851.628709282139;14874.628134296512;14899.851001490064;8269.338452923752;8386.87419688705;8572.228499435081;8683.782905427288;8703.912960870437;8379.95810020946;8418.284445822052;8455.408121431563;8631.266342360845;8641.697540586176;3789.5452545694693;4442.933355999663;4598.747068911242;4629.907401851944;4653.162430762495;1893.3657224829835;1931.58470928751;1940.5536726552689;1949.152118828286;1956.7847536770944;834.5978755690377;960;974.4153507895206;983.9065288797552;992.1963209800085;14946.925265373604;19819;19932.00339982995;20701.89649051745;20910.895445522674;911.2345629671108;923.2752289452748;930.8225095254509;940.5156344482597;952.7713348796377;8732.956335218283;10435.217358698128;10839.295445795999;10908.563657453771;10909.290896091887;623179;630292;630326;633843;647532;109954;114770.85229147768;139604;145791.81312280113;150386;842.7808769719917;863.684755064397;877.5612193902921;920.6777627830206;996.6063404955003;15607.687846242785;15756.92121539385;16771.32914683448;18910.716339255196;18956.620867582296;30109;35562.82218588891;38355.232895342495;54259.18611220756;54368.45631543634;82387;84139;84427.15572844193;84664;84920;6990.300969902969;6991.930080699128;7456.440766942609;7457.291557302047;7723.5752033636445;10430.895691043295;12237.938810305892;12729.745405092031;12829.93585032069;13229.140105893086;10945.781084378426;10983.231173817756;11060.336379817236;11167.441627918734;11193.66419007431;10642.255042146975;10695;10815;10888.510017049093;10977;10395.688129356131;11183.384913829492;11251.606193783178;11281.830772538255;11288.363187337625;7361.153467351109;7426.517276377018;7549.886751698838;7555.055618047744;7555.773326800205;10571.841422378824;10814.29707069038;11025.889741102486;11066.778664426505;11439.485223165144 03:01:09 INFO - PROCESS | 1654 | |3;mootools.html;1467.075742282362;1498.2658497336306;1640.7702921590972;1650.8844380893336;1698.3885801111599;7573.886391704115;7850.646720897559;8104.756857294283;8527.104654011333;8547.145285471457;8070.757877263677;8380.245777879989;8406.159384061591;8500;8517;2343.2033108743026;2362.9291121266306;2366.183666635017;2368.12379419615;2380.9285721428387;2365.1485465232504;2389.64155376694;2405.7113146422453;2417.891194896234;2425.9757402425926;2350.7296660883962;2370.182287110944;2375.9406014849683;2384.844985075973;2388.6775285336516;2333.3583264602203;2341.800946919514;2372.466195106096;2373.549025685123;2375.655529948165;2370.134900761227;2376.512814872947;2381.142788596104;2396.928092157238;2404.038384646138;8198.754037378889;8283.50298982057;8309.584520773997;8309.95845020777;8345.582720863933;5061.822836200752;5239.79040838366;5252.6323157379;5256.316678831766;5260.500252476008;2993.925151871199;3488.7383446241633;3592.3713350163616;3619.348517266891;3632.291703117893;1073.5169173871789;1081.3836113415357;1104.1498046504228;1119.9160062995227;1128.2722643894724;11017.944910275477;11067.446627668583;11091.389973551451;11129.443527823576;11152.052075573585;4271.743695378225;4470.882279430142;4500.099980004013;4534.614557762561;4550.34020067095;8564.48613083217;8703.825923481494;8717;8719.12808719123;8737.956310218535;5122.590192784568;5124.077666020152;5125.077486052546;5131.384233891957;5138.845834624967;3952.4071389291835;4296.957030429656;4418.911621767546;4755.358026666425;4762.404699412574;3277.311764529428;3711.183539621279;3738.794366309879;3824.5601755797884;3831.386978083549;1147.5065721739732;1172.261475270574;1173.4484792147678;1176.4294317256295;1176.8881956214145;782.7377828427541;895.713371721043;897.9730608081768;917.7017469322496;919.3197034194782;5775;5831.2127862738835;5853.619514731528;5940.8811823764145;6150.7847225346895;897.0894542039835;906.4968942237122;913.2693844924167;925.3476299209042;987.9209663226925;3163.3831402876676;3358.882439114619;3721.1255354992095;3865.8260378283044;4017.417474466186;9514.857277140849;10238.53926573306;10320.690379288633;10342.482875856178;10347.223958203165;10043.899561004442;10309.48452577383;10310.587576496857;10324.967503249614;10325.63860264887;7932.16712245206;8108.472949258279;8128.187181281824;8144.918550814416;8155.388345874083;4940.950590494049;5566.801113560202;5628.662280263197;5640.097584386478;5766.913496297643;9441.527923603655;9455.858162127435;9572.32993690435;9572.377795443273;9635.325527213028;8507.447015943944;8608.09614990417;9521.523923803643;9581.089796469325;9610.27922905799;6581.703823327866;6826.761063362758;7081.256468070985;7209.134903811576;7398.186199517941;7919.524828510308;8013.8397232056195;8028.518288902685;8128;8145.063317718538;7170.820729481596;7266.843480326106;7319.5242309249725;7344.522606030805;7412.518186317872;7039.296070393125;7119.466040046914;7178.533395329287;7191.820204494929;7237.493375463667;6809.829754256183;6858.245592984668;6873.381395674413;6874.518783685294;6889.345512176335;3975.92048159041;4637.04940487206;4663.510331415153;4864.513548645107;4956.752162391938;4570.588647021784;4866;4888.682235654671;5054.721990290569;5126.615503837153 03:01:09 INFO - PROCESS | 1654 | |4;prototype.html;259.26886180969666;305.1927651362146;311.5202588014458;316.7102101577058;319.5127430668231;4919.385076865387;5445.754941027653;5594.9720251398785;5690.914636280454;5738.42615738426;4603.941093548486;5348.438413966536;5534.418886016971;5548.69482178481;5603.551715862732;3750.6061863504347;4236.237477254093;4249.235137675218;4272.9359059614135;4341.891452713676;4182.372644103379;4263.936040959388;4324.054175620968;4330.7086614173295;4338.8047537860875;4010.6390424861756;4072.755634661915;4237.512686041098;4271.893202669927;4276.636485898703;3405.523226748257;3809.085819403351;4275.0594869128745;4279.2083464559155;4360.993942786306;2747.697753247141;3590.838412271454;3612.349777040132;3631.2555926035366;3705.4997575327257;4584.885377865547;4862.708237505761;5481.232627432163;5507.944920550824;5523.8066667666435;4774.355462012619;4789.712617242976;4810.39870016248;4848.29699693546;4848.612111031109;4944.653874228806;5586.55307575393;5888.882222355529;5899.882002359972;5902.2327097477055;3064.9119562555193;3371.376295385337;4009.679225661969;4010.435929987307;4017.2969730297373;6120.693965301762;6166.167567378391;6172.475339596095;6173.2900716417735;6312.305646378894;3756.6431189037;3972.2849887020034;3989.3417586097967;4012.25773231953;4065.333213382499;3685.7051435885064;4096.487939007624;4110.157417729359;4111.9177616447505;4115.633510731342;4238.470191226097;4666.2572582617795;4798.23228283473;4853.247746599282;4864.124457597666;4869.780859861315;5670;5727.880684146892;5883.382244864228;5924.7037648118285;1151.948162332697;1215.295128825279;1231.858336291338;1253.6803115205746;1301.8242537257538;809.0978558906777;838.6330281641008;883.3595643158659;894.4454438248198;900.9684661036832;4613.892665760193;4860.857698440864;5106.897862042739;5300.681959082467;5351.919721204185;4763.571278584944;5078.492150784966;5356.3572371315695;5684.289463817023;5773.3072031356505;4819.927701084486;4966.975165124223;5301.575873930076;5317.7341132943975;5330.654512014778;2391.0316321889663;2845.193302253043;3000.444917690191;3050.664426913038;3079.2455848317304;5346.823698786338;5543.445655434424;5707.600467967285;5923.578341198081;6040.879182416327;5344.759485823147;5708.885822283614;5920.940790592039;5934.943504095394;5948.85127871798;5939.1982082420045;6002;6008.729607167688;6021.42796434338;6027.758889644453;5272.736363181903;5507.642003269774;5776.740046697824;5835.299764028344;5864.765409383577;4837.7581120943105;5258.632755483525;5351.785928562814;5497.587680924026;5569.303837020372;5259.815906443256;5290.497402746733;5354.055269601626;5569.931362460142;6084.787032453843;3506.526618906415;3522.5841503469333;3759.642833930772;3849.8845034649007;3851.268259030775;5632.774689012557;5668.659880407189;5726.656400615976;5782.132680098019;5841.299044114563;5714.228599129336;5819.592628515963;5909.497692696169;5918.697886464971;5952.119262205123;5435.755391007493;5517.36550296721;5657.43425657431;5939.703014849327;5950.583459157818;5337.893242135213;5515.262692251928;5738.254026976467;5750.654960702372;5833.766649333979;5641.830745077655;5917.85205369852;5955.27795128045;5960.761569537343;6004.639721616542;4496.8201271950065;5277.894442111059;5569.567149941824;5846.5615078870105;5867.471927526543 03:01:09 INFO - PROCESS | 1654 | |5;yui.html;569.2770181869024;663.8738639658465;719.5287086958044;757.2389748302954;806.568485860065;11363.772724545504;12351.567695130672;13528.255945922983;13733.763961243487;13847;10897.673069807899;13320.666983325422;13392.06255562111;13397.330133493335;13399.999999999976;788.5781107107698;791.9881201781977;817.4400535633081;825.8183199696057;825.9669613215494;817.2318021060214;822.6544851162527;824.8515267251893;827.5903427803246;828.0766944856472;871.4292138649163;871.7341210930664;873.0178549132227;874.5802015032756;878.6968495868915;736.3078706016328;854.2994744309668;858.1590041759112;867.8611422172485;869.7782065573301;629.1255155334089;635.7425242776636;643.3373625166087;643.5077165968038;643.7811144210943;14150.716985660332;14158.787618185735;14166.29168541579;14231.573052808433;14242.857571424256;13129.638323161827;13321;13405.46378144873;13543.713347231997;13594.38825252866;11119.888801111967;11301.208915375926;11360.091192704647;11383.26008809433;11663.241889277255;3472.5832900052155;3617.782933024027;3621.529201203853;3633.6729694327373;3634.218642991743;89043;90636.18727625477;91186;91583.54208228983;92052;10201.132903703268;10346.741331466774;10380.688579342632;10431.5827366906;10457.11114555256;20086.59826803456;20144.697829532568;20162.395128146178;20184.19263229484;20435.4891127723;7456.067991501062;7458.776236712907;7495.287947644965;7509.849803003909;7589.620518974029;4180.7909604519655;4182.895427614334;4220.831166753295;4235.894102647459;4276.743395396286;3344.2141096842224;3441.587009558819;3455.6026057003264;3461.5846098468346;3463.1688394785574;575.8992176369119;618.7648693496533;624.0327492386782;624.5284809968535;635.237714742311;641.7657554992394;649.8602800397937;653.2030922274818;657.3196741372657;686.7356067913889;9041.321900857462;9176.6788162414;9263.397879137834;9349.158575728217;9511.524423778783;568.3577557360156;619.4827319188438;622.4677900395187;654.1267408010265;667.853072324088;4329.458817647794;4470.150671372428;4514.81940722374;4549.45406551216;4555.772211389483;115138;116231;116562;117051.05066069479;117956.23065654023;99248;99321.50339248257;99616.50191748995;101517;104683.4765826166;86356;87396.56301718578;87729.56135219283;88365;88652.11347886438;8586.411513869954;8874.156955089256;8914.687985920462;8932.86600700977;9116.088391161096;55681.72159139178;58269.70865145647;58864.23407297788;58952.70523647354;59888.70055649694;75778.48443030998;80497;82891.5855420719;84910.57544712236;84967;10692.465376731288;11180;11356.091512679131;11385.316880987168;11413.258138221321;9605.47169905662;10602.886696897023;11400.372979486208;12096.398441604664;12336.259824410565;9021.548922553977;10297.661304030427;11525.538978440769;11593.18847680688;12467.688307792378;11728.648140555797;11980.700482488008;12026.819597706217;12093.818592721293;12134.817977730165;11169.553217871195;11461.713457163638;11789.705257368634;11811.409429528661;12345.753084938071;9757.89175460119;10115.59537618487;10345.120664743581;10385.480725963822;10404.791904161722;9731.270154738282;10269.229807764297;10280.742981425525;10304.381737095799;10376.221783366429 03:01:09 INFO - PROCESS | 1654 | __end_tp_report 03:01:09 INFO - PROCESS | 1654 | __start_cc_report 03:01:09 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,363 03:01:09 INFO - PROCESS | 1654 | __end_cc_report 03:01:09 INFO - PROCESS | 1654 | __startTimestamp1480158069962__endTimestamp 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | ------- Summary: start ------- 03:01:09 INFO - PROCESS | 1654 | Number of tests: 6 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5829.97 Median:6100.00 stddev:634.79 (10.4%) stddev-sans-first:607.55 03:01:09 INFO - PROCESS | 1654 | Values: 3404.5 3415.6 3427.3 3432.6 3454.1 5880.9 5890.1 5947.3 5962.2 5971.3 5949.0 5971.8 5974.2 6009.8 6015.9 5359.0 5359.1 5398.6 5430.5 5435.7 5417.3 5428.8 5432.8 5436.6 5474.5 5279.9 5285.7 5441.0 5451.1 5477.8 5296.1 5318.4 5333.2 5344.3 5352.6 5243.3 5317.4 5377.9 5378.1 5383.0 4957.9 5998.2 6024.3 6060.9 6087.7 6154.3 6172.9 6176.1 6234.8 6264.7 6287.6 6296.9 6300.3 6306.3 6309.3 6057.7 6070.9 6081.5 6093.5 6100.0 6167.2 6204.0 6217.9 6231.7 6241.6 6125.9 6140.5 6207.7 6207.8 6216.9 6222.7 6239.2 6251.2 6269.6 6282.7 5037.3 5787.3 6114.0 6219.4 6226.9 6177.9 6219.3 6231.5 6249.8 6261.6 4436.7 4890.4 5015.7 5017.2 5024.9 4452.4 4480.5 4530.4 4541.6 4564.0 5790.9 6027.5 6098.1 6138.8 6145.3 5787.5 5791.4 6259.3 6272.4 6277.0 5917.1 5949.5 5985.3 6025.9 6136.1 4958.8 5419.6 5489.1 5526.4 5537.7 6323.0 6351.7 6379.1 6383.0 6410.4 6119.2 6214.6 6226.8 6260.0 6280.8 6273.5 6370.3 6383.8 6387.7 6580.5 6240.1 6246.8 6256.2 6261.0 6293.6 5154.8 6085.5 6239.0 6265.0 6265.7 6124.3 6126.2 6205.6 6214.7 6222.8 6223.8 6233.1 6258.7 6287.4 6298.4 6026.6 6051.4 6105.8 6212.6 6220.8 6095.1 6141.9 6144.9 6230.9 6249.1 6045.2 6089.5 6130.4 6131.6 6189.0 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:71885.42 Median:39750.20 stddev:159313.15 (400.8%) stddev-sans-first:159669.85 03:01:09 INFO - PROCESS | 1654 | Values: 477.1 511.3 511.7 514.7 544.0 32657.5 38546.8 40577.0 40867.6 40913.8 41190.2 41379.6 41560.8 41679.4 41759.2 9338.3 9475.0 9478.7 9483.6 9497.4 9309.1 9375.2 9382.1 9385.7 9417.6 9395.2 9400.5 9403.3 9443.2 9443.9 9328.3 9362.0 9404.9 9434.8 9435.1 9338.3 9364.0 9426.4 9446.7 9455.1 39134.0 39368.4 39441.2 39579.4 39590.8 3136.7 3322.3 3330.9 3333.5 3352.3 25066.1 26796.9 27200.7 27348.0 28425.3 3162.9 3229.1 3244.4 3254.9 3259.3 515799.0 517052.0 524716.0 525141.0 526187.4 51615.5 53256.0 61446.4 61865.0 61925.0 63429.4 63858.0 64336.0 64445.7 64486.0 16143.6 16167.1 16307.6 16329.4 16429.0 12627.6 12632.6 12638.1 12640.1 12653.4 18104.8 18609.4 18824.9 18843.6 18986.2 3150.6 3251.4 6611.0 7180.3 7413.0 834.3 841.0 880.2 978.5 1051.4 25266.0 29152.6 30258.7 30458.2 30898.2 1037.1 1056.6 1070.0 1101.1 1194.1 15380.5 15505.2 15610.3 15914.9 16000.8 642737.0 643227.0 645286.0 647847.0 650087.0 57297.4 57506.0 57969.4 58077.7 58400.0 1339.0 1358.4 1371.1 1372.7 1375.5 29032.1 29750.6 29856.1 29967.1 30314.5 50262.7 50593.5 50622.2 50758.0 50833.0 609553.0 610010.0 611607.0 612243.0 614695.0 26057.9 26296.0 26500.9 26523.7 26568.5 44554.7 45061.5 45156.3 45368.3 45413.5 38282.0 38324.4 40025.6 40456.4 41736.0 37426.3 38496.0 38864.0 39539.0 39909.6 34647.8 37699.0 38571.0 38627.8 38710.6 33087.8 34081.7 34303.7 34756.4 34760.1 24027.9 24101.9 24261.4 24352.5 24392.0 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35562.86 Median:2742.67 stddev:105860.59 (3859.8%) stddev-sans-first:106124.47 03:01:09 INFO - PROCESS | 1654 | Values: 310.9 371.0 379.8 384.4 399.9 13457.6 15410.6 20072.9 20245.8 20300.9 11513.4 16918.9 17798.6 18443.0 18605.9 5144.6 5379.4 5405.8 5406.4 5468.9 5279.9 5348.4 5634.4 5955.2 6002.0 5994.8 6022.3 6032.1 6036.1 6045.4 5889.6 5923.9 5954.3 6039.3 6048.5 5245.2 5852.8 5857.1 5861.1 5879.6 12726.0 13218.0 13261.0 13302.3 13303.0 2046.9 2261.3 2354.2 2477.4 3008.0 9678.2 9861.0 10029.0 10115.2 10244.8 1752.9 1817.6 1827.1 1889.2 1913.3 120059.2 122957.2 125769.0 132220.3 132893.3 11282.6 11636.8 11775.8 11994.9 11999.1 14800.3 14837.3 14851.6 14874.6 14899.9 8269.3 8386.9 8572.2 8683.8 8703.9 8380.0 8418.3 8455.4 8631.3 8641.7 3789.5 4442.9 4598.7 4629.9 4653.2 1893.4 1931.6 1940.6 1949.2 1956.8 834.6 960.0 974.4 983.9 992.2 14946.9 19819.0 19932.0 20701.9 20910.9 911.2 923.3 930.8 940.5 952.8 8733.0 10435.2 10839.3 10908.6 10909.3 623179.0 630292.0 630326.0 633843.0 647532.0 109954.0 114770.9 139604.0 145791.8 150386.0 842.8 863.7 877.6 920.7 996.6 15607.7 15756.9 16771.3 18910.7 18956.6 30109.0 35562.8 38355.2 54259.2 54368.5 82387.0 84139.0 84427.2 84664.0 84920.0 6990.3 6991.9 7456.4 7457.3 7723.6 10430.9 12237.9 12729.7 12829.9 13229.1 10945.8 10983.2 11060.3 11167.4 11193.7 10642.3 10695.0 10815.0 10888.5 10977.0 10395.7 11183.4 11251.6 11281.8 11288.4 7361.2 7426.5 7549.9 7555.1 7555.8 10571.8 10814.3 11025.9 11066.8 11439.5 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5462.97 Median:5123.33 stddev:2999.27 (58.5%) stddev-sans-first:2992.65 03:01:09 INFO - PROCESS | 1654 | Values: 1467.1 1498.3 1640.8 1650.9 1698.4 7573.9 7850.6 8104.8 8527.1 8547.1 8070.8 8380.2 8406.2 8500.0 8517.0 2343.2 2362.9 2366.2 2368.1 2380.9 2365.1 2389.6 2405.7 2417.9 2426.0 2350.7 2370.2 2375.9 2384.8 2388.7 2333.4 2341.8 2372.5 2373.5 2375.7 2370.1 2376.5 2381.1 2396.9 2404.0 8198.8 8283.5 8309.6 8310.0 8345.6 5061.8 5239.8 5252.6 5256.3 5260.5 2993.9 3488.7 3592.4 3619.3 3632.3 1073.5 1081.4 1104.1 1119.9 1128.3 11017.9 11067.4 11091.4 11129.4 11152.1 4271.7 4470.9 4500.1 4534.6 4550.3 8564.5 8703.8 8717.0 8719.1 8738.0 5122.6 5124.1 5125.1 5131.4 5138.8 3952.4 4297.0 4418.9 4755.4 4762.4 3277.3 3711.2 3738.8 3824.6 3831.4 1147.5 1172.3 1173.4 1176.4 1176.9 782.7 895.7 898.0 917.7 919.3 5775.0 5831.2 5853.6 5940.9 6150.8 897.1 906.5 913.3 925.3 987.9 3163.4 3358.9 3721.1 3865.8 4017.4 9514.9 10238.5 10320.7 10342.5 10347.2 10043.9 10309.5 10310.6 10325.0 10325.6 7932.2 8108.5 8128.2 8144.9 8155.4 4941.0 5566.8 5628.7 5640.1 5766.9 9441.5 9455.9 9572.3 9572.4 9635.3 8507.4 8608.1 9521.5 9581.1 9610.3 6581.7 6826.8 7081.3 7209.1 7398.2 7919.5 8013.8 8028.5 8128.0 8145.1 7170.8 7266.8 7319.5 7344.5 7412.5 7039.3 7119.5 7178.5 7191.8 7237.5 6809.8 6858.2 6873.4 6874.5 6889.3 3975.9 4637.0 4663.5 4864.5 4956.8 4570.6 4866.0 4888.7 5054.7 5126.6 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4650.56 Median:5301.13 stddev:1450.35 (27.4%) stddev-sans-first:1416.47 03:01:09 INFO - PROCESS | 1654 | Values: 259.3 305.2 311.5 316.7 319.5 4919.4 5445.8 5595.0 5690.9 5738.4 4603.9 5348.4 5534.4 5548.7 5603.6 3750.6 4236.2 4249.2 4272.9 4341.9 4182.4 4263.9 4324.1 4330.7 4338.8 4010.6 4072.8 4237.5 4271.9 4276.6 3405.5 3809.1 4275.1 4279.2 4361.0 2747.7 3590.8 3612.3 3631.3 3705.5 4584.9 4862.7 5481.2 5507.9 5523.8 4774.4 4789.7 4810.4 4848.3 4848.6 4944.7 5586.6 5888.9 5899.9 5902.2 3064.9 3371.4 4009.7 4010.4 4017.3 6120.7 6166.2 6172.5 6173.3 6312.3 3756.6 3972.3 3989.3 4012.3 4065.3 3685.7 4096.5 4110.2 4111.9 4115.6 4238.5 4666.3 4798.2 4853.2 4864.1 4869.8 5670.0 5727.9 5883.4 5924.7 1151.9 1215.3 1231.9 1253.7 1301.8 809.1 838.6 883.4 894.4 901.0 4613.9 4860.9 5106.9 5300.7 5351.9 4763.6 5078.5 5356.4 5684.3 5773.3 4819.9 4967.0 5301.6 5317.7 5330.7 2391.0 2845.2 3000.4 3050.7 3079.2 5346.8 5543.4 5707.6 5923.6 6040.9 5344.8 5708.9 5920.9 5934.9 5948.9 5939.2 6002.0 6008.7 6021.4 6027.8 5272.7 5507.6 5776.7 5835.3 5864.8 4837.8 5258.6 5351.8 5497.6 5569.3 5259.8 5290.5 5354.1 5569.9 6084.8 3506.5 3522.6 3759.6 3849.9 3851.3 5632.8 5668.7 5726.7 5782.1 5841.3 5714.2 5819.6 5909.5 5918.7 5952.1 5435.8 5517.4 5657.4 5939.7 5950.6 5337.9 5515.3 5738.3 5750.7 5833.8 5641.8 5917.9 5955.3 5960.8 6004.6 4496.8 5277.9 5569.6 5846.6 5867.5 03:01:09 INFO - PROCESS | 1654 | 03:01:09 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:21029.03 Median:4532.14 stddev:31901.14 (703.9%) stddev-sans-first:31953.64 03:01:09 INFO - PROCESS | 1654 | Values: 569.3 663.9 719.5 757.2 806.6 11363.8 12351.6 13528.3 13733.8 13847.0 10897.7 13320.7 13392.1 13397.3 13400.0 788.6 792.0 817.4 825.8 826.0 817.2 822.7 824.9 827.6 828.1 871.4 871.7 873.0 874.6 878.7 736.3 854.3 858.2 867.9 869.8 629.1 635.7 643.3 643.5 643.8 14150.7 14158.8 14166.3 14231.6 14242.9 13129.6 13321.0 13405.5 13543.7 13594.4 11119.9 11301.2 11360.1 11383.3 11663.2 3472.6 3617.8 3621.5 3633.7 3634.2 89043.0 90636.2 91186.0 91583.5 92052.0 10201.1 10346.7 10380.7 10431.6 10457.1 20086.6 20144.7 20162.4 20184.2 20435.5 7456.1 7458.8 7495.3 7509.8 7589.6 4180.8 4182.9 4220.8 4235.9 4276.7 3344.2 3441.6 3455.6 3461.6 3463.2 575.9 618.8 624.0 624.5 635.2 641.8 649.9 653.2 657.3 686.7 9041.3 9176.7 9263.4 9349.2 9511.5 568.4 619.5 622.5 654.1 667.9 4329.5 4470.2 4514.8 4549.5 4555.8 115138.0 116231.0 116562.0 117051.1 117956.2 99248.0 99321.5 99616.5 101517.0 104683.5 86356.0 87396.6 87729.6 88365.0 88652.1 8586.4 8874.2 8914.7 8932.9 9116.1 55681.7 58269.7 58864.2 58952.7 59888.7 75778.5 80497.0 82891.6 84910.6 84967.0 10692.5 11180.0 11356.1 11385.3 11413.3 9605.5 10602.9 11400.4 12096.4 12336.3 9021.5 10297.7 11525.5 11593.2 12467.7 11728.6 11980.7 12026.8 12093.8 12134.8 11169.6 11461.7 11789.7 11811.4 12345.8 9757.9 10115.6 10345.1 10385.5 10404.8 9731.3 10269.2 10280.7 10304.4 10376.2 03:01:09 INFO - PROCESS | 1654 | -------- Summary: end -------- 03:01:09 INFO - PROCESS | 1654 | 03:01:10 INFO - TEST-INFO | 1654: exit 0 03:01:10 INFO - TEST-OK | dromaeo_css | took 1117473ms 03:01:10 INFO - TEST-START | kraken 03:01:10 INFO - operating with platform_type : mac_ 03:01:10 INFO - Initialising browser for kraken test... 03:01:10 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmptwX9N3/profile http://localhost:49243/getInfo.html) 03:01:13 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 03:01:13 INFO - PROCESS | 1661 | colorDepth:24 03:01:13 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 03:01:13 INFO - PROCESS | 1661 | __metrics 03:01:13 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:01:14 INFO - TEST-INFO | 1661: exit 0 03:01:14 INFO - Browser initialized. 03:01:14 INFO - Running cycle 1/1 for kraken test... 03:01:14 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmptwX9N3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:26 INFO - PROCESS | 1664 | RSS: Main: 229875712 03:01:26 INFO - PROCESS | 1664 | 03:01:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:30 INFO - PROCESS | 1664 | RSS: Main: 241815552 03:01:30 INFO - PROCESS | 1664 | 03:01:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 03:01:33 INFO - PROCESS | 1664 | RSS: Main: 249384960 03:01:33 INFO - PROCESS | 1664 | 03:01:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 03:01:38 INFO - PROCESS | 1664 | RSS: Main: 251015168 03:01:38 INFO - PROCESS | 1664 | 03:01:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 03:01:40 INFO - PROCESS | 1664 | RSS: Main: 253677568 03:01:40 INFO - PROCESS | 1664 | 03:01:42 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:01:43 INFO - PROCESS | 1664 | RSS: Main: 254107648 03:01:43 INFO - PROCESS | 1664 | 03:01:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 03:01:46 INFO - PROCESS | 1664 | RSS: Main: 258494464 03:01:46 INFO - PROCESS | 1664 | 03:01:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 03:01:50 INFO - PROCESS | 1664 | RSS: Main: 257937408 03:01:50 INFO - PROCESS | 1664 | 03:01:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 03:01:54 INFO - PROCESS | 1664 | RSS: Main: 258248704 03:01:54 INFO - PROCESS | 1664 | 03:01:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:01:56 INFO - PROCESS | 1664 | RSS: Main: 257155072 03:01:56 INFO - PROCESS | 1664 | 03:01:58 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:01:58 INFO - PROCESS | 1664 | RSS: Main: 257212416 03:01:58 INFO - PROCESS | 1664 | 03:02:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:02:01 INFO - PROCESS | 1664 | RSS: Main: 257613824 03:02:01 INFO - PROCESS | 1664 | 03:02:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:02:05 INFO - PROCESS | 1664 | RSS: Main: 257302528 03:02:05 INFO - PROCESS | 1664 | 03:02:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:02:08 INFO - PROCESS | 1664 | RSS: Main: 257384448 03:02:08 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 03:02:10 INFO - PROCESS | 1664 | RSS: Main: 259022848 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | __start_tp_report 03:02:10 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 03:02:10 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 03:02:10 INFO - PROCESS | 1664 | |i|pagename|runs| 03:02:10 INFO - PROCESS | 1664 | |0;ai-astar;109;121;119;119;118;119;121;109;119;121 03:02:10 INFO - PROCESS | 1664 | |1;audio-beat-detection;148;116;115;154;142;151;101;152;132;147 03:02:10 INFO - PROCESS | 1664 | |2;audio-dft;201;194;195;184;273;259;200;270;198;201 03:02:10 INFO - PROCESS | 1664 | |3;audio-fft;76;58;58;81;60;62;60;59;76;59 03:02:10 INFO - PROCESS | 1664 | |4;audio-oscillator;85;103;122;80;70;71;87;69;69;89 03:02:10 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;104;88;90;89;91;101;91;89;90;88 03:02:10 INFO - PROCESS | 1664 | |6;imaging-darkroom;99;101;101;139;168;99;100;99;99;115 03:02:10 INFO - PROCESS | 1664 | |7;imaging-desaturate;89;89;90;94;136;86;144;141;100;136 03:02:10 INFO - PROCESS | 1664 | |8;json-parse-financial;55;55;56;60;60;58;58;59;60;60 03:02:10 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;69;63;75;75;77;88;76;64;72;103 03:02:10 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;84;86;84;89;88;89;90;91;89;80 03:02:10 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;146;147;147;156;152;159;151;168;221;187 03:02:10 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;173;164;204;218;170;168;171;169;169;169 03:02:10 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;70;66;69;69;68;69;68;66;68;67 03:02:10 INFO - PROCESS | 1664 | __end_tp_report 03:02:10 INFO - PROCESS | 1664 | __start_cc_report 03:02:10 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,983 03:02:10 INFO - PROCESS | 1664 | __end_cc_report 03:02:10 INFO - PROCESS | 1664 | __startTimestamp1480158130923__endTimestamp 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | ------- Summary: start ------- 03:02:10 INFO - PROCESS | 1664 | Number of tests: 14 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:117.50 Median:119.00 stddev:4.60 (3.9%) stddev-sans-first:3.71 03:02:10 INFO - PROCESS | 1664 | Values: 109.0 121.0 119.0 119.0 118.0 119.0 121.0 109.0 119.0 121.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:147.50 stddev:18.82 (12.8%) stddev-sans-first:19.44 03:02:10 INFO - PROCESS | 1664 | Values: 148.0 116.0 115.0 154.0 142.0 151.0 101.0 152.0 132.0 147.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:217.50 Median:201.00 stddev:34.91 (17.4%) stddev-sans-first:36.52 03:02:10 INFO - PROCESS | 1664 | Values: 201.0 194.0 195.0 184.0 273.0 259.0 200.0 270.0 198.0 201.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:64.90 Median:61.00 stddev:8.99 (14.7%) stddev-sans-first:8.59 03:02:10 INFO - PROCESS | 1664 | Values: 76.0 58.0 58.0 81.0 60.0 62.0 60.0 59.0 76.0 59.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:75.50 stddev:17.22 (22.8%) stddev-sans-first:18.26 03:02:10 INFO - PROCESS | 1664 | Values: 85.0 103.0 122.0 80.0 70.0 71.0 87.0 69.0 69.0 89.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:89.50 stddev:5.63 (6.3%) stddev-sans-first:3.99 03:02:10 INFO - PROCESS | 1664 | Values: 104.0 88.0 90.0 89.0 91.0 101.0 91.0 89.0 90.0 88.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:133.50 stddev:23.42 (17.5%) stddev-sans-first:24.36 03:02:10 INFO - PROCESS | 1664 | Values: 99.0 101.0 101.0 139.0 168.0 99.0 100.0 99.0 99.0 115.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:110.50 Median:87.50 stddev:25.12 (28.7%) stddev-sans-first:25.41 03:02:10 INFO - PROCESS | 1664 | Values: 89.0 89.0 90.0 94.0 136.0 86.0 144.0 141.0 100.0 136.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:59.50 stddev:2.08 (3.5%) stddev-sans-first:1.88 03:02:10 INFO - PROCESS | 1664 | Values: 55.0 55.0 56.0 60.0 60.0 58.0 58.0 59.0 60.0 60.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:75.00 stddev:11.80 (15.7%) stddev-sans-first:12.23 03:02:10 INFO - PROCESS | 1664 | Values: 69.0 63.0 75.0 75.0 77.0 88.0 76.0 64.0 72.0 103.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:89.00 stddev:3.43 (3.9%) stddev-sans-first:3.46 03:02:10 INFO - PROCESS | 1664 | Values: 84.0 86.0 84.0 89.0 88.0 89.0 90.0 91.0 89.0 80.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:163.40 Median:157.50 stddev:23.79 (15.1%) stddev-sans-first:24.39 03:02:10 INFO - PROCESS | 1664 | Values: 146.0 147.0 147.0 156.0 152.0 159.0 151.0 168.0 221.0 187.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:170.50 stddev:18.11 (10.6%) stddev-sans-first:19.13 03:02:10 INFO - PROCESS | 1664 | Values: 173.0 164.0 204.0 218.0 170.0 168.0 171.0 169.0 169.0 169.0 03:02:10 INFO - PROCESS | 1664 | 03:02:10 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.33 (1.9%) stddev-sans-first:1.20 03:02:10 INFO - PROCESS | 1664 | Values: 70.0 66.0 69.0 69.0 68.0 69.0 68.0 66.0 68.0 67.0 03:02:10 INFO - PROCESS | 1664 | -------- Summary: end -------- 03:02:10 INFO - PROCESS | 1664 | 03:02:11 INFO - TEST-INFO | 1664: exit 0 03:02:11 INFO - TEST-OK | kraken | took 61307ms 03:02:11 INFO - SUITE-END | took 1178s 03:02:12 INFO - Completed test suite (00:19:38) 03:02:12 INFO - javascript benchmark 03:02:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7186.6833040009, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3404.4893266010113, 3415.5559777228955, 3427.263138425238, 3432.5537680101584, 3454.0501362125406, 5880.882382352351, 5890.087036509342, 5947.316058653256, 5962.165296858432, 5971.283445986483, 5949.018411962021, 5971.761129554812, 5974.163617093611, 6009.75960961561, 6015.879682406349, 5359.0, 5359.08895487766, 5398.595105367093, 5430.511253987141, 5435.728213589325, 5417.349918009844, 5428.782848686048, 5432.837014889559, 5436.565074794027, 5474.534664553517, 5279.9208011879855, 5285.656432331886, 5441.020616289066, 5451.073317536008, 5477.808276710316, 5296.073187192226, 5318.388385335697, 5333.173358129496, 5344.251804747339, 5352.57179425645, 5243.2659427680155, 5317.388500322474, 5377.865553361158, 5378.112611419111, 5383.00414423329, 4957.900841983176, 5998.1602575639445, 6024.277086749618, 6060.878782424327, 6087.726052327612, 6154.323024467305, 6172.938270617281, 6176.135341052256, 6234.844128896769, 6264.749410023594, 6287.622742635456, 6296.87406251877, 6300.338464461257, 6306.274778400497, 6309.274433440121, 6057.697115144225, 6070.908936365958, 6081.452669259744, 6093.451589356979, 6100.0, 6167.229096362955, 6204.0, 6217.906731399033, 6231.657258850716, 6241.563090583706, 6125.944885418659, 6140.478059364915, 6207.689615519206, 6207.844803879939, 6216.937830621727, 6222.688865556704, 6239.157713708682, 6251.218597675291, 6269.5611307208055, 6282.717277722513, 5037.269595908573, 5787.305523337142, 6114.021756518936, 6219.378062193835, 6226.906596401058, 6177.938220617826, 6219.346968568326, 6231.470325022333, 6249.78125765596, 6261.624302541862, 4436.733795972252, 4890.364252647204, 5015.749212539358, 5017.247412888023, 5024.874378140503, 4452.354408610733, 4480.4623445186135, 4530.388397566287, 4541.636669066466, 4564.018735971782, 5790.855228619234, 6027.487663548647, 6098.14625952367, 6138.846528836725, 6145.293291271471, 5787.536997040227, 5791.449812267828, 6259.311475737665, 6272.40412160844, 6277.0, 5917.053271476543, 5949.524038076944, 5985.281766188085, 6025.9096113558335, 6136.079588061826, 4958.76030992252, 5419.566434685215, 5489.066858634042, 5526.392096869341, 5537.695426751487, 6322.999999999908, 6351.650659213788, 6379.106925030406, 6382.968085159545, 6410.358964103739, 6119.197913140417, 6214.5960512566535, 6226.782062627967, 6259.96870015647, 6280.811575652738, 6273.52948528853, 6370.267419246846, 6383.776567820104, 6387.744490220525, 6580.5064620152725, 6240.063990401476, 6246.843828904313, 6256.155419018556, 6260.968695156495, 6293.622382657055, 5154.768035438339, 6085.4523092921845, 6239.0, 6265.0, 6265.749370025148, 6124.2588809726185, 6126.181801870855, 6205.565610407409, 6214.658193799384, 6222.844428889314, 6223.751049957951, 6233.127362169391, 6258.655773932477, 6287.402696743802, 6298.401651843067, 6026.578139530191, 6051.394860513913, 6105.84735381619, 6212.627242365473, 6220.844478888064, 6095.085737139465, 6141.915626108588, 6144.880016394337, 6230.875382492415, 6249.125122482947, 6045.153678484928, 6089.512838972783, 6130.448259656652, 6131.590761709946, 6189.04069869171], "value": 5790.836314862669, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.098284242781, 511.2944137090814, 511.6904272914886, 514.66546744616, 543.9972800135998, 32657.51013734793, 38546.80726596367, 40577.0, 40867.59132408675, 40913.7954310228, 41190.17619647605, 41379.586204138024, 41560.79219603905, 41679.374809377885, 41759.16481670365, 9338.25293976482, 9474.952625236865, 9478.715638530855, 9483.620655173785, 9497.430154190735, 9309.069093090704, 9375.203107735852, 9382.061793820632, 9385.671501497449, 9417.576209070608, 9395.154436100784, 9400.482973436458, 9403.341766076377, 9443.244540436748, 9443.905560944371, 9328.300377471684, 9361.953190234039, 9404.858927116098, 9434.811303773955, 9435.05649435051, 9338.299627527962, 9363.953180234123, 9426.387284826533, 9446.716598502057, 9455.101765332283, 39134.0, 39368.409473857915, 39441.21117577633, 39579.40630890539, 39590.802045989585, 3136.7176954074243, 3322.318924620471, 3330.8667653293837, 3333.4833100869405, 3352.2960178362327, 25066.122685705912, 26796.928122875062, 27200.727992720018, 27348.0, 28425.289367765763, 3162.936741265162, 3229.1281354034513, 3244.4160051190775, 3254.869805207789, 3259.3481303739345, 515799.0, 517052.0, 524716.0, 525141.0, 526187.3690631561, 51615.48384516182, 53256.0, 61446.385536144066, 61865.0, 61925.0, 63429.36570634327, 63858.0421293681, 64336.0, 64445.67777161178, 64486.0, 16143.596410089842, 16167.110808905389, 16307.59231019234, 16329.428470003493, 16429.0, 12627.5580354689, 12632.621021369374, 12638.05214608908, 12640.11519193666, 12653.430595623218, 18104.77095053711, 18609.44171674852, 18824.905875470537, 18843.623127537372, 18986.240550377832, 3150.5904232449634, 3251.365983633169, 6611.008348747726, 7180.281971802882, 7412.96293518529, 834.2866848844272, 840.9915900840913, 880.2341962492673, 978.5400861595039, 1051.4374809476892, 25266.0, 29152.562711559345, 30258.697413026028, 30458.238544036132, 30898.22754431112, 1037.113268155731, 1056.5932116135189, 1070.0155856611937, 1101.058594901364, 1194.1223200947297, 15380.538583842503, 15505.224738763016, 15610.29753661088, 15914.92042539803, 16000.839991599934, 642737.0, 643227.0, 645286.0, 647847.0, 650087.0, 57297.427025730045, 57506.0, 57969.42030579725, 58077.70961145252, 58400.0, 1339.0, 1358.3887250737207, 1371.060823336018, 1372.7117305365784, 1375.5254437219144, 29032.12903612895, 29750.553741694326, 29856.10431687053, 29967.100986970425, 30314.545281821232, 50262.74868625634, 50593.494065058876, 50622.2406663893, 50758.0, 50833.0, 609553.0, 610010.0, 611607.0, 612243.0, 614695.0, 26057.869710652085, 26296.0, 26500.867495662398, 26523.673816309492, 26568.468630626892, 44554.662523528925, 45061.549384505735, 45156.32265516085, 45368.31947520856, 45413.54586454093, 38282.0, 38324.42513362246, 40025.59974400335, 40456.39315410212, 41736.0, 37426.31581578781, 38496.03759906025, 38864.02839929024, 39539.0, 39909.60090399059, 34647.82676086603, 37699.0, 38571.0, 38627.80686096552, 38710.612893870704, 33087.84192553249, 34081.65918340884, 34303.65696343005, 34756.43596038235, 34760.13099672528, 24027.879860600584, 24101.91541380607, 24261.393465163514, 24352.51294974126, 24392.0], "value": 19629.802635255946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.9005118362124, 370.96846768024716, 379.7987066854567, 384.4118498696991, 399.9461419160511, 13457.596272111829, 15410.61473463164, 20072.89963550182, 20245.797542024575, 20300.89849550754, 11513.424328783549, 16918.900271482344, 17798.555036124104, 18443.0, 18605.906970465163, 5144.61415393846, 5379.408265090837, 5405.7567409466665, 5406.378266499344, 5468.91796623051, 5279.868003299929, 5348.3849357323825, 5634.436556344353, 5955.166276721263, 6001.9699901500435, 5994.760209591611, 6022.337542870281, 6032.125341825433, 6036.094585812141, 6045.425684559959, 5889.64662120272, 5923.904077745631, 5954.285485741717, 6039.275286965549, 6048.516118710492, 5245.239440281176, 5852.824415267549, 5857.062869940789, 5861.120831875211, 5879.617824841372, 12726.0, 13218.0, 13261.0, 13302.268375239359, 13303.0, 2046.9078891449772, 2261.2650888461153, 2354.2466410748566, 2477.355887469253, 3007.9800523427984, 9678.17735492484, 9861.013898610081, 10029.047240512213, 10115.241356898263, 10244.846327305022, 1752.896524170987, 1817.6273863857878, 1827.0955876840917, 1889.2254175787998, 1913.320771126258, 120059.19911201339, 122957.15564266543, 125769.0, 132220.33889830587, 132893.33553332268, 11282.605108821315, 11636.825447618292, 11775.823362649568, 11994.88005119955, 11999.145897577244, 14800.333984970703, 14837.258137093102, 14851.628709282139, 14874.628134296512, 14899.851001490064, 8269.338452923752, 8386.87419688705, 8572.228499435081, 8683.782905427288, 8703.912960870437, 8379.95810020946, 8418.284445822052, 8455.408121431563, 8631.266342360845, 8641.697540586176, 3789.5452545694693, 4442.933355999663, 4598.747068911242, 4629.907401851944, 4653.162430762495, 1893.3657224829835, 1931.58470928751, 1940.5536726552689, 1949.152118828286, 1956.7847536770944, 834.5978755690377, 960.0, 974.4153507895206, 983.9065288797552, 992.1963209800085, 14946.925265373604, 19819.0, 19932.00339982995, 20701.89649051745, 20910.895445522674, 911.2345629671108, 923.2752289452748, 930.8225095254509, 940.5156344482597, 952.7713348796377, 8732.956335218283, 10435.217358698128, 10839.295445795999, 10908.563657453771, 10909.290896091887, 623179.0, 630292.0, 630326.0, 633843.0, 647532.0, 109954.0, 114770.85229147768, 139604.0, 145791.81312280113, 150386.0, 842.7808769719917, 863.684755064397, 877.5612193902921, 920.6777627830206, 996.6063404955003, 15607.687846242785, 15756.92121539385, 16771.32914683448, 18910.716339255196, 18956.620867582296, 30109.0, 35562.82218588891, 38355.232895342495, 54259.18611220756, 54368.45631543634, 82387.0, 84139.0, 84427.15572844193, 84664.0, 84920.0, 6990.300969902969, 6991.930080699128, 7456.440766942609, 7457.291557302047, 7723.5752033636445, 10430.895691043295, 12237.938810305892, 12729.745405092031, 12829.93585032069, 13229.140105893086, 10945.781084378426, 10983.231173817756, 11060.336379817236, 11167.441627918734, 11193.66419007431, 10642.255042146975, 10695.0, 10815.0, 10888.510017049093, 10977.0, 10395.688129356131, 11183.384913829492, 11251.606193783178, 11281.830772538255, 11288.363187337625, 7361.153467351109, 7426.517276377018, 7549.886751698838, 7555.055618047744, 7555.773326800205, 10571.841422378824, 10814.29707069038, 11025.889741102486, 11066.778664426505, 11439.485223165144], "value": 9173.103520191384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.075742282362, 1498.2658497336306, 1640.7702921590972, 1650.8844380893336, 1698.3885801111599, 7573.886391704115, 7850.646720897559, 8104.756857294283, 8527.104654011333, 8547.145285471457, 8070.757877263677, 8380.245777879989, 8406.159384061591, 8500.0, 8517.0, 2343.2033108743026, 2362.9291121266306, 2366.183666635017, 2368.12379419615, 2380.9285721428387, 2365.1485465232504, 2389.64155376694, 2405.7113146422453, 2417.891194896234, 2425.9757402425926, 2350.7296660883962, 2370.182287110944, 2375.9406014849683, 2384.844985075973, 2388.6775285336516, 2333.3583264602203, 2341.800946919514, 2372.466195106096, 2373.549025685123, 2375.655529948165, 2370.134900761227, 2376.512814872947, 2381.142788596104, 2396.928092157238, 2404.038384646138, 8198.754037378889, 8283.50298982057, 8309.584520773997, 8309.95845020777, 8345.582720863933, 5061.822836200752, 5239.79040838366, 5252.6323157379, 5256.316678831766, 5260.500252476008, 2993.925151871199, 3488.7383446241633, 3592.3713350163616, 3619.348517266891, 3632.291703117893, 1073.5169173871789, 1081.3836113415357, 1104.1498046504228, 1119.9160062995227, 1128.2722643894724, 11017.944910275477, 11067.446627668583, 11091.389973551451, 11129.443527823576, 11152.052075573585, 4271.743695378225, 4470.882279430142, 4500.099980004013, 4534.614557762561, 4550.34020067095, 8564.48613083217, 8703.825923481494, 8717.0, 8719.12808719123, 8737.956310218535, 5122.590192784568, 5124.077666020152, 5125.077486052546, 5131.384233891957, 5138.845834624967, 3952.4071389291835, 4296.957030429656, 4418.911621767546, 4755.358026666425, 4762.404699412574, 3277.311764529428, 3711.183539621279, 3738.794366309879, 3824.5601755797884, 3831.386978083549, 1147.5065721739732, 1172.261475270574, 1173.4484792147678, 1176.4294317256295, 1176.8881956214145, 782.7377828427541, 895.713371721043, 897.9730608081768, 917.7017469322496, 919.3197034194782, 5775.0, 5831.2127862738835, 5853.619514731528, 5940.8811823764145, 6150.7847225346895, 897.0894542039835, 906.4968942237122, 913.2693844924167, 925.3476299209042, 987.9209663226925, 3163.3831402876676, 3358.882439114619, 3721.1255354992095, 3865.8260378283044, 4017.417474466186, 9514.857277140849, 10238.53926573306, 10320.690379288633, 10342.482875856178, 10347.223958203165, 10043.899561004442, 10309.48452577383, 10310.587576496857, 10324.967503249614, 10325.63860264887, 7932.16712245206, 8108.472949258279, 8128.187181281824, 8144.918550814416, 8155.388345874083, 4940.950590494049, 5566.801113560202, 5628.662280263197, 5640.097584386478, 5766.913496297643, 9441.527923603655, 9455.858162127435, 9572.32993690435, 9572.377795443273, 9635.325527213028, 8507.447015943944, 8608.09614990417, 9521.523923803643, 9581.089796469325, 9610.27922905799, 6581.703823327866, 6826.761063362758, 7081.256468070985, 7209.134903811576, 7398.186199517941, 7919.524828510308, 8013.8397232056195, 8028.518288902685, 8128.0, 8145.063317718538, 7170.820729481596, 7266.843480326106, 7319.5242309249725, 7344.522606030805, 7412.518186317872, 7039.296070393125, 7119.466040046914, 7178.533395329287, 7191.820204494929, 7237.493375463667, 6809.829754256183, 6858.245592984668, 6873.381395674413, 6874.518783685294, 6889.345512176335, 3975.92048159041, 4637.04940487206, 4663.510331415153, 4864.513548645107, 4956.752162391938, 4570.588647021784, 4866.0, 4888.682235654671, 5054.721990290569, 5126.615503837153], "value": 4429.952217439306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.26886180969666, 305.1927651362146, 311.5202588014458, 316.7102101577058, 319.5127430668231, 4919.385076865387, 5445.754941027653, 5594.9720251398785, 5690.914636280454, 5738.42615738426, 4603.941093548486, 5348.438413966536, 5534.418886016971, 5548.69482178481, 5603.551715862732, 3750.6061863504347, 4236.237477254093, 4249.235137675218, 4272.9359059614135, 4341.891452713676, 4182.372644103379, 4263.936040959388, 4324.054175620968, 4330.7086614173295, 4338.8047537860875, 4010.6390424861756, 4072.755634661915, 4237.512686041098, 4271.893202669927, 4276.636485898703, 3405.523226748257, 3809.085819403351, 4275.0594869128745, 4279.2083464559155, 4360.993942786306, 2747.697753247141, 3590.838412271454, 3612.349777040132, 3631.2555926035366, 3705.4997575327257, 4584.885377865547, 4862.708237505761, 5481.232627432163, 5507.944920550824, 5523.8066667666435, 4774.355462012619, 4789.712617242976, 4810.39870016248, 4848.29699693546, 4848.612111031109, 4944.653874228806, 5586.55307575393, 5888.882222355529, 5899.882002359972, 5902.2327097477055, 3064.9119562555193, 3371.376295385337, 4009.679225661969, 4010.435929987307, 4017.2969730297373, 6120.693965301762, 6166.167567378391, 6172.475339596095, 6173.2900716417735, 6312.305646378894, 3756.6431189037, 3972.2849887020034, 3989.3417586097967, 4012.25773231953, 4065.333213382499, 3685.7051435885064, 4096.487939007624, 4110.157417729359, 4111.9177616447505, 4115.633510731342, 4238.470191226097, 4666.2572582617795, 4798.23228283473, 4853.247746599282, 4864.124457597666, 4869.780859861315, 5670.0, 5727.880684146892, 5883.382244864228, 5924.7037648118285, 1151.948162332697, 1215.295128825279, 1231.858336291338, 1253.6803115205746, 1301.8242537257538, 809.0978558906777, 838.6330281641008, 883.3595643158659, 894.4454438248198, 900.9684661036832, 4613.892665760193, 4860.857698440864, 5106.897862042739, 5300.681959082467, 5351.919721204185, 4763.571278584944, 5078.492150784966, 5356.3572371315695, 5684.289463817023, 5773.3072031356505, 4819.927701084486, 4966.975165124223, 5301.575873930076, 5317.7341132943975, 5330.654512014778, 2391.0316321889663, 2845.193302253043, 3000.444917690191, 3050.664426913038, 3079.2455848317304, 5346.823698786338, 5543.445655434424, 5707.600467967285, 5923.578341198081, 6040.879182416327, 5344.759485823147, 5708.885822283614, 5920.940790592039, 5934.943504095394, 5948.85127871798, 5939.1982082420045, 6002.0, 6008.729607167688, 6021.42796434338, 6027.758889644453, 5272.736363181903, 5507.642003269774, 5776.740046697824, 5835.299764028344, 5864.765409383577, 4837.7581120943105, 5258.632755483525, 5351.785928562814, 5497.587680924026, 5569.303837020372, 5259.815906443256, 5290.497402746733, 5354.055269601626, 5569.931362460142, 6084.787032453843, 3506.526618906415, 3522.5841503469333, 3759.642833930772, 3849.8845034649007, 3851.268259030775, 5632.774689012557, 5668.659880407189, 5726.656400615976, 5782.132680098019, 5841.299044114563, 5714.228599129336, 5819.592628515963, 5909.497692696169, 5918.697886464971, 5952.119262205123, 5435.755391007493, 5517.36550296721, 5657.43425657431, 5939.703014849327, 5950.583459157818, 5337.893242135213, 5515.262692251928, 5738.254026976467, 5750.654960702372, 5833.766649333979, 5641.830745077655, 5917.85205369852, 5955.27795128045, 5960.761569537343, 6004.639721616542, 4496.8201271950065, 5277.894442111059, 5569.567149941824, 5846.5615078870105, 5867.471927526543], "value": 4174.35902926093, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2770181869024, 663.8738639658465, 719.5287086958044, 757.2389748302954, 806.568485860065, 11363.772724545504, 12351.567695130672, 13528.255945922983, 13733.763961243487, 13847.0, 10897.673069807899, 13320.666983325422, 13392.06255562111, 13397.330133493335, 13399.999999999976, 788.5781107107698, 791.9881201781977, 817.4400535633081, 825.8183199696057, 825.9669613215494, 817.2318021060214, 822.6544851162527, 824.8515267251893, 827.5903427803246, 828.0766944856472, 871.4292138649163, 871.7341210930664, 873.0178549132227, 874.5802015032756, 878.6968495868915, 736.3078706016328, 854.2994744309668, 858.1590041759112, 867.8611422172485, 869.7782065573301, 629.1255155334089, 635.7425242776636, 643.3373625166087, 643.5077165968038, 643.7811144210943, 14150.716985660332, 14158.787618185735, 14166.29168541579, 14231.573052808433, 14242.857571424256, 13129.638323161827, 13321.0, 13405.46378144873, 13543.713347231997, 13594.38825252866, 11119.888801111967, 11301.208915375926, 11360.091192704647, 11383.26008809433, 11663.241889277255, 3472.5832900052155, 3617.782933024027, 3621.529201203853, 3633.6729694327373, 3634.218642991743, 89043.0, 90636.18727625477, 91186.0, 91583.54208228983, 92052.0, 10201.132903703268, 10346.741331466774, 10380.688579342632, 10431.5827366906, 10457.11114555256, 20086.59826803456, 20144.697829532568, 20162.395128146178, 20184.19263229484, 20435.4891127723, 7456.067991501062, 7458.776236712907, 7495.287947644965, 7509.849803003909, 7589.620518974029, 4180.7909604519655, 4182.895427614334, 4220.831166753295, 4235.894102647459, 4276.743395396286, 3344.2141096842224, 3441.587009558819, 3455.6026057003264, 3461.5846098468346, 3463.1688394785574, 575.8992176369119, 618.7648693496533, 624.0327492386782, 624.5284809968535, 635.237714742311, 641.7657554992394, 649.8602800397937, 653.2030922274818, 657.3196741372657, 686.7356067913889, 9041.321900857462, 9176.6788162414, 9263.397879137834, 9349.158575728217, 9511.524423778783, 568.3577557360156, 619.4827319188438, 622.4677900395187, 654.1267408010265, 667.853072324088, 4329.458817647794, 4470.150671372428, 4514.81940722374, 4549.45406551216, 4555.772211389483, 115138.0, 116231.0, 116562.0, 117051.05066069479, 117956.23065654023, 99248.0, 99321.50339248257, 99616.50191748995, 101517.0, 104683.4765826166, 86356.0, 87396.56301718578, 87729.56135219283, 88365.0, 88652.11347886438, 8586.411513869954, 8874.156955089256, 8914.687985920462, 8932.86600700977, 9116.088391161096, 55681.72159139178, 58269.70865145647, 58864.23407297788, 58952.70523647354, 59888.70055649694, 75778.48443030998, 80497.0, 82891.5855420719, 84910.57544712236, 84967.0, 10692.465376731288, 11180.0, 11356.091512679131, 11385.316880987168, 11413.258138221321, 9605.47169905662, 10602.886696897023, 11400.372979486208, 12096.398441604664, 12336.259824410565, 9021.548922553977, 10297.661304030427, 11525.538978440769, 11593.18847680688, 12467.688307792378, 11728.648140555797, 11980.700482488008, 12026.819597706217, 12093.818592721293, 12134.817977730165, 11169.553217871195, 11461.713457163638, 11789.705257368634, 11811.409429528661, 12345.753084938071, 9757.89175460119, 10115.59537618487, 10345.120664743581, 10385.480725963822, 10404.791904161722, 9731.270154738282, 10269.229807764297, 10280.742981425525, 10304.381737095799, 10376.221783366429], "value": 7144.370222965982, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 121.0, 119.0, 119.0, 118.0, 119.0, 121.0, 109.0, 119.0, 121.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 115.0, 154.0, 142.0, 151.0, 101.0, 152.0, 132.0, 147.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 194.0, 195.0, 184.0, 273.0, 259.0, 200.0, 270.0, 198.0, 201.0], "value": 217.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 58.0, 58.0, 81.0, 60.0, 62.0, 60.0, 59.0, 76.0, 59.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 103.0, 122.0, 80.0, 70.0, 71.0, 87.0, 69.0, 69.0, 89.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 88.0, 90.0, 89.0, 91.0, 101.0, 91.0, 89.0, 90.0, 88.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 101.0, 139.0, 168.0, 99.0, 100.0, 99.0, 99.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 94.0, 136.0, 86.0, 144.0, 141.0, 100.0, 136.0], "value": 110.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 60.0, 60.0, 58.0, 58.0, 59.0, 60.0, 60.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 75.0, 75.0, 77.0, 88.0, 76.0, 64.0, 72.0, 103.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 89.0, 88.0, 89.0, 90.0, 91.0, 89.0, 80.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 156.0, 152.0, 159.0, 151.0, 168.0, 221.0, 187.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 164.0, 204.0, 218.0, 170.0, 168.0, 171.0, 169.0, 169.0, 169.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 69.0, 69.0, 68.0, 69.0, 68.0, 66.0, 68.0, 67.0], "value": 68.0, "unit": "score"}]}]} 03:02:12 INFO - Return code: 0 03:02:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:02:12 ERROR - # TBPL SUCCESS # 03:02:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:02:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:02:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:02:12 INFO - 2016-11-26 03:02:12.269 screenresolution[1669:14766] starting screenresolution argv=screenresolution get 03:02:12 INFO - 2016-11-26 03:02:12.272 screenresolution[1669:14766] Display 0: 1600x1200x32@60 03:02:12 INFO - 2016-11-26 03:02:12.278 screenresolution[1670:14769] starting screenresolution argv=screenresolution list 03:02:12 INFO - Available Modes on Display 0 03:02:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:02:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:02:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:02:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:02:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:02:12 INFO - Intel Iris: 03:02:12 INFO - Chipset Model: Intel Iris 03:02:12 INFO - Type: GPU 03:02:12 INFO - Bus: Built-In 03:02:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:02:12 INFO - Vendor: Intel (0x8086) 03:02:12 INFO - Device ID: 0x0a2e 03:02:12 INFO - Revision ID: 0x0009 03:02:12 INFO - Displays: 03:02:12 INFO - Display: 03:02:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:02:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:02:12 INFO - Display Serial Number: 1600x1200 60 03:02:12 INFO - Main Display: Yes 03:02:12 INFO - Mirror: Off 03:02:12 INFO - Online: Yes 03:02:12 INFO - Rotation: Supported 03:02:12 INFO - Return code: 0 03:02:12 INFO - Running post-action listener: _resource_record_post_action 03:02:12 INFO - [mozharness: 2016-11-26 11:02:12.519297Z] Finished run-tests step (success) 03:02:12 INFO - Running post-run listener: _resource_record_post_run 03:02:12 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32222208; Write bytes: 660572160; Read time: 197; Write time: 1913 03:02:12 INFO - TinderboxPrint: CPU usage
54.5% 03:02:12 INFO - TinderboxPrint: I/O read bytes / time
32,222,208 / 197 03:02:12 INFO - TinderboxPrint: I/O write bytes / time
660,572,160 / 1,913 03:02:12 INFO - TinderboxPrint: CPU idle
2,204.3 (45.5%) 03:02:12 INFO - TinderboxPrint: CPU system
982.9 (20.3%) 03:02:12 INFO - TinderboxPrint: CPU user
1,654.4 (34.2%) 03:02:12 INFO - TinderboxPrint: Swap in / out
376,340,480 / 0 03:02:12 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 349338112; Write bytes: 352499712; Read time: 26790; Write time: 755 03:02:12 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29076480; Write bytes: 306671616; Read time: 173; Write time: 1152 03:02:13 INFO - Running post-run listener: _upload_blobber_files 03:02:13 INFO - Blob upload gear active. 03:02:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:02:13 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 03:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:02:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:14 INFO - (blobuploader) - INFO - Done attempting. 03:02:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:02:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:15 INFO - (blobuploader) - INFO - Done attempting. 03:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:17 INFO - (blobuploader) - INFO - Done attempting. 03:02:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:02:17 INFO - Return code: 0 03:02:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:02:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:02:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39e6eea21f8d9b9e01f073edd743e1c2c9758135d9ce2512897b84537f5b34899ae8f7712c6fef9da4c35153f0d9d149396eb9c30a60302e48d0a8813ed6d77d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bba234517df5390f3ed5ede9b53c64dbe1a26033412aeda8f8fad81c68012daae5ef6ae2e04fb3788352f6c5a5f4fdd64baf2380ed7d5c20066259c6cde7456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63fbd7ccfcdb0633aac4f2d1c3bc5a786cbf2b6f071f7576164bf594cdf98961f03b09f5448e1c31a7ea95a45f4139c28794658c6ed860b3e8bb2b3c84c26e22"} 03:02:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:02:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:02:17 INFO - Contents: 03:02:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39e6eea21f8d9b9e01f073edd743e1c2c9758135d9ce2512897b84537f5b34899ae8f7712c6fef9da4c35153f0d9d149396eb9c30a60302e48d0a8813ed6d77d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bba234517df5390f3ed5ede9b53c64dbe1a26033412aeda8f8fad81c68012daae5ef6ae2e04fb3788352f6c5a5f4fdd64baf2380ed7d5c20066259c6cde7456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63fbd7ccfcdb0633aac4f2d1c3bc5a786cbf2b6f071f7576164bf594cdf98961f03b09f5448e1c31a7ea95a45f4139c28794658c6ed860b3e8bb2b3c84c26e22"} 03:02:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:02:17 INFO - Copying logs to upload dir... 03:02:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:02:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.117199 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-26 03:02:17.777331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 03:02:17.781362) ========= 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.WyhCf2ajy2/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.iwb97QDHjc/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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/Mozilla-Aurora/sha512/39e6eea21f8d9b9e01f073edd743e1c2c9758135d9ce2512897b84537f5b34899ae8f7712c6fef9da4c35153f0d9d149396eb9c30a60302e48d0a8813ed6d77d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bba234517df5390f3ed5ede9b53c64dbe1a26033412aeda8f8fad81c68012daae5ef6ae2e04fb3788352f6c5a5f4fdd64baf2380ed7d5c20066259c6cde7456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63fbd7ccfcdb0633aac4f2d1c3bc5a786cbf2b6f071f7576164bf594cdf98961f03b09f5448e1c31a7ea95a45f4139c28794658c6ed860b3e8bb2b3c84c26e22"} build_url:https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/KenOEgEtSb2s_6x5GDoghw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39e6eea21f8d9b9e01f073edd743e1c2c9758135d9ce2512897b84537f5b34899ae8f7712c6fef9da4c35153f0d9d149396eb9c30a60302e48d0a8813ed6d77d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bba234517df5390f3ed5ede9b53c64dbe1a26033412aeda8f8fad81c68012daae5ef6ae2e04fb3788352f6c5a5f4fdd64baf2380ed7d5c20066259c6cde7456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63fbd7ccfcdb0633aac4f2d1c3bc5a786cbf2b6f071f7576164bf594cdf98961f03b09f5448e1c31a7ea95a45f4139c28794658c6ed860b3e8bb2b3c84c26e22"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 03:02:17.823356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:02:17.823989) ========= 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.WyhCf2ajy2/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.iwb97QDHjc/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.004684 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:02:17.876582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 03:02:17.877292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 03:02:17.877985) ========= ========= Total master_lag: 0.30 =========