builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0021 starttime: 1476460737.83 results: success (0) buildid: 20161014060324 builduid: cc12e163b33e4b2fb41aa379f63cd7aa revision: 0c899672fff6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:57.830638) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:57.831117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:57.831393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:57.854633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:57.855141) ========= 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.KqZMMH71wB/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.atm9LOprg4/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-14 08:58:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2016-10-14 08:58:57 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:58.021821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:58.022237) ========= 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.KqZMMH71wB/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.atm9LOprg4/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.018065 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:58.070842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 08:58:58.071201) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c899672fff6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0c899672fff6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KqZMMH71wB/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.atm9LOprg4/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-14 08:58:58,139 Setting DEBUG logging. 2016-10-14 08:58:58,139 attempt 1/10 2016-10-14 08:58:58,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c899672fff6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 08:58:59,358 unpacking tar archive at: mozilla-central-0c899672fff6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.774996 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 08:58:59.871829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:59.872672) ========= script_repo_revision: 0c899672fff6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:59.873173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:59.873480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 08:58:59.892080) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-14 08:58:59.892696) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KqZMMH71wB/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.atm9LOprg4/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:00 INFO - MultiFileLogger online at 20161014 08:59:00 in /builds/slave/test 08:59:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:59:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:00 INFO - {'append_to_log': False, 08:59:00 INFO - 'base_work_dir': '/builds/slave/test', 08:59:00 INFO - 'blob_upload_branch': 'Firefox', 08:59:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:00 INFO - 'branch': 'Firefox', 08:59:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:00 INFO - 'config_files': ('talos/mac_config.py',), 08:59:00 INFO - 'default_actions': ('clobber', 08:59:00 INFO - 'read-buildbot-config', 08:59:00 INFO - 'download-and-extract', 08:59:00 INFO - 'populate-webroot', 08:59:00 INFO - 'create-virtualenv', 08:59:00 INFO - 'install', 08:59:00 INFO - 'run-tests'), 08:59:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:00 INFO - 'download_minidump_stackwalk': True, 08:59:00 INFO - 'download_symbols': 'ondemand', 08:59:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:00 INFO - 'installer_path': 'installer.exe', 08:59:00 INFO - 'log_level': 'info', 08:59:00 INFO - 'log_name': 'talos', 08:59:00 INFO - 'log_to_console': True, 08:59:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:59:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:59:00 INFO - 'opt_config_files': (), 08:59:00 INFO - 'pip_index': False, 08:59:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:00 INFO - 'cmd': ('bash', 08:59:00 INFO - '-c', 08:59:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:00 INFO - 'enabled': True, 08:59:00 INFO - 'halt_on_failure': False, 08:59:00 INFO - 'name': 'check_screen_resolution'},), 08:59:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:00 INFO - 'cmd': ('bash', 08:59:00 INFO - '-c', 08:59:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:00 INFO - 'enabled': True, 08:59:00 INFO - 'halt_on_failure': False, 08:59:00 INFO - 'name': 'check_screen_resolution'},), 08:59:00 INFO - 'run_cmd_checks_enabled': True, 08:59:00 INFO - 'sps_profile': False, 08:59:00 INFO - 'sps_profile_interval': 0, 08:59:00 INFO - 'suite': 'dromaeojs', 08:59:00 INFO - 'system_bits': '32', 08:59:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:00 INFO - 'title': 't-yosemite-r7-0021', 08:59:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:00 INFO - 'use_talos_json': True, 08:59:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:00 INFO - 'work_dir': 'build'} 08:59:00 INFO - [mozharness: 2016-10-14 15:59:00.093986Z] Running clobber step. 08:59:00 INFO - Running pre-action listener: _resource_record_pre_action 08:59:00 INFO - Running main action method: clobber 08:59:00 INFO - rmtree: /builds/slave/test/build 08:59:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:01 INFO - Running post-action listener: _resource_record_post_action 08:59:01 INFO - [mozharness: 2016-10-14 15:59:01.615812Z] Finished clobber step (success) 08:59:01 INFO - [mozharness: 2016-10-14 15:59:01.616006Z] Running read-buildbot-config step. 08:59:01 INFO - Running pre-action listener: _resource_record_pre_action 08:59:01 INFO - Running main action method: read_buildbot_config 08:59:01 INFO - Using buildbot properties: 08:59:01 INFO - { 08:59:01 INFO - "project": "", 08:59:01 INFO - "product": "firefox", 08:59:01 INFO - "script_repo_revision": "production", 08:59:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:59:01 INFO - "repository": "", 08:59:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:59:01 INFO - "buildid": "20161014060324", 08:59:01 INFO - "stage_platform": "macosx64", 08:59:01 INFO - "basedir": "/builds/slave/test", 08:59:01 INFO - "nightly_build": "True", 08:59:01 INFO - "buildnumber": 3, 08:59:01 INFO - "slavename": "t-yosemite-r7-0021", 08:59:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:59:01 INFO - "platform": "yosemite_r7", 08:59:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:59:01 INFO - "branch": "mozilla-central", 08:59:01 INFO - "repo_path": "mozilla-central", 08:59:01 INFO - "revision": "0c899672fff6", 08:59:01 INFO - "pgo_build": "False", 08:59:01 INFO - "builduid": "cc12e163b33e4b2fb41aa379f63cd7aa", 08:59:01 INFO - "slavebuilddir": "test" 08:59:01 INFO - } 08:59:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:59:01 INFO - Running post-action listener: _resource_record_post_action 08:59:01 INFO - [mozharness: 2016-10-14 15:59:01.619530Z] Finished read-buildbot-config step (success) 08:59:01 INFO - [mozharness: 2016-10-14 15:59:01.619663Z] Running download-and-extract step. 08:59:01 INFO - Running pre-action listener: _resource_record_pre_action 08:59:01 INFO - Running main action method: download_and_extract 08:59:01 INFO - mkdir: /builds/slave/test/build/tests 08:59: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')]} 08:59:01 INFO - trying https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:59:01 INFO - Downloading https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 08:59:02 INFO - Downloaded 1199 bytes. 08:59:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:59:02 INFO - Using the following test package requirements: 08:59:02 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:59:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:59:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:59:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'jsshell-mac.zip'], 08:59:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:59:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:59:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:59:02 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:59:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:59:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:59:02 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:59:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:59:03 INFO - Http code: 200 08:59:03 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 08:59:03 INFO - x-amz-cf-id: Yd78Z1IKiQ9VzDJEW9CbBHh5vs5fru888V0sVJeh_NT7RYyY1GX0fw== 08:59:03 INFO - x-amz-version-id: 79ar5oblkmkwB3Af44h7LN7Jip16BziA 08:59:03 INFO - Expected file size: 16517006 08:59:03 INFO - Obtained file size: 16517006 08:59:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:59:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:59:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:59:10 INFO - Fetch https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:59:10 INFO - Http code: 200 08:59:10 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 08:59:10 INFO - x-amz-cf-id: bPkbLGuUUK4I9ytpBVMKxhxlraf_L0VluIwOi-n8GwKP99t6oD4PyA== 08:59:10 INFO - x-amz-version-id: 79ar5oblkmkwB3Af44h7LN7Jip16BziA 08:59:11 INFO - Expected file size: 16517006 08:59:11 INFO - Obtained file size: 16517006 08:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:59:18 INFO - Http code: 200 08:59:18 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 08:59:18 INFO - x-amz-cf-id: NyEDKs80ZBk8z9Ooce-UmTwJNDQj9noCpNfNhWYcsaYh5qC70sSoUQ== 08:59:18 INFO - x-amz-version-id: OIPIrHjIm5KxO3dATVMP10W.973hhzKI 08:59:18 INFO - Expected file size: 14409006 08:59:18 INFO - Obtained file size: 14409006 08:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:18 INFO - trying https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:59:18 INFO - Downloading https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 08:59:21 INFO - Downloaded 112078794 bytes. 08:59:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:59:21 INFO - mkdir: /builds/slave/test/properties 08:59:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:21 INFO - Contents: 08:59:21 INFO - build_url:https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:59:22 INFO - Running post-action listener: _resource_record_post_action 08:59:22 INFO - Running post-action listener: set_extra_try_arguments 08:59:22 INFO - [mozharness: 2016-10-14 15:59:22.235039Z] Finished download-and-extract step (success) 08:59:22 INFO - [mozharness: 2016-10-14 15:59:22.235177Z] Running populate-webroot step. 08:59:22 INFO - Running pre-action listener: _resource_record_pre_action 08:59:22 INFO - Running main action method: populate_webroot 08:59:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:22 INFO - '--tppagecycles', 08:59:22 INFO - '7'], 08:59:22 INFO - 'tests': ['tsvgm']}}, 08:59:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['damp', 'tps']}, 08:59:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'tests': ['damp', 'tps']}, 08:59:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['dromaeo_dom']}, 08:59:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['basic_compositor_video']}, 08:59:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tsvgx', 08:59:22 INFO - 'tsvgr_opacity', 08:59:22 INFO - 'tart', 08:59:22 INFO - 'tscrollx', 08:59:22 INFO - 'cart']}, 08:59:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:22 INFO - 'tsvgr_opacity', 08:59:22 INFO - 'tart', 08:59:22 INFO - 'tscrollx', 08:59:22 INFO - 'cart']}, 08:59:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tp5o']}, 08:59:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'tests': ['tp5o']}, 08:59:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s', 08:59:22 INFO - '--xperf_path', 08:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:22 INFO - 'tests': ['tp5n']}, 08:59:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:22 INFO - 'talos_options': ['--xperf_path', 08:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:22 INFO - 'tests': ['tp5n']}}, 08:59:22 INFO - 'talos.zip': {'path': '', 08:59:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:22 INFO - Running post-action listener: _resource_record_post_action 08:59:22 INFO - [mozharness: 2016-10-14 15:59:22.253948Z] Finished populate-webroot step (success) 08:59:22 INFO - [mozharness: 2016-10-14 15:59:22.254060Z] Running create-virtualenv step. 08:59:22 INFO - Running pre-action listener: _resource_record_pre_action 08:59:22 INFO - Running main action method: create_virtualenv 08:59:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:22 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 08:59:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:22 INFO - Using real prefix '/tools/python27' 08:59:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:25 INFO - Installing pip.................done. 08:59:25 INFO - Return code: 0 08:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:26 INFO - Reading from file tmpfile_stdout 08:59:26 INFO - Output received: 08:59:26 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) 08:59:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:26 INFO - 'HOME': '/Users/cltbld', 08:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:26 INFO - 'LOGNAME': 'cltbld', 08:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:26 INFO - 'MOZ_NO_REMOTE': '1', 08:59:26 INFO - 'NO_EM_RESTART': '1', 08:59:26 INFO - 'PAGER': '/bin/cat', 08:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:26 INFO - 'PWD': '/builds/slave/test', 08:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:26 INFO - 'SHELL': '/bin/bash', 08:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:26 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:26 INFO - 'USER': 'cltbld', 08:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:26 INFO - 'XPC_FLAGS': '0x0', 08:59:26 INFO - 'XPC_SERVICE_NAME': '0', 08:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:26 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 08:59:26 INFO - Cleaning up... 08:59:26 INFO - Return code: 0 08:59:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:26 INFO - 'HOME': '/Users/cltbld', 08:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:26 INFO - 'LOGNAME': 'cltbld', 08:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:26 INFO - 'MOZ_NO_REMOTE': '1', 08:59:26 INFO - 'NO_EM_RESTART': '1', 08:59:26 INFO - 'PAGER': '/bin/cat', 08:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:26 INFO - 'PWD': '/builds/slave/test', 08:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:26 INFO - 'SHELL': '/bin/bash', 08:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:26 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:26 INFO - 'USER': 'cltbld', 08:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:26 INFO - 'XPC_FLAGS': '0x0', 08:59:26 INFO - 'XPC_SERVICE_NAME': '0', 08:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:26 INFO - Downloading/unpacking psutil>=3.1.1 08:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:30 INFO - Installing collected packages: psutil 08:59:30 INFO - Running setup.py install for psutil 08:59:30 INFO - building 'psutil._psutil_osx' extension 08:59:30 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 08:59:30 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 08:59:30 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 08:59:30 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 08:59:30 INFO - building 'psutil._psutil_posix' extension 08:59:30 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 08:59:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:59:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:59:30 INFO - ^ 08:59:30 INFO - 1 warning generated. 08:59:30 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 08:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:30 INFO - Successfully installed psutil 08:59:30 INFO - Cleaning up... 08:59:30 INFO - Return code: 0 08:59:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:59: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 mozsystemmonitor==0.3 08:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:30 INFO - 'HOME': '/Users/cltbld', 08:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:30 INFO - 'LOGNAME': 'cltbld', 08:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:30 INFO - 'MOZ_NO_REMOTE': '1', 08:59:30 INFO - 'NO_EM_RESTART': '1', 08:59:30 INFO - 'PAGER': '/bin/cat', 08:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:30 INFO - 'PWD': '/builds/slave/test', 08:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:30 INFO - 'SHELL': '/bin/bash', 08:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:30 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:30 INFO - 'USER': 'cltbld', 08:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:31 INFO - 'XPC_FLAGS': '0x0', 08:59:31 INFO - 'XPC_SERVICE_NAME': '0', 08:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:59:34 INFO - Installing collected packages: mozsystemmonitor 08:59:34 INFO - Running setup.py install for mozsystemmonitor 08:59:34 INFO - Successfully installed mozsystemmonitor 08:59:34 INFO - Cleaning up... 08:59:34 INFO - Return code: 0 08:59:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:59:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:35 INFO - 'HOME': '/Users/cltbld', 08:59:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:35 INFO - 'LOGNAME': 'cltbld', 08:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:35 INFO - 'MOZ_NO_REMOTE': '1', 08:59:35 INFO - 'NO_EM_RESTART': '1', 08:59:35 INFO - 'PAGER': '/bin/cat', 08:59:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:35 INFO - 'PWD': '/builds/slave/test', 08:59:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:35 INFO - 'SHELL': '/bin/bash', 08:59:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:35 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:35 INFO - 'USER': 'cltbld', 08:59:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:35 INFO - 'XPC_FLAGS': '0x0', 08:59:35 INFO - 'XPC_SERVICE_NAME': '0', 08:59:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:35 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 08:59:35 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 08:59:35 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 08:59:35 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 08:59:35 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 08:59:35 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 08:59:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:38 INFO - warning: no files found matching '*.txt' 08:59:38 INFO - no previously-included directories found matching 'build' 08:59:38 INFO - no previously-included directories found matching 'dist' 08:59:38 INFO - no previously-included directories found matching '.git*' 08:59:38 INFO - Installing collected packages: jsonschema, functools32 08:59:38 INFO - Running setup.py install for functools32 08:59:38 INFO - warning: no files found matching '*.txt' 08:59:38 INFO - no previously-included directories found matching 'build' 08:59:38 INFO - no previously-included directories found matching 'dist' 08:59:38 INFO - no previously-included directories found matching '.git*' 08:59:38 INFO - Successfully installed jsonschema functools32 08:59:38 INFO - Cleaning up... 08:59:38 INFO - Return code: 0 08:59:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:38 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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:38 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 08:59:38 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 08:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:38 INFO - 'HOME': '/Users/cltbld', 08:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:38 INFO - 'LOGNAME': 'cltbld', 08:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:38 INFO - 'MOZ_NO_REMOTE': '1', 08:59:38 INFO - 'NO_EM_RESTART': '1', 08:59:38 INFO - 'PAGER': '/bin/cat', 08:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:38 INFO - 'PWD': '/builds/slave/test', 08:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:38 INFO - 'SHELL': '/bin/bash', 08:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:38 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:38 INFO - 'USER': 'cltbld', 08:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:38 INFO - 'XPC_FLAGS': '0x0', 08:59:38 INFO - 'XPC_SERVICE_NAME': '0', 08:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:59:38 INFO - Cleaning up... 08:59:38 INFO - Return code: 0 08:59:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:38 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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:38 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 08:59:38 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 08:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:38 INFO - 'HOME': '/Users/cltbld', 08:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:38 INFO - 'LOGNAME': 'cltbld', 08:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:38 INFO - 'MOZ_NO_REMOTE': '1', 08:59:38 INFO - 'NO_EM_RESTART': '1', 08:59:38 INFO - 'PAGER': '/bin/cat', 08:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:38 INFO - 'PWD': '/builds/slave/test', 08:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:38 INFO - 'SHELL': '/bin/bash', 08:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:38 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:38 INFO - 'USER': 'cltbld', 08:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:38 INFO - 'XPC_FLAGS': '0x0', 08:59:38 INFO - 'XPC_SERVICE_NAME': '0', 08:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:38 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 08:59:38 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 08:59:38 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 08:59:38 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 08:59:38 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 08:59:38 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 08:59:41 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59: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 08:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 INFO - Downloading docopt-0.6.1.tar.gz 08:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:42 INFO - Running setup.py install for blobuploader 08:59:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:42 INFO - Running setup.py install for requests 08:59:43 INFO - Running setup.py install for docopt 08:59:43 INFO - Successfully installed blobuploader requests docopt 08:59:43 INFO - Cleaning up... 08:59:43 INFO - Return code: 0 08:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:43 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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:43 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 08:59:43 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 08:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:43 INFO - 'HOME': '/Users/cltbld', 08:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:43 INFO - 'LOGNAME': 'cltbld', 08:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:43 INFO - 'MOZ_NO_REMOTE': '1', 08:59:43 INFO - 'NO_EM_RESTART': '1', 08:59:43 INFO - 'PAGER': '/bin/cat', 08:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:43 INFO - 'PWD': '/builds/slave/test', 08:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:43 INFO - 'SHELL': '/bin/bash', 08:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:43 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:43 INFO - 'USER': 'cltbld', 08:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:43 INFO - 'XPC_FLAGS': '0x0', 08:59:43 INFO - 'XPC_SERVICE_NAME': '0', 08:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:43 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-GsjQaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:43 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-CPkeC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-IPQQKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-LwGBzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-n3vWV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-HVu50s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-yWMDdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-KsQnh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-MXinYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DTyYZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-vFi281-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:44 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-En14rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-7TYbYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-uz2_ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-dnVB7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-sjU1a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-xANcb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:45 INFO - Running setup.py install for manifestparser 08:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:45 INFO - Running setup.py install for mozcrash 08:59:45 INFO - Running setup.py install for mozdebug 08:59:46 INFO - Running setup.py install for mozdevice 08:59:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozfile 08:59:46 INFO - Running setup.py install for mozhttpd 08:59:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozinfo 08:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozInstall 08:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozleak 08:59:46 INFO - Running setup.py install for mozlog 08:59:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Running setup.py install for moznetwork 08:59:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Running setup.py install for mozprocess 08:59:47 INFO - Running setup.py install for mozprofile 08:59:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Running setup.py install for mozrunner 08:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Running setup.py install for mozscreenshot 08:59:47 INFO - Running setup.py install for moztest 08:59:48 INFO - Running setup.py install for mozversion 08:59:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:48 INFO - Cleaning up... 08:59:48 INFO - Return code: 0 08:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:48 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')]} 08:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:48 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')]} 08:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:48 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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:48 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 08:59:48 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 08:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:48 INFO - 'HOME': '/Users/cltbld', 08:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:48 INFO - 'LOGNAME': 'cltbld', 08:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:48 INFO - 'MOZ_NO_REMOTE': '1', 08:59:48 INFO - 'NO_EM_RESTART': '1', 08:59:48 INFO - 'PAGER': '/bin/cat', 08:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:48 INFO - 'PWD': '/builds/slave/test', 08:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:48 INFO - 'SHELL': '/bin/bash', 08:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:48 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:48 INFO - 'USER': 'cltbld', 08:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:48 INFO - 'XPC_FLAGS': '0x0', 08:59:48 INFO - 'XPC_SERVICE_NAME': '0', 08:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:48 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-faxcJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:48 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)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:48 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-2IhtzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:48 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-4tY0OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:48 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)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:48 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-oIctc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:48 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)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:48 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-SmXEp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-kdBODm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-iDXCfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-jK9Bl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-JRfG2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-KnHXp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-A_3txP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-GEbyTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-zdAZEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:49 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)) 08:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:49 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-nYQV7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:50 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-prDUCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:50 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)) 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:50 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-I_SM5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:50 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)) 08:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:50 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-FYp0_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:50 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)) 08:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:50 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)) 08:59:50 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)) 08:59:50 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)) 08:59:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:52 INFO - Downloading blessings-1.6.tar.gz 08:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:52 INFO - Installing collected packages: blessings 08:59:52 INFO - Running setup.py install for blessings 08:59:53 INFO - Successfully installed blessings 08:59:53 INFO - Cleaning up... 08:59:53 INFO - Return code: 0 08:59:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:53 INFO - Reading from file tmpfile_stdout 08:59:53 INFO - Current package versions: 08:59:53 INFO - blessings == 1.6 08:59:53 INFO - blobuploader == 1.2.4 08:59:53 INFO - docopt == 0.6.1 08:59:53 INFO - functools32 == 3.2.3-2 08:59:53 INFO - jsonschema == 2.5.1 08:59:53 INFO - manifestparser == 1.1 08:59:53 INFO - mozInstall == 1.12 08:59:53 INFO - mozcrash == 0.17 08:59:53 INFO - mozdebug == 0.1 08:59:53 INFO - mozdevice == 0.48 08:59:53 INFO - mozfile == 1.2 08:59:53 INFO - mozhttpd == 0.7 08:59:53 INFO - mozinfo == 0.9 08:59:53 INFO - mozleak == 0.1 08:59:53 INFO - mozlog == 3.4 08:59:53 INFO - moznetwork == 0.27 08:59:53 INFO - mozprocess == 0.23 08:59:53 INFO - mozprofile == 0.28 08:59:53 INFO - mozrunner == 6.12 08:59:53 INFO - mozscreenshot == 0.1 08:59:53 INFO - mozsystemmonitor == 0.3 08:59:53 INFO - moztest == 0.7 08:59:53 INFO - mozversion == 1.4 08:59:53 INFO - psutil == 3.1.1 08:59:53 INFO - requests == 1.2.3 08:59:53 INFO - wsgiref == 0.1.2 08:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:53 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')]} 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 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')]} 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:53 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 08:59:53 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 08:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:53 INFO - 'HOME': '/Users/cltbld', 08:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:53 INFO - 'LOGNAME': 'cltbld', 08:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:53 INFO - 'MOZ_NO_REMOTE': '1', 08:59:53 INFO - 'NO_EM_RESTART': '1', 08:59:53 INFO - 'PAGER': '/bin/cat', 08:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:53 INFO - 'PWD': '/builds/slave/test', 08:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:53 INFO - 'SHELL': '/bin/bash', 08:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:53 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:53 INFO - 'USER': 'cltbld', 08:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:53 INFO - 'XPC_FLAGS': '0x0', 08:59:53 INFO - 'XPC_SERVICE_NAME': '0', 08:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 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)) 08:59:53 INFO - Cleaning up... 08:59:53 INFO - Return code: 0 08:59:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:53 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')]} 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 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')]} 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:53 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 0x1066ee490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106664570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b79ce3880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, '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.KqZMMH71wB/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.atm9LOprg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 08:59:53 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 08:59:53 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 08:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 08:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:59:53 INFO - 'HOME': '/Users/cltbld', 08:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:59:53 INFO - 'LOGNAME': 'cltbld', 08:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:53 INFO - 'MOZ_NO_REMOTE': '1', 08:59:53 INFO - 'NO_EM_RESTART': '1', 08:59:53 INFO - 'PAGER': '/bin/cat', 08:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:53 INFO - 'PWD': '/builds/slave/test', 08:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:59:53 INFO - 'SHELL': '/bin/bash', 08:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 08:59:53 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 08:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:59:53 INFO - 'USER': 'cltbld', 08:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:53 INFO - 'XPC_FLAGS': '0x0', 08:59:53 INFO - 'XPC_SERVICE_NAME': '0', 08:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:59:53 INFO - Cleaning up... 08:59:53 INFO - Return code: 0 08:59:53 INFO - Running post-action listener: _resource_record_post_action 08:59:53 INFO - Running post-action listener: _start_resource_monitoring 08:59:53 INFO - Starting resource monitoring. 08:59:53 INFO - [mozharness: 2016-10-14 15:59:53.958010Z] Finished create-virtualenv step (success) 08:59:53 INFO - [mozharness: 2016-10-14 15:59:53.959046Z] Running install step. 08:59:53 INFO - Running pre-action listener: _resource_record_pre_action 08:59:53 INFO - Running main action method: install 08:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:54 INFO - Reading from file tmpfile_stdout 08:59:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:54 INFO - Reading from file tmpfile_stdout 08:59:54 INFO - Output received: 08:59:54 INFO - Usage: mozinstall [options] installer 08:59:54 INFO - Options: 08:59:54 INFO - -h, --help show this help message and exit 08:59:54 INFO - -d DEST, --destination=DEST 08:59:54 INFO - Directory to install application into. [default: 08:59:54 INFO - "/builds/slave/test"] 08:59:54 INFO - --app=APP Application being installed. [default: firefox] 08:59:54 INFO - mkdir: /builds/slave/test/build/application 08:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:00:29 INFO - Reading from file tmpfile_stdout 09:00:29 INFO - Output received: 09:00:29 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:00:29 INFO - Running post-action listener: _resource_record_post_action 09:00:29 INFO - [mozharness: 2016-10-14 16:00:29.618620Z] Finished install step (success) 09:00:29 INFO - [mozharness: 2016-10-14 16:00:29.618758Z] Running run-tests step. 09:00:29 INFO - Running pre-action listener: _resource_record_pre_action 09:00:29 INFO - Running main action method: run_tests 09:00:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:00:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:00:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:00:29 INFO - 2016-10-14 09:00:29.633 screenresolution[3119:47550] starting screenresolution argv=screenresolution get 09:00:29 INFO - 2016-10-14 09:00:29.635 screenresolution[3119:47550] Display 0: 1600x1200x32@60 09:00:29 INFO - 2016-10-14 09:00:29.641 screenresolution[3120:47552] starting screenresolution argv=screenresolution list 09:00:29 INFO - Available Modes on Display 0 09:00:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:00:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:00:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:00:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:00:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:00:29 INFO - Intel Iris: 09:00:29 INFO - Chipset Model: Intel Iris 09:00:29 INFO - Type: GPU 09:00:29 INFO - Bus: Built-In 09:00:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:00:29 INFO - Vendor: Intel (0x8086) 09:00:29 INFO - Device ID: 0x0a2e 09:00:29 INFO - Revision ID: 0x0009 09:00:29 INFO - Displays: 09:00:29 INFO - Display: 09:00:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:00:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:00:29 INFO - Display Serial Number: 1600x1200 60 09:00:29 INFO - Main Display: Yes 09:00:29 INFO - Mirror: Off 09:00:29 INFO - Online: Yes 09:00:29 INFO - Rotation: Supported 09:00:29 INFO - Return code: 0 09:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:29 INFO - Python 2.7.3 09:00:29 INFO - Return code: 0 09:00:29 INFO - grabbing minidump binary from tooltool 09:00:29 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')]} 09:00:29 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 0x106502d30>, '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 0x106328db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064fab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:29 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 09:00:29 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 09:00:29 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 09:00:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:30 INFO - Return code: 0 09:00:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:00:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:00:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:00:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KqZMMH71wB/Render', 09:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:30 INFO - 'HOME': '/Users/cltbld', 09:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:30 INFO - 'LOGNAME': 'cltbld', 09:00:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:30 INFO - 'MOZ_NO_REMOTE': '1', 09:00:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:30 INFO - 'NO_EM_RESTART': '1', 09:00:30 INFO - 'PAGER': '/bin/cat', 09:00:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:30 INFO - 'PWD': '/builds/slave/test', 09:00:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:30 INFO - 'SHELL': '/bin/bash', 09:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atm9LOprg4/Listeners', 09:00:30 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 09:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:30 INFO - 'USER': 'cltbld', 09:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:30 INFO - 'XPC_FLAGS': '0x0', 09:00:30 INFO - 'XPC_SERVICE_NAME': '0', 09:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:00:30 INFO - mozversion application_buildid: 20161014060324 09:00:30 INFO - mozversion application_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 09:00:30 INFO - mozversion application_display_name: Nightly 09:00:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:30 INFO - mozversion application_name: Firefox 09:00:30 INFO - mozversion application_remotingname: firefox 09:00:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:00:30 INFO - mozversion application_vendor: Mozilla 09:00:30 INFO - mozversion application_version: 52.0a1 09:00:30 INFO - mozversion platform_buildid: 20161014060324 09:00:30 INFO - mozversion platform_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 09:00:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:00:30 INFO - mozversion platform_version: 52.0a1 09:00:30 INFO - using testdate: 1476460830 09:00:30 INFO - actual date: 1476460830 09:00:30 INFO - starting webserver on 'localhost:61860' 09:00:30 INFO - SUITE-START | Running 2 tests 09:00:30 INFO - TEST-START | dromaeo_css 09:00:30 INFO - operating with platform_type : mac_ 09:00:30 INFO - Initialising browser for dromaeo_css test... 09:00:30 INFO - TEST-INFO | started process 3130 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmp62qV0f/profile http://localhost:61860/getInfo.html) 09:00:32 INFO - PROCESS | 3130 | __metrics Screen width/height:1600/1200 09:00:32 INFO - PROCESS | 3130 | colorDepth:24 09:00:32 INFO - PROCESS | 3130 | Browser inner width/height: 1024/689 09:00:32 INFO - PROCESS | 3130 | __metrics 09:00:32 INFO - PROCESS | 3130 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:00:32 INFO - PROCESS | 3130 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:33 INFO - TEST-INFO | 3130: exit 0 09:00:33 INFO - Browser initialized. 09:00:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:33 INFO - TEST-INFO | started process 3134 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmp62qV0f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:45 INFO - PROCESS | 3134 | RSS: Main: 239345664 09:00:45 INFO - PROCESS | 3134 | 09:01:37 INFO - PROCESS | 3134 | 1476460897021 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] 09:03:51 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:61860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61860/tests/dromaeo/cssquery-ext.html) 09:03:52 INFO - PROCESS | 3134 | RSS: Main: 409292800 09:03:52 INFO - PROCESS | 3134 | 09:06:55 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:61860/tests/dromaeo/cssquery-ext.html (next: http://localhost:61860/tests/dromaeo/cssquery-jquery.html) 09:06:56 INFO - PROCESS | 3134 | RSS: Main: 371183616 09:06:56 INFO - PROCESS | 3134 | 09:09:58 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:61860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61860/tests/dromaeo/cssquery-mootools.html) 09:09:59 INFO - PROCESS | 3134 | RSS: Main: 340983808 09:09:59 INFO - PROCESS | 3134 | 09:13:01 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:61860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61860/tests/dromaeo/cssquery-prototype.html) 09:13:02 INFO - PROCESS | 3134 | RSS: Main: 350449664 09:13:02 INFO - PROCESS | 3134 | 09:16:05 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:61860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61860/tests/dromaeo/cssquery-yui.html) 09:16:06 INFO - PROCESS | 3134 | RSS: Main: 333996032 09:16:06 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:61860/tests/dromaeo/cssquery-yui.html (next: http://localhost:61860/tests/dromaeo/cssquery-dojo.html) 09:19:09 INFO - PROCESS | 3134 | RSS: Main: 407126016 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | __start_tp_report 09:19:09 INFO - PROCESS | 3134 | _x_x_mozilla_page_load 09:19:09 INFO - PROCESS | 3134 | _x_x_mozilla_page_load_details 09:19:09 INFO - PROCESS | 3134 | |i|pagename|runs| 09:19:09 INFO - PROCESS | 3134 | |0;dojo.html;3307.7519186061045;3326.0354497195813;3333.9166520836975;3383.4079036168664;3408.60801007884;5584.581156413265;5662.037453632882;5679.7160141992945;5739.856503587413;5802.216700745393;4715.528447155283;5686.147077938301;5692.601517893749;5717.742701578429;5851.034579294422;5151.793928242866;5165.63840531163;5231.372235331746;5239.240310155025;5300.178472336794;5166.741662916858;5291.973540132294;5299.814506492274;5318.787248510074;5322.0952438085615;5241.109011468059;5255.395629502599;5287.206918962148;5296.576273898079;5350.384705758848;5150.253213284052;5162.12243918531;5196.45437229093;5225.790968361261;5234.398044224925;5182.714950677711;5184.300119483859;5217.58259339252;5253.106971814763;5294.549963253128;5625.128105143709;5631.2960879890015;5672.092465205588;5681.34664513578;5702.914456283159;6081.695915204266;6141.140240366352;6222.97320942044;6225.7509699611965;6227.1282020517165;6194.132821405007;6201.906971395432;6218.844528886769;6252.624842509418;6341.873162536724;5774.595778295563;5781.595288329777;5782.56630752691;5804.04233301509;5816.534677225812;5375.87106707588;6226.097215903668;6286.591371560834;6306.369363063657;6312;5941.138534912414;5997.190379298739;6012.819615411545;6017.06735456005;6135.294441139326;6221.626702397871;6226.034964580497;6250.96859018266;6255.781047663401;6260.874782504325;6188.412100850502;6192.845178870564;6208.689565521706;6208.782692605737;6218.31598524162;6021.939780602138;6080.391960803884;6109.969450152721;6247.156633854463;6271.498280137578;4841.176999910023;4861.95138048615;4864.318995340655;4871.050145221719;4876.926846097312;4346.6522678185665;4460.107978404332;4467.396901418332;4469.7988590513505;4476.932846007313;5644.802431914945;5695.7152142392715;5706.28671416073;5712.686362023387;5715.542756579547;6157.907631385533;6171.382861713882;6172.290186628596;6190.133381326618;6192.783252586228;5701.344345400332;5729.627574207663;5734.913976290359;5741.167530708108;5749.367569567345;5369;5390.326209223847;5397.460253974571;5410.675359478444;5412.864678383072;6282.639343936769;6316.684165791692;6327.58870673414;6345.206849143857;6345.4923606112325;6283.963146081029;6285.968570157303;6292.370762923854;6300.432961033529;6318.304986451579;6141.201643786279;6189.938100618936;6190.133381326528;6249.312575616587;6256.249250090018;6149.600275982047;6186.072089186658;6192.721327540181;6211.751529938751;6211.782587609412;6249.562530622813;6272.655003974825;6273.749050037947;6279.497640188865;6295.401936815995;4858.732769697559;5918.668299632548;5979.162917191509;5981.880362392815;6122.142899994094;5995.250593675791;6020.759169633166;6048.969755151196;6049.213602231682;6123.510119190365;5934.525237980864;5945.524358051259;5951;5953.315368732651;5999.040153575407;6090.908636370546;6131.785387511416;6138.63168209891;6141.385861413823;6147.723352449061;5793.797217097382;5817.360090390139;5849.912251316148;5935.732892019956;5952.523798096228 09:19:09 INFO - PROCESS | 3134 | |1;ext.html;476.1809687337779;505.6915281678178;522.3470661672909;522.9450907654697;530.9044372013036;22293.665595016068;31136.377272454538;40826;40890;40954.771356859266;40694;42868.35697464541;42972.78513607428;42972.78513607435;42996.78501607488;9469.526523673823;9653.565589548487;9667.178289845371;9673;9675.903240967606;9542.188913942324;9639.421634701941;9639.807203855918;9655.90344096557;9676.032396760304;9680.56437460316;9696.12734853863;9725.173360264385;9730.805383892319;9732.75668108296;8193.549354785484;9645.807083858319;9668.516574171334;9670.129688328014;9727.270454715854;9588.90411095887;9647.903520964841;9661.951690241574;9669.661561845302;9685.41887486753;40223.396649050286;40454;40512;40625.78122656325;40675.98310042272;3301.3892429900543;3339.96660033399;3363.276895467486;3375.932481350384;3379.746519011084;30153.547696784564;30758.692413075805;31060.378792424024;31095.37809243825;31375;3081.1218802641138;3092.567040614316;3103.487924492456;3105.1150422129585;3173.8889138880027;403496;486223.56888215686;487118;488045;500142;59906.70046649826;60193.699031505435;60198.39801602015;60356.69821650864;60400.39599603948;34333.65666343355;34974.65025349714;35286.47070293948;63230.36769632245;63300;15820.525384238492;16274.023558586287;16287.59281017984;16296.26666799997;16298.51104466868;12220.083493738006;12397.75204495905;12496.437660305308;12499.687507812378;12556.183848049848;15328.923355383151;18854.434366969013;19097.472202223787;19183.136758845885;19212.519687007658;7558.735444259424;7688;7745.457817952802;7763.767086987399;7834.921650783534;854.3891117850767;899.2131884600974;928.679605536089;990.960361585543;1016.3444578246989;21013.606862072724;29691.85154074259;30333.848330758647;31142.844285778425;31219;959.8704174936295;1013.3717095400751;1057.9206559508068;1059.3432072115338;1096.2271598523023;15199.316030778642;15211.771823422658;15290.617734556503;15359.462418815512;15680.92159539195;653363;656236.7188164028;658268;658518;659899;55695;56023;56039.439605603424;56232;56240.71879640576;1330.3348325837082;1361.1764882246296;1380.6548362909273;1381.6062422209823;1385.1135273425016;27534.449311013268;29235.269118272212;29299.267518312212;29951.55072673955;29956.95150669716;50023.74988125036;50559.49440505695;50617.74691126521;50619.49380506148;50724.23913641372;581949.1805081895;584424;584795;585454.0727296507;587121;25636;26033.869830650725;26438.603420949086;26530;27068.323291917073;45677.08645827131;45976.08047838957;46065.30902036405;47065.05869882651;47292.7635361821;36554.086147846516;38789.6121038786;39098.41352379773;39747.20505589814;40232;38430.423543646306;38798.4180237291;39453.605463944994;39978.80010599928;40386.59613403946;32050.839745802055;32833;37544;38640.806795965844;38854.028649283995;28700;31733.682663173073;33933.8123165688;34815.82592087024;35116.473252901735;20369.87965661903;23179.65230521577;24367.634485482376;24722.88747006353;25610.926688797463 09:19:09 INFO - PROCESS | 3134 | |2;jquery.html;372.3725522494595;373.87848949091546;378.9412641040638;392.8251927892089;402.51295931922374;18768.62462750746;20770.792292077076;21133.15467381305;21166.25918092867;21413;20370;21333;21426.57146857062;21661.91690415477;21966.560668786613;5743.856403589902;5755.884882302352;5960.254968128984;6011.068284415901;6015.187949626788;4122.711410201287;4357.150355680644;5876.76492940284;6019.638821670692;6023.548233882477;4306;4338.783060846961;6569.572977756455;6634.0712300278;6638.73445062197;5529.281193444826;5984.521238300969;6600.207975043001;6618.371254730793;6622.106015687893;5733.627314224562;5742.799002034951;5746.65520068793;5747.6551406915305;5769.365369809318;26183.476330473284;26709.73290267092;26795.464090718076;26825.195244142513;27093.864530677416;2269.897854596547;2293.7591552886875;2384.2727967969763;2638.8152829301957;2770.8476033818133;9819.165370943478;10288.537015834305;10332.535035923327;10418.531166097468;10439.791204175874;1461.6126726417508;1903.4955736729778;1937.5446770009037;1948.9656411228761;1971.0639479805645;118534;119672.40163799212;119726;122873;123595;9368.2973776967;11390;11578.942105289589;11582.204758262484;11718.589849355401;14628.707425851424;14631.707365852624;14662.853371466363;14675.633109172142;14681.77977330341;8268.545230012287;8433.536155511383;8442.788930276793;8457.915420845837;8625.223729864343;8258.958705206436;8278.71024514139;8462.345709859552;8481.575921203916;8513.872291915626;4397.912041759147;4507.549245075532;4530.728156310632;4592.15045216636;4636.334107887978;1625.5123462961064;1670.9749353759703;1826.8538516918616;1850.5836186858119;1902.73361729358;803.8753993131074;851.2976794144731;900.5587262241454;905.7961958559272;963.5808423335872;21027;21621.35135945924;21626.675599866016;21646.891765541073;21709.891450542647;893.9284857211537;966.1594412860856;970.834958057132;1016.7712264740375;1017.1405162637559;9517.5717092731;11322;11371.431428428545;11441.970222679998;11546.884531154748;553695.1674349247;588753;589609;596677;599254;120813.39593301977;121336;123544.38227808803;131590.34204828914;131932;935.5415846235431;979.8677178580942;984.242133557157;993.2600212841479;993.9304248702522;18888.716669250247;19496.122674479968;19533.023348832787;19572.8042719571;19646.312379066665;48087;50684.74657626688;53667.19499207437;53943;54190;73919;76396;78869.60565197137;79054;79974.20025799901;7614.8096297593;7757.2242775724235;7982.521048737094;8026.197380261927;8164.5917704115745;9073.682421115229;11826.645200643994;12480.126391152533;12732.299723515296;12933.870661293267;10844.132469402271;11006.679198496231;11157.442127893735;11211.327320360804;11305;10783.784324313627;10893.673189804318;11119.499622516845;11167.385793781095;11229.49467273991;10924.344539327665;11020.338779673246;11330.37682927447;11375.601853935073;11383.317000979967;7942.722004729807;7966.28303452692;8027.879581806161;8083.959580202061;8088.231617996281;7451.180370159386;7756.263155000266;7799.415043871846;9243.936947251152;11038.392888390894 09:19:09 INFO - PROCESS | 3134 | |3;mootools.html;1369.9383527741252;1403.9719205615881;1568.945086921958;1786.5890845105625;1981.0684582532033;7842.215778422155;8369.330453563707;8372.91627083729;8374.497530148195;8380.8742868857;8386.748397548068;8597.183267589584;8712.782180445492;8796.07641197673;8812.691555795549;2345.3667509772395;2381.9166329178483;2383.2016274548046;2384.2966324934187;2385.2367242482414;2345.155743932183;2381.749916258785;2384.308550520347;2404.4469771952463;2405.759424057589;2352.494213744045;2363.338265285714;2372.988135059331;2389.653500242464;2391.055533064447;2065.266830275261;2199.43914301852;2339.9064037438484;2344.6365813298967;2359.4101474631343;2329.277923843597;2346.5541547105995;2348.5302939412186;2352.423656204224;2354.1878052072007;8737.868931965962;8790.164934331227;8846.203841654218;8865.822683546357;8876.334274929342;4804.039192161582;4961.255811628249;5309.123994540896;5365.704886231256;5366.812161574365;2759.820611660256;3387.4580067189377;3394.6096198937194;3399.1162297802503;3511.9824400877833;941.665708673418;946.7585765629789;999.4552968632113;1035.4253389368898;1037.667946257198;11593.188476806627;11720.120990925629;11752.647420577396;11755.294682319003;11764.411779410995;4407.338899165151;4593.839215627437;4747.715137091716;4776.47458779534;4800.279958006327;9918.305718599773;9923.80152396948;9934.354266972623;9959.751006224757;9968;5374.865628359323;5375.19372094189;5381.273528073738;5383.057964856134;5385.5960802939935;4404.361367601679;4527.524609915978;4594.678372513892;4906.288588154697;4947.208446648519;3845.480860083853;3868.207017561393;3934.1934903344745;3965.1673148638533;3971.6624086952356;1267.7718010758151;1275.6747029507417;1278.7953927371575;1293.043148070421;1293.6701141209119;900.594732370436;923.8568021956607;936.9871189138192;939.8214339275653;986.753311672082;5076.314697515788;5819.679917604572;5990.760369585255;6029.758809647565;6362.300146983828;772.8067983004249;907.7004588485784;911.4030310146732;929.9860502092474;974.8245315843075;3449.6722811333384;3731.4468026078707;3988.920221595552;3995.04119011441;4063.227986682521;10513.737156570995;10766.784664306826;10872.891271087346;10882.183836212316;10951.561937522569;10847.186461015455;10862.968018038273;10870.673879783619;10877.891221087846;10887.129029677766;7704.614769261514;8110.067342255598;8152.918470815216;8218.096009438957;8221.54781487024;5293.973530132324;5872.324682661549;5878.676672783038;5913.911291330547;6245;8539.914600853912;10033.548490317808;10053.949730251303;10055.748606284902;10081.747956301151;9832.410055396698;10155;10167.644132455329;10234.48827558634;10408.167346612101;6902.206246281541;7139.2503787101605;7160.427165826617;7394.55632662042;7527.510711803715;8122.1065682776025;8439.66241350339;8444.831103378021;8548.187922147386;8571.82856342882;7264.5834062357335;7403.703851845866;7485.176630570524;7550.584717840352;7676.270754278335;6591.307912669101;7051.5063945523325;7274.236205198378;7366.447516436181;7440.330370266702;6866.073080134318;7029.964850175921;7041.190263119602;7044.36600705939;7047.6828542714675;4715.292706094114;4947.802087916587;4988;5030.622703297194;5112.233165025127;4811.663183577116;4919.729414882216;4962.826301079445;4968.900621987467;5239.187925871496 09:19:09 INFO - PROCESS | 3134 | |4;prototype.html;291.13532807561535;297.0983066393496;307.1997446651472;312.2910992048051;313.62208538710854;4779.737114458708;4859.878503037421;5109.948900510994;5219.321488206532;5306.230596563506;4631.444226692794;5214.556762675168;5252.40210455838;5255.816046438365;5287.762050707718;4052.5744796796353;4053;4053.27041132596;4058.9594104059024;4059.437116710073;3202.6316973548105;3700.8519659213734;4074.653654439361;4082.3876418537307;4084.387341898724;3114.8351895432684;3406.2506248625386;3648.233870887117;3965.325894597925;4011.338129208677;4023.6177563131455;4028.3353246714255;4028.697847661437;4040.8585699500522;4044.8382064717375;3276.1645780326103;3468.271662950783;3473.6526347365316;3503.8598456061727;3511.5434993450945;4278.700490965633;4471.2845944649025;4606.470255920579;4723.267893476516;5042.335839348624;4581.61056310214;4588.954110458886;4594.277146070223;4618.307253911907;4633.675642705012;4634.629229661653;5255;5562.384450107422;5609.49514543693;5629.24005259293;3344.866205351783;3545.6454354564594;3829.7319187656876;3842.654161125512;3860.5946375630715;4778.952210477885;4958.404991401019;5500.232340846573;5725.341585717612;5729.942700572941;3691.7046636269033;3737.588865224823;3814.6376094271;3843.7885916274313;3852.5954774748807;3895.3572660511263;3935.409688546741;3936.37018077112;3950.328444164499;3965.762054276695;4089.8364065437645;4537.546245375502;4553.817847286137;4570.565796249351;4606.216943119678;5014.921791814777;5206.271122042917;5254.92117618236;5490.419502833662;5668.319801623831;1179.9557391708229;1322.1802482460935;1326.8606796286444;1337.3112846883862;1344.0121510689635;772.0582734422819;802.5064585280128;819.7417813388763;821.7206149909059;822.9135940726258;4340.978295108504;4396.307102034242;4398.582134697199;4409.184300904343;4463.888402789891;4161.794249048009;4655;4811.9518804812205;4813.831515896997;4831.830885918976;3492.214251793326;3533.505309256706;3860.7955397020405;4391.925652043582;4411.580899814512;2492.8216523932133;2504.9980007996946;2519.886605102775;2721.3876877702755;2916.431295897322;4962.6774259673;5364.624476286623;5884.558658100574;5948.643081415129;5959.195508606283;5569.972150139223;5903.675297858573;5910.670099227639;5912.40875912414;5951.3751056139345;4833.969732712199;5938.584299099108;5974.701264936736;6015.6691381974415;6083.847903802441;5269.235960785742;5774.451427114417;5804.939246567408;5816.447437493432;5824;4566.931496027629;5211.348581427322;5509.338879334506;5651.378348381592;5749.54003679713;4904.975475122602;5243.659162154448;5478.794665173656;5837.6497410155525;5977.581569290282;3491.6159222486012;3661.6338366163172;3730.328540862562;3748.02551336649;3854.575996640311;5003.599712023102;5775.768969241183;5786;5811.215485909348;5813.011787996135;5359.758810853443;5638.407967163389;5652.463016013472;5667.1782591524825;5672.461116193955;4883.560479556857;5492.231087647652;5520.641158324696;5544.473275038865;5588.636738611977;5475.534579560623;5481.506664400223;5491.858175311711;5491.862703432446;5505.412456145606;5254.97372513135;5641.474078700812;5689.330381903566;5689.971550142222;5706.804189653807;4282.743035417885;4457.8439754608435;5235.528802407802;5555.3611334697025;5568.49883510486 09:19:09 INFO - PROCESS | 3134 | |5;yui.html;707.8867381219004;738.6454501839115;756.7200135949696;789.5854676294948;843.0684094076049;17152.656946861054;18064.09679516024;18066.458006259818;18458.630827383477;18542;16232.431864884731;16344.83655163451;16359.263833127508;16379.935304205219;16393;704.6934583456213;868.4485351801604;891.0243283604443;896.5786080542135;896.7220161749879;719.9352058314751;876.1545108969843;897.407710910799;906.9274458043341;914.9359544831865;934.4813628436215;935.228436539854;935.6771913689767;935.9251259899191;936.1153709744294;921.9861702074475;923.1276443760648;923.5797712041006;923.995380023099;924.2051835421532;535.1037013003204;553.6235359955228;677.6713294052381;697.6093387702903;698.7100353353352;15719.292631831595;15761.527154185393;15766.369345226178;15768.526944191693;15788;13341.666458338523;13713.17720936737;13758.31208439574;13793;14096.929515352358;12412.503499859995;12854.485820567166;13072.215667060007;13535.661608459768;13546.59360219195;4358.8967256158485;4449.555044495557;4452.332150177467;4480.238359478896;4632.791524381377;116383.41808290989;117279;119559.40220298842;120987;121953.39023304827;9064.682736104205;10552.366857988545;10607.946960265304;10757.03186713184;11099.056580190774;21274.042668079972;21276.89361553213;21288.935553222276;21294.574108518053;21310.36068917935;6740.427063699641;7584.317411432998;7636.160022397532;7718.53688778675;7927.960360198162;4075.4294398784195;4313.784310784448;4358.4769827620885;4364.236258654722;4392.1874453226255;3528;3629.94555081674;3691.9446208306895;3791.109089363997;3795.411711184771;707.2397173038901;708.1042481261209;713.3793599568409;713.5896859305919;724.7572063358729;555.849920521457;563.8356793221983;569.6297406685604;642.4121928435429;665.2848188197706;8059.194080591894;8976.102389761103;9124.361294709306;9167.358284919992;9204.309676774268;546.529984213576;554.9167624856223;572.7623036439915;601.5532643991208;653.2552889705739;3686.3733165361955;3716.349638813197;4357.7385356878685;4622.6301895848255;4637.1653102441205;89712;102892;128586;131176;142709;81601.59199203966;82961.58519207485;83379;85214;114364;75465.84937828363;92150.53924730468;101061.49469252607;101231;108898.75417441565;7977.760667179994;8239.217274358927;9204.493752843659;9699.563519641773;9825.754356140867;62301.68849155725;62580.37419625746;63970.3602963983;64994.675026624565;65812.67093664501;92094.53952730194;94123;96434;96584.06831863464;101120.49439752754;12791.040671949455;12824.487020519075;12867.806982895452;12902.225866448043;13035.869641303465;14250.501232456814;14532.927335363256;14993.400263989319;15164;15352.769708454158;11282.210245282751;12288.262704237774;13312.534061307808;13686.315684215948;13878.236696981763;13521.459141634225;13793.931030344784;13982.930085349915;14119.364628591944;14154.929225353808;12290.832370924747;12851.357432128543;12992.870071299167;13273.535426260034;13375.732485350043;9963.352382095141;11079.667609971713;11170.441477925908;11588.072954163477;11787.233829801036;9257.629694812133;10237.488125593542;11214.215004949576;11348.092152627605;11519.88480115188 09:19:09 INFO - PROCESS | 3134 | __end_tp_report 09:19:09 INFO - PROCESS | 3134 | __start_cc_report 09:19:09 INFO - PROCESS | 3134 | _x_x_mozilla_cycle_collect,1785 09:19:09 INFO - PROCESS | 3134 | __end_cc_report 09:19:09 INFO - PROCESS | 3134 | __startTimestamp1476461949894__endTimestamp 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | ------- Summary: start ------- 09:19:09 INFO - PROCESS | 3134 | Number of tests: 6 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | [#0] dojo.html Cycles:165 Average:5719.56 Median:5935.73 stddev:636.24 (10.7%) stddev-sans-first:609.41 09:19:09 INFO - PROCESS | 3134 | Values: 3307.8 3326.0 3333.9 3383.4 3408.6 5584.6 5662.0 5679.7 5739.9 5802.2 4715.5 5686.1 5692.6 5717.7 5851.0 5151.8 5165.6 5231.4 5239.2 5300.2 5166.7 5292.0 5299.8 5318.8 5322.1 5241.1 5255.4 5287.2 5296.6 5350.4 5150.3 5162.1 5196.5 5225.8 5234.4 5182.7 5184.3 5217.6 5253.1 5294.5 5625.1 5631.3 5672.1 5681.3 5702.9 6081.7 6141.1 6223.0 6225.8 6227.1 6194.1 6201.9 6218.8 6252.6 6341.9 5774.6 5781.6 5782.6 5804.0 5816.5 5375.9 6226.1 6286.6 6306.4 6312.0 5941.1 5997.2 6012.8 6017.1 6135.3 6221.6 6226.0 6251.0 6255.8 6260.9 6188.4 6192.8 6208.7 6208.8 6218.3 6021.9 6080.4 6110.0 6247.2 6271.5 4841.2 4862.0 4864.3 4871.1 4876.9 4346.7 4460.1 4467.4 4469.8 4476.9 5644.8 5695.7 5706.3 5712.7 5715.5 6157.9 6171.4 6172.3 6190.1 6192.8 5701.3 5729.6 5734.9 5741.2 5749.4 5369.0 5390.3 5397.5 5410.7 5412.9 6282.6 6316.7 6327.6 6345.2 6345.5 6284.0 6286.0 6292.4 6300.4 6318.3 6141.2 6189.9 6190.1 6249.3 6256.2 6149.6 6186.1 6192.7 6211.8 6211.8 6249.6 6272.7 6273.7 6279.5 6295.4 4858.7 5918.7 5979.2 5981.9 6122.1 5995.3 6020.8 6049.0 6049.2 6123.5 5934.5 5945.5 5951.0 5953.3 5999.0 6090.9 6131.8 6138.6 6141.4 6147.7 5793.8 5817.4 5849.9 5935.7 5952.5 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | [#1] ext.html Cycles:180 Average:69635.64 Median:221941.30 stddev:154428.68 (69.6%) stddev-sans-first:154774.59 09:19:09 INFO - PROCESS | 3134 | Values: 476.2 505.7 522.3 522.9 530.9 22293.7 31136.4 40826.0 40890.0 40954.8 40694.0 42868.4 42972.8 42972.8 42996.8 9469.5 9653.6 9667.2 9673.0 9675.9 9542.2 9639.4 9639.8 9655.9 9676.0 9680.6 9696.1 9725.2 9730.8 9732.8 8193.5 9645.8 9668.5 9670.1 9727.3 9588.9 9647.9 9662.0 9669.7 9685.4 40223.4 40454.0 40512.0 40625.8 40676.0 3301.4 3340.0 3363.3 3375.9 3379.7 30153.5 30758.7 31060.4 31095.4 31375.0 3081.1 3092.6 3103.5 3105.1 3173.9 403496.0 486223.6 487118.0 488045.0 500142.0 59906.7 60193.7 60198.4 60356.7 60400.4 34333.7 34974.7 35286.5 63230.4 63300.0 15820.5 16274.0 16287.6 16296.3 16298.5 12220.1 12397.8 12496.4 12499.7 12556.2 15328.9 18854.4 19097.5 19183.1 19212.5 7558.7 7688.0 7745.5 7763.8 7834.9 854.4 899.2 928.7 991.0 1016.3 21013.6 29691.9 30333.8 31142.8 31219.0 959.9 1013.4 1057.9 1059.3 1096.2 15199.3 15211.8 15290.6 15359.5 15680.9 653363.0 656236.7 658268.0 658518.0 659899.0 55695.0 56023.0 56039.4 56232.0 56240.7 1330.3 1361.2 1380.7 1381.6 1385.1 27534.4 29235.3 29299.3 29951.6 29957.0 50023.7 50559.5 50617.7 50619.5 50724.2 581949.2 584424.0 584795.0 585454.1 587121.0 25636.0 26033.9 26438.6 26530.0 27068.3 45677.1 45976.1 46065.3 47065.1 47292.8 36554.1 38789.6 39098.4 39747.2 40232.0 38430.4 38798.4 39453.6 39978.8 40386.6 32050.8 32833.0 37544.0 38640.8 38854.0 28700.0 31733.7 33933.8 34815.8 35116.5 20369.9 23179.7 24367.6 24722.9 25610.9 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | [#2] jquery.html Cycles:180 Average:34671.37 Median:376.41 stddev:97914.07 (26012.6%) stddev-sans-first:98154.87 09:19:09 INFO - PROCESS | 3134 | Values: 372.4 373.9 378.9 392.8 402.5 18768.6 20770.8 21133.2 21166.3 21413.0 20370.0 21333.0 21426.6 21661.9 21966.6 5743.9 5755.9 5960.3 6011.1 6015.2 4122.7 4357.2 5876.8 6019.6 6023.5 4306.0 4338.8 6569.6 6634.1 6638.7 5529.3 5984.5 6600.2 6618.4 6622.1 5733.6 5742.8 5746.7 5747.7 5769.4 26183.5 26709.7 26795.5 26825.2 27093.9 2269.9 2293.8 2384.3 2638.8 2770.8 9819.2 10288.5 10332.5 10418.5 10439.8 1461.6 1903.5 1937.5 1949.0 1971.1 118534.0 119672.4 119726.0 122873.0 123595.0 9368.3 11390.0 11578.9 11582.2 11718.6 14628.7 14631.7 14662.9 14675.6 14681.8 8268.5 8433.5 8442.8 8457.9 8625.2 8259.0 8278.7 8462.3 8481.6 8513.9 4397.9 4507.5 4530.7 4592.2 4636.3 1625.5 1671.0 1826.9 1850.6 1902.7 803.9 851.3 900.6 905.8 963.6 21027.0 21621.4 21626.7 21646.9 21709.9 893.9 966.2 970.8 1016.8 1017.1 9517.6 11322.0 11371.4 11442.0 11546.9 553695.2 588753.0 589609.0 596677.0 599254.0 120813.4 121336.0 123544.4 131590.3 131932.0 935.5 979.9 984.2 993.3 993.9 18888.7 19496.1 19533.0 19572.8 19646.3 48087.0 50684.7 53667.2 53943.0 54190.0 73919.0 76396.0 78869.6 79054.0 79974.2 7614.8 7757.2 7982.5 8026.2 8164.6 9073.7 11826.6 12480.1 12732.3 12933.9 10844.1 11006.7 11157.4 11211.3 11305.0 10783.8 10893.7 11119.5 11167.4 11229.5 10924.3 11020.3 11330.4 11375.6 11383.3 7942.7 7966.3 8027.9 8084.0 8088.2 7451.2 7756.3 7799.4 9243.9 11038.4 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | [#3] mootools.html Cycles:180 Average:5677.62 Median:4962.04 stddev:3207.50 (64.6%) stddev-sans-first:3200.16 09:19:09 INFO - PROCESS | 3134 | Values: 1369.9 1404.0 1568.9 1786.6 1981.1 7842.2 8369.3 8372.9 8374.5 8380.9 8386.7 8597.2 8712.8 8796.1 8812.7 2345.4 2381.9 2383.2 2384.3 2385.2 2345.2 2381.7 2384.3 2404.4 2405.8 2352.5 2363.3 2373.0 2389.7 2391.1 2065.3 2199.4 2339.9 2344.6 2359.4 2329.3 2346.6 2348.5 2352.4 2354.2 8737.9 8790.2 8846.2 8865.8 8876.3 4804.0 4961.3 5309.1 5365.7 5366.8 2759.8 3387.5 3394.6 3399.1 3512.0 941.7 946.8 999.5 1035.4 1037.7 11593.2 11720.1 11752.6 11755.3 11764.4 4407.3 4593.8 4747.7 4776.5 4800.3 9918.3 9923.8 9934.4 9959.8 9968.0 5374.9 5375.2 5381.3 5383.1 5385.6 4404.4 4527.5 4594.7 4906.3 4947.2 3845.5 3868.2 3934.2 3965.2 3971.7 1267.8 1275.7 1278.8 1293.0 1293.7 900.6 923.9 937.0 939.8 986.8 5076.3 5819.7 5990.8 6029.8 6362.3 772.8 907.7 911.4 930.0 974.8 3449.7 3731.4 3988.9 3995.0 4063.2 10513.7 10766.8 10872.9 10882.2 10951.6 10847.2 10863.0 10870.7 10877.9 10887.1 7704.6 8110.1 8152.9 8218.1 8221.5 5294.0 5872.3 5878.7 5913.9 6245.0 8539.9 10033.5 10053.9 10055.7 10081.7 9832.4 10155.0 10167.6 10234.5 10408.2 6902.2 7139.3 7160.4 7394.6 7527.5 8122.1 8439.7 8444.8 8548.2 8571.8 7264.6 7403.7 7485.2 7550.6 7676.3 6591.3 7051.5 7274.2 7366.4 7440.3 6866.1 7030.0 7041.2 7044.4 7047.7 4715.3 4947.8 4988.0 5030.6 5112.2 4811.7 4919.7 4962.8 4968.9 5239.2 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | [#4] prototype.html Cycles:180 Average:4403.92 Median:4751.11 stddev:1384.80 (29.1%) stddev-sans-first:1353.84 09:19:09 INFO - PROCESS | 3134 | Values: 291.1 297.1 307.2 312.3 313.6 4779.7 4859.9 5109.9 5219.3 5306.2 4631.4 5214.6 5252.4 5255.8 5287.8 4052.6 4053.0 4053.3 4059.0 4059.4 3202.6 3700.9 4074.7 4082.4 4084.4 3114.8 3406.3 3648.2 3965.3 4011.3 4023.6 4028.3 4028.7 4040.9 4044.8 3276.2 3468.3 3473.7 3503.9 3511.5 4278.7 4471.3 4606.5 4723.3 5042.3 4581.6 4589.0 4594.3 4618.3 4633.7 4634.6 5255.0 5562.4 5609.5 5629.2 3344.9 3545.6 3829.7 3842.7 3860.6 4779.0 4958.4 5500.2 5725.3 5729.9 3691.7 3737.6 3814.6 3843.8 3852.6 3895.4 3935.4 3936.4 3950.3 3965.8 4089.8 4537.5 4553.8 4570.6 4606.2 5014.9 5206.3 5254.9 5490.4 5668.3 1180.0 1322.2 1326.9 1337.3 1344.0 772.1 802.5 819.7 821.7 822.9 4341.0 4396.3 4398.6 4409.2 4463.9 4161.8 4655.0 4812.0 4813.8 4831.8 3492.2 3533.5 3860.8 4391.9 4411.6 2492.8 2505.0 2519.9 2721.4 2916.4 4962.7 5364.6 5884.6 5948.6 5959.2 5570.0 5903.7 5910.7 5912.4 5951.4 4834.0 5938.6 5974.7 6015.7 6083.8 5269.2 5774.5 5804.9 5816.4 5824.0 4566.9 5211.3 5509.3 5651.4 5749.5 4905.0 5243.7 5478.8 5837.6 5977.6 3491.6 3661.6 3730.3 3748.0 3854.6 5003.6 5775.8 5786.0 5811.2 5813.0 5359.8 5638.4 5652.5 5667.2 5672.5 4883.6 5492.2 5520.6 5544.5 5588.6 5475.5 5481.5 5491.9 5491.9 5505.4 5255.0 5641.5 5689.3 5690.0 5706.8 4282.7 4457.8 5235.5 5555.4 5568.5 09:19:09 INFO - PROCESS | 3134 | 09:19:09 INFO - PROCESS | 3134 | [#5] yui.html Cycles:180 Average:23069.41 Median:4358.11 stddev:34905.65 (800.9%) stddev-sans-first:34963.19 09:19:09 INFO - PROCESS | 3134 | Values: 707.9 738.6 756.7 789.6 843.1 17152.7 18064.1 18066.5 18458.6 18542.0 16232.4 16344.8 16359.3 16379.9 16393.0 704.7 868.4 891.0 896.6 896.7 719.9 876.2 897.4 906.9 914.9 934.5 935.2 935.7 935.9 936.1 922.0 923.1 923.6 924.0 924.2 535.1 553.6 677.7 697.6 698.7 15719.3 15761.5 15766.4 15768.5 15788.0 13341.7 13713.2 13758.3 13793.0 14096.9 12412.5 12854.5 13072.2 13535.7 13546.6 4358.9 4449.6 4452.3 4480.2 4632.8 116383.4 117279.0 119559.4 120987.0 121953.4 9064.7 10552.4 10607.9 10757.0 11099.1 21274.0 21276.9 21288.9 21294.6 21310.4 6740.4 7584.3 7636.2 7718.5 7928.0 4075.4 4313.8 4358.5 4364.2 4392.2 3528.0 3629.9 3691.9 3791.1 3795.4 707.2 708.1 713.4 713.6 724.8 555.8 563.8 569.6 642.4 665.3 8059.2 8976.1 9124.4 9167.4 9204.3 546.5 554.9 572.8 601.6 653.3 3686.4 3716.3 4357.7 4622.6 4637.2 89712.0 102892.0 128586.0 131176.0 142709.0 81601.6 82961.6 83379.0 85214.0 114364.0 75465.8 92150.5 101061.5 101231.0 108898.8 7977.8 8239.2 9204.5 9699.6 9825.8 62301.7 62580.4 63970.4 64994.7 65812.7 92094.5 94123.0 96434.0 96584.1 101120.5 12791.0 12824.5 12867.8 12902.2 13035.9 14250.5 14532.9 14993.4 15164.0 15352.8 11282.2 12288.3 13312.5 13686.3 13878.2 13521.5 13793.9 13982.9 14119.4 14154.9 12290.8 12851.4 12992.9 13273.5 13375.7 9963.4 11079.7 11170.4 11588.1 11787.2 9257.6 10237.5 11214.2 11348.1 11519.9 09:19:09 INFO - PROCESS | 3134 | -------- Summary: end -------- 09:19:09 INFO - PROCESS | 3134 | 09:19:10 INFO - TEST-INFO | 3134: exit 0 09:19:10 INFO - TEST-OK | dromaeo_css | took 1120337ms 09:19:10 INFO - TEST-START | kraken 09:19:10 INFO - operating with platform_type : mac_ 09:19:10 INFO - Initialising browser for kraken test... 09:19:10 INFO - TEST-INFO | started process 3247 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpMtb21g/profile http://localhost:61860/getInfo.html) 09:19:12 INFO - PROCESS | 3247 | __metrics Screen width/height:1600/1200 09:19:12 INFO - PROCESS | 3247 | colorDepth:24 09:19:12 INFO - PROCESS | 3247 | Browser inner width/height: 1024/689 09:19:12 INFO - PROCESS | 3247 | __metrics 09:19:13 INFO - PROCESS | 3247 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:19:13 INFO - PROCESS | 3247 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:13 INFO - TEST-INFO | 3247: exit 0 09:19:13 INFO - Browser initialized. 09:19:13 INFO - Running cycle 1/1 for kraken test... 09:19:13 INFO - TEST-INFO | started process 3250 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpMtb21g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:25 INFO - PROCESS | 3250 | RSS: Main: 238911488 09:19:25 INFO - PROCESS | 3250 | 09:19:28 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61860/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:29 INFO - PROCESS | 3250 | RSS: Main: 290508800 09:19:29 INFO - PROCESS | 3250 | 09:19:32 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61860/tests/kraken/driver.html?testName=audio-dft) 09:19:32 INFO - PROCESS | 3250 | RSS: Main: 289148928 09:19:32 INFO - PROCESS | 3250 | 09:19:36 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61860/tests/kraken/driver.html?testName=audio-fft) 09:19:36 INFO - PROCESS | 3250 | RSS: Main: 384270336 09:19:36 INFO - PROCESS | 3250 | 09:19:39 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61860/tests/kraken/driver.html?testName=audio-oscillator) 09:19:39 INFO - PROCESS | 3250 | RSS: Main: 284983296 09:19:39 INFO - PROCESS | 3250 | 09:19:41 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:42 INFO - PROCESS | 3250 | RSS: Main: 289492992 09:19:42 INFO - PROCESS | 3250 | 09:19:45 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61860/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:45 INFO - PROCESS | 3250 | RSS: Main: 326995968 09:19:45 INFO - PROCESS | 3250 | 09:19:48 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61860/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:49 INFO - PROCESS | 3250 | RSS: Main: 327782400 09:19:49 INFO - PROCESS | 3250 | 09:19:51 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61860/tests/kraken/driver.html?testName=json-parse-financial) 09:19:52 INFO - PROCESS | 3250 | RSS: Main: 326971392 09:19:52 INFO - PROCESS | 3250 | 09:19:54 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:54 INFO - PROCESS | 3250 | RSS: Main: 302616576 09:19:54 INFO - PROCESS | 3250 | 09:19:56 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:57 INFO - PROCESS | 3250 | RSS: Main: 305192960 09:19:57 INFO - PROCESS | 3250 | 09:19:59 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:00 INFO - PROCESS | 3250 | RSS: Main: 307519488 09:20:00 INFO - PROCESS | 3250 | 09:20:03 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:03 INFO - PROCESS | 3250 | RSS: Main: 324624384 09:20:03 INFO - PROCESS | 3250 | 09:20:06 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:07 INFO - PROCESS | 3250 | RSS: Main: 318107648 09:20:07 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | Cycle 1(1): loaded http://localhost:61860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61860/tests/kraken/driver.html?testName=ai-astar) 09:20:09 INFO - PROCESS | 3250 | RSS: Main: 362225664 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | __start_tp_report 09:20:09 INFO - PROCESS | 3250 | _x_x_mozilla_page_load 09:20:09 INFO - PROCESS | 3250 | _x_x_mozilla_page_load_details 09:20:09 INFO - PROCESS | 3250 | |i|pagename|runs| 09:20:09 INFO - PROCESS | 3250 | |0;ai-astar;112;113;113;111;112;113;113;112;112;112 09:20:09 INFO - PROCESS | 3250 | |1;audio-beat-detection;150;129;142;150;113;112;112;110;148;116 09:20:09 INFO - PROCESS | 3250 | |2;audio-dft;184;184;182;186;185;186;205;250;185;203 09:20:09 INFO - PROCESS | 3250 | |3;audio-fft;81;60;59;90;63;61;59;58;98;79 09:20:09 INFO - PROCESS | 3250 | |4;audio-oscillator;87;72;92;70;68;69;93;68;69;90 09:20:09 INFO - PROCESS | 3250 | |5;imaging-gaussian-blur;91;74;108;131;134;84;89;83;87;85 09:20:09 INFO - PROCESS | 3250 | |6;imaging-darkroom;97;95;97;96;95;96;96;97;96;97 09:20:09 INFO - PROCESS | 3250 | |7;imaging-desaturate;80;81;79;82;84;81;82;84;81;81 09:20:09 INFO - PROCESS | 3250 | |8;json-parse-financial;57;54;55;54;54;54;55;55;55;55 09:20:09 INFO - PROCESS | 3250 | |9;json-stringify-tinderbox;65;73;75;76;72;71;68;69;69;71 09:20:09 INFO - PROCESS | 3250 | |10;stanford-crypto-aes;88;84;87;84;87;92;88;86;86;91 09:20:09 INFO - PROCESS | 3250 | |11;stanford-crypto-ccm;146;146;178;177;157;158;145;146;182;167 09:20:09 INFO - PROCESS | 3250 | |12;stanford-crypto-pbkdf2;173;181;210;174;171;172;173;173;171;169 09:20:09 INFO - PROCESS | 3250 | |13;stanford-crypto-sha256-iterative;68;66;67;69;68;67;79;87;88;70 09:20:09 INFO - PROCESS | 3250 | __end_tp_report 09:20:09 INFO - PROCESS | 3250 | __start_cc_report 09:20:09 INFO - PROCESS | 3250 | _x_x_mozilla_cycle_collect,2147 09:20:09 INFO - PROCESS | 3250 | __end_cc_report 09:20:09 INFO - PROCESS | 3250 | __startTimestamp1476462009625__endTimestamp 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | ------- Summary: start ------- 09:20:09 INFO - PROCESS | 3250 | Number of tests: 14 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:20:09 INFO - PROCESS | 3250 | Values: 112.0 113.0 113.0 111.0 112.0 113.0 113.0 112.0 112.0 112.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:135.50 stddev:17.54 (12.9%) stddev-sans-first:16.74 09:20:09 INFO - PROCESS | 3250 | Values: 150.0 129.0 142.0 150.0 113.0 112.0 112.0 110.0 148.0 116.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#2] audio-dft Cycles:10 Average:195.00 Median:186.00 stddev:20.98 (11.3%) stddev-sans-first:21.87 09:20:09 INFO - PROCESS | 3250 | Values: 184.0 184.0 182.0 186.0 185.0 186.0 205.0 250.0 185.0 203.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#3] audio-fft Cycles:10 Average:70.80 Median:71.00 stddev:14.89 (21.0%) stddev-sans-first:15.33 09:20:09 INFO - PROCESS | 3250 | Values: 81.0 60.0 59.0 90.0 63.0 61.0 59.0 58.0 98.0 79.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.50 stddev:11.09 (14.0%) stddev-sans-first:11.26 09:20:09 INFO - PROCESS | 3250 | Values: 87.0 72.0 92.0 70.0 68.0 69.0 93.0 68.0 69.0 90.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:84.50 stddev:20.77 (24.6%) stddev-sans-first:21.93 09:20:09 INFO - PROCESS | 3250 | Values: 91.0 74.0 108.0 131.0 134.0 84.0 89.0 83.0 87.0 85.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 09:20:09 INFO - PROCESS | 3250 | Values: 97.0 95.0 97.0 96.0 95.0 96.0 96.0 97.0 96.0 97.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#7] imaging-desaturate Cycles:10 Average:81.50 Median:81.50 stddev:1.58 (1.9%) stddev-sans-first:1.58 09:20:09 INFO - PROCESS | 3250 | Values: 80.0 81.0 79.0 82.0 84.0 81.0 82.0 84.0 81.0 81.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.53 09:20:09 INFO - PROCESS | 3250 | Values: 57.0 54.0 55.0 54.0 54.0 54.0 55.0 55.0 55.0 55.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:3.31 (4.6%) stddev-sans-first:2.74 09:20:09 INFO - PROCESS | 3250 | Values: 65.0 73.0 75.0 76.0 72.0 71.0 68.0 69.0 69.0 71.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.50 stddev:2.63 (3.0%) stddev-sans-first:2.77 09:20:09 INFO - PROCESS | 3250 | Values: 88.0 84.0 87.0 84.0 87.0 92.0 88.0 86.0 86.0 91.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:162.50 stddev:14.80 (9.1%) stddev-sans-first:14.78 09:20:09 INFO - PROCESS | 3250 | Values: 146.0 146.0 178.0 177.0 157.0 158.0 145.0 146.0 182.0 167.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:173.00 stddev:12.12 (7.0%) stddev-sans-first:12.78 09:20:09 INFO - PROCESS | 3250 | Values: 173.0 181.0 210.0 174.0 171.0 172.0 173.0 173.0 171.0 169.0 09:20:09 INFO - PROCESS | 3250 | 09:20:09 INFO - PROCESS | 3250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:69.50 stddev:8.52 (12.3%) stddev-sans-first:8.85 09:20:09 INFO - PROCESS | 3250 | Values: 68.0 66.0 67.0 69.0 68.0 67.0 79.0 87.0 88.0 70.0 09:20:09 INFO - PROCESS | 3250 | -------- Summary: end -------- 09:20:09 INFO - PROCESS | 3250 | 09:20:10 INFO - TEST-INFO | 3250: exit 0 09:20:10 INFO - TEST-OK | kraken | took 59957ms 09:20:10 INFO - SUITE-END | took 1180s 09:20:10 INFO - Completed test suite (00:19:40) 09:20:10 INFO - javascript benchmark 09:20:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.7519186061045, 3326.0354497195813, 3333.9166520836975, 3383.4079036168664, 3408.60801007884, 5584.581156413265, 5662.037453632882, 5679.7160141992945, 5739.856503587413, 5802.216700745393, 4715.528447155283, 5686.147077938301, 5692.601517893749, 5717.742701578429, 5851.034579294422, 5151.793928242866, 5165.63840531163, 5231.372235331746, 5239.240310155025, 5300.178472336794, 5166.741662916858, 5291.973540132294, 5299.814506492274, 5318.787248510074, 5322.0952438085615, 5241.109011468059, 5255.395629502599, 5287.206918962148, 5296.576273898079, 5350.384705758848, 5150.253213284052, 5162.12243918531, 5196.45437229093, 5225.790968361261, 5234.398044224925, 5182.714950677711, 5184.300119483859, 5217.58259339252, 5253.106971814763, 5294.549963253128, 5625.128105143709, 5631.2960879890015, 5672.092465205588, 5681.34664513578, 5702.914456283159, 6081.695915204266, 6141.140240366352, 6222.97320942044, 6225.7509699611965, 6227.1282020517165, 6194.132821405007, 6201.906971395432, 6218.844528886769, 6252.624842509418, 6341.873162536724, 5774.595778295563, 5781.595288329777, 5782.56630752691, 5804.04233301509, 5816.534677225812, 5375.87106707588, 6226.097215903668, 6286.591371560834, 6306.369363063657, 6312.0, 5941.138534912414, 5997.190379298739, 6012.819615411545, 6017.06735456005, 6135.294441139326, 6221.626702397871, 6226.034964580497, 6250.96859018266, 6255.781047663401, 6260.874782504325, 6188.412100850502, 6192.845178870564, 6208.689565521706, 6208.782692605737, 6218.31598524162, 6021.939780602138, 6080.391960803884, 6109.969450152721, 6247.156633854463, 6271.498280137578, 4841.176999910023, 4861.95138048615, 4864.318995340655, 4871.050145221719, 4876.926846097312, 4346.6522678185665, 4460.107978404332, 4467.396901418332, 4469.7988590513505, 4476.932846007313, 5644.802431914945, 5695.7152142392715, 5706.28671416073, 5712.686362023387, 5715.542756579547, 6157.907631385533, 6171.382861713882, 6172.290186628596, 6190.133381326618, 6192.783252586228, 5701.344345400332, 5729.627574207663, 5734.913976290359, 5741.167530708108, 5749.367569567345, 5369.0, 5390.326209223847, 5397.460253974571, 5410.675359478444, 5412.864678383072, 6282.639343936769, 6316.684165791692, 6327.58870673414, 6345.206849143857, 6345.4923606112325, 6283.963146081029, 6285.968570157303, 6292.370762923854, 6300.432961033529, 6318.304986451579, 6141.201643786279, 6189.938100618936, 6190.133381326528, 6249.312575616587, 6256.249250090018, 6149.600275982047, 6186.072089186658, 6192.721327540181, 6211.751529938751, 6211.782587609412, 6249.562530622813, 6272.655003974825, 6273.749050037947, 6279.497640188865, 6295.401936815995, 4858.732769697559, 5918.668299632548, 5979.162917191509, 5981.880362392815, 6122.142899994094, 5995.250593675791, 6020.759169633166, 6048.969755151196, 6049.213602231682, 6123.510119190365, 5934.525237980864, 5945.524358051259, 5951.0, 5953.315368732651, 5999.040153575407, 6090.908636370546, 6131.785387511416, 6138.63168209891, 6141.385861413823, 6147.723352449061, 5793.797217097382, 5817.360090390139, 5849.912251316148, 5935.732892019956, 5952.523798096228], "value": 5679.323138459347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.1809687337779, 505.6915281678178, 522.3470661672909, 522.9450907654697, 530.9044372013036, 22293.665595016068, 31136.377272454538, 40826.0, 40890.0, 40954.771356859266, 40694.0, 42868.35697464541, 42972.78513607428, 42972.78513607435, 42996.78501607488, 9469.526523673823, 9653.565589548487, 9667.178289845371, 9673.0, 9675.903240967606, 9542.188913942324, 9639.421634701941, 9639.807203855918, 9655.90344096557, 9676.032396760304, 9680.56437460316, 9696.12734853863, 9725.173360264385, 9730.805383892319, 9732.75668108296, 8193.549354785484, 9645.807083858319, 9668.516574171334, 9670.129688328014, 9727.270454715854, 9588.90411095887, 9647.903520964841, 9661.951690241574, 9669.661561845302, 9685.41887486753, 40223.396649050286, 40454.0, 40512.0, 40625.78122656325, 40675.98310042272, 3301.3892429900543, 3339.96660033399, 3363.276895467486, 3375.932481350384, 3379.746519011084, 30153.547696784564, 30758.692413075805, 31060.378792424024, 31095.37809243825, 31375.0, 3081.1218802641138, 3092.567040614316, 3103.487924492456, 3105.1150422129585, 3173.8889138880027, 403496.0, 486223.56888215686, 487118.0, 488045.0, 500142.0, 59906.70046649826, 60193.699031505435, 60198.39801602015, 60356.69821650864, 60400.39599603948, 34333.65666343355, 34974.65025349714, 35286.47070293948, 63230.36769632245, 63300.0, 15820.525384238492, 16274.023558586287, 16287.59281017984, 16296.26666799997, 16298.51104466868, 12220.083493738006, 12397.75204495905, 12496.437660305308, 12499.687507812378, 12556.183848049848, 15328.923355383151, 18854.434366969013, 19097.472202223787, 19183.136758845885, 19212.519687007658, 7558.735444259424, 7688.0, 7745.457817952802, 7763.767086987399, 7834.921650783534, 854.3891117850767, 899.2131884600974, 928.679605536089, 990.960361585543, 1016.3444578246989, 21013.606862072724, 29691.85154074259, 30333.848330758647, 31142.844285778425, 31219.0, 959.8704174936295, 1013.3717095400751, 1057.9206559508068, 1059.3432072115338, 1096.2271598523023, 15199.316030778642, 15211.771823422658, 15290.617734556503, 15359.462418815512, 15680.92159539195, 653363.0, 656236.7188164028, 658268.0, 658518.0, 659899.0, 55695.0, 56023.0, 56039.439605603424, 56232.0, 56240.71879640576, 1330.3348325837082, 1361.1764882246296, 1380.6548362909273, 1381.6062422209823, 1385.1135273425016, 27534.449311013268, 29235.269118272212, 29299.267518312212, 29951.55072673955, 29956.95150669716, 50023.74988125036, 50559.49440505695, 50617.74691126521, 50619.49380506148, 50724.23913641372, 581949.1805081895, 584424.0, 584795.0, 585454.0727296507, 587121.0, 25636.0, 26033.869830650725, 26438.603420949086, 26530.0, 27068.323291917073, 45677.08645827131, 45976.08047838957, 46065.30902036405, 47065.05869882651, 47292.7635361821, 36554.086147846516, 38789.6121038786, 39098.41352379773, 39747.20505589814, 40232.0, 38430.423543646306, 38798.4180237291, 39453.605463944994, 39978.80010599928, 40386.59613403946, 32050.839745802055, 32833.0, 37544.0, 38640.806795965844, 38854.028649283995, 28700.0, 31733.682663173073, 33933.8123165688, 34815.82592087024, 35116.473252901735, 20369.87965661903, 23179.65230521577, 24367.634485482376, 24722.88747006353, 25610.926688797463], "value": 19543.751112768223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.3725522494595, 373.87848949091546, 378.9412641040638, 392.8251927892089, 402.51295931922374, 18768.62462750746, 20770.792292077076, 21133.15467381305, 21166.25918092867, 21413.0, 20370.0, 21333.0, 21426.57146857062, 21661.91690415477, 21966.560668786613, 5743.856403589902, 5755.884882302352, 5960.254968128984, 6011.068284415901, 6015.187949626788, 4122.711410201287, 4357.150355680644, 5876.76492940284, 6019.638821670692, 6023.548233882477, 4306.0, 4338.783060846961, 6569.572977756455, 6634.0712300278, 6638.73445062197, 5529.281193444826, 5984.521238300969, 6600.207975043001, 6618.371254730793, 6622.106015687893, 5733.627314224562, 5742.799002034951, 5746.65520068793, 5747.6551406915305, 5769.365369809318, 26183.476330473284, 26709.73290267092, 26795.464090718076, 26825.195244142513, 27093.864530677416, 2269.897854596547, 2293.7591552886875, 2384.2727967969763, 2638.8152829301957, 2770.8476033818133, 9819.165370943478, 10288.537015834305, 10332.535035923327, 10418.531166097468, 10439.791204175874, 1461.6126726417508, 1903.4955736729778, 1937.5446770009037, 1948.9656411228761, 1971.0639479805645, 118534.0, 119672.40163799212, 119726.0, 122873.0, 123595.0, 9368.2973776967, 11390.0, 11578.942105289589, 11582.204758262484, 11718.589849355401, 14628.707425851424, 14631.707365852624, 14662.853371466363, 14675.633109172142, 14681.77977330341, 8268.545230012287, 8433.536155511383, 8442.788930276793, 8457.915420845837, 8625.223729864343, 8258.958705206436, 8278.71024514139, 8462.345709859552, 8481.575921203916, 8513.872291915626, 4397.912041759147, 4507.549245075532, 4530.728156310632, 4592.15045216636, 4636.334107887978, 1625.5123462961064, 1670.9749353759703, 1826.8538516918616, 1850.5836186858119, 1902.73361729358, 803.8753993131074, 851.2976794144731, 900.5587262241454, 905.7961958559272, 963.5808423335872, 21027.0, 21621.35135945924, 21626.675599866016, 21646.891765541073, 21709.891450542647, 893.9284857211537, 966.1594412860856, 970.834958057132, 1016.7712264740375, 1017.1405162637559, 9517.5717092731, 11322.0, 11371.431428428545, 11441.970222679998, 11546.884531154748, 553695.1674349247, 588753.0, 589609.0, 596677.0, 599254.0, 120813.39593301977, 121336.0, 123544.38227808803, 131590.34204828914, 131932.0, 935.5415846235431, 979.8677178580942, 984.242133557157, 993.2600212841479, 993.9304248702522, 18888.716669250247, 19496.122674479968, 19533.023348832787, 19572.8042719571, 19646.312379066665, 48087.0, 50684.74657626688, 53667.19499207437, 53943.0, 54190.0, 73919.0, 76396.0, 78869.60565197137, 79054.0, 79974.20025799901, 7614.8096297593, 7757.2242775724235, 7982.521048737094, 8026.197380261927, 8164.5917704115745, 9073.682421115229, 11826.645200643994, 12480.126391152533, 12732.299723515296, 12933.870661293267, 10844.132469402271, 11006.679198496231, 11157.442127893735, 11211.327320360804, 11305.0, 10783.784324313627, 10893.673189804318, 11119.499622516845, 11167.385793781095, 11229.49467273991, 10924.344539327665, 11020.338779673246, 11330.37682927447, 11375.601853935073, 11383.317000979967, 7942.722004729807, 7966.28303452692, 8027.879581806161, 8083.959580202061, 8088.231617996281, 7451.180370159386, 7756.263155000266, 7799.415043871846, 9243.936947251152, 11038.392888390894], "value": 9500.786549622073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.9383527741252, 1403.9719205615881, 1568.945086921958, 1786.5890845105625, 1981.0684582532033, 7842.215778422155, 8369.330453563707, 8372.91627083729, 8374.497530148195, 8380.8742868857, 8386.748397548068, 8597.183267589584, 8712.782180445492, 8796.07641197673, 8812.691555795549, 2345.3667509772395, 2381.9166329178483, 2383.2016274548046, 2384.2966324934187, 2385.2367242482414, 2345.155743932183, 2381.749916258785, 2384.308550520347, 2404.4469771952463, 2405.759424057589, 2352.494213744045, 2363.338265285714, 2372.988135059331, 2389.653500242464, 2391.055533064447, 2065.266830275261, 2199.43914301852, 2339.9064037438484, 2344.6365813298967, 2359.4101474631343, 2329.277923843597, 2346.5541547105995, 2348.5302939412186, 2352.423656204224, 2354.1878052072007, 8737.868931965962, 8790.164934331227, 8846.203841654218, 8865.822683546357, 8876.334274929342, 4804.039192161582, 4961.255811628249, 5309.123994540896, 5365.704886231256, 5366.812161574365, 2759.820611660256, 3387.4580067189377, 3394.6096198937194, 3399.1162297802503, 3511.9824400877833, 941.665708673418, 946.7585765629789, 999.4552968632113, 1035.4253389368898, 1037.667946257198, 11593.188476806627, 11720.120990925629, 11752.647420577396, 11755.294682319003, 11764.411779410995, 4407.338899165151, 4593.839215627437, 4747.715137091716, 4776.47458779534, 4800.279958006327, 9918.305718599773, 9923.80152396948, 9934.354266972623, 9959.751006224757, 9968.0, 5374.865628359323, 5375.19372094189, 5381.273528073738, 5383.057964856134, 5385.5960802939935, 4404.361367601679, 4527.524609915978, 4594.678372513892, 4906.288588154697, 4947.208446648519, 3845.480860083853, 3868.207017561393, 3934.1934903344745, 3965.1673148638533, 3971.6624086952356, 1267.7718010758151, 1275.6747029507417, 1278.7953927371575, 1293.043148070421, 1293.6701141209119, 900.594732370436, 923.8568021956607, 936.9871189138192, 939.8214339275653, 986.753311672082, 5076.314697515788, 5819.679917604572, 5990.760369585255, 6029.758809647565, 6362.300146983828, 772.8067983004249, 907.7004588485784, 911.4030310146732, 929.9860502092474, 974.8245315843075, 3449.6722811333384, 3731.4468026078707, 3988.920221595552, 3995.04119011441, 4063.227986682521, 10513.737156570995, 10766.784664306826, 10872.891271087346, 10882.183836212316, 10951.561937522569, 10847.186461015455, 10862.968018038273, 10870.673879783619, 10877.891221087846, 10887.129029677766, 7704.614769261514, 8110.067342255598, 8152.918470815216, 8218.096009438957, 8221.54781487024, 5293.973530132324, 5872.324682661549, 5878.676672783038, 5913.911291330547, 6245.0, 8539.914600853912, 10033.548490317808, 10053.949730251303, 10055.748606284902, 10081.747956301151, 9832.410055396698, 10155.0, 10167.644132455329, 10234.48827558634, 10408.167346612101, 6902.206246281541, 7139.2503787101605, 7160.427165826617, 7394.55632662042, 7527.510711803715, 8122.1065682776025, 8439.66241350339, 8444.831103378021, 8548.187922147386, 8571.82856342882, 7264.5834062357335, 7403.703851845866, 7485.176630570524, 7550.584717840352, 7676.270754278335, 6591.307912669101, 7051.5063945523325, 7274.236205198378, 7366.447516436181, 7440.330370266702, 6866.073080134318, 7029.964850175921, 7041.190263119602, 7044.36600705939, 7047.6828542714675, 4715.292706094114, 4947.802087916587, 4988.0, 5030.622703297194, 5112.233165025127, 4811.663183577116, 4919.729414882216, 4962.826301079445, 4968.900621987467, 5239.187925871496], "value": 4552.426328194284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.13532807561535, 297.0983066393496, 307.1997446651472, 312.2910992048051, 313.62208538710854, 4779.737114458708, 4859.878503037421, 5109.948900510994, 5219.321488206532, 5306.230596563506, 4631.444226692794, 5214.556762675168, 5252.40210455838, 5255.816046438365, 5287.762050707718, 4052.5744796796353, 4053.0, 4053.27041132596, 4058.9594104059024, 4059.437116710073, 3202.6316973548105, 3700.8519659213734, 4074.653654439361, 4082.3876418537307, 4084.387341898724, 3114.8351895432684, 3406.2506248625386, 3648.233870887117, 3965.325894597925, 4011.338129208677, 4023.6177563131455, 4028.3353246714255, 4028.697847661437, 4040.8585699500522, 4044.8382064717375, 3276.1645780326103, 3468.271662950783, 3473.6526347365316, 3503.8598456061727, 3511.5434993450945, 4278.700490965633, 4471.2845944649025, 4606.470255920579, 4723.267893476516, 5042.335839348624, 4581.61056310214, 4588.954110458886, 4594.277146070223, 4618.307253911907, 4633.675642705012, 4634.629229661653, 5255.0, 5562.384450107422, 5609.49514543693, 5629.24005259293, 3344.866205351783, 3545.6454354564594, 3829.7319187656876, 3842.654161125512, 3860.5946375630715, 4778.952210477885, 4958.404991401019, 5500.232340846573, 5725.341585717612, 5729.942700572941, 3691.7046636269033, 3737.588865224823, 3814.6376094271, 3843.7885916274313, 3852.5954774748807, 3895.3572660511263, 3935.409688546741, 3936.37018077112, 3950.328444164499, 3965.762054276695, 4089.8364065437645, 4537.546245375502, 4553.817847286137, 4570.565796249351, 4606.216943119678, 5014.921791814777, 5206.271122042917, 5254.92117618236, 5490.419502833662, 5668.319801623831, 1179.9557391708229, 1322.1802482460935, 1326.8606796286444, 1337.3112846883862, 1344.0121510689635, 772.0582734422819, 802.5064585280128, 819.7417813388763, 821.7206149909059, 822.9135940726258, 4340.978295108504, 4396.307102034242, 4398.582134697199, 4409.184300904343, 4463.888402789891, 4161.794249048009, 4655.0, 4811.9518804812205, 4813.831515896997, 4831.830885918976, 3492.214251793326, 3533.505309256706, 3860.7955397020405, 4391.925652043582, 4411.580899814512, 2492.8216523932133, 2504.9980007996946, 2519.886605102775, 2721.3876877702755, 2916.431295897322, 4962.6774259673, 5364.624476286623, 5884.558658100574, 5948.643081415129, 5959.195508606283, 5569.972150139223, 5903.675297858573, 5910.670099227639, 5912.40875912414, 5951.3751056139345, 4833.969732712199, 5938.584299099108, 5974.701264936736, 6015.6691381974415, 6083.847903802441, 5269.235960785742, 5774.451427114417, 5804.939246567408, 5816.447437493432, 5824.0, 4566.931496027629, 5211.348581427322, 5509.338879334506, 5651.378348381592, 5749.54003679713, 4904.975475122602, 5243.659162154448, 5478.794665173656, 5837.6497410155525, 5977.581569290282, 3491.6159222486012, 3661.6338366163172, 3730.328540862562, 3748.02551336649, 3854.575996640311, 5003.599712023102, 5775.768969241183, 5786.0, 5811.215485909348, 5813.011787996135, 5359.758810853443, 5638.407967163389, 5652.463016013472, 5667.1782591524825, 5672.461116193955, 4883.560479556857, 5492.231087647652, 5520.641158324696, 5544.473275038865, 5588.636738611977, 5475.534579560623, 5481.506664400223, 5491.858175311711, 5491.862703432446, 5505.412456145606, 5254.97372513135, 5641.474078700812, 5689.330381903566, 5689.971550142222, 5706.804189653807, 4282.743035417885, 4457.8439754608435, 5235.528802407802, 5555.3611334697025, 5568.49883510486], "value": 3963.291849898946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.8867381219004, 738.6454501839115, 756.7200135949696, 789.5854676294948, 843.0684094076049, 17152.656946861054, 18064.09679516024, 18066.458006259818, 18458.630827383477, 18542.0, 16232.431864884731, 16344.83655163451, 16359.263833127508, 16379.935304205219, 16393.0, 704.6934583456213, 868.4485351801604, 891.0243283604443, 896.5786080542135, 896.7220161749879, 719.9352058314751, 876.1545108969843, 897.407710910799, 906.9274458043341, 914.9359544831865, 934.4813628436215, 935.228436539854, 935.6771913689767, 935.9251259899191, 936.1153709744294, 921.9861702074475, 923.1276443760648, 923.5797712041006, 923.995380023099, 924.2051835421532, 535.1037013003204, 553.6235359955228, 677.6713294052381, 697.6093387702903, 698.7100353353352, 15719.292631831595, 15761.527154185393, 15766.369345226178, 15768.526944191693, 15788.0, 13341.666458338523, 13713.17720936737, 13758.31208439574, 13793.0, 14096.929515352358, 12412.503499859995, 12854.485820567166, 13072.215667060007, 13535.661608459768, 13546.59360219195, 4358.8967256158485, 4449.555044495557, 4452.332150177467, 4480.238359478896, 4632.791524381377, 116383.41808290989, 117279.0, 119559.40220298842, 120987.0, 121953.39023304827, 9064.682736104205, 10552.366857988545, 10607.946960265304, 10757.03186713184, 11099.056580190774, 21274.042668079972, 21276.89361553213, 21288.935553222276, 21294.574108518053, 21310.36068917935, 6740.427063699641, 7584.317411432998, 7636.160022397532, 7718.53688778675, 7927.960360198162, 4075.4294398784195, 4313.784310784448, 4358.4769827620885, 4364.236258654722, 4392.1874453226255, 3528.0, 3629.94555081674, 3691.9446208306895, 3791.109089363997, 3795.411711184771, 707.2397173038901, 708.1042481261209, 713.3793599568409, 713.5896859305919, 724.7572063358729, 555.849920521457, 563.8356793221983, 569.6297406685604, 642.4121928435429, 665.2848188197706, 8059.194080591894, 8976.102389761103, 9124.361294709306, 9167.358284919992, 9204.309676774268, 546.529984213576, 554.9167624856223, 572.7623036439915, 601.5532643991208, 653.2552889705739, 3686.3733165361955, 3716.349638813197, 4357.7385356878685, 4622.6301895848255, 4637.1653102441205, 89712.0, 102892.0, 128586.0, 131176.0, 142709.0, 81601.59199203966, 82961.58519207485, 83379.0, 85214.0, 114364.0, 75465.84937828363, 92150.53924730468, 101061.49469252607, 101231.0, 108898.75417441565, 7977.760667179994, 8239.217274358927, 9204.493752843659, 9699.563519641773, 9825.754356140867, 62301.68849155725, 62580.37419625746, 63970.3602963983, 64994.675026624565, 65812.67093664501, 92094.53952730194, 94123.0, 96434.0, 96584.06831863464, 101120.49439752754, 12791.040671949455, 12824.487020519075, 12867.806982895452, 12902.225866448043, 13035.869641303465, 14250.501232456814, 14532.927335363256, 14993.400263989319, 15164.0, 15352.769708454158, 11282.210245282751, 12288.262704237774, 13312.534061307808, 13686.315684215948, 13878.236696981763, 13521.459141634225, 13793.931030344784, 13982.930085349915, 14119.364628591944, 14154.929225353808, 12290.832370924747, 12851.357432128543, 12992.870071299167, 13273.535426260034, 13375.732485350043, 9963.352382095141, 11079.667609971713, 11170.441477925908, 11588.072954163477, 11787.233829801036, 9257.629694812133, 10237.488125593542, 11214.215004949576, 11348.092152627605, 11519.88480115188], "value": 7748.545559443309, "unit": "score"}], "name": "dromaeo_css", "value": 7268.392263153601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 111.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 142.0, 150.0, 113.0, 112.0, 112.0, 110.0, 148.0, 116.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 186.0, 185.0, 186.0, 205.0, 250.0, 185.0, 203.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 90.0, 63.0, 61.0, 59.0, 58.0, 98.0, 79.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 92.0, 70.0, 68.0, 69.0, 93.0, 68.0, 69.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 74.0, 108.0, 131.0, 134.0, 84.0, 89.0, 83.0, 87.0, 85.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 82.0, 84.0, 81.0, 82.0, 84.0, 81.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 75.0, 76.0, 72.0, 71.0, 68.0, 69.0, 69.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 84.0, 87.0, 92.0, 88.0, 86.0, 86.0, 91.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 178.0, 177.0, 157.0, 158.0, 145.0, 146.0, 182.0, 167.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 181.0, 210.0, 174.0, 171.0, 172.0, 173.0, 173.0, 171.0, 169.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 69.0, 68.0, 67.0, 79.0, 87.0, 88.0, 70.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1481.2000000000003, "alertThreshold": 2.0}]} 09:20:10 INFO - Return code: 0 09:20:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:10 INFO - # TBPL SUCCESS # 09:20:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:20:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:20:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:20:10 INFO - 2016-10-14 09:20:10.928 screenresolution[3259:49701] starting screenresolution argv=screenresolution get 09:20:10 INFO - 2016-10-14 09:20:10.931 screenresolution[3259:49701] Display 0: 1600x1200x32@60 09:20:10 INFO - 2016-10-14 09:20:10.937 screenresolution[3260:49705] starting screenresolution argv=screenresolution list 09:20:10 INFO - Available Modes on Display 0 09:20:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:20:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:20:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:20:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:20:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:20:11 INFO - Intel Iris: 09:20:11 INFO - Chipset Model: Intel Iris 09:20:11 INFO - Type: GPU 09:20:11 INFO - Bus: Built-In 09:20:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:20:11 INFO - Vendor: Intel (0x8086) 09:20:11 INFO - Device ID: 0x0a2e 09:20:11 INFO - Revision ID: 0x0009 09:20:11 INFO - Displays: 09:20:11 INFO - Display: 09:20:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:20:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:20:11 INFO - Display Serial Number: 1600x1200 60 09:20:11 INFO - Main Display: Yes 09:20:11 INFO - Mirror: Off 09:20:11 INFO - Online: Yes 09:20:11 INFO - Rotation: Supported 09:20:11 INFO - Return code: 0 09:20:11 INFO - Running post-action listener: _resource_record_post_action 09:20:11 INFO - [mozharness: 2016-10-14 16:20:11.174740Z] Finished run-tests step (success) 09:20:11 INFO - Running post-run listener: _resource_record_post_run 09:20:11 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 364544; Write bytes: 709746176; Read time: 4; Write time: 2085 09:20:11 INFO - TinderboxPrint: CPU usage
53.5% 09:20:11 INFO - TinderboxPrint: I/O read bytes / time
364,544 / 4 09:20:11 INFO - TinderboxPrint: I/O write bytes / time
709,746,176 / 2,085 09:20:11 INFO - TinderboxPrint: CPU idle
2,262.0 (46.5%) 09:20:11 INFO - TinderboxPrint: CPU system
976.9 (20.1%) 09:20:11 INFO - TinderboxPrint: CPU user
1,626.7 (33.4%) 09:20:11 INFO - TinderboxPrint: Swap in / out
407,764,992 / 0 09:20:11 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 394594816; Write bytes: 388564992; Read time: 30201; Write time: 704 09:20:11 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 364544; Write bytes: 298669568; Read time: 4; Write time: 1331 09:20:11 INFO - Running post-run listener: _upload_blobber_files 09:20:11 INFO - Blob upload gear active. 09:20:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:11 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 09:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:20:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:13 INFO - (blobuploader) - INFO - Done attempting. 09:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:13 INFO - (blobuploader) - INFO - Done attempting. 09:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:16 INFO - (blobuploader) - INFO - Done attempting. 09:20:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:16 INFO - Return code: 0 09:20:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00251ad8bc5de2f5673440d3be2c70993cd748f33d37d585214e0b50939da3cc40edeac7af451801ecc2d5d38edf8a4976f9839dfdf306aa0a1610154a80dd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2e41857bdd252173c06d37f75ca63f040d8b8df15c3d068ce8a2ba691ba01db4a915191de5328df4e800978b1c535a057d6ac25c836da2b27d7df3d34bff8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b6e80e437e61d84ab7be708510e353890712a32842c1fed5860a841909f16fb213ca397dc01d604120bfd5ec7f356abf5f6aa84770a5d7c1193b67652ee910"} 09:20:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:16 INFO - Contents: 09:20:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00251ad8bc5de2f5673440d3be2c70993cd748f33d37d585214e0b50939da3cc40edeac7af451801ecc2d5d38edf8a4976f9839dfdf306aa0a1610154a80dd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2e41857bdd252173c06d37f75ca63f040d8b8df15c3d068ce8a2ba691ba01db4a915191de5328df4e800978b1c535a057d6ac25c836da2b27d7df3d34bff8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b6e80e437e61d84ab7be708510e353890712a32842c1fed5860a841909f16fb213ca397dc01d604120bfd5ec7f356abf5f6aa84770a5d7c1193b67652ee910"} 09:20:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:16 INFO - Copying logs to upload dir... 09:20:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.409465 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-14 09:20:16.343977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 09:20:16.347276) ========= 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.KqZMMH71wB/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.atm9LOprg4/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00251ad8bc5de2f5673440d3be2c70993cd748f33d37d585214e0b50939da3cc40edeac7af451801ecc2d5d38edf8a4976f9839dfdf306aa0a1610154a80dd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2e41857bdd252173c06d37f75ca63f040d8b8df15c3d068ce8a2ba691ba01db4a915191de5328df4e800978b1c535a057d6ac25c836da2b27d7df3d34bff8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b6e80e437e61d84ab7be708510e353890712a32842c1fed5860a841909f16fb213ca397dc01d604120bfd5ec7f356abf5f6aa84770a5d7c1193b67652ee910"} build_url:https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/aRl1RoL9R-aO9hN9l3WOWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00251ad8bc5de2f5673440d3be2c70993cd748f33d37d585214e0b50939da3cc40edeac7af451801ecc2d5d38edf8a4976f9839dfdf306aa0a1610154a80dd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb2e41857bdd252173c06d37f75ca63f040d8b8df15c3d068ce8a2ba691ba01db4a915191de5328df4e800978b1c535a057d6ac25c836da2b27d7df3d34bff8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4b6e80e437e61d84ab7be708510e353890712a32842c1fed5860a841909f16fb213ca397dc01d604120bfd5ec7f356abf5f6aa84770a5d7c1193b67652ee910"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 09:20:16.380337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:20:16.380691) ========= 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.KqZMMH71wB/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.atm9LOprg4/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.005288 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:20:16.432855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 09:20:16.433531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 09:20:16.434257) ========= ========= Total master_lag: 0.19 =========