builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1474892620.02 results: success (0) buildid: 20160926030203 builduid: 854aba1db67b485e88ec5b703b09252b revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.016876) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.017320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.017665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.079991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.080570) ========= 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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-09-26 05:23:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-09-26 05:23:40 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.266791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.267126) ========= 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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.028658 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.316756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 05:23:40.317105) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --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 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-09-26 05:23:40,391 truncating revision to first 12 chars 2016-09-26 05:23:40,391 Setting DEBUG logging. 2016-09-26 05:23:40,391 attempt 1/10 2016-09-26 05:23:40,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29beaebdfacc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 05:23:41,127 unpacking tar archive at: mozilla-central-29beaebdfacc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 05:23:41.347910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.348237) ========= script_repo_revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.348636) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.348900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.367609) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-26 05:23:41.377902) ========= /tools/buildbot/bin/python 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', '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:23:41 INFO - MultiFileLogger online at 20160926 05:23:41 in /builds/slave/test 05:23:41 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 05:23:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:41 INFO - {'append_to_log': False, 05:23:41 INFO - 'base_work_dir': '/builds/slave/test', 05:23:41 INFO - 'blob_upload_branch': 'Firefox', 05:23:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:41 INFO - 'branch': 'Firefox', 05:23:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:41 INFO - 'config_files': ('talos/mac_config.py',), 05:23:41 INFO - 'default_actions': ('clobber', 05:23:41 INFO - 'read-buildbot-config', 05:23:41 INFO - 'download-and-extract', 05:23:41 INFO - 'populate-webroot', 05:23:41 INFO - 'create-virtualenv', 05:23:41 INFO - 'install', 05:23:41 INFO - 'run-tests'), 05:23:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:41 INFO - 'download_minidump_stackwalk': True, 05:23:41 INFO - 'download_symbols': 'ondemand', 05:23:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:41 INFO - 'installer_path': 'installer.exe', 05:23:41 INFO - 'log_level': 'info', 05:23:41 INFO - 'log_name': 'talos', 05:23:41 INFO - 'log_to_console': True, 05:23:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:23:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:23:41 INFO - 'opt_config_files': (), 05:23:41 INFO - 'pip_index': False, 05:23:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:41 INFO - 'cmd': ('bash', 05:23:41 INFO - '-c', 05:23:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:41 INFO - 'enabled': True, 05:23:41 INFO - 'halt_on_failure': False, 05:23:41 INFO - 'name': 'check_screen_resolution'},), 05:23:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:41 INFO - 'cmd': ('bash', 05:23:41 INFO - '-c', 05:23:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:41 INFO - 'enabled': True, 05:23:41 INFO - 'halt_on_failure': False, 05:23:41 INFO - 'name': 'check_screen_resolution'},), 05:23:41 INFO - 'run_cmd_checks_enabled': True, 05:23:41 INFO - 'sps_profile': False, 05:23:41 INFO - 'sps_profile_interval': 0, 05:23:41 INFO - 'suite': 'dromaeojs', 05:23:41 INFO - 'system_bits': '32', 05:23:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:41 INFO - 'title': 't-yosemite-r7-0191', 05:23:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:41 INFO - 'use_talos_json': True, 05:23:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:41 INFO - 'work_dir': 'build'} 05:23:41 INFO - [mozharness: 2016-09-26 12:23:41.588403Z] Running clobber step. 05:23:41 INFO - Running pre-action listener: _resource_record_pre_action 05:23:41 INFO - Running main action method: clobber 05:23:41 INFO - rmtree: /builds/slave/test/build 05:23:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:43 INFO - Running post-action listener: _resource_record_post_action 05:23:43 INFO - [mozharness: 2016-09-26 12:23:43.809617Z] Finished clobber step (success) 05:23:43 INFO - [mozharness: 2016-09-26 12:23:43.809740Z] Running read-buildbot-config step. 05:23:43 INFO - Running pre-action listener: _resource_record_pre_action 05:23:43 INFO - Running main action method: read_buildbot_config 05:23:43 INFO - Using buildbot properties: 05:23:43 INFO - { 05:23:43 INFO - "project": "", 05:23:43 INFO - "product": "firefox", 05:23:43 INFO - "script_repo_revision": "production", 05:23:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:23:43 INFO - "repository": "", 05:23:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:23:43 INFO - "buildid": "20160926030203", 05:23:43 INFO - "stage_platform": "macosx64", 05:23:43 INFO - "basedir": "/builds/slave/test", 05:23:43 INFO - "nightly_build": "True", 05:23:43 INFO - "buildnumber": 32, 05:23:43 INFO - "slavename": "t-yosemite-r7-0191", 05:23:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:23:43 INFO - "platform": "yosemite_r7", 05:23:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:23:43 INFO - "branch": "mozilla-central", 05:23:43 INFO - "repo_path": "mozilla-central", 05:23:43 INFO - "revision": "29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49", 05:23:43 INFO - "pgo_build": "False", 05:23:43 INFO - "builduid": "854aba1db67b485e88ec5b703b09252b", 05:23:43 INFO - "slavebuilddir": "test" 05:23:43 INFO - } 05:23:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:23:43 INFO - Running post-action listener: _resource_record_post_action 05:23:43 INFO - [mozharness: 2016-09-26 12:23:43.813001Z] Finished read-buildbot-config step (success) 05:23:43 INFO - [mozharness: 2016-09-26 12:23:43.813110Z] Running download-and-extract step. 05:23:43 INFO - Running pre-action listener: _resource_record_pre_action 05:23:43 INFO - Running main action method: download_and_extract 05:23:43 INFO - mkdir: /builds/slave/test/build/tests 05:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:43 INFO - trying https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:23:43 INFO - Downloading https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:23:45 INFO - Downloaded 1199 bytes. 05:23:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:23:45 INFO - Using the following test package requirements: 05:23:45 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:23:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:23:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:23:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'jsshell-mac.zip'], 05:23:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:23:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:23:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:23:45 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:23:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:23:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:23:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:23:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:23:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:23:45 INFO - Fetch https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:23:45 INFO - Expected file size: 16438988 05:23:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:23:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:23:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:23:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:23:53 INFO - Expected file size: 16438988 05:23:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:23:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:23:59 INFO - Fetch https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:24:01 INFO - Expected file size: 14414059 05:24: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')]} 05:24:01 INFO - trying https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:24:01 INFO - Downloading https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:24:06 INFO - Downloaded 111715330 bytes. 05:24:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:24:06 INFO - mkdir: /builds/slave/test/properties 05:24:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:06 INFO - Contents: 05:24:06 INFO - build_url:https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - Running post-action listener: set_extra_try_arguments 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.018157Z] Finished download-and-extract step (success) 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.018260Z] Running populate-webroot step. 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: populate_webroot 05:24:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:07 INFO - '--tppagecycles', 05:24:07 INFO - '7'], 05:24:07 INFO - 'tests': ['tsvgm']}}, 05:24:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['damp', 'tps']}, 05:24:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'tests': ['damp', 'tps']}, 05:24:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['dromaeo_dom']}, 05:24:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['basic_compositor_video']}, 05:24:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:24:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tsvgx', 05:24:07 INFO - 'tsvgr_opacity', 05:24:07 INFO - 'tart', 05:24:07 INFO - 'tscrollx', 05:24:07 INFO - 'cart']}, 05:24:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:07 INFO - 'tsvgr_opacity', 05:24:07 INFO - 'tart', 05:24:07 INFO - 'tscrollx', 05:24:07 INFO - 'cart']}, 05:24:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tp5o']}, 05:24:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'tests': ['tp5o']}, 05:24:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s', 05:24:07 INFO - '--xperf_path', 05:24:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:07 INFO - 'tests': ['tp5n']}, 05:24:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--xperf_path', 05:24:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:07 INFO - 'tests': ['tp5n']}}, 05:24:07 INFO - 'talos.zip': {'path': '', 05:24:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.037471Z] Finished populate-webroot step (success) 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.037575Z] Running create-virtualenv step. 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: create_virtualenv 05:24:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:24:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:07 INFO - Using real prefix '/tools/python27' 05:24:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:10 INFO - Installing pip.................done. 05:24:10 INFO - Return code: 0 05:24:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:10 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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:10 INFO - 'HOME': '/Users/cltbld', 05:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:10 INFO - 'LOGNAME': 'cltbld', 05:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:10 INFO - 'MOZ_NO_REMOTE': '1', 05:24:10 INFO - 'NO_EM_RESTART': '1', 05:24:10 INFO - 'PAGER': '/bin/cat', 05:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:10 INFO - 'PWD': '/builds/slave/test', 05:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:10 INFO - 'SHELL': '/bin/bash', 05:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:10 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:10 INFO - 'USER': 'cltbld', 05:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:10 INFO - 'XPC_FLAGS': '0x0', 05:24:10 INFO - 'XPC_SERVICE_NAME': '0', 05:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:24:10 INFO - Cleaning up... 05:24:11 INFO - Return code: 0 05:24:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:11 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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:11 INFO - 'HOME': '/Users/cltbld', 05:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:11 INFO - 'LOGNAME': 'cltbld', 05:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:11 INFO - 'MOZ_NO_REMOTE': '1', 05:24:11 INFO - 'NO_EM_RESTART': '1', 05:24:11 INFO - 'PAGER': '/bin/cat', 05:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:11 INFO - 'PWD': '/builds/slave/test', 05:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:11 INFO - 'SHELL': '/bin/bash', 05:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:11 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:11 INFO - 'USER': 'cltbld', 05:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:11 INFO - 'XPC_FLAGS': '0x0', 05:24:11 INFO - 'XPC_SERVICE_NAME': '0', 05:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:11 INFO - Downloading/unpacking psutil>=3.1.1 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:14 INFO - Installing collected packages: psutil 05:24:14 INFO - Running setup.py install for psutil 05:24:14 INFO - building 'psutil._psutil_osx' extension 05:24:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:24:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:24:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:24:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:24:15 INFO - building 'psutil._psutil_posix' extension 05:24:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:24:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:24:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:24:15 INFO - ^ 05:24:15 INFO - 1 warning generated. 05:24:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:15 INFO - Successfully installed psutil 05:24:15 INFO - Cleaning up... 05:24:15 INFO - Return code: 0 05:24:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:16 INFO - 'HOME': '/Users/cltbld', 05:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:16 INFO - 'LOGNAME': 'cltbld', 05:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:16 INFO - 'MOZ_NO_REMOTE': '1', 05:24:16 INFO - 'NO_EM_RESTART': '1', 05:24:16 INFO - 'PAGER': '/bin/cat', 05:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:16 INFO - 'PWD': '/builds/slave/test', 05:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:16 INFO - 'SHELL': '/bin/bash', 05:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:16 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:16 INFO - 'USER': 'cltbld', 05:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:16 INFO - 'XPC_FLAGS': '0x0', 05:24:16 INFO - 'XPC_SERVICE_NAME': '0', 05:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:18 INFO - Installing collected packages: mozsystemmonitor 05:24:18 INFO - Running setup.py install for mozsystemmonitor 05:24:18 INFO - Successfully installed mozsystemmonitor 05:24:18 INFO - Cleaning up... 05:24:19 INFO - Return code: 0 05:24:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:19 INFO - 'HOME': '/Users/cltbld', 05:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PAGER': '/bin/cat', 05:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:19 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - 'XPC_FLAGS': '0x0', 05:24:19 INFO - 'XPC_SERVICE_NAME': '0', 05:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 INFO - Downloading/unpacking jsonschema==2.5.1 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:22 INFO - warning: no files found matching '*.txt' 05:24:22 INFO - no previously-included directories found matching 'build' 05:24:22 INFO - no previously-included directories found matching 'dist' 05:24:22 INFO - no previously-included directories found matching '.git*' 05:24:22 INFO - Installing collected packages: jsonschema, functools32 05:24:22 INFO - Running setup.py install for functools32 05:24:22 INFO - warning: no files found matching '*.txt' 05:24:22 INFO - no previously-included directories found matching 'build' 05:24:22 INFO - no previously-included directories found matching 'dist' 05:24:22 INFO - no previously-included directories found matching '.git*' 05:24:22 INFO - Successfully installed jsonschema functools32 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:22 INFO - 'HOME': '/Users/cltbld', 05:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PAGER': '/bin/cat', 05:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:22 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - 'XPC_FLAGS': '0x0', 05:24:22 INFO - 'XPC_SERVICE_NAME': '0', 05:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:22 INFO - 'HOME': '/Users/cltbld', 05:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PAGER': '/bin/cat', 05:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:22 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - 'XPC_FLAGS': '0x0', 05:24:22 INFO - 'XPC_SERVICE_NAME': '0', 05:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:26 INFO - Downloading docopt-0.6.1.tar.gz 05:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:26 INFO - Running setup.py install for blobuploader 05:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:26 INFO - Running setup.py install for requests 05:24:27 INFO - Running setup.py install for docopt 05:24:27 INFO - Successfully installed blobuploader requests docopt 05:24:27 INFO - Cleaning up... 05:24:27 INFO - Return code: 0 05:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:27 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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:27 INFO - 'HOME': '/Users/cltbld', 05:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:27 INFO - 'LOGNAME': 'cltbld', 05:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:27 INFO - 'MOZ_NO_REMOTE': '1', 05:24:27 INFO - 'NO_EM_RESTART': '1', 05:24:27 INFO - 'PAGER': '/bin/cat', 05:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:27 INFO - 'PWD': '/builds/slave/test', 05:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:27 INFO - 'SHELL': '/bin/bash', 05:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:27 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:27 INFO - 'USER': 'cltbld', 05:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:27 INFO - 'XPC_FLAGS': '0x0', 05:24:27 INFO - 'XPC_SERVICE_NAME': '0', 05:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Pdu5AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-pFR9ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1jb4_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-HGbagj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YuXoyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-onVlXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-vSE3tF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bf4_j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-tE_Ac2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-pWHTmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:28 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cneOCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:29 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-o7gybv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:29 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-L1F7ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:29 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-k70E__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:29 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-htHPfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:29 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-QOiJuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:29 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-93uz_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:29 INFO - Running setup.py install for manifestparser 05:24:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:29 INFO - Running setup.py install for mozcrash 05:24:29 INFO - Running setup.py install for mozdebug 05:24:30 INFO - Running setup.py install for mozdevice 05:24:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozfile 05:24:30 INFO - Running setup.py install for mozhttpd 05:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozinfo 05:24:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozInstall 05:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozleak 05:24:30 INFO - Running setup.py install for mozlog 05:24:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for moznetwork 05:24:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for mozprocess 05:24:31 INFO - Running setup.py install for mozprofile 05:24:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for mozrunner 05:24:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for mozscreenshot 05:24:31 INFO - Running setup.py install for moztest 05:24:32 INFO - Running setup.py install for mozversion 05:24:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:32 INFO - Cleaning up... 05:24:32 INFO - Return code: 0 05:24:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:32 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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:32 INFO - 'HOME': '/Users/cltbld', 05:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:32 INFO - 'LOGNAME': 'cltbld', 05:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:32 INFO - 'MOZ_NO_REMOTE': '1', 05:24:32 INFO - 'NO_EM_RESTART': '1', 05:24:32 INFO - 'PAGER': '/bin/cat', 05:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:32 INFO - 'PWD': '/builds/slave/test', 05:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:32 INFO - 'SHELL': '/bin/bash', 05:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:32 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:32 INFO - 'USER': 'cltbld', 05:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:32 INFO - 'XPC_FLAGS': '0x0', 05:24:32 INFO - 'XPC_SERVICE_NAME': '0', 05:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-a1KLrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iUEd_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6dnUVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-A0HyXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:32 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-kiknHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hgDPW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-SuGrz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Sk9MDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-E1U2Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-o4jzNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-V6ZGt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-RBIoDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iRPgEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:33 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-r9qwq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:34 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-rjizSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:34 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-OZTMKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:34 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-F_D2V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:36 INFO - Downloading blessings-1.6.tar.gz 05:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:36 INFO - Installing collected packages: blessings 05:24:36 INFO - Running setup.py install for blessings 05:24:37 INFO - Successfully installed blessings 05:24:37 INFO - Cleaning up... 05:24:37 INFO - Return code: 0 05:24:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:37 INFO - Reading from file tmpfile_stdout 05:24:37 INFO - Current package versions: 05:24:37 INFO - blessings == 1.6 05:24:37 INFO - blobuploader == 1.2.4 05:24:37 INFO - docopt == 0.6.1 05:24:37 INFO - functools32 == 3.2.3-2 05:24:37 INFO - jsonschema == 2.5.1 05:24:37 INFO - manifestparser == 1.1 05:24:37 INFO - mozInstall == 1.12 05:24:37 INFO - mozcrash == 0.17 05:24:37 INFO - mozdebug == 0.1 05:24:37 INFO - mozdevice == 0.48 05:24:37 INFO - mozfile == 1.2 05:24:37 INFO - mozhttpd == 0.7 05:24:37 INFO - mozinfo == 0.9 05:24:37 INFO - mozleak == 0.1 05:24:37 INFO - mozlog == 3.4 05:24:37 INFO - moznetwork == 0.27 05:24:37 INFO - mozprocess == 0.23 05:24:37 INFO - mozprofile == 0.28 05:24:37 INFO - mozrunner == 6.12 05:24:37 INFO - mozscreenshot == 0.1 05:24:37 INFO - mozsystemmonitor == 0.3 05:24:37 INFO - moztest == 0.7 05:24:37 INFO - mozversion == 1.4 05:24:37 INFO - psutil == 3.1.1 05:24:37 INFO - requests == 1.2.3 05:24:37 INFO - wsgiref == 0.1.2 05:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 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 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:37 INFO - 'HOME': '/Users/cltbld', 05:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:37 INFO - 'LOGNAME': 'cltbld', 05:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:37 INFO - 'MOZ_NO_REMOTE': '1', 05:24:37 INFO - 'NO_EM_RESTART': '1', 05:24:37 INFO - 'PAGER': '/bin/cat', 05:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:37 INFO - 'PWD': '/builds/slave/test', 05:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:37 INFO - 'SHELL': '/bin/bash', 05:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:37 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:37 INFO - 'USER': 'cltbld', 05:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:37 INFO - 'XPC_FLAGS': '0x0', 05:24:37 INFO - 'XPC_SERVICE_NAME': '0', 05:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:24:37 INFO - Cleaning up... 05:24:37 INFO - Return code: 0 05:24:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108225490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10819b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe550492040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, '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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:37 INFO - 'HOME': '/Users/cltbld', 05:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:37 INFO - 'LOGNAME': 'cltbld', 05:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:37 INFO - 'MOZ_NO_REMOTE': '1', 05:24:37 INFO - 'NO_EM_RESTART': '1', 05:24:37 INFO - 'PAGER': '/bin/cat', 05:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:37 INFO - 'PWD': '/builds/slave/test', 05:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:37 INFO - 'SHELL': '/bin/bash', 05:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:24:37 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:37 INFO - 'USER': 'cltbld', 05:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:37 INFO - 'XPC_FLAGS': '0x0', 05:24:37 INFO - 'XPC_SERVICE_NAME': '0', 05:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:38 INFO - Cleaning up... 05:24:38 INFO - Return code: 0 05:24:38 INFO - Running post-action listener: _resource_record_post_action 05:24:38 INFO - Running post-action listener: _start_resource_monitoring 05:24:38 INFO - Starting resource monitoring. 05:24:38 INFO - [mozharness: 2016-09-26 12:24:38.061400Z] Finished create-virtualenv step (success) 05:24:38 INFO - [mozharness: 2016-09-26 12:24:38.062411Z] Running install step. 05:24:38 INFO - Running pre-action listener: _resource_record_pre_action 05:24:38 INFO - Running main action method: install 05:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:38 INFO - Reading from file tmpfile_stdout 05:24:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:38 INFO - Reading from file tmpfile_stdout 05:24:38 INFO - Output received: 05:24:38 INFO - Usage: mozinstall [options] installer 05:24:38 INFO - Options: 05:24:38 INFO - -h, --help show this help message and exit 05:24:38 INFO - -d DEST, --destination=DEST 05:24:38 INFO - Directory to install application into. [default: 05:24:38 INFO - "/builds/slave/test"] 05:24:38 INFO - --app=APP Application being installed. [default: firefox] 05:24:38 INFO - mkdir: /builds/slave/test/build/application 05:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:25:12 INFO - Reading from file tmpfile_stdout 05:25:12 INFO - Output received: 05:25:12 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:25:12 INFO - Running post-action listener: _resource_record_post_action 05:25:12 INFO - [mozharness: 2016-09-26 12:25:12.926947Z] Finished install step (success) 05:25:12 INFO - [mozharness: 2016-09-26 12:25:12.927104Z] Running run-tests step. 05:25:12 INFO - Running pre-action listener: _resource_record_pre_action 05:25:12 INFO - Running main action method: run_tests 05:25:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:12 INFO - 2016-09-26 05:25:12.941 screenresolution[1647:8353] starting screenresolution argv=screenresolution get 05:25:12 INFO - 2016-09-26 05:25:12.944 screenresolution[1647:8353] Display 0: 1600x1200x32@60 05:25:12 INFO - 2016-09-26 05:25:12.949 screenresolution[1648:8355] starting screenresolution argv=screenresolution list 05:25:12 INFO - Available Modes on Display 0 05:25:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:13 INFO - Intel Iris: 05:25:13 INFO - Chipset Model: Intel Iris 05:25:13 INFO - Type: GPU 05:25:13 INFO - Bus: Built-In 05:25:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:13 INFO - Vendor: Intel (0x8086) 05:25:13 INFO - Device ID: 0x0a2e 05:25:13 INFO - Revision ID: 0x0009 05:25:13 INFO - Displays: 05:25:13 INFO - Display: 05:25:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:13 INFO - Display Serial Number: 1600x1200 60 05:25:13 INFO - Main Display: Yes 05:25:13 INFO - Mirror: Off 05:25:13 INFO - Online: Yes 05:25:13 INFO - Rotation: Supported 05:25:13 INFO - Return code: 0 05:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:13 INFO - Python 2.7.3 05:25:13 INFO - Return code: 0 05:25:13 INFO - grabbing minidump binary from tooltool 05:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:13 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 0x108039d30>, '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 0x107e5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108031b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:25:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:25:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:25:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:13 INFO - Return code: 0 05:25:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:13 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/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 05:25:13 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/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 05:25:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LJ3HMW9K1H/Render', 05:25:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:13 INFO - 'HOME': '/Users/cltbld', 05:25:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:13 INFO - 'LOGNAME': 'cltbld', 05:25:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:13 INFO - 'MOZ_NO_REMOTE': '1', 05:25:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:13 INFO - 'NO_EM_RESTART': '1', 05:25:13 INFO - 'PAGER': '/bin/cat', 05:25:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:13 INFO - 'PWD': '/builds/slave/test', 05:25:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:13 INFO - 'SHELL': '/bin/bash', 05:25:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BHnbG1Alcs/Listeners', 05:25:13 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 05:25:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:13 INFO - 'USER': 'cltbld', 05:25:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:13 INFO - 'XPC_FLAGS': '0x0', 05:25:13 INFO - 'XPC_SERVICE_NAME': '0', 05:25:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:13 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/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 05:25:13 INFO - mozversion application_buildid: 20160926030203 05:25:13 INFO - mozversion application_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 05:25:13 INFO - mozversion application_display_name: Nightly 05:25:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:13 INFO - mozversion application_name: Firefox 05:25:13 INFO - mozversion application_remotingname: firefox 05:25:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:25:13 INFO - mozversion application_vendor: Mozilla 05:25:13 INFO - mozversion application_version: 52.0a1 05:25:13 INFO - mozversion platform_buildid: 20160926030203 05:25:13 INFO - mozversion platform_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 05:25:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:25:13 INFO - mozversion platform_version: 52.0a1 05:25:13 INFO - using testdate: 1474892713 05:25:13 INFO - actual date: 1474892713 05:25:13 INFO - starting webserver on 'localhost:49275' 05:25:13 INFO - SUITE-START | Running 2 tests 05:25:13 INFO - TEST-START | dromaeo_css 05:25:13 INFO - operating with platform_type : mac_ 05:25:13 INFO - Initialising browser for dromaeo_css test... 05:25:13 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmppJ4ERS/profile http://localhost:49275/getInfo.html) 05:25:15 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 05:25:15 INFO - PROCESS | 1658 | colorDepth:24 05:25:15 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 05:25:15 INFO - PROCESS | 1658 | __metrics 05:25:16 INFO - PROCESS | 1658 | 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" 05:25:16 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:16 INFO - TEST-INFO | 1658: exit 0 05:25:16 INFO - Browser initialized. 05:25:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:16 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmppJ4ERS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:28 INFO - PROCESS | 1662 | RSS: Main: 235749376 05:25:28 INFO - PROCESS | 1662 | 05:26:19 INFO - PROCESS | 1662 | 1474892779951 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:28:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:28:33 INFO - PROCESS | 1662 | RSS: Main: 386330624 05:28:33 INFO - PROCESS | 1662 | 05:31:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:31:37 INFO - PROCESS | 1662 | RSS: Main: 374198272 05:31:37 INFO - PROCESS | 1662 | 05:34:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:34:40 INFO - PROCESS | 1662 | RSS: Main: 339009536 05:34:40 INFO - PROCESS | 1662 | 05:37:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:37:43 INFO - PROCESS | 1662 | RSS: Main: 349204480 05:37:43 INFO - PROCESS | 1662 | 05:40:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:40:47 INFO - PROCESS | 1662 | RSS: Main: 329019392 05:40:47 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:43:50 INFO - PROCESS | 1662 | RSS: Main: 423174144 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | __start_tp_report 05:43:50 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:43:50 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:43:50 INFO - PROCESS | 1662 | |i|pagename|runs| 05:43:50 INFO - PROCESS | 1662 | |0;dojo.html;3000.6249218847643;3293.5883014623164;3332.1169889979146;3352.89941301761;3368.040108569057;5540.307461567304;5582;5657.547396208303;5666.575006874486;5696.572757043223;5632.662040277576;5676.063449530822;5690.829275121742;5699.829005129843;5709.029464990951;5100.923486147702;5154.974225128869;5169.638125331228;5185.377754669445;5216.139337009389;5226.111561034633;5237.869053273661;5239.371275446952;5249.448807875176;5265.631405801595;5142.177251639739;5173.094708426011;5192.740362981855;5215.1395019821875;5255.343082114736;5236.188390799452;5238.319018527605;5254.4220135785035;5274.683518988873;5293.920591191135;5011.523905228997;5115.5396014358885;5198.532132108091;5207.843764687065;5214.165733482625;5533.667979921218;5607.243022191993;5624.409437009137;5659.292588426447;5662.801801936913;5365.3293338332705;6149.723262453201;6156.815295541141;6164.291106522763;6170.074488826667;5328.49379308965;6291.748330066792;6297.338779428185;6323.620582765049;6327.145835312266;5629.268195134607;5668.631538950038;5680;5719.056355701346;5796.797112101099;6283.7800676977;6315.40003699657;6326.936730632635;6331.240251169889;6332.1135041094285;6113.541484388688;6124.663143527148;6126.203593532812;6129.877402452015;6132.080187971751;6003.759849605967;6126.151269885539;6127.711360156438;6238.438540531283;6258.186435763413;6087.908681369783;6127.325994140641;6130.249081909707;6134.405972711579;6136.325004249618;6108.450239478379;6146.7233974471255;6164.568480206342;6168.259808822881;6172.69136543171;4780.163471392492;4812.5668689818085;4847.127517046895;4849.2726091085915;4881.877953051131;4327.7186982846015;4372.978135109368;4436.201483732959;4441.111777644484;4452.910941781146;5660.320761508563;5692.743826527816;5714.457126572969;5744.425557444222;5746;6202.689865506797;6220.782272620437;6228.34602366745;6233.376662333821;6247.812565623039;5620.747066382022;5654.830355089354;5657.830265092054;5677.37548869624;5724.971375143097;5278.129108697099;5318.734063296897;5321.122014867504;5353.625246232727;5366.114591092504;6297.685115744194;6321.683915804283;6328.557001010069;6340.112384266206;6345.2702939160745;6109.20580324555;6214.751409943552;6221.782237621843;6224.564280500322;6235.906461402992;6234.2830574484515;6254.437100660963;6324.083007963727;6340.968295158679;6350.841228969312;6143;6153.323134455117;6183.443490085914;6195.597286176384;6210.254769427697;6182.196314479089;6240.251169859646;6243.719032643451;6251.874962500816;6260.092286618506;5919.112133180058;5967.134765459071;6007.189029480965;6102;6140.385961403824;5968.134620479919;5984.251968503937;5987.371326010706;6027.065804800263;6080.452759251689;5880.294364676266;5884.735186916685;5891.941080589139;5900.616459930091;5900.763969441175;4518.525554816829;6036.245469316335;6044.516438684983;6056.394360563909;6064.666443345658;5677.630953987978;5835.824925252249;5837.532997360286;5851.561132914963;5860.736266868086 05:43:50 INFO - PROCESS | 1662 | |1;ext.html;488.74096728733764;519.0812262295736;530.9761060752265;539.6330495263222;556.5797822643905;30228.395432091373;38505.42241866371;39685.603143968554;39754;39985;33322.833385833095;41347.58652413475;41376.758697239056;41427;41642;8669.739907802745;9682.031796820314;9876.308658393915;9880.604775808959;9883.209343252522;8787.428817126898;11800.704982375466;12057.758844823098;12090.697732556668;12287.324197169151;12038;12110.455029523648;12114.515419383215;12142.332171730552;12174.939125304405;10058.798824023515;10116.393016419039;12113.93943030288;12121;12140.757184856342;11825;11902.9882459991;11923.092305231121;11923.105767067505;11923.701907452296;39359.21281574381;39738;39755.807325780275;39783.40324895129;39826.40260396097;3581.2658405026905;3952.7035472339403;3997.960020399788;4022.1151346703678;4025.677945764332;30322.69677303243;30813.691863081305;30983.690163098305;31280;31348.37303253945;3182.236263296815;3242.7243684286864;3263.1515805890403;3375.6455572164814;3385.3737058643983;448712;450499;481070;485219;487343;55693.607659808826;55889;55956;56004.71997639986;56139.71930140323;29669;33289.500657489676;33984.81053163127;34195.658043419746;35148;15577.376904923904;15721.742260619123;15730.449434269745;15751.527454176394;15762.76355854663;11236.438178091063;11398.886011139783;12318.568850090203;12414.193077449936;12437.75124497505;14847.777283340758;18198.542276967335;18625;18877.244910203437;18903.338383156522;7832.138464768871;7934;7952.574464788179;8029.638666260033;8050;825.3273582030625;836.8033512124646;930.9162175404247;974.3812678948918;1034.9793004140026;25983.350416239744;28697.856510717313;29156.979505717198;29901.25246868802;30051;917.9541022948825;1078.1644225725126;1103.2222283290262;1105.237386203517;1134.8978591926766;14218.928905355613;14659.193744344164;15260.160691161871;15760.60598485047;15765.763513547307;190740;933269;946601;946800;947079;47619.285710714365;56421.43578564244;57088.14367784486;57113.71443142841;57214;1208.800547909585;1243.9378031098229;1247.7754004279136;1348.8786009259018;1367.2411811444545;23903.76096239015;30036.549451757804;30079.097627071224;30088.548671769502;30761.692383076777;50902;51533.227001594256;51557;51637.483625163266;51805;597160;603939;603997;604025;605841;22606.77393226047;23042;23150.3054908353;25555.87222063878;25972.740272597788;28765.28086797847;33174.668253317155;43293.35059974166;45730.771346143054;46493.76753116213;36757;38175.236495270496;38247.42628860625;39595.604043960346;40106.1978760429;38123;38266.426003610526;39227.803860980515;39397.80301098476;39689.40465892956;36726.816365918;37220.06949826168;37871.81064094662;38021.429678555396;38290.0427489315;32302.19244518906;33256.501152483215;33984.320313593096;34172.82913585416;34192.487112692834;20127.899360503103;20637.69043464379;25317;25520.489590208465;25672.716364182088 05:43:50 INFO - PROCESS | 1662 | |2;jquery.html;344.47123665173933;360.74927925092055;369.5030184401978;372.73908264215055;396.3579002016733;13370.799438008438;14944.626384340398;15602.21988900556;20736.89631551844;21202.57594848106;19950.70073948892;20497.487562810937;20954;21205;21609.3517194484;5620.5503559715125;5995.6702381369005;6262.6868656566985;6268.623882567038;6274.4353008229255;5685.431456854323;6217.347178546255;6265.874682506347;6294.653794041325;6299;5882.294124705041;6102.450779429851;6228.314885362606;6238.59449135807;6240.812775616739;6100.877982440348;6152.753889844401;6157.507399408059;6163.291221509517;6171.012637977947;5048.091343558158;5236.1098613235845;5281.577473802086;5310.336207974004;5316.255724198615;25615.743842561707;26147.869260653573;26190.476190476085;26491;26841.328966775793;2424.9272521824373;2472.295395812203;2998.250437390652;3155.384699983504;3165.271987442878;15581.376744930189;15726.9213653931;15749.370025198978;15915.920420397824;16554.83445165557;1674.6315810521787;1882.4070417818343;1902.5529000684828;1947.6494231038407;1998.9000549972443;95894;116246.41876790646;123316;123699;128513.7148628511;11197.888021119847;11359.602413915472;11581.42092895352;11599.594014209462;11721.011142158695;14460.132392056299;14472;14477;14489.98570100104;14518.346674399678;8263.834723305501;8519.275861551714;8550.27322677567;8667.133286671282;8668.739937801876;6972.755953541602;8401.579921003926;8410.285125764256;8417.326613870875;8499.192576705203;3920.843166273374;4379.64962802975;4522.140793249272;4543.4408072852575;4619.56793394049;1904.1621686457913;1927.1520530966611;1928.2961718972754;1975.4172519106899;1979.3764964036282;855.8245559660379;897.3763234551924;914.8078903430354;948.1798244518579;966.0387914025589;21006.496906116394;22218.88905554716;22285.4400191985;22344.776552234594;22351.547149435235;803.333233416263;911;932.8880534335788;951.9286053546011;991.5389343955095;11009.229353945308;11390.65828025144;11461.312321260752;11532.711682208012;11546.59586914454;389990;465478.3452165503;469331.6533417311;558269;589462.0526897338;132592.3370383142;137838.31080844533;139156;139753;142533.28733356268;933.7338858425317;959.9616015359447;990.9108180263667;991.7966816802539;992.771662517625;19001.144948477075;19035.809641903958;19916.70124948098;20119.59760804805;20255.4936126598;55337.44662553484;57579.80252468441;57706.422935770104;58494.4150558506;59192.1121183174;80764.59617701874;83052.09317673852;84522.57738711267;87748;89400.5529972372;11064.889351106385;11708.590199342982;12028.75942481163;12548.30984295836;12574.30841303737;13066.869331306565;13600.52398166099;13694.178349299074;13733.793993090312;14236.786448203078;5499.477549632778;7879.921200787919;9505.19205867509;11796.88203117992;11981.341026243641;10044.648437304659;11683.941580292045;11709.887560681722;11883.345326617122;12052.276863388224;11575.131865109983;11730.824037639613;12175.878241217475;12216.389180541115;12278.140530162802;11723.41382930833;11805.822912656145;12316.721406539818;12417.689557761129;12530.686732831753;11500.654980350602;11701.531938722355;11880.940595297314;11895.940520297343;11976.401179940794 05:43:50 INFO - PROCESS | 1662 | |3;mootools.html;1347.2859384526191;1529.8546638069383;1548.9302981365838;1763.409257898604;1932.3430033788509;7793.415493837956;8321;8600.397972141946;8935.285177185826;8954.776130596738;8843.425177363466;8886.466811991286;8890.86663700045;8892.95553522233;8902.243309318716;2371.2412028150998;2400.627902675088;2400.8919598618104;2403.158894386959;2404.266698656909;2052.374025922093;2343.484433424644;2372.9762702373014;2403.435192729707;2404.0864471500804;2358.6226203807396;2379.0602711928777;2388.080588973249;2394.126143957452;2398.832081754278;2306.5848147333472;2332.9300120996313;2342.16853017179;2348.2250857217077;2354.7880690737916;2317.53649270145;2345.824063195267;2357.1278626907983;2357.2574638988663;2371.6561098640773;8619.65521379144;8733.956330218372;8773.34199935001;8820.647174113028;8885.689000884939;5172.379314482287;5346.812861549866;5377.274068000809;5402.973435047328;5404.216388623628;3525.7708248963736;3568.7145028397667;3622.5471816022996;3629.3467175908327;3654.7807131571926;1067.215596536545;1073.2862646340175;1076.4658522766808;1088.0697004061572;1095.8904109589057;11526.59656912004;11595.188336816425;11721.945024947796;11722.882771172179;11772.705682357924;4529.660275479352;4701.905961880743;4818.879528011757;4826.806927722922;4832.975835120802;10028.548715307828;10033.899661003297;10045.949770251102;10054.59781608742;10079.244056695778;5293;5294.8941021180135;5342.679439233659;5384.703841288689;5396.83809485716;4122.546519882811;4362;4523.886902827456;4551.499335073139;4895.0209958008545;3415.8121303328057;3772.1889793694486;3914.8842579864604;3968.3849003404516;3973.543042550086;1245.8318127052912;1265.7405231927617;1270.3457719274581;1276.9233845969272;1281.2760790153534;816.7141500474786;892.6250974590688;913.3058875254854;913.7304495173939;914.7530166854912;5587;5711.257536520226;5916;5934.881302374015;6032.276126864805;419.96010379013944;429.993814474132;439.65047787009405;439.9428074350314;442.9214861811435;3872.4384964180035;3890.6966166334028;3986.681065514752;3999.1601763629965;4007;10284.742881427874;10720.678379648623;10725.356478611307;10742.3017503862;10752.784944301071;9117.36178467501;10549.630762923261;10685.145188384911;10693.358398496115;10705.090067344207;8047.476914000571;8105;8260.215279548433;8285.875711864326;8292.17078292166;5246.632735708464;5523.143912693539;5732.45541673557;5753.1370294456165;5790;9619.56711947978;9721.9027809721;10020.148287395654;10059.245556583139;10065.748356291151;8830.293576513735;9276.768080798034;9879.209663227068;10012.899871001197;10283.07452329264;6024.246969128859;6977.581345119309;7157.892631610426;7432.814179645336;7536.208698086842;8206.425550211428;8208.138145494637;8218.547979861165;8290.963629546306;8292.626831792704;7147.678354474165;7181.820454488679;7387.1135463744695;7541.962290188514;7623.390128789572;7102.786916392516;7308.524945878501;7360.1903790584065;7401.96299018523;7537.736179233701;6913.3777959983845;6963.059986901703;7041.084658994298;7047.788566343018;7048.154221493453;4879.414470263591;4984.177610694195;4997.225430058346;5027.120253955616;5171.586273098218;5014.297998280171;5055.789573620704;5069.493050694901;5099.082165210298;5209.583233341399 05:43:50 INFO - PROCESS | 1662 | |4;prototype.html;300.09222103138006;301.8415331950726;308.41093511393234;315.8199826099123;316.5678848371973;4422.513523512415;5359.062164121283;5372.758225879835;5384.892302153955;5393.838184854456;3838.596947320533;4532.710980954614;5094.350937512491;5108.565771909392;5250.18622113572;3532.0286921096776;3764.3036038333;4047.696422768297;4058.472398588179;4102.774347410891;3526.7002304804123;4072.9389059163987;4105.794710264475;4123.9793801030955;4125.628693417591;3914.745541539805;3956.9909673033335;4042.9797851010703;4056.776877271749;4088.407180958774;3622.655847694478;4025.7181997260204;4076.9388459172987;4081.08175660477;4083.6324730774077;3361.46216605342;3525.6298088700573;3536.5756109266795;3537.398642230827;3551.8756843510355;4142.834286628531;4276.422682937795;4578.450585929677;5154.587632989389;5228.346456692913;4065.5527891931865;4647.767611619439;4660.1145782301255;4677.573340131258;4727.22000869856;4389.978050109729;5448.891022179534;5619.353774315965;5646.600194917185;5652.208690783294;3453.5510383649967;3880.8939452256254;3925.548561915359;3948.526176858795;3963.54419241788;4698.908985501487;5384.300040994684;5797.173890224608;5827.155062515912;5903;3071.6774738652566;3205.611819194715;3277.066530746823;3822.6559609635265;3829.525632631457;3305.2977716476034;3927.548331941863;3929.6659783918117;3946.5664871561926;3953.940690889639;4145.258991223694;4289.828406863753;4385.386045953569;4674;4679.321498382716;4877.487863774323;5123.718195499283;5673.290838645169;5680.034394153004;5724.656520608693;1325.754735373959;1374.6288502104376;1390.1659004597363;1401.3063533550753;1406.4866323791946;896.551724137931;912.2154946745793;928.6842473558887;952.9952350238204;960.4957397366438;5207.817726379559;5231.55531779803;5243.659162154448;5245.580353571705;5255.948810237967;4926.655134140576;5455.844941248185;5463.644863083887;5495.945040549624;5746.166805813134;4091.181763647223;4927;4950.653454258239;5161.406438259573;5556.666600004012;3006.864691088906;3031.999440184734;3036.284499257912;3036.6356037275227;3063.862126204326;5483.725813709299;5889.911651325234;5896.852578685567;5925.970370148121;5943.762249510058;5084.737291905067;5346.732663366816;5489.286392768914;5491.588130890199;5827.59206855516;4884.215996881743;5332.866678332995;5535.501804837584;5848.736806843703;5872.500837428866;4485.37204791336;4957.909259962802;5129.615003948988;5425.565954723534;5920.135157425398;5773.711314434346;5779.393163717918;5792.742334384308;5796.739146738491;5810.854728631818;4675.625949924066;5423.159410291411;5441.7279136043835;6002.409361519288;6044.486218671462;3878.6509214169732;3884.7662594009125;3912.061105334756;3941.4087886817206;3964.3458829292845;5825.116567299214;5863.976927960018;5872.853178670567;5887.8233652990475;5968.76124954997;5499.5325397340075;5633.3521645009705;5700.315962084576;5740.885182296414;5745.597808153389;4792.849716068049;5187.974060129675;5611.466910643482;5627.606067575231;5743.310802703702;4697.953020469751;5156.278121063129;5438.320209973754;5543.473370029841;5608.4111168326735;4914.778834952507;5484.862878428071;5515.338159420895;5619;5676.574256930664;4590.88522786933;4715.316279139437;5509.548251028254;5568.805091821767;5583.928839138376 05:43:50 INFO - PROCESS | 1662 | |5;yui.html;618.3908849782963;760.6120878352039;775.7711475114841;808.672487642505;817.3505298840677;13826.23955682437;15127.924360378196;16225.594360141002;16496;16564.751528727065;14622.707545849076;14680.339384727686;14741.115533068023;14761.188134652617;14826;847.8092429203441;854.3592305770673;877.079066979672;890.5458216309664;890.7906641939139;682.4915437998698;708.989365159523;710.8116349167475;888.3515034025165;895.404555970279;880.2385936165203;918.4030380252823;918.7519369770158;919.5815903763771;924.9676261330854;905.6875377994581;906.8141031088677;907.5280853955971;908.5548081440113;909.077286554148;523.330137424094;547.4388751529674;674.6019848289533;676.0467740485891;677.1366507702719;13260.005499587473;14928.925355373261;15518;15546;15650.139242341667;11920.940395298056;13987.160770353812;14306.856931430657;14580.781288280685;14732.116073035651;11587.652370428901;11913.821292680617;12160;12247.571335003233;12395.876041239562;3753.2681127180213;3766;3777.622237776228;3807.60020197878;3820.2550502651993;85395;129988;132356.3382183083;132590;132854.33572832073;10796.78406431867;10998.34009959405;11115;11127.109831213484;11568.595099171489;22779.544409111724;22804.2018529354;22810.885945570168;22823.087076516753;22824.429389265068;7865.213478652204;8074.192580741878;8080.515169089874;8083.393745469113;8156.1028286888395;4542;4544.863654090383;4616.961183733633;4655.138799322136;4673.929891051637;3665.1020499977144;3750.662440380379;3799.715021373408;3800.4299355096955;3804.8668296609485;664.2759392262457;667.7729571945465;672.1564436631995;680.1158493957835;685.3694600967123;582.9504492118217;660.7951535024158;680.8229860236374;681.574248561925;681.9659017049227;8995.55022248885;9610.711678649512;9612.327137100476;9662.420254784736;9717.17404020652;508.6261597725669;542.4738004135982;549.6839317392515;603.4177019176516;606.7148440233084;3640.4903313535597;4677.134730074947;4713.878426318911;4716.773638853854;4748.19280722278;129551;156917;158588;159508.4049159517;159710.201448992;129727;131349.68650313566;132955;134083.32958335147;136627.63372366148;86870;109088.4545577267;114091.42954285341;114125;116539.77093779601;7062.894056589258;7990.680372785256;8870.955645221733;8939.195472407515;9120.49837258957;65471;66103.66948165228;66468;67055;67651.66174169097;60753.48116296951;61071;88939.55530222307;99615;99845.00154998357;13067.411966461343;13071.738565228832;13197.736045279233;13322.200667959953;13751.793723094363;13199.934000329937;14813.259337033322;14820.036697615053;15502.5349239523;15585.922070389575;13519.797203042159;13575.456981720621;14107.29463526799;14366.13803171813;14570;13622.071254680292;13684.45262189541;13949.860501395262;14090.436382544583;14332.283385830458;12887.711228877037;13276.26980516081;13888.375023124187;13979;14178.29108544548;11202.551897923991;11402.771944561227;11412.600558980395;11667.533298667959;11960.700982475508;6941.687624056828;9774.266929980422;10579.889111643166;10587;11052.283585131881 05:43:50 INFO - PROCESS | 1662 | __end_tp_report 05:43:50 INFO - PROCESS | 1662 | __start_cc_report 05:43:50 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1464 05:43:50 INFO - PROCESS | 1662 | __end_cc_report 05:43:50 INFO - PROCESS | 1662 | __startTimestamp1474893830796__endTimestamp 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:43:50 INFO - PROCESS | 1662 | Number of tests: 6 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5690.73 Median:5860.74 stddev:650.82 (11.1%) stddev-sans-first:617.65 05:43:50 INFO - PROCESS | 1662 | Values: 3000.6 3293.6 3332.1 3352.9 3368.0 5540.3 5582.0 5657.5 5666.6 5696.6 5632.7 5676.1 5690.8 5699.8 5709.0 5100.9 5155.0 5169.6 5185.4 5216.1 5226.1 5237.9 5239.4 5249.4 5265.6 5142.2 5173.1 5192.7 5215.1 5255.3 5236.2 5238.3 5254.4 5274.7 5293.9 5011.5 5115.5 5198.5 5207.8 5214.2 5533.7 5607.2 5624.4 5659.3 5662.8 5365.3 6149.7 6156.8 6164.3 6170.1 5328.5 6291.7 6297.3 6323.6 6327.1 5629.3 5668.6 5680.0 5719.1 5796.8 6283.8 6315.4 6326.9 6331.2 6332.1 6113.5 6124.7 6126.2 6129.9 6132.1 6003.8 6126.2 6127.7 6238.4 6258.2 6087.9 6127.3 6130.2 6134.4 6136.3 6108.5 6146.7 6164.6 6168.3 6172.7 4780.2 4812.6 4847.1 4849.3 4881.9 4327.7 4373.0 4436.2 4441.1 4452.9 5660.3 5692.7 5714.5 5744.4 5746.0 6202.7 6220.8 6228.3 6233.4 6247.8 5620.7 5654.8 5657.8 5677.4 5725.0 5278.1 5318.7 5321.1 5353.6 5366.1 6297.7 6321.7 6328.6 6340.1 6345.3 6109.2 6214.8 6221.8 6224.6 6235.9 6234.3 6254.4 6324.1 6341.0 6350.8 6143.0 6153.3 6183.4 6195.6 6210.3 6182.2 6240.3 6243.7 6251.9 6260.1 5919.1 5967.1 6007.2 6102.0 6140.4 5968.1 5984.3 5987.4 6027.1 6080.5 5880.3 5884.7 5891.9 5900.6 5900.8 4518.5 6036.2 6044.5 6056.4 6064.7 5677.6 5835.8 5837.5 5851.6 5860.7 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:73327.33 Median:34182.66 stddev:178313.47 (521.6%) stddev-sans-first:178729.82 05:43:50 INFO - PROCESS | 1662 | Values: 488.7 519.1 531.0 539.6 556.6 30228.4 38505.4 39685.6 39754.0 39985.0 33322.8 41347.6 41376.8 41427.0 41642.0 8669.7 9682.0 9876.3 9880.6 9883.2 8787.4 11800.7 12057.8 12090.7 12287.3 12038.0 12110.5 12114.5 12142.3 12174.9 10058.8 10116.4 12113.9 12121.0 12140.8 11825.0 11903.0 11923.1 11923.1 11923.7 39359.2 39738.0 39755.8 39783.4 39826.4 3581.3 3952.7 3998.0 4022.1 4025.7 30322.7 30813.7 30983.7 31280.0 31348.4 3182.2 3242.7 3263.2 3375.6 3385.4 448712.0 450499.0 481070.0 485219.0 487343.0 55693.6 55889.0 55956.0 56004.7 56139.7 29669.0 33289.5 33984.8 34195.7 35148.0 15577.4 15721.7 15730.4 15751.5 15762.8 11236.4 11398.9 12318.6 12414.2 12437.8 14847.8 18198.5 18625.0 18877.2 18903.3 7832.1 7934.0 7952.6 8029.6 8050.0 825.3 836.8 930.9 974.4 1035.0 25983.4 28697.9 29157.0 29901.3 30051.0 918.0 1078.2 1103.2 1105.2 1134.9 14218.9 14659.2 15260.2 15760.6 15765.8 190740.0 933269.0 946601.0 946800.0 947079.0 47619.3 56421.4 57088.1 57113.7 57214.0 1208.8 1243.9 1247.8 1348.9 1367.2 23903.8 30036.5 30079.1 30088.5 30761.7 50902.0 51533.2 51557.0 51637.5 51805.0 597160.0 603939.0 603997.0 604025.0 605841.0 22606.8 23042.0 23150.3 25555.9 25972.7 28765.3 33174.7 43293.4 45730.8 46493.8 36757.0 38175.2 38247.4 39595.6 40106.2 38123.0 38266.4 39227.8 39397.8 39689.4 36726.8 37220.1 37871.8 38021.4 38290.0 32302.2 33256.5 33984.3 34172.8 34192.5 20127.9 20637.7 25317.0 25520.5 25672.7 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33208.48 Median:12388.24 stddev:84889.71 (685.2%) stddev-sans-first:85091.98 05:43:50 INFO - PROCESS | 1662 | Values: 344.5 360.7 369.5 372.7 396.4 13370.8 14944.6 15602.2 20736.9 21202.6 19950.7 20497.5 20954.0 21205.0 21609.4 5620.6 5995.7 6262.7 6268.6 6274.4 5685.4 6217.3 6265.9 6294.7 6299.0 5882.3 6102.5 6228.3 6238.6 6240.8 6100.9 6152.8 6157.5 6163.3 6171.0 5048.1 5236.1 5281.6 5310.3 5316.3 25615.7 26147.9 26190.5 26491.0 26841.3 2424.9 2472.3 2998.3 3155.4 3165.3 15581.4 15726.9 15749.4 15915.9 16554.8 1674.6 1882.4 1902.6 1947.6 1998.9 95894.0 116246.4 123316.0 123699.0 128513.7 11197.9 11359.6 11581.4 11599.6 11721.0 14460.1 14472.0 14477.0 14490.0 14518.3 8263.8 8519.3 8550.3 8667.1 8668.7 6972.8 8401.6 8410.3 8417.3 8499.2 3920.8 4379.6 4522.1 4543.4 4619.6 1904.2 1927.2 1928.3 1975.4 1979.4 855.8 897.4 914.8 948.2 966.0 21006.5 22218.9 22285.4 22344.8 22351.5 803.3 911.0 932.9 951.9 991.5 11009.2 11390.7 11461.3 11532.7 11546.6 389990.0 465478.3 469331.7 558269.0 589462.1 132592.3 137838.3 139156.0 139753.0 142533.3 933.7 960.0 990.9 991.8 992.8 19001.1 19035.8 19916.7 20119.6 20255.5 55337.4 57579.8 57706.4 58494.4 59192.1 80764.6 83052.1 84522.6 87748.0 89400.6 11064.9 11708.6 12028.8 12548.3 12574.3 13066.9 13600.5 13694.2 13733.8 14236.8 5499.5 7879.9 9505.2 11796.9 11981.3 10044.6 11683.9 11709.9 11883.3 12052.3 11575.1 11730.8 12175.9 12216.4 12278.1 11723.4 11805.8 12316.7 12417.7 12530.7 11500.7 11701.5 11880.9 11895.9 11976.4 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5653.54 Median:4822.84 stddev:3186.25 (66.1%) stddev-sans-first:3178.75 05:43:50 INFO - PROCESS | 1662 | Values: 1347.3 1529.9 1548.9 1763.4 1932.3 7793.4 8321.0 8600.4 8935.3 8954.8 8843.4 8886.5 8890.9 8893.0 8902.2 2371.2 2400.6 2400.9 2403.2 2404.3 2052.4 2343.5 2373.0 2403.4 2404.1 2358.6 2379.1 2388.1 2394.1 2398.8 2306.6 2332.9 2342.2 2348.2 2354.8 2317.5 2345.8 2357.1 2357.3 2371.7 8619.7 8734.0 8773.3 8820.6 8885.7 5172.4 5346.8 5377.3 5403.0 5404.2 3525.8 3568.7 3622.5 3629.3 3654.8 1067.2 1073.3 1076.5 1088.1 1095.9 11526.6 11595.2 11721.9 11722.9 11772.7 4529.7 4701.9 4818.9 4826.8 4833.0 10028.5 10033.9 10045.9 10054.6 10079.2 5293.0 5294.9 5342.7 5384.7 5396.8 4122.5 4362.0 4523.9 4551.5 4895.0 3415.8 3772.2 3914.9 3968.4 3973.5 1245.8 1265.7 1270.3 1276.9 1281.3 816.7 892.6 913.3 913.7 914.8 5587.0 5711.3 5916.0 5934.9 6032.3 420.0 430.0 439.7 439.9 442.9 3872.4 3890.7 3986.7 3999.2 4007.0 10284.7 10720.7 10725.4 10742.3 10752.8 9117.4 10549.6 10685.1 10693.4 10705.1 8047.5 8105.0 8260.2 8285.9 8292.2 5246.6 5523.1 5732.5 5753.1 5790.0 9619.6 9721.9 10020.1 10059.2 10065.7 8830.3 9276.8 9879.2 10012.9 10283.1 6024.2 6977.6 7157.9 7432.8 7536.2 8206.4 8208.1 8218.5 8291.0 8292.6 7147.7 7181.8 7387.1 7542.0 7623.4 7102.8 7308.5 7360.2 7402.0 7537.7 6913.4 6963.1 7041.1 7047.8 7048.2 4879.4 4984.2 4997.2 5027.1 5171.6 5014.3 5055.8 5069.5 5099.1 5209.6 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4490.83 Median:4954.28 stddev:1373.00 (27.7%) stddev-sans-first:1340.34 05:43:50 INFO - PROCESS | 1662 | Values: 300.1 301.8 308.4 315.8 316.6 4422.5 5359.1 5372.8 5384.9 5393.8 3838.6 4532.7 5094.4 5108.6 5250.2 3532.0 3764.3 4047.7 4058.5 4102.8 3526.7 4072.9 4105.8 4124.0 4125.6 3914.7 3957.0 4043.0 4056.8 4088.4 3622.7 4025.7 4076.9 4081.1 4083.6 3361.5 3525.6 3536.6 3537.4 3551.9 4142.8 4276.4 4578.5 5154.6 5228.3 4065.6 4647.8 4660.1 4677.6 4727.2 4390.0 5448.9 5619.4 5646.6 5652.2 3453.6 3880.9 3925.5 3948.5 3963.5 4698.9 5384.3 5797.2 5827.2 5903.0 3071.7 3205.6 3277.1 3822.7 3829.5 3305.3 3927.5 3929.7 3946.6 3953.9 4145.3 4289.8 4385.4 4674.0 4679.3 4877.5 5123.7 5673.3 5680.0 5724.7 1325.8 1374.6 1390.2 1401.3 1406.5 896.6 912.2 928.7 953.0 960.5 5207.8 5231.6 5243.7 5245.6 5255.9 4926.7 5455.8 5463.6 5495.9 5746.2 4091.2 4927.0 4950.7 5161.4 5556.7 3006.9 3032.0 3036.3 3036.6 3063.9 5483.7 5889.9 5896.9 5926.0 5943.8 5084.7 5346.7 5489.3 5491.6 5827.6 4884.2 5332.9 5535.5 5848.7 5872.5 4485.4 4957.9 5129.6 5425.6 5920.1 5773.7 5779.4 5792.7 5796.7 5810.9 4675.6 5423.2 5441.7 6002.4 6044.5 3878.7 3884.8 3912.1 3941.4 3964.3 5825.1 5864.0 5872.9 5887.8 5968.8 5499.5 5633.4 5700.3 5740.9 5745.6 4792.8 5188.0 5611.5 5627.6 5743.3 4698.0 5156.3 5438.3 5543.5 5608.4 4914.8 5484.9 5515.3 5619.0 5676.6 4590.9 4715.3 5509.5 5568.8 5583.9 05:43:50 INFO - PROCESS | 1662 | 05:43:50 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25299.43 Median:3771.81 stddev:40936.61 (1085.3%) stddev-sans-first:41009.51 05:43:50 INFO - PROCESS | 1662 | Values: 618.4 760.6 775.8 808.7 817.4 13826.2 15127.9 16225.6 16496.0 16564.8 14622.7 14680.3 14741.1 14761.2 14826.0 847.8 854.4 877.1 890.5 890.8 682.5 709.0 710.8 888.4 895.4 880.2 918.4 918.8 919.6 925.0 905.7 906.8 907.5 908.6 909.1 523.3 547.4 674.6 676.0 677.1 13260.0 14928.9 15518.0 15546.0 15650.1 11920.9 13987.2 14306.9 14580.8 14732.1 11587.7 11913.8 12160.0 12247.6 12395.9 3753.3 3766.0 3777.6 3807.6 3820.3 85395.0 129988.0 132356.3 132590.0 132854.3 10796.8 10998.3 11115.0 11127.1 11568.6 22779.5 22804.2 22810.9 22823.1 22824.4 7865.2 8074.2 8080.5 8083.4 8156.1 4542.0 4544.9 4617.0 4655.1 4673.9 3665.1 3750.7 3799.7 3800.4 3804.9 664.3 667.8 672.2 680.1 685.4 583.0 660.8 680.8 681.6 682.0 8995.6 9610.7 9612.3 9662.4 9717.2 508.6 542.5 549.7 603.4 606.7 3640.5 4677.1 4713.9 4716.8 4748.2 129551.0 156917.0 158588.0 159508.4 159710.2 129727.0 131349.7 132955.0 134083.3 136627.6 86870.0 109088.5 114091.4 114125.0 116539.8 7062.9 7990.7 8871.0 8939.2 9120.5 65471.0 66103.7 66468.0 67055.0 67651.7 60753.5 61071.0 88939.6 99615.0 99845.0 13067.4 13071.7 13197.7 13322.2 13751.8 13199.9 14813.3 14820.0 15502.5 15585.9 13519.8 13575.5 14107.3 14366.1 14570.0 13622.1 13684.5 13949.9 14090.4 14332.3 12887.7 13276.3 13888.4 13979.0 14178.3 11202.6 11402.8 11412.6 11667.5 11960.7 6941.7 9774.3 10579.9 10587.0 11052.3 05:43:50 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:43:50 INFO - PROCESS | 1662 | 05:43:51 INFO - TEST-INFO | 1662: exit 0 05:43:51 INFO - TEST-OK | dromaeo_css | took 1117886ms 05:43:51 INFO - TEST-START | kraken 05:43:51 INFO - operating with platform_type : mac_ 05:43:51 INFO - Initialising browser for kraken test... 05:43:51 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpXm5VfK/profile http://localhost:49275/getInfo.html) 05:43:53 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:43:53 INFO - PROCESS | 1668 | colorDepth:24 05:43:53 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:43:53 INFO - PROCESS | 1668 | __metrics 05:43:53 INFO - PROCESS | 1668 | 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" 05:43:53 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:43:54 INFO - TEST-INFO | 1668: exit 0 05:43:54 INFO - Browser initialized. 05:43:54 INFO - Running cycle 1/1 for kraken test... 05:43:54 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpXm5VfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:06 INFO - PROCESS | 1670 | RSS: Main: 235184128 05:44:06 INFO - PROCESS | 1670 | 05:44:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:09 INFO - PROCESS | 1670 | RSS: Main: 293969920 05:44:09 INFO - PROCESS | 1670 | 05:44:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:44:13 INFO - PROCESS | 1670 | RSS: Main: 293609472 05:44:13 INFO - PROCESS | 1670 | 05:44:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:44:17 INFO - PROCESS | 1670 | RSS: Main: 385634304 05:44:17 INFO - PROCESS | 1670 | 05:44:19 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:44:20 INFO - PROCESS | 1670 | RSS: Main: 286572544 05:44:20 INFO - PROCESS | 1670 | 05:44:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:22 INFO - PROCESS | 1670 | RSS: Main: 290398208 05:44:22 INFO - PROCESS | 1670 | 05:44:25 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:26 INFO - PROCESS | 1670 | RSS: Main: 328929280 05:44:26 INFO - PROCESS | 1670 | 05:44:29 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:29 INFO - PROCESS | 1670 | RSS: Main: 330297344 05:44:29 INFO - PROCESS | 1670 | 05:44:32 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:44:33 INFO - PROCESS | 1670 | RSS: Main: 327868416 05:44:33 INFO - PROCESS | 1670 | 05:44:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:35 INFO - PROCESS | 1670 | RSS: Main: 304300032 05:44:35 INFO - PROCESS | 1670 | 05:44:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:37 INFO - PROCESS | 1670 | RSS: Main: 305291264 05:44:37 INFO - PROCESS | 1670 | 05:44:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:40 INFO - PROCESS | 1670 | RSS: Main: 308654080 05:44:40 INFO - PROCESS | 1670 | 05:44:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:44 INFO - PROCESS | 1670 | RSS: Main: 317161472 05:44:44 INFO - PROCESS | 1670 | 05:44:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:47 INFO - PROCESS | 1670 | RSS: Main: 319172608 05:44:47 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:44:49 INFO - PROCESS | 1670 | RSS: Main: 362528768 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | __start_tp_report 05:44:49 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 05:44:49 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 05:44:49 INFO - PROCESS | 1670 | |i|pagename|runs| 05:44:49 INFO - PROCESS | 1670 | |0;ai-astar;113;113;113;112;114;114;112;113;113;113 05:44:49 INFO - PROCESS | 1670 | |1;audio-beat-detection;165;137;95;169;137;106;131;138;170;120 05:44:49 INFO - PROCESS | 1670 | |2;audio-dft;183;183;183;185;185;182;179;185;183;184 05:44:49 INFO - PROCESS | 1670 | |3;audio-fft;82;60;59;86;61;59;60;75;100;58 05:44:49 INFO - PROCESS | 1670 | |4;audio-oscillator;88;71;92;69;68;69;90;68;68;89 05:44:49 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;88;89;89;91;89;84;112;130;123;85 05:44:49 INFO - PROCESS | 1670 | |6;imaging-darkroom;98;96;96;97;95;97;97;119;160;97 05:44:49 INFO - PROCESS | 1670 | |7;imaging-desaturate;84;86;84;86;86;83;90;85;84;86 05:44:49 INFO - PROCESS | 1670 | |8;json-parse-financial;56;57;55;56;57;57;57;57;57;57 05:44:49 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;64;75;69;75;72;69;68;69;70;75 05:44:49 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;89;88;87;110;103;105;105;105;90;84 05:44:49 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;142;136;134;148;152;137;137;139;167;137 05:44:49 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;171;181;170;168;170;172;170;169;170;166 05:44:49 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;68;71;70;79;86;90;71;69;69;67 05:44:49 INFO - PROCESS | 1670 | __end_tp_report 05:44:49 INFO - PROCESS | 1670 | __start_cc_report 05:44:49 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1908 05:44:49 INFO - PROCESS | 1670 | __end_cc_report 05:44:49 INFO - PROCESS | 1670 | __startTimestamp1474893889902__endTimestamp 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | ------- Summary: start ------- 05:44:49 INFO - PROCESS | 1670 | Number of tests: 14 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:44:49 INFO - PROCESS | 1670 | Values: 113.0 113.0 113.0 112.0 114.0 114.0 112.0 113.0 113.0 113.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:151.50 stddev:25.71 (17.0%) stddev-sans-first:25.16 05:44:49 INFO - PROCESS | 1670 | Values: 165.0 137.0 95.0 169.0 137.0 106.0 131.0 138.0 170.0 120.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.81 (1.0%) stddev-sans-first:1.92 05:44:49 INFO - PROCESS | 1670 | Values: 183.0 183.0 183.0 185.0 185.0 182.0 179.0 185.0 183.0 184.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:70.00 Median:60.50 stddev:14.88 (24.6%) stddev-sans-first:15.13 05:44:49 INFO - PROCESS | 1670 | Values: 82.0 60.0 59.0 86.0 61.0 59.0 60.0 75.0 100.0 58.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:10.88 (13.7%) stddev-sans-first:10.82 05:44:49 INFO - PROCESS | 1670 | Values: 88.0 71.0 92.0 69.0 68.0 69.0 90.0 68.0 68.0 89.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:98.00 Median:88.50 stddev:17.00 (19.2%) stddev-sans-first:17.65 05:44:49 INFO - PROCESS | 1670 | Values: 88.0 89.0 89.0 91.0 89.0 84.0 112.0 130.0 123.0 85.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:97.00 stddev:20.51 (21.1%) stddev-sans-first:21.59 05:44:49 INFO - PROCESS | 1670 | Values: 98.0 96.0 96.0 97.0 95.0 97.0 97.0 119.0 160.0 97.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.96 (2.3%) stddev-sans-first:2.01 05:44:49 INFO - PROCESS | 1670 | Values: 84.0 86.0 84.0 86.0 86.0 83.0 90.0 85.0 84.0 86.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 05:44:49 INFO - PROCESS | 1670 | Values: 56.0 57.0 55.0 56.0 57.0 57.0 57.0 57.0 57.0 57.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.63 (5.1%) stddev-sans-first:2.96 05:44:49 INFO - PROCESS | 1670 | Values: 64.0 75.0 69.0 75.0 72.0 69.0 68.0 69.0 70.0 75.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:85.50 stddev:9.77 (11.4%) stddev-sans-first:9.96 05:44:49 INFO - PROCESS | 1670 | Values: 89.0 88.0 87.0 110.0 103.0 105.0 105.0 105.0 90.0 84.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.50 stddev:10.20 (7.3%) stddev-sans-first:10.82 05:44:49 INFO - PROCESS | 1670 | Values: 142.0 136.0 134.0 148.0 152.0 137.0 137.0 139.0 167.0 137.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.00 stddev:3.97 (2.3%) stddev-sans-first:4.21 05:44:49 INFO - PROCESS | 1670 | Values: 171.0 181.0 170.0 168.0 170.0 172.0 170.0 169.0 170.0 166.0 05:44:49 INFO - PROCESS | 1670 | 05:44:49 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:71.00 stddev:8.12 (11.4%) stddev-sans-first:8.32 05:44:49 INFO - PROCESS | 1670 | Values: 68.0 71.0 70.0 79.0 86.0 90.0 71.0 69.0 69.0 67.0 05:44:49 INFO - PROCESS | 1670 | -------- Summary: end -------- 05:44:49 INFO - PROCESS | 1670 | 05:44:50 INFO - TEST-INFO | 1670: exit 0 05:44:50 INFO - TEST-OK | kraken | took 59347ms 05:44:50 INFO - SUITE-END | took 1177s 05:44:51 INFO - Completed test suite (00:19:37) 05:44:51 INFO - javascript benchmark 05:44:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.6249218847643, 3293.5883014623164, 3332.1169889979146, 3352.89941301761, 3368.040108569057, 5540.307461567304, 5582.0, 5657.547396208303, 5666.575006874486, 5696.572757043223, 5632.662040277576, 5676.063449530822, 5690.829275121742, 5699.829005129843, 5709.029464990951, 5100.923486147702, 5154.974225128869, 5169.638125331228, 5185.377754669445, 5216.139337009389, 5226.111561034633, 5237.869053273661, 5239.371275446952, 5249.448807875176, 5265.631405801595, 5142.177251639739, 5173.094708426011, 5192.740362981855, 5215.1395019821875, 5255.343082114736, 5236.188390799452, 5238.319018527605, 5254.4220135785035, 5274.683518988873, 5293.920591191135, 5011.523905228997, 5115.5396014358885, 5198.532132108091, 5207.843764687065, 5214.165733482625, 5533.667979921218, 5607.243022191993, 5624.409437009137, 5659.292588426447, 5662.801801936913, 5365.3293338332705, 6149.723262453201, 6156.815295541141, 6164.291106522763, 6170.074488826667, 5328.49379308965, 6291.748330066792, 6297.338779428185, 6323.620582765049, 6327.145835312266, 5629.268195134607, 5668.631538950038, 5680.0, 5719.056355701346, 5796.797112101099, 6283.7800676977, 6315.40003699657, 6326.936730632635, 6331.240251169889, 6332.1135041094285, 6113.541484388688, 6124.663143527148, 6126.203593532812, 6129.877402452015, 6132.080187971751, 6003.759849605967, 6126.151269885539, 6127.711360156438, 6238.438540531283, 6258.186435763413, 6087.908681369783, 6127.325994140641, 6130.249081909707, 6134.405972711579, 6136.325004249618, 6108.450239478379, 6146.7233974471255, 6164.568480206342, 6168.259808822881, 6172.69136543171, 4780.163471392492, 4812.5668689818085, 4847.127517046895, 4849.2726091085915, 4881.877953051131, 4327.7186982846015, 4372.978135109368, 4436.201483732959, 4441.111777644484, 4452.910941781146, 5660.320761508563, 5692.743826527816, 5714.457126572969, 5744.425557444222, 5746.0, 6202.689865506797, 6220.782272620437, 6228.34602366745, 6233.376662333821, 6247.812565623039, 5620.747066382022, 5654.830355089354, 5657.830265092054, 5677.37548869624, 5724.971375143097, 5278.129108697099, 5318.734063296897, 5321.122014867504, 5353.625246232727, 5366.114591092504, 6297.685115744194, 6321.683915804283, 6328.557001010069, 6340.112384266206, 6345.2702939160745, 6109.20580324555, 6214.751409943552, 6221.782237621843, 6224.564280500322, 6235.906461402992, 6234.2830574484515, 6254.437100660963, 6324.083007963727, 6340.968295158679, 6350.841228969312, 6143.0, 6153.323134455117, 6183.443490085914, 6195.597286176384, 6210.254769427697, 6182.196314479089, 6240.251169859646, 6243.719032643451, 6251.874962500816, 6260.092286618506, 5919.112133180058, 5967.134765459071, 6007.189029480965, 6102.0, 6140.385961403824, 5968.134620479919, 5984.251968503937, 5987.371326010706, 6027.065804800263, 6080.452759251689, 5880.294364676266, 5884.735186916685, 5891.941080589139, 5900.616459930091, 5900.763969441175, 4518.525554816829, 6036.245469316335, 6044.516438684983, 6056.394360563909, 6064.666443345658, 5677.630953987978, 5835.824925252249, 5837.532997360286, 5851.561132914963, 5860.736266868086], "value": 5648.491211824358, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.74096728733764, 519.0812262295736, 530.9761060752265, 539.6330495263222, 556.5797822643905, 30228.395432091373, 38505.42241866371, 39685.603143968554, 39754.0, 39985.0, 33322.833385833095, 41347.58652413475, 41376.758697239056, 41427.0, 41642.0, 8669.739907802745, 9682.031796820314, 9876.308658393915, 9880.604775808959, 9883.209343252522, 8787.428817126898, 11800.704982375466, 12057.758844823098, 12090.697732556668, 12287.324197169151, 12038.0, 12110.455029523648, 12114.515419383215, 12142.332171730552, 12174.939125304405, 10058.798824023515, 10116.393016419039, 12113.93943030288, 12121.0, 12140.757184856342, 11825.0, 11902.9882459991, 11923.092305231121, 11923.105767067505, 11923.701907452296, 39359.21281574381, 39738.0, 39755.807325780275, 39783.40324895129, 39826.40260396097, 3581.2658405026905, 3952.7035472339403, 3997.960020399788, 4022.1151346703678, 4025.677945764332, 30322.69677303243, 30813.691863081305, 30983.690163098305, 31280.0, 31348.37303253945, 3182.236263296815, 3242.7243684286864, 3263.1515805890403, 3375.6455572164814, 3385.3737058643983, 448712.0, 450499.0, 481070.0, 485219.0, 487343.0, 55693.607659808826, 55889.0, 55956.0, 56004.71997639986, 56139.71930140323, 29669.0, 33289.500657489676, 33984.81053163127, 34195.658043419746, 35148.0, 15577.376904923904, 15721.742260619123, 15730.449434269745, 15751.527454176394, 15762.76355854663, 11236.438178091063, 11398.886011139783, 12318.568850090203, 12414.193077449936, 12437.75124497505, 14847.777283340758, 18198.542276967335, 18625.0, 18877.244910203437, 18903.338383156522, 7832.138464768871, 7934.0, 7952.574464788179, 8029.638666260033, 8050.0, 825.3273582030625, 836.8033512124646, 930.9162175404247, 974.3812678948918, 1034.9793004140026, 25983.350416239744, 28697.856510717313, 29156.979505717198, 29901.25246868802, 30051.0, 917.9541022948825, 1078.1644225725126, 1103.2222283290262, 1105.237386203517, 1134.8978591926766, 14218.928905355613, 14659.193744344164, 15260.160691161871, 15760.60598485047, 15765.763513547307, 190740.0, 933269.0, 946601.0, 946800.0, 947079.0, 47619.285710714365, 56421.43578564244, 57088.14367784486, 57113.71443142841, 57214.0, 1208.800547909585, 1243.9378031098229, 1247.7754004279136, 1348.8786009259018, 1367.2411811444545, 23903.76096239015, 30036.549451757804, 30079.097627071224, 30088.548671769502, 30761.692383076777, 50902.0, 51533.227001594256, 51557.0, 51637.483625163266, 51805.0, 597160.0, 603939.0, 603997.0, 604025.0, 605841.0, 22606.77393226047, 23042.0, 23150.3054908353, 25555.87222063878, 25972.740272597788, 28765.28086797847, 33174.668253317155, 43293.35059974166, 45730.771346143054, 46493.76753116213, 36757.0, 38175.236495270496, 38247.42628860625, 39595.604043960346, 40106.1978760429, 38123.0, 38266.426003610526, 39227.803860980515, 39397.80301098476, 39689.40465892956, 36726.816365918, 37220.06949826168, 37871.81064094662, 38021.429678555396, 38290.0427489315, 32302.19244518906, 33256.501152483215, 33984.320313593096, 34172.82913585416, 34192.487112692834, 20127.899360503103, 20637.69043464379, 25317.0, 25520.489590208465, 25672.716364182088], "value": 19800.786735420785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.47123665173933, 360.74927925092055, 369.5030184401978, 372.73908264215055, 396.3579002016733, 13370.799438008438, 14944.626384340398, 15602.21988900556, 20736.89631551844, 21202.57594848106, 19950.70073948892, 20497.487562810937, 20954.0, 21205.0, 21609.3517194484, 5620.5503559715125, 5995.6702381369005, 6262.6868656566985, 6268.623882567038, 6274.4353008229255, 5685.431456854323, 6217.347178546255, 6265.874682506347, 6294.653794041325, 6299.0, 5882.294124705041, 6102.450779429851, 6228.314885362606, 6238.59449135807, 6240.812775616739, 6100.877982440348, 6152.753889844401, 6157.507399408059, 6163.291221509517, 6171.012637977947, 5048.091343558158, 5236.1098613235845, 5281.577473802086, 5310.336207974004, 5316.255724198615, 25615.743842561707, 26147.869260653573, 26190.476190476085, 26491.0, 26841.328966775793, 2424.9272521824373, 2472.295395812203, 2998.250437390652, 3155.384699983504, 3165.271987442878, 15581.376744930189, 15726.9213653931, 15749.370025198978, 15915.920420397824, 16554.83445165557, 1674.6315810521787, 1882.4070417818343, 1902.5529000684828, 1947.6494231038407, 1998.9000549972443, 95894.0, 116246.41876790646, 123316.0, 123699.0, 128513.7148628511, 11197.888021119847, 11359.602413915472, 11581.42092895352, 11599.594014209462, 11721.011142158695, 14460.132392056299, 14472.0, 14477.0, 14489.98570100104, 14518.346674399678, 8263.834723305501, 8519.275861551714, 8550.27322677567, 8667.133286671282, 8668.739937801876, 6972.755953541602, 8401.579921003926, 8410.285125764256, 8417.326613870875, 8499.192576705203, 3920.843166273374, 4379.64962802975, 4522.140793249272, 4543.4408072852575, 4619.56793394049, 1904.1621686457913, 1927.1520530966611, 1928.2961718972754, 1975.4172519106899, 1979.3764964036282, 855.8245559660379, 897.3763234551924, 914.8078903430354, 948.1798244518579, 966.0387914025589, 21006.496906116394, 22218.88905554716, 22285.4400191985, 22344.776552234594, 22351.547149435235, 803.333233416263, 911.0, 932.8880534335788, 951.9286053546011, 991.5389343955095, 11009.229353945308, 11390.65828025144, 11461.312321260752, 11532.711682208012, 11546.59586914454, 389990.0, 465478.3452165503, 469331.6533417311, 558269.0, 589462.0526897338, 132592.3370383142, 137838.31080844533, 139156.0, 139753.0, 142533.28733356268, 933.7338858425317, 959.9616015359447, 990.9108180263667, 991.7966816802539, 992.771662517625, 19001.144948477075, 19035.809641903958, 19916.70124948098, 20119.59760804805, 20255.4936126598, 55337.44662553484, 57579.80252468441, 57706.422935770104, 58494.4150558506, 59192.1121183174, 80764.59617701874, 83052.09317673852, 84522.57738711267, 87748.0, 89400.5529972372, 11064.889351106385, 11708.590199342982, 12028.75942481163, 12548.30984295836, 12574.30841303737, 13066.869331306565, 13600.52398166099, 13694.178349299074, 13733.793993090312, 14236.786448203078, 5499.477549632778, 7879.921200787919, 9505.19205867509, 11796.88203117992, 11981.341026243641, 10044.648437304659, 11683.941580292045, 11709.887560681722, 11883.345326617122, 12052.276863388224, 11575.131865109983, 11730.824037639613, 12175.878241217475, 12216.389180541115, 12278.140530162802, 11723.41382930833, 11805.822912656145, 12316.721406539818, 12417.689557761129, 12530.686732831753, 11500.654980350602, 11701.531938722355, 11880.940595297314, 11895.940520297343, 11976.401179940794], "value": 10012.08321165464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.2859384526191, 1529.8546638069383, 1548.9302981365838, 1763.409257898604, 1932.3430033788509, 7793.415493837956, 8321.0, 8600.397972141946, 8935.285177185826, 8954.776130596738, 8843.425177363466, 8886.466811991286, 8890.86663700045, 8892.95553522233, 8902.243309318716, 2371.2412028150998, 2400.627902675088, 2400.8919598618104, 2403.158894386959, 2404.266698656909, 2052.374025922093, 2343.484433424644, 2372.9762702373014, 2403.435192729707, 2404.0864471500804, 2358.6226203807396, 2379.0602711928777, 2388.080588973249, 2394.126143957452, 2398.832081754278, 2306.5848147333472, 2332.9300120996313, 2342.16853017179, 2348.2250857217077, 2354.7880690737916, 2317.53649270145, 2345.824063195267, 2357.1278626907983, 2357.2574638988663, 2371.6561098640773, 8619.65521379144, 8733.956330218372, 8773.34199935001, 8820.647174113028, 8885.689000884939, 5172.379314482287, 5346.812861549866, 5377.274068000809, 5402.973435047328, 5404.216388623628, 3525.7708248963736, 3568.7145028397667, 3622.5471816022996, 3629.3467175908327, 3654.7807131571926, 1067.215596536545, 1073.2862646340175, 1076.4658522766808, 1088.0697004061572, 1095.8904109589057, 11526.59656912004, 11595.188336816425, 11721.945024947796, 11722.882771172179, 11772.705682357924, 4529.660275479352, 4701.905961880743, 4818.879528011757, 4826.806927722922, 4832.975835120802, 10028.548715307828, 10033.899661003297, 10045.949770251102, 10054.59781608742, 10079.244056695778, 5293.0, 5294.8941021180135, 5342.679439233659, 5384.703841288689, 5396.83809485716, 4122.546519882811, 4362.0, 4523.886902827456, 4551.499335073139, 4895.0209958008545, 3415.8121303328057, 3772.1889793694486, 3914.8842579864604, 3968.3849003404516, 3973.543042550086, 1245.8318127052912, 1265.7405231927617, 1270.3457719274581, 1276.9233845969272, 1281.2760790153534, 816.7141500474786, 892.6250974590688, 913.3058875254854, 913.7304495173939, 914.7530166854912, 5587.0, 5711.257536520226, 5916.0, 5934.881302374015, 6032.276126864805, 419.96010379013944, 429.993814474132, 439.65047787009405, 439.9428074350314, 442.9214861811435, 3872.4384964180035, 3890.6966166334028, 3986.681065514752, 3999.1601763629965, 4007.0, 10284.742881427874, 10720.678379648623, 10725.356478611307, 10742.3017503862, 10752.784944301071, 9117.36178467501, 10549.630762923261, 10685.145188384911, 10693.358398496115, 10705.090067344207, 8047.476914000571, 8105.0, 8260.215279548433, 8285.875711864326, 8292.17078292166, 5246.632735708464, 5523.143912693539, 5732.45541673557, 5753.1370294456165, 5790.0, 9619.56711947978, 9721.9027809721, 10020.148287395654, 10059.245556583139, 10065.748356291151, 8830.293576513735, 9276.768080798034, 9879.209663227068, 10012.899871001197, 10283.07452329264, 6024.246969128859, 6977.581345119309, 7157.892631610426, 7432.814179645336, 7536.208698086842, 8206.425550211428, 8208.138145494637, 8218.547979861165, 8290.963629546306, 8292.626831792704, 7147.678354474165, 7181.820454488679, 7387.1135463744695, 7541.962290188514, 7623.390128789572, 7102.786916392516, 7308.524945878501, 7360.1903790584065, 7401.96299018523, 7537.736179233701, 6913.3777959983845, 6963.059986901703, 7041.084658994298, 7047.788566343018, 7048.154221493453, 4879.414470263591, 4984.177610694195, 4997.225430058346, 5027.120253955616, 5171.586273098218, 5014.297998280171, 5055.789573620704, 5069.493050694901, 5099.082165210298, 5209.583233341399], "value": 4468.443482200644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.09222103138006, 301.8415331950726, 308.41093511393234, 315.8199826099123, 316.5678848371973, 4422.513523512415, 5359.062164121283, 5372.758225879835, 5384.892302153955, 5393.838184854456, 3838.596947320533, 4532.710980954614, 5094.350937512491, 5108.565771909392, 5250.18622113572, 3532.0286921096776, 3764.3036038333, 4047.696422768297, 4058.472398588179, 4102.774347410891, 3526.7002304804123, 4072.9389059163987, 4105.794710264475, 4123.9793801030955, 4125.628693417591, 3914.745541539805, 3956.9909673033335, 4042.9797851010703, 4056.776877271749, 4088.407180958774, 3622.655847694478, 4025.7181997260204, 4076.9388459172987, 4081.08175660477, 4083.6324730774077, 3361.46216605342, 3525.6298088700573, 3536.5756109266795, 3537.398642230827, 3551.8756843510355, 4142.834286628531, 4276.422682937795, 4578.450585929677, 5154.587632989389, 5228.346456692913, 4065.5527891931865, 4647.767611619439, 4660.1145782301255, 4677.573340131258, 4727.22000869856, 4389.978050109729, 5448.891022179534, 5619.353774315965, 5646.600194917185, 5652.208690783294, 3453.5510383649967, 3880.8939452256254, 3925.548561915359, 3948.526176858795, 3963.54419241788, 4698.908985501487, 5384.300040994684, 5797.173890224608, 5827.155062515912, 5903.0, 3071.6774738652566, 3205.611819194715, 3277.066530746823, 3822.6559609635265, 3829.525632631457, 3305.2977716476034, 3927.548331941863, 3929.6659783918117, 3946.5664871561926, 3953.940690889639, 4145.258991223694, 4289.828406863753, 4385.386045953569, 4674.0, 4679.321498382716, 4877.487863774323, 5123.718195499283, 5673.290838645169, 5680.034394153004, 5724.656520608693, 1325.754735373959, 1374.6288502104376, 1390.1659004597363, 1401.3063533550753, 1406.4866323791946, 896.551724137931, 912.2154946745793, 928.6842473558887, 952.9952350238204, 960.4957397366438, 5207.817726379559, 5231.55531779803, 5243.659162154448, 5245.580353571705, 5255.948810237967, 4926.655134140576, 5455.844941248185, 5463.644863083887, 5495.945040549624, 5746.166805813134, 4091.181763647223, 4927.0, 4950.653454258239, 5161.406438259573, 5556.666600004012, 3006.864691088906, 3031.999440184734, 3036.284499257912, 3036.6356037275227, 3063.862126204326, 5483.725813709299, 5889.911651325234, 5896.852578685567, 5925.970370148121, 5943.762249510058, 5084.737291905067, 5346.732663366816, 5489.286392768914, 5491.588130890199, 5827.59206855516, 4884.215996881743, 5332.866678332995, 5535.501804837584, 5848.736806843703, 5872.500837428866, 4485.37204791336, 4957.909259962802, 5129.615003948988, 5425.565954723534, 5920.135157425398, 5773.711314434346, 5779.393163717918, 5792.742334384308, 5796.739146738491, 5810.854728631818, 4675.625949924066, 5423.159410291411, 5441.7279136043835, 6002.409361519288, 6044.486218671462, 3878.6509214169732, 3884.7662594009125, 3912.061105334756, 3941.4087886817206, 3964.3458829292845, 5825.116567299214, 5863.976927960018, 5872.853178670567, 5887.8233652990475, 5968.76124954997, 5499.5325397340075, 5633.3521645009705, 5700.315962084576, 5740.885182296414, 5745.597808153389, 4792.849716068049, 5187.974060129675, 5611.466910643482, 5627.606067575231, 5743.310802703702, 4697.953020469751, 5156.278121063129, 5438.320209973754, 5543.473370029841, 5608.4111168326735, 4914.778834952507, 5484.862878428071, 5515.338159420895, 5619.0, 5676.574256930664, 4590.88522786933, 4715.316279139437, 5509.548251028254, 5568.805091821767, 5583.928839138376], "value": 4064.513262699048, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3908849782963, 760.6120878352039, 775.7711475114841, 808.672487642505, 817.3505298840677, 13826.23955682437, 15127.924360378196, 16225.594360141002, 16496.0, 16564.751528727065, 14622.707545849076, 14680.339384727686, 14741.115533068023, 14761.188134652617, 14826.0, 847.8092429203441, 854.3592305770673, 877.079066979672, 890.5458216309664, 890.7906641939139, 682.4915437998698, 708.989365159523, 710.8116349167475, 888.3515034025165, 895.404555970279, 880.2385936165203, 918.4030380252823, 918.7519369770158, 919.5815903763771, 924.9676261330854, 905.6875377994581, 906.8141031088677, 907.5280853955971, 908.5548081440113, 909.077286554148, 523.330137424094, 547.4388751529674, 674.6019848289533, 676.0467740485891, 677.1366507702719, 13260.005499587473, 14928.925355373261, 15518.0, 15546.0, 15650.139242341667, 11920.940395298056, 13987.160770353812, 14306.856931430657, 14580.781288280685, 14732.116073035651, 11587.652370428901, 11913.821292680617, 12160.0, 12247.571335003233, 12395.876041239562, 3753.2681127180213, 3766.0, 3777.622237776228, 3807.60020197878, 3820.2550502651993, 85395.0, 129988.0, 132356.3382183083, 132590.0, 132854.33572832073, 10796.78406431867, 10998.34009959405, 11115.0, 11127.109831213484, 11568.595099171489, 22779.544409111724, 22804.2018529354, 22810.885945570168, 22823.087076516753, 22824.429389265068, 7865.213478652204, 8074.192580741878, 8080.515169089874, 8083.393745469113, 8156.1028286888395, 4542.0, 4544.863654090383, 4616.961183733633, 4655.138799322136, 4673.929891051637, 3665.1020499977144, 3750.662440380379, 3799.715021373408, 3800.4299355096955, 3804.8668296609485, 664.2759392262457, 667.7729571945465, 672.1564436631995, 680.1158493957835, 685.3694600967123, 582.9504492118217, 660.7951535024158, 680.8229860236374, 681.574248561925, 681.9659017049227, 8995.55022248885, 9610.711678649512, 9612.327137100476, 9662.420254784736, 9717.17404020652, 508.6261597725669, 542.4738004135982, 549.6839317392515, 603.4177019176516, 606.7148440233084, 3640.4903313535597, 4677.134730074947, 4713.878426318911, 4716.773638853854, 4748.19280722278, 129551.0, 156917.0, 158588.0, 159508.4049159517, 159710.201448992, 129727.0, 131349.68650313566, 132955.0, 134083.32958335147, 136627.63372366148, 86870.0, 109088.4545577267, 114091.42954285341, 114125.0, 116539.77093779601, 7062.894056589258, 7990.680372785256, 8870.955645221733, 8939.195472407515, 9120.49837258957, 65471.0, 66103.66948165228, 66468.0, 67055.0, 67651.66174169097, 60753.48116296951, 61071.0, 88939.55530222307, 99615.0, 99845.00154998357, 13067.411966461343, 13071.738565228832, 13197.736045279233, 13322.200667959953, 13751.793723094363, 13199.934000329937, 14813.259337033322, 14820.036697615053, 15502.5349239523, 15585.922070389575, 13519.797203042159, 13575.456981720621, 14107.29463526799, 14366.13803171813, 14570.0, 13622.071254680292, 13684.45262189541, 13949.860501395262, 14090.436382544583, 14332.283385830458, 12887.711228877037, 13276.26980516081, 13888.375023124187, 13979.0, 14178.29108544548, 11202.551897923991, 11402.771944561227, 11412.600558980395, 11667.533298667959, 11960.700982475508, 6941.687624056828, 9774.266929980422, 10579.889111643166, 10587.0, 11052.283585131881], "value": 7845.292902667773, "unit": "score"}], "name": "dromaeo_css", "value": 7364.786869746327, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 114.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 137.0, 95.0, 169.0, 137.0, 106.0, 131.0, 138.0, 170.0, 120.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 185.0, 185.0, 182.0, 179.0, 185.0, 183.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 86.0, 61.0, 59.0, 60.0, 75.0, 100.0, 58.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 92.0, 69.0, 68.0, 69.0, 90.0, 68.0, 68.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 91.0, 89.0, 84.0, 112.0, 130.0, 123.0, 85.0], "value": 98.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 97.0, 95.0, 97.0, 97.0, 119.0, 160.0, 97.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 86.0, 86.0, 83.0, 90.0, 85.0, 84.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 69.0, 75.0, 72.0, 69.0, 68.0, 69.0, 70.0, 75.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 110.0, 103.0, 105.0, 105.0, 105.0, 90.0, 84.0], "value": 96.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 134.0, 148.0, 152.0, 137.0, 137.0, 139.0, 167.0, 137.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 181.0, 170.0, 168.0, 170.0, 172.0, 170.0, 169.0, 170.0, 166.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 70.0, 79.0, 86.0, 90.0, 71.0, 69.0, 69.0, 67.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1480.2000000000003, "alertThreshold": 2.0}]} 05:44:51 INFO - Return code: 0 05:44:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:44:51 INFO - # TBPL SUCCESS # 05:44:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:44:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:44:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:44:51 INFO - 2016-09-26 05:44:51.245 screenresolution[1676:10560] starting screenresolution argv=screenresolution get 05:44:51 INFO - 2016-09-26 05:44:51.248 screenresolution[1676:10560] Display 0: 1600x1200x32@60 05:44:51 INFO - 2016-09-26 05:44:51.254 screenresolution[1677:10562] starting screenresolution argv=screenresolution list 05:44:51 INFO - Available Modes on Display 0 05:44:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:44:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:44:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:44:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:44:51 INFO - Intel Iris: 05:44:51 INFO - Chipset Model: Intel Iris 05:44:51 INFO - Type: GPU 05:44:51 INFO - Bus: Built-In 05:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 05:44:51 INFO - Vendor: Intel (0x8086) 05:44:51 INFO - Device ID: 0x0a2e 05:44:51 INFO - Revision ID: 0x0009 05:44:51 INFO - Displays: 05:44:51 INFO - Display: 05:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:44:51 INFO - Display Serial Number: 1600x1200 60 05:44:51 INFO - Main Display: Yes 05:44:51 INFO - Mirror: Off 05:44:51 INFO - Online: Yes 05:44:51 INFO - Rotation: Supported 05:44:51 INFO - Return code: 0 05:44:51 INFO - Running post-action listener: _resource_record_post_action 05:44:51 INFO - [mozharness: 2016-09-26 12:44:51.499301Z] Finished run-tests step (success) 05:44:51 INFO - Running post-run listener: _resource_record_post_run 05:44:51 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32570368; Write bytes: 705049600; Read time: 311; Write time: 2271 05:44:51 INFO - TinderboxPrint: CPU usage
53.5% 05:44:51 INFO - TinderboxPrint: I/O read bytes / time
32,570,368 / 311 05:44:51 INFO - TinderboxPrint: I/O write bytes / time
705,049,600 / 2,271 05:44:51 INFO - TinderboxPrint: CPU idle
2,252.8 (46.5%) 05:44:51 INFO - TinderboxPrint: CPU system
969.3 (20.0%) 05:44:51 INFO - TinderboxPrint: CPU user
1,627.7 (33.6%) 05:44:51 INFO - TinderboxPrint: Swap in / out
435,847,168 / 0 05:44:51 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388737536; Write bytes: 383157248; Read time: 29532; Write time: 631 05:44:51 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31640576; Write bytes: 295555072; Read time: 297; Write time: 1589 05:44:51 INFO - Running post-run listener: _upload_blobber_files 05:44:51 INFO - Blob upload gear active. 05:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:53 INFO - (blobuploader) - INFO - Done attempting. 05:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:54 INFO - (blobuploader) - INFO - Done attempting. 05:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:56 INFO - (blobuploader) - INFO - Done attempting. 05:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:56 INFO - Return code: 0 05:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95050f2d413f0fe45e31decf943b109a2281818efda29c49ca6fa1bad8a5cee4c872348a09d7009084b1236a9421a76ea26eca5c2255caeff245433ceeebf5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/279e21dee2632a20ce336c13c18d03923f3c74262630efa9507746fbad98181a61373749fc3b65edd1e4415fd70ce448f6bfe2bc0b29b1f102b2e9eaad3e9014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778ba64a2eda1519d3675b469b16a12b129ad89c522bfe05b0cd272f6985876eac6abe64dd08523da2e873db6db235ae7388197486774f5ae63a800d5dec8fe9"} 05:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:56 INFO - Contents: 05:44:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95050f2d413f0fe45e31decf943b109a2281818efda29c49ca6fa1bad8a5cee4c872348a09d7009084b1236a9421a76ea26eca5c2255caeff245433ceeebf5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/279e21dee2632a20ce336c13c18d03923f3c74262630efa9507746fbad98181a61373749fc3b65edd1e4415fd70ce448f6bfe2bc0b29b1f102b2e9eaad3e9014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778ba64a2eda1519d3675b469b16a12b129ad89c522bfe05b0cd272f6985876eac6abe64dd08523da2e873db6db235ae7388197486774f5ae63a800d5dec8fe9"} 05:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:56 INFO - Copying logs to upload dir... 05:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.065756 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-26 05:44:56.809213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:56.816559) ========= 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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/95050f2d413f0fe45e31decf943b109a2281818efda29c49ca6fa1bad8a5cee4c872348a09d7009084b1236a9421a76ea26eca5c2255caeff245433ceeebf5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/279e21dee2632a20ce336c13c18d03923f3c74262630efa9507746fbad98181a61373749fc3b65edd1e4415fd70ce448f6bfe2bc0b29b1f102b2e9eaad3e9014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778ba64a2eda1519d3675b469b16a12b129ad89c522bfe05b0cd272f6985876eac6abe64dd08523da2e873db6db235ae7388197486774f5ae63a800d5dec8fe9"} build_url:https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/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/95050f2d413f0fe45e31decf943b109a2281818efda29c49ca6fa1bad8a5cee4c872348a09d7009084b1236a9421a76ea26eca5c2255caeff245433ceeebf5e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/279e21dee2632a20ce336c13c18d03923f3c74262630efa9507746fbad98181a61373749fc3b65edd1e4415fd70ce448f6bfe2bc0b29b1f102b2e9eaad3e9014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/778ba64a2eda1519d3675b469b16a12b129ad89c522bfe05b0cd272f6985876eac6abe64dd08523da2e873db6db235ae7388197486774f5ae63a800d5dec8fe9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:56.855998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:56.856446) ========= 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.LJ3HMW9K1H/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.BHnbG1Alcs/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005035 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:56.905004) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:44:56.905364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:44:56.905753) ========= ========= Total master_lag: 0.50 =========