builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1479817550.45 results: success (0) buildid: 20161122030551 builduid: 77f002958bfc403082d49368ca05a729 revision: 5650168b1ca4efc51ee7ca345935bd2e1b00584f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.449736) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.450201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.450496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.474959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.475322) ========= 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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-22 04:25:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 67.9M=0s 2016-11-22 04:25:50 (67.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.663720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.664032) ========= 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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.021568 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:50.719412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 04:25:50.719757) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5650168b1ca4efc51ee7ca345935bd2e1b00584f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5650168b1ca4efc51ee7ca345935bd2e1b00584f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-22 04:25:50,802 truncating revision to first 12 chars 2016-11-22 04:25:50,802 Setting DEBUG logging. 2016-11-22 04:25:50,802 attempt 1/10 2016-11-22 04:25:50,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5650168b1ca4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 04:25:52,092 unpacking tar archive at: mozilla-beta-5650168b1ca4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571511 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 04:25:52.314952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:52.315285) ========= script_repo_revision: 5650168b1ca4efc51ee7ca345935bd2e1b00584f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:52.315672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:52.315934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 04:25:52.337177) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-22 04:25:52.337473) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:25:52 INFO - MultiFileLogger online at 20161122 04:25:52 in /builds/slave/test 04:25:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:25:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:52 INFO - {'append_to_log': False, 04:25:52 INFO - 'base_work_dir': '/builds/slave/test', 04:25:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:25:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:52 INFO - 'branch': 'Mozilla-Beta', 04:25:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:52 INFO - 'config_files': ('talos/mac_config.py',), 04:25:52 INFO - 'default_actions': ('clobber', 04:25:52 INFO - 'read-buildbot-config', 04:25:52 INFO - 'download-and-extract', 04:25:52 INFO - 'populate-webroot', 04:25:52 INFO - 'create-virtualenv', 04:25:52 INFO - 'install', 04:25:52 INFO - 'run-tests'), 04:25:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:52 INFO - 'download_minidump_stackwalk': True, 04:25:52 INFO - 'download_symbols': 'ondemand', 04:25:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:52 INFO - 'installer_path': 'installer.exe', 04:25:52 INFO - 'log_level': 'info', 04:25:52 INFO - 'log_name': 'talos', 04:25:52 INFO - 'log_to_console': True, 04:25:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:25:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:25:52 INFO - 'opt_config_files': (), 04:25:52 INFO - 'pip_index': False, 04:25:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:52 INFO - 'cmd': ('bash', 04:25:52 INFO - '-c', 04:25:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:52 INFO - 'enabled': True, 04:25:52 INFO - 'halt_on_failure': False, 04:25:52 INFO - 'name': 'check_screen_resolution'},), 04:25:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:52 INFO - 'cmd': ('bash', 04:25:52 INFO - '-c', 04:25:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:52 INFO - 'enabled': True, 04:25:52 INFO - 'halt_on_failure': False, 04:25:52 INFO - 'name': 'check_screen_resolution'},), 04:25:52 INFO - 'run_cmd_checks_enabled': True, 04:25:52 INFO - 'sps_profile': False, 04:25:52 INFO - 'sps_profile_interval': 0, 04:25:52 INFO - 'suite': 'dromaeojs', 04:25:52 INFO - 'system_bits': '32', 04:25:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:52 INFO - 'title': 't-yosemite-r7-0263', 04:25:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:52 INFO - 'use_talos_json': True, 04:25:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:52 INFO - 'work_dir': 'build'} 04:25:52 INFO - [mozharness: 2016-11-22 12:25:52.546208Z] Running clobber step. 04:25:52 INFO - Running pre-action listener: _resource_record_pre_action 04:25:52 INFO - Running main action method: clobber 04:25:52 INFO - rmtree: /builds/slave/test/build 04:25:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:54 INFO - Running post-action listener: _resource_record_post_action 04:25:54 INFO - [mozharness: 2016-11-22 12:25:54.642628Z] Finished clobber step (success) 04:25:54 INFO - [mozharness: 2016-11-22 12:25:54.642777Z] Running read-buildbot-config step. 04:25:54 INFO - Running pre-action listener: _resource_record_pre_action 04:25:54 INFO - Running main action method: read_buildbot_config 04:25:54 INFO - Using buildbot properties: 04:25:54 INFO - { 04:25:54 INFO - "project": "", 04:25:54 INFO - "product": "firefox", 04:25:54 INFO - "script_repo_revision": "production", 04:25:54 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:25:54 INFO - "repository": "", 04:25:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:25:54 INFO - "buildid": "20161122030551", 04:25:54 INFO - "pgo_build": "False", 04:25:54 INFO - "basedir": "/builds/slave/test", 04:25:54 INFO - "buildnumber": 14, 04:25:54 INFO - "slavename": "t-yosemite-r7-0263", 04:25:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:25:54 INFO - "platform": "yosemite_r7", 04:25:54 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:25:54 INFO - "branch": "mozilla-beta", 04:25:54 INFO - "repo_path": "releases/mozilla-beta", 04:25:54 INFO - "revision": "5650168b1ca4efc51ee7ca345935bd2e1b00584f", 04:25:54 INFO - "stage_platform": "macosx64", 04:25:54 INFO - "builduid": "77f002958bfc403082d49368ca05a729", 04:25:54 INFO - "slavebuilddir": "test" 04:25:54 INFO - } 04:25:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 04:25:54 INFO - Running post-action listener: _resource_record_post_action 04:25:54 INFO - [mozharness: 2016-11-22 12:25:54.646003Z] Finished read-buildbot-config step (success) 04:25:54 INFO - [mozharness: 2016-11-22 12:25:54.646147Z] Running download-and-extract step. 04:25:54 INFO - Running pre-action listener: _resource_record_pre_action 04:25:54 INFO - Running main action method: download_and_extract 04:25:54 INFO - mkdir: /builds/slave/test/build/tests 04:25:54 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')]} 04:25:54 INFO - trying https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 04:25:54 INFO - Downloading https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 04:25:56 INFO - Downloaded 1165 bytes. 04:25:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 04:25:56 INFO - Using the following test package requirements: 04:25:56 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:25:56 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 04:25:56 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 04:25:56 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:25:56 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 04:25:56 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 04:25:56 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 04:25:56 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 04:25:56 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 04:25:56 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 04:25:56 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 04:25:56 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 04:25:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:25:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:25:56 INFO - Fetch https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:25:56 INFO - Expected file size: 16231401 04:26:03 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:26:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 04:26:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 04:26:03 INFO - Fetch https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 04:26:04 INFO - Expected file size: 16231401 04:26:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 04:26:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 04:26:10 INFO - Fetch https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 04:26:12 INFO - Expected file size: 14414089 04:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:12 INFO - trying https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:26:12 INFO - Downloading https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 04:26:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 04:26:14 INFO - Downloaded 86034449 bytes. 04:26:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:26:14 INFO - mkdir: /builds/slave/test/properties 04:26:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:14 INFO - Contents: 04:26:14 INFO - build_url:https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 04:26:15 INFO - Running post-action listener: _resource_record_post_action 04:26:15 INFO - Running post-action listener: set_extra_try_arguments 04:26:15 INFO - [mozharness: 2016-11-22 12:26:15.713144Z] Finished download-and-extract step (success) 04:26:15 INFO - [mozharness: 2016-11-22 12:26:15.713282Z] Running populate-webroot step. 04:26:15 INFO - Running pre-action listener: _resource_record_pre_action 04:26:15 INFO - Running main action method: populate_webroot 04:26:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:15 INFO - '--tppagecycles', 04:26:15 INFO - '7'], 04:26:15 INFO - 'tests': ['tsvgm']}}, 04:26:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['damp', 'tps']}, 04:26:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'tests': ['damp', 'tps']}, 04:26:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['dromaeo_dom']}, 04:26:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['basic_compositor_video']}, 04:26:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:26:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['a11yr', 04:26:15 INFO - 'ts_paint', 04:26:15 INFO - 'tpaint', 04:26:15 INFO - 'sessionrestore', 04:26:15 INFO - 'sessionrestore_no_auto_restore', 04:26:15 INFO - 'tabpaint']}, 04:26:15 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:15 INFO - 'ts_paint', 04:26:15 INFO - 'tpaint', 04:26:15 INFO - 'sessionrestore', 04:26:15 INFO - 'sessionrestore_no_auto_restore', 04:26:15 INFO - 'tabpaint']}, 04:26:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:15 INFO - 'ts_paint', 04:26:15 INFO - 'tpaint', 04:26:15 INFO - 'sessionrestore', 04:26:15 INFO - 'sessionrestore_no_auto_restore', 04:26:15 INFO - 'tabpaint']}, 04:26:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:15 INFO - 'ts_paint', 04:26:15 INFO - 'tpaint', 04:26:15 INFO - 'sessionrestore', 04:26:15 INFO - 'sessionrestore_no_auto_restore', 04:26:15 INFO - 'tabpaint']}, 04:26:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['a11yr', 04:26:15 INFO - 'ts_paint', 04:26:15 INFO - 'tpaint', 04:26:15 INFO - 'sessionrestore', 04:26:15 INFO - 'sessionrestore_no_auto_restore', 04:26:15 INFO - 'tabpaint']}, 04:26:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['a11yr', 04:26:15 INFO - 'ts_paint', 04:26:15 INFO - 'tpaint', 04:26:15 INFO - 'sessionrestore', 04:26:15 INFO - 'sessionrestore_no_auto_restore', 04:26:15 INFO - 'tabpaint']}, 04:26:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['tsvgx', 04:26:15 INFO - 'tsvgr_opacity', 04:26:15 INFO - 'tart', 04:26:15 INFO - 'tscrollx', 04:26:15 INFO - 'cart']}, 04:26:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:15 INFO - 'tsvgr_opacity', 04:26:15 INFO - 'tart', 04:26:15 INFO - 'tscrollx', 04:26:15 INFO - 'cart']}, 04:26:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'talos_options': ['--disable-e10s'], 04:26:15 INFO - 'tests': ['tp5o']}, 04:26:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'tests': ['tp5o']}, 04:26:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'talos_options': ['--disable-e10s', 04:26:15 INFO - '--xperf_path', 04:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:15 INFO - 'tests': ['tp5n']}, 04:26:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:15 INFO - 'talos_options': ['--xperf_path', 04:26:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:15 INFO - 'tests': ['tp5n']}}, 04:26:15 INFO - 'talos.zip': {'path': '', 04:26:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:15 INFO - Running post-action listener: _resource_record_post_action 04:26:15 INFO - [mozharness: 2016-11-22 12:26:15.731969Z] Finished populate-webroot step (success) 04:26:15 INFO - [mozharness: 2016-11-22 12:26:15.732111Z] Running create-virtualenv step. 04:26:15 INFO - Running pre-action listener: _resource_record_pre_action 04:26:15 INFO - Running main action method: create_virtualenv 04:26:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:15 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 04:26:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:15 INFO - Using real prefix '/tools/python27' 04:26:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:19 INFO - Installing pip.................done. 04:26:19 INFO - Return code: 0 04:26:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26: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', 'pip>=1.5'] in /builds/slave/test/build 04:26: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 pip>=1.5 04:26:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:19 INFO - 'HOME': '/Users/cltbld', 04:26:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:19 INFO - 'LOGNAME': 'cltbld', 04:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:19 INFO - 'MOZ_NO_REMOTE': '1', 04:26:19 INFO - 'NO_EM_RESTART': '1', 04:26:19 INFO - 'PAGER': '/bin/cat', 04:26:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:19 INFO - 'PWD': '/builds/slave/test', 04:26:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:19 INFO - 'SHELL': '/bin/bash', 04:26:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:19 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:19 INFO - 'USER': 'cltbld', 04:26:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:19 INFO - 'XPC_FLAGS': '0x0', 04:26:19 INFO - 'XPC_SERVICE_NAME': '0', 04:26:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:19 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 04:26:19 INFO - Cleaning up... 04:26:19 INFO - Return code: 0 04:26:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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', '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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:26: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 psutil>=3.1.1 04:26:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:19 INFO - 'HOME': '/Users/cltbld', 04:26:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:19 INFO - 'LOGNAME': 'cltbld', 04:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:19 INFO - 'MOZ_NO_REMOTE': '1', 04:26:19 INFO - 'NO_EM_RESTART': '1', 04:26:19 INFO - 'PAGER': '/bin/cat', 04:26:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:19 INFO - 'PWD': '/builds/slave/test', 04:26:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:19 INFO - 'SHELL': '/bin/bash', 04:26:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:19 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:19 INFO - 'USER': 'cltbld', 04:26:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:19 INFO - 'XPC_FLAGS': '0x0', 04:26:19 INFO - 'XPC_SERVICE_NAME': '0', 04:26:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:19 INFO - Downloading/unpacking psutil>=3.1.1 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:23 INFO - Installing collected packages: psutil 04:26:23 INFO - Running setup.py install for psutil 04:26:23 INFO - building 'psutil._psutil_osx' extension 04:26:23 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 04:26:23 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 04:26:23 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 04:26:23 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 04:26:24 INFO - building 'psutil._psutil_posix' extension 04:26:24 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 04:26:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:26:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:26:24 INFO - ^ 04:26:24 INFO - 1 warning generated. 04:26:24 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 04:26:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:24 INFO - Successfully installed psutil 04:26:24 INFO - Cleaning up... 04:26:24 INFO - Return code: 0 04:26:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:24 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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:24 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 04:26:24 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 04:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:24 INFO - 'HOME': '/Users/cltbld', 04:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:24 INFO - 'LOGNAME': 'cltbld', 04:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:24 INFO - 'MOZ_NO_REMOTE': '1', 04:26:24 INFO - 'NO_EM_RESTART': '1', 04:26:24 INFO - 'PAGER': '/bin/cat', 04:26:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:24 INFO - 'PWD': '/builds/slave/test', 04:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:24 INFO - 'SHELL': '/bin/bash', 04:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:24 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:24 INFO - 'USER': 'cltbld', 04:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:24 INFO - 'XPC_FLAGS': '0x0', 04:26:24 INFO - 'XPC_SERVICE_NAME': '0', 04:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:26:24 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 04:26:24 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 04:26:24 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 04:26:24 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 04:26:24 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 04:26:24 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 04:26:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:26:27 INFO - Installing collected packages: mozsystemmonitor 04:26:27 INFO - Running setup.py install for mozsystemmonitor 04:26:27 INFO - Successfully installed mozsystemmonitor 04:26:27 INFO - Cleaning up... 04:26:27 INFO - Return code: 0 04:26:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:27 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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:27 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 04:26:27 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 04:26:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:27 INFO - 'HOME': '/Users/cltbld', 04:26:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:27 INFO - 'LOGNAME': 'cltbld', 04:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:27 INFO - 'MOZ_NO_REMOTE': '1', 04:26:27 INFO - 'NO_EM_RESTART': '1', 04:26:27 INFO - 'PAGER': '/bin/cat', 04:26:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:27 INFO - 'PWD': '/builds/slave/test', 04:26:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:27 INFO - 'SHELL': '/bin/bash', 04:26:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:27 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:27 INFO - 'USER': 'cltbld', 04:26:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:27 INFO - 'XPC_FLAGS': '0x0', 04:26:27 INFO - 'XPC_SERVICE_NAME': '0', 04:26:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:27 INFO - Downloading/unpacking jsonschema==2.5.1 04:26:27 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 04:26:27 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 04:26:27 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 04:26:27 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 04:26:27 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 04:26:27 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 04:26:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:30 INFO - warning: no files found matching '*.txt' 04:26:30 INFO - no previously-included directories found matching 'build' 04:26:30 INFO - no previously-included directories found matching 'dist' 04:26:30 INFO - no previously-included directories found matching '.git*' 04:26:30 INFO - Installing collected packages: jsonschema, functools32 04:26:30 INFO - Running setup.py install for functools32 04:26:31 INFO - warning: no files found matching '*.txt' 04:26:31 INFO - no previously-included directories found matching 'build' 04:26:31 INFO - no previously-included directories found matching 'dist' 04:26:31 INFO - no previously-included directories found matching '.git*' 04:26:31 INFO - Successfully installed jsonschema functools32 04:26:31 INFO - Cleaning up... 04:26:31 INFO - Return code: 0 04:26:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:26:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:31 INFO - 'HOME': '/Users/cltbld', 04:26:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:31 INFO - 'LOGNAME': 'cltbld', 04:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:31 INFO - 'MOZ_NO_REMOTE': '1', 04:26:31 INFO - 'NO_EM_RESTART': '1', 04:26:31 INFO - 'PAGER': '/bin/cat', 04:26:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:31 INFO - 'PWD': '/builds/slave/test', 04:26:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:31 INFO - 'SHELL': '/bin/bash', 04:26:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:31 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:31 INFO - 'USER': 'cltbld', 04:26:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:31 INFO - 'XPC_FLAGS': '0x0', 04:26:31 INFO - 'XPC_SERVICE_NAME': '0', 04:26:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:26:31 INFO - Cleaning up... 04:26:31 INFO - Return code: 0 04:26:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:26:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:31 INFO - 'HOME': '/Users/cltbld', 04:26:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:31 INFO - 'LOGNAME': 'cltbld', 04:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:31 INFO - 'MOZ_NO_REMOTE': '1', 04:26:31 INFO - 'NO_EM_RESTART': '1', 04:26:31 INFO - 'PAGER': '/bin/cat', 04:26:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:31 INFO - 'PWD': '/builds/slave/test', 04:26:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:31 INFO - 'SHELL': '/bin/bash', 04:26:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:31 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:31 INFO - 'USER': 'cltbld', 04:26:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:31 INFO - 'XPC_FLAGS': '0x0', 04:26:31 INFO - 'XPC_SERVICE_NAME': '0', 04:26:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:35 INFO - Downloading docopt-0.6.1.tar.gz 04:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:35 INFO - Running setup.py install for blobuploader 04:26:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:35 INFO - Running setup.py install for requests 04:26:36 INFO - Running setup.py install for docopt 04:26:36 INFO - Successfully installed blobuploader requests docopt 04:26:36 INFO - Cleaning up... 04:26:36 INFO - Return code: 0 04:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:36 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')]} 04:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:36 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')]} 04:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:36 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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:36 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 04:26:36 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 04:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:36 INFO - 'HOME': '/Users/cltbld', 04:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:36 INFO - 'LOGNAME': 'cltbld', 04:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:36 INFO - 'MOZ_NO_REMOTE': '1', 04:26:36 INFO - 'NO_EM_RESTART': '1', 04:26:36 INFO - 'PAGER': '/bin/cat', 04:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:36 INFO - 'PWD': '/builds/slave/test', 04:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:36 INFO - 'SHELL': '/bin/bash', 04:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:36 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:36 INFO - 'USER': 'cltbld', 04:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:36 INFO - 'XPC_FLAGS': '0x0', 04:26:36 INFO - 'XPC_SERVICE_NAME': '0', 04:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-QHwaMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-DD4u4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-BfoMNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-W316v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-wpiGE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-vwhiBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-hPR2Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-1ciCd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-JkMuWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-nBKOYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-UmC_L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-sUH9Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-61pq80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-eRglfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-EeoQjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-eyk_za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:38 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GoSbVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:38 INFO - Running setup.py install for manifestparser 04:26:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:38 INFO - Running setup.py install for mozcrash 04:26:38 INFO - Running setup.py install for mozdebug 04:26:38 INFO - Running setup.py install for mozdevice 04:26:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozfile 04:26:39 INFO - Running setup.py install for mozhttpd 04:26:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozinfo 04:26:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozInstall 04:26:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for mozleak 04:26:39 INFO - Running setup.py install for mozlog 04:26:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:39 INFO - Running setup.py install for moznetwork 04:26:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozprocess 04:26:40 INFO - Running setup.py install for mozprofile 04:26:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozrunner 04:26:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Running setup.py install for mozscreenshot 04:26:40 INFO - Running setup.py install for moztest 04:26:40 INFO - Running setup.py install for mozversion 04:26:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:40 INFO - Cleaning up... 04:26:40 INFO - Return code: 0 04:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:41 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 04:26:41 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 04:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:41 INFO - 'HOME': '/Users/cltbld', 04:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:41 INFO - 'LOGNAME': 'cltbld', 04:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:41 INFO - 'MOZ_NO_REMOTE': '1', 04:26:41 INFO - 'NO_EM_RESTART': '1', 04:26:41 INFO - 'PAGER': '/bin/cat', 04:26:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:41 INFO - 'PWD': '/builds/slave/test', 04:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:41 INFO - 'SHELL': '/bin/bash', 04:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:41 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:41 INFO - 'USER': 'cltbld', 04:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:41 INFO - 'XPC_FLAGS': '0x0', 04:26:41 INFO - 'XPC_SERVICE_NAME': '0', 04:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mmkhFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tc7_yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-AvLwAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-3CeKY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-nZHttY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-LA7s3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:41 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)) 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:41 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-M1TqBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-8i9x67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NExTmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ITfEyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-d71VFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-6Udpsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pHBZSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tbBnpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-wlkzve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:42 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)) 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:42 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-O1xEDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:43 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)) 04:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:43 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4BW6Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:43 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)) 04:26:43 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)) 04:26:43 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)) 04:26:43 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)) 04:26:43 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)) 04:26:43 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)) 04:26:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:43 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 04:26:43 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 04:26:43 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 04:26:43 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 04:26:43 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 04:26:43 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 04:26:45 INFO - Downloading blessings-1.6.tar.gz 04:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:45 INFO - Installing collected packages: blessings 04:26:45 INFO - Running setup.py install for blessings 04:26:45 INFO - Successfully installed blessings 04:26:45 INFO - Cleaning up... 04:26:46 INFO - Return code: 0 04:26:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:46 INFO - Reading from file tmpfile_stdout 04:26:46 INFO - Current package versions: 04:26:46 INFO - blessings == 1.6 04:26:46 INFO - blobuploader == 1.2.4 04:26:46 INFO - docopt == 0.6.1 04:26:46 INFO - functools32 == 3.2.3-2 04:26:46 INFO - jsonschema == 2.5.1 04:26:46 INFO - manifestparser == 1.1 04:26:46 INFO - mozInstall == 1.12 04:26:46 INFO - mozcrash == 0.17 04:26:46 INFO - mozdebug == 0.1 04:26:46 INFO - mozdevice == 0.48 04:26:46 INFO - mozfile == 1.2 04:26:46 INFO - mozhttpd == 0.7 04:26:46 INFO - mozinfo == 0.9 04:26:46 INFO - mozleak == 0.1 04:26:46 INFO - mozlog == 3.4 04:26:46 INFO - moznetwork == 0.27 04:26:46 INFO - mozprocess == 0.23 04:26:46 INFO - mozprofile == 0.28 04:26:46 INFO - mozrunner == 6.12 04:26:46 INFO - mozscreenshot == 0.1 04:26:46 INFO - mozsystemmonitor == 0.3 04:26:46 INFO - moztest == 0.7 04:26:46 INFO - mozversion == 1.4 04:26:46 INFO - psutil == 3.1.1 04:26:46 INFO - requests == 1.2.3 04:26:46 INFO - wsgiref == 0.1.2 04:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:46 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')]} 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:46 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')]} 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:46 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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:46 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 04:26:46 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 04:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:46 INFO - 'HOME': '/Users/cltbld', 04:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:46 INFO - 'LOGNAME': 'cltbld', 04:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:46 INFO - 'MOZ_NO_REMOTE': '1', 04:26:46 INFO - 'NO_EM_RESTART': '1', 04:26:46 INFO - 'PAGER': '/bin/cat', 04:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:46 INFO - 'PWD': '/builds/slave/test', 04:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:46 INFO - 'SHELL': '/bin/bash', 04:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:46 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:46 INFO - 'USER': 'cltbld', 04:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:46 INFO - 'XPC_FLAGS': '0x0', 04:26:46 INFO - 'XPC_SERVICE_NAME': '0', 04:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 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)) 04:26:46 INFO - Cleaning up... 04:26:46 INFO - Return code: 0 04:26:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:46 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')]} 04:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:46 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')]} 04:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:46 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 0x108759490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086cf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde50d85760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, '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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:46 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 04:26:46 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 04:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:46 INFO - 'HOME': '/Users/cltbld', 04:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:46 INFO - 'LOGNAME': 'cltbld', 04:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:46 INFO - 'MOZ_NO_REMOTE': '1', 04:26:46 INFO - 'NO_EM_RESTART': '1', 04:26:46 INFO - 'PAGER': '/bin/cat', 04:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:46 INFO - 'PWD': '/builds/slave/test', 04:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:46 INFO - 'SHELL': '/bin/bash', 04:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:26:46 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:46 INFO - 'USER': 'cltbld', 04:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:46 INFO - 'XPC_FLAGS': '0x0', 04:26:46 INFO - 'XPC_SERVICE_NAME': '0', 04:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:47 INFO - Cleaning up... 04:26:47 INFO - Return code: 0 04:26:47 INFO - Running post-action listener: _resource_record_post_action 04:26:47 INFO - Running post-action listener: _start_resource_monitoring 04:26:47 INFO - Starting resource monitoring. 04:26:47 INFO - [mozharness: 2016-11-22 12:26:47.282754Z] Finished create-virtualenv step (success) 04:26:47 INFO - [mozharness: 2016-11-22 12:26:47.283739Z] Running install step. 04:26:47 INFO - Running pre-action listener: _resource_record_pre_action 04:26:47 INFO - Running main action method: install 04:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:47 INFO - Reading from file tmpfile_stdout 04:26:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:47 INFO - Reading from file tmpfile_stdout 04:26:47 INFO - Output received: 04:26:47 INFO - Usage: mozinstall [options] installer 04:26:47 INFO - Options: 04:26:47 INFO - -h, --help show this help message and exit 04:26:47 INFO - -d DEST, --destination=DEST 04:26:47 INFO - Directory to install application into. [default: 04:26:47 INFO - "/builds/slave/test"] 04:26:47 INFO - --app=APP Application being installed. [default: firefox] 04:26:47 INFO - mkdir: /builds/slave/test/build/application 04:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:27:09 INFO - Reading from file tmpfile_stdout 04:27:09 INFO - Output received: 04:27:09 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:27:09 INFO - Running post-action listener: _resource_record_post_action 04:27:09 INFO - [mozharness: 2016-11-22 12:27:09.494205Z] Finished install step (success) 04:27:09 INFO - [mozharness: 2016-11-22 12:27:09.494327Z] Running run-tests step. 04:27:09 INFO - Running pre-action listener: _resource_record_pre_action 04:27:09 INFO - Running main action method: run_tests 04:27:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:09 INFO - 2016-11-22 04:27:09.509 screenresolution[2205:75203] starting screenresolution argv=screenresolution get 04:27:09 INFO - 2016-11-22 04:27:09.512 screenresolution[2205:75203] Display 0: 1600x1200x32@60 04:27:09 INFO - 2016-11-22 04:27:09.518 screenresolution[2206:75205] starting screenresolution argv=screenresolution list 04:27:09 INFO - Available Modes on Display 0 04:27:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:09 INFO - Intel Iris: 04:27:09 INFO - Chipset Model: Intel Iris 04:27:09 INFO - Type: GPU 04:27:09 INFO - Bus: Built-In 04:27:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:09 INFO - Vendor: Intel (0x8086) 04:27:09 INFO - Device ID: 0x0a2e 04:27:09 INFO - Revision ID: 0x0009 04:27:09 INFO - Displays: 04:27:09 INFO - Display: 04:27:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:09 INFO - Display Serial Number: 1600x1200 60 04:27:09 INFO - Main Display: Yes 04:27:09 INFO - Mirror: Off 04:27:09 INFO - Online: Yes 04:27:09 INFO - Rotation: Supported 04:27:09 INFO - Return code: 0 04:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:09 INFO - Python 2.7.3 04:27:09 INFO - Return code: 0 04:27:09 INFO - grabbing minidump binary from tooltool 04:27:09 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')]} 04:27:09 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 0x10856dd30>, '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 0x1083d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108565b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:09 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 04:27:09 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 04:27:09 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 04:27:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:09 INFO - Return code: 0 04:27:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:27:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:27:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 04:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gP7FyAQZlZ/Render', 04:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:09 INFO - 'HOME': '/Users/cltbld', 04:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:09 INFO - 'LOGNAME': 'cltbld', 04:27:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:09 INFO - 'MOZ_NO_REMOTE': '1', 04:27:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:09 INFO - 'NO_EM_RESTART': '1', 04:27:09 INFO - 'PAGER': '/bin/cat', 04:27:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:09 INFO - 'PWD': '/builds/slave/test', 04:27:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:09 INFO - 'SHELL': '/bin/bash', 04:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VCJ2COVb2q/Listeners', 04:27:09 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:09 INFO - 'USER': 'cltbld', 04:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:09 INFO - 'XPC_FLAGS': '0x0', 04:27:09 INFO - 'XPC_SERVICE_NAME': '0', 04:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:27:10 INFO - mozversion application_buildid: 20161122030551 04:27:10 INFO - mozversion application_changeset: 5650168b1ca4efc51ee7ca345935bd2e1b00584f 04:27:10 INFO - mozversion application_display_name: Firefox 04:27:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:10 INFO - mozversion application_name: Firefox 04:27:10 INFO - mozversion application_remotingname: firefox 04:27:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:27:10 INFO - mozversion application_vendor: Mozilla 04:27:10 INFO - mozversion application_version: 51.0 04:27:10 INFO - mozversion platform_buildid: 20161122030551 04:27:10 INFO - mozversion platform_changeset: 5650168b1ca4efc51ee7ca345935bd2e1b00584f 04:27:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:27:10 INFO - mozversion platform_version: 51.0 04:27:10 INFO - using testdate: 1479817630 04:27:10 INFO - actual date: 1479817630 04:27:10 INFO - starting webserver on 'localhost:58244' 04:27:10 INFO - SUITE-START | Running 2 tests 04:27:10 INFO - TEST-START | dromaeo_css 04:27:10 INFO - operating with platform_type : mac_ 04:27:10 INFO - Initialising browser for dromaeo_css test... 04:27:10 INFO - TEST-INFO | started process 2216 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp3c1Mr9/profile http://localhost:58244/getInfo.html) 04:27:12 INFO - PROCESS | 2216 | __metrics Screen width/height:1600/1200 04:27:12 INFO - PROCESS | 2216 | colorDepth:24 04:27:12 INFO - PROCESS | 2216 | Browser inner width/height: 1024/689 04:27:12 INFO - PROCESS | 2216 | __metrics 04:27:12 INFO - PROCESS | 2216 | 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" 04:27:12 INFO - PROCESS | 2216 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:27:13 INFO - TEST-INFO | 2216: exit 0 04:27:13 INFO - Browser initialized. 04:27:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:13 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp3c1Mr9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:25 INFO - PROCESS | 2219 | RSS: Main: 167927808 04:27:25 INFO - PROCESS | 2219 | 04:28:16 INFO - PROCESS | 2219 | 1479817696863 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] 04:30:26 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58244/tests/dromaeo/cssquery-ext.html) 04:30:28 INFO - PROCESS | 2219 | RSS: Main: 269139968 04:30:28 INFO - PROCESS | 2219 | 04:33:31 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-ext.html (next: http://localhost:58244/tests/dromaeo/cssquery-jquery.html) 04:33:31 INFO - PROCESS | 2219 | RSS: Main: 301891584 04:33:31 INFO - PROCESS | 2219 | 04:36:33 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58244/tests/dromaeo/cssquery-mootools.html) 04:36:34 INFO - PROCESS | 2219 | RSS: Main: 276140032 04:36:34 INFO - PROCESS | 2219 | 04:39:36 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58244/tests/dromaeo/cssquery-prototype.html) 04:39:36 INFO - PROCESS | 2219 | RSS: Main: 274407424 04:39:36 INFO - PROCESS | 2219 | 04:42:40 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58244/tests/dromaeo/cssquery-yui.html) 04:42:40 INFO - PROCESS | 2219 | RSS: Main: 262086656 04:42:40 INFO - PROCESS | 2219 | 04:45:43 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:58244/tests/dromaeo/cssquery-yui.html (next: http://localhost:58244/tests/dromaeo/cssquery-dojo.html) 04:45:44 INFO - PROCESS | 2219 | RSS: Main: 311525376 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | __start_tp_report 04:45:44 INFO - PROCESS | 2219 | _x_x_mozilla_page_load 04:45:44 INFO - PROCESS | 2219 | _x_x_mozilla_page_load_details 04:45:44 INFO - PROCESS | 2219 | |i|pagename|runs| 04:45:44 INFO - PROCESS | 2219 | |0;dojo.html;3435.690787829095;3436.8453419596117;3452.257764580613;3475.496053072306;3515.6835884770367;5840.861032098743;5971.641701497908;5982;5984.88030239395;5989.490893274077;5851.034579294422;5964.642121472714;5967.88064238716;5990.760369585222;5996.730147143378;5283.233931079991;5332.280142180794;5338.439463856297;5380.300560927074;5406.864828379303;5235.397929238129;5258;5264.947350526484;5414.702191379492;5420.105682562373;5323.520883120518;5325.920111198335;5326.121190003645;5328.387235467932;5338.039152952467;5318.680879147244;5333.946660533384;5342.439043900412;5400.675959442407;5403.081476149064;5177.171652535576;5253.737313134367;5305.283786688786;5313.787448502056;5327.840164795062;5815.185873977646;5832.416758324176;5862.355140934494;5880.206172166788;5925.377835327272;6148.78479253224;6202.875942481125;6205.255369355661;6225;6233.438990490878;6280.277768056686;6291.968540157316;6295.181626388586;6305.621662700252;6316.526260530479;4884.3650325457465;5865.736041878125;5871.383504731984;5878.353381128072;5903.793367232126;6255.781047663401;6279.340669229757;6299.937000630027;6303.212098487689;6312.589681670676;6232.875342493125;6240.5319601030105;6248.50011999039;6255.311915689271;6256.718447669775;6194.287656919512;6211.223597050369;6241.656708880964;6289.905651415233;6297.842553936188;6273.96863015682;6304.117423560705;6314.273858506239;6316.147320111818;6345.904811427832;6232.3144454110015;6288.717007734663;6292.119103325538;6305.306416294204;6307.306196318401;4934.8766280843265;4992.176290911959;5000.424951130593;5076.949230507647;5088.72012039334;4542;4560.566746159109;4610.216263235258;4614.976925115353;4639;5938.376470470625;5943.643381397043;5947.167396564484;5950.613210141327;5951.107333899863;6215.378462153839;6249.250089989139;6269.467095296951;6287.654179020106;6292.685365731695;5753.05074662676;5829.854253643693;5878.647281163058;5899.941000589939;5959.433853783884;4634.304854271819;5474.5894057945015;5505.119180931032;5510.586705996986;5518.91721624176;6413.454856337264;6414.64719440426;6417.711202995876;6428.003659432796;6434.710438030206;6128.319797384666;6206.534509911684;6251.343608920998;6263.74945002213;6284.465820405317;6331.2085989251345;6388.041793730978;6429.22849258092;6458.451031662361;6461.160049193575;6326.493880489457;6332.145160403286;6336.3030066693545;6340.365963403808;6344.809655710336;6214.067889816563;6223.533235007302;6231.3145553988115;6242.812715618538;6278.905816412849;6101.176341194059;6132.936844521141;6251.812445626639;6262.780802671885;6270.435660790551;6253.499720022478;6260.655663938345;6268.780592679234;6271.874562508816;6290.9056364155485;5039.596832253337;5942.732577033958;6095.878082438415;6099.2985806632805;6118.969405152946;6112.235970503687;6128.594790794166;6147.07793830911;6209.689515524115;6282;5761.251037365283;6116.449519543263;6139.017757158833;6148.077788331607;6164.291106522807 04:45:44 INFO - PROCESS | 2219 | |1;ext.html;523.4268476018759;529.1163756526602;532.4994505165145;538.754866535726;552.1827695011385;31910;33795.83102084486;33817.1545711357;33825.492617610755;33837.83081084591;43058.35412468808;43965.68102956908;44172.55827441725;45937;45939.77030114853;10027.999999999982;10208.693739187836;10212.795744085113;10216.693499194998;10218.978102189796;9395.57719902606;10006.099451049404;10103.696889093302;10110.191184705205;10139.797204055914;9390.24878009761;12215;12495.812562811565;12502.937485312561;12679.619611411672;12380.62858114258;12436.689082772913;12441.191322564004;12471;12522.998160147212;12338.383080846012;12436.81344779829;12441.191322564004;12444.75110497785;12450.875491245062;42034.57965420337;42332.57667423317;42368.15263694709;42426.515071972644;42488.57511424908;3459.705924996353;3591.8204089795668;3700.4264339027495;3997.4403583498042;4064.2887494688607;29695.851520742475;30253.394932101233;30993.690063099304;32335.838320808245;32675.6732432675;3396.235846934445;3445.87939422119;3524.7004004659634;3568.0901370150445;3570.625084366156;527039;533847;537158;537288;537591.999999996;34615.480767788504;35443.82278088593;61526.69236653788;62119.068213976825;62145.689271553354;36139.91580252597;36390;36434;36460.81769591135;36471.4529282061;15737.291821868044;15947.760783588255;15950.441734539236;15956.281967311266;15962.680746385007;13321.733565328639;13392.531261405804;13438.260895650637;13441.596752097452;13446.93276533611;7594.278543538355;7727.806804829812;8000.5599692017495;8036.758897233092;8125.228103330174;3322.667733226658;3386.72906167506;3389.457686770105;3394.8472318745717;3400.268942177444;910.7905181808221;1032.4166845732288;1034.622362837559;1084.2976526852924;1138.6925530106826;28827.56758648622;30255.848720756254;30455.543166852516;30649.38701225963;30682.563338301043;1066.7439814444479;1093.775775965925;1116.1349953785882;1139.943002849854;1205.8191271309374;15876.60308492297;15906.363745450284;15919.522414327588;16002.719782417378;16210.59473513148;731497;740187;740477;742636;743340.2832985909;52742.208866867026;53332.73333633307;61019.6949015261;61469.38530614637;61811.763764724456;1407.240090351199;1411.5200831717266;1451.4557041109583;1464.633841539615;1467.93394297259;30008.399832003674;31393.90121345742;31585.8420707895;31600.209994750316;32170.03489895307;43822;51669.483305167974;52260;52551.21173182482;52607;521890.171647418;526224;629818;644893;883516;26836.194914152606;27080.729192707822;27119.86440067787;27219.86390068037;27224.455510890068;33270;33404.832975834965;33682.98951031473;33805.83097084597;33839.661603383654;32704.018879433654;37226.25547488981;37849;38577.80711096426;38709.64516241918;34344.82827585846;37471.43792843164;39005.80497097496;39773;40117.59882401139;31105;37556.624433755314;38107.809460952514;38124.42813357857;38516.8444946652;32253.193670158435;34459.4831077529;34529.13677158091;34667.47998780071;34767;24644;24940.625890612017;25714.842832072976;26385.4722905537;26817 04:45:44 INFO - PROCESS | 2219 | |2;jquery.html;361.849319165055;363.8126364922067;384.50398985308954;393.1978763322821;413.6793984661887;19159.99999999998;20856.270030548934;21508.677369839425;21683.45791355215;21689.457763555918;11775;12059.638210853689;12243.755124897496;12244.693882652939;12245;5332.306800115989;5638.774449022034;5648.068068768648;5648.971755141239;5654.095344744842;5545.584081193906;5558.916616250759;5841.15303281024;6086.513078953673;6164.876702465948;6171.567990240685;6185.165002724642;6195.473384762301;6200.3179650238435;6204.4105809948205;6107.175531303284;6849.7602583909575;6902.585844849325;6914.688839002257;6945.409640180591;5010.69935803853;5342.5993050521365;6099.9085013724825;6114.755409783604;6118.082287656843;13152.342382880817;13382;13391.598252052454;13412.664683382896;20651.17395304186;2192.9451763706033;2213.3249358945513;2252.3693365857584;2307.8153747700144;2364.2552595932398;9665.565049572786;9928.950355248178;10511.421871797049;10685.679429617125;16335.754963675554;1863.1429542410508;1892.6120145370303;1892.8769629974008;1906.3423119023914;1951.1317463728647;109155.45422272917;116942.41528792387;122938.15592766115;123248.38375808063;124128;11385.658430247106;11394.601188958346;11631.302121872715;11676.241044332091;11897.643070707893;15002.24988750558;15020.248987550578;15036.548903532912;15038.398464061534;15046.398144074334;7768.184340644264;8726.16750482393;8763.518006509703;8985.730428087169;9099.81800363989;8928.955355223183;8953.552322383855;8958.193762561401;9098.363114582047;9104.681336153202;4449.421575195204;4514.187446259705;4530.255851497197;4550.954490455119;4617.492075871652;1616.272677295222;1645.2514106081703;1770.2918832466858;1821.3807305516189;1883.171404582007;720.92069872314;873.323174539724;958.6021800952666;959.2230293462318;1041.7864337810731;20342.79657203409;22089;22189.778102219094;22205.555888882456;22333.441663958532;963.3352986439335;984.5471083301618;1002.4436437777103;1002.9448380339152;1007.0584003956325;10060.49697515136;10974.176936729777;11534.653960381202;11571.247868888495;11585.478653460614;627853;628510;635126;638156;648551;107381;111761.32358014636;124500;130882;142211.28894355462;852.1989330029752;989.8020395920701;1004.6232662751469;1006.4062203300089;1007.3049595778889;15171.620709482351;18631.906840465712;18979.525511862314;19304.613907721487;19363.612727745647;50289.49710502994;51227;51963.01062873059;52108;53116;72461;73569.63215184104;74452;75896.86154707795;77820;7989.880151797844;8121.106678265268;8311.501309921425;8447.197516235949;8552.615132318937;12191.756164876475;12754.298513581842;12906.483740650268;13034.739305214032;13189.93405033007;10907.181961352771;10980.07848626503;11286.717832054264;11354;11477.426128693698;5075.670081444694;11020.842811504677;11396.48715807774;11477.540898363972;11806.527738890692;6007.549433792396;11359.659210223706;11520.251183673034;11747.47136378848;12071.57749478799;7348.669309880961;7991.760247192594;8082.19178082187;8181.67273309061;8221.876671849808;9743.756406089904;11695.532178712756;11800.704982375166;11921.927026567651;11933.940330298294 04:45:44 INFO - PROCESS | 2219 | |3;mootools.html;1580.8103027636685;1608.1075003373128;1825.9269629214832;1948.318088668966;1965.8427325813936;8638.049814520398;9210.49342286174;9223.169914707674;9225.7693557661;9273.536323183831;8071.434999550034;8324.209200125993;8686.86969695455;8930.062343453941;8998.145176208267;2409.3856066702965;2449.4243852694603;2450.9509809803794;2451.1053465485147;2452.0682140786475;2412.541617092747;2436.683231179944;2455.017992802875;2455.1038870812204;2459.7417271186537;2424.854508729473;2431.161249368965;2433.8904749286235;2454.288256405649;2456.778889899909;2044.9591008179752;2422.2612103308484;2430.3559556717305;2432.8905199266073;2436.415260337524;2405.3625789165885;2419.709634843812;2430.21018169094;2430.5503481855912;2437.914672986437;9029.864552031724;9055.728328150166;9165.816683666357;9169.40398874071;9185.862212066824;5371.006363822667;5532.640378375393;5536.75084621193;5543.362513310981;5549.361823390281;3432.4508078707536;3541.8406171722336;3615.5119058927235;3619.1856832212807;3620.348337299285;1076.34343050739;1104.0780947908506;1116.1182665694091;1128.1313388690744;1132.6205721083447;12033.879661203364;12107.515699372014;12112.273263604213;12117.636470905887;12151.513939442411;4744.840235447711;4756.809727610926;4805.927911081267;4862.902741945141;4916.8770780730765;10184.949075254724;10185.541650625739;10185.898141018642;10190.847137292947;10239;5485.6982865942755;5494.2857428534035;5495.670259784426;5496.31296087989;5508.7521061552325;4536.047430039728;4708.929366059512;4712.575868171881;5011.774470148852;5042.294078828967;3323.651016643266;3427.246005878703;3999.1601763629383;4091.8977025574004;4125.566815484391;1296.7471343088007;1302.1275745250705;1304.1914013311807;1314.2968511846116;1315.1714419915393;929.762910457829;931.3945935142211;948.3645957208687;967.9274054445945;1005.7284533176002;5720.742566584514;5855.824325270249;5873.4126587340925;6019.127226552213;6137.5449820071435;404.1976676297547;446.39290564831805;450.86474057782533;452.710265430125;455.1670443089205;3954.9011274718364;3959.346707793182;4020.537638171589;4054.189162167578;4068.389741538793;10240.539175737109;10956.34261944286;11081.279716818543;11114.777704445865;11115.666530004113;10775.892241077645;11036.006759391694;11049.613263535737;11080.501377438035;11098.944505277583;8222.095569487352;8409.453385529921;8415.200555947175;8438.156184381636;8439.409241353047;5730.398308177581;5779.739911703899;5923.940760592512;5958.40415958418;6007.789727359522;10191;10297.02178293061;10355.84466232992;10365.533550990072;10377.9481102594;9952.751181220527;10350.016748408889;10360.844587331045;10490.947545262225;10552.630657926935;7119.430445564239;7375.409967202718;7530.736424225126;7691.961540192263;7892.210778922062;7905.56519391439;8207.015158181057;8214.712485062993;8220.753377398687;8227.053888802624;6559.573627714183;7725.381969442544;7772.417068719756;7777.377809775091;7881.684732610861;7539.623018849145;7559.8110047247055;7578.09062912454;7732.420068494998;7761.417893658111;7154.499185057204;7332.743353982585;7334.669939852826;7345.081864766904;7361.484696071224;5000.549950504472;5062.594992400673;5114.0027694600685;5117.43708192106;5271.288376069335;5098.745062746773;5146.228065790161;5154.098032844312;5222.503862133091;5227.137522308776 04:45:44 INFO - PROCESS | 2219 | |4;prototype.html;306.55855567982104;309.2762934732725;316.1448282396118;321.68956956536937;323.50342224685113;5248.816291429801;5564.415736347686;5599.860003499909;5605.178317046961;5649.293838270211;4567.725936443816;5067.670601410906;5088.847334579959;5201.375834899817;5207.755679121513;4159.272127377697;4166.708330416872;4190.371444283352;4204.978975105136;4247.893802654928;3952.881413557598;4172.123853990651;4182.958170418303;4190.518090419595;4203.642690371322;3573.8927832165077;4024.2353952748886;4106.632561299735;4190.413342132104;4223.853229344143;3550.6626870447394;4169.791510424467;4176.665866730655;4182.184474027566;4194.224068547329;3350.664933506654;3605.6574625410544;3606.5131207286945;3621.8370173342264;3651;5119.820806271762;5366.70483123428;5404.702741349224;5411.269478620376;5415.588179446962;4750.192467280571;4786.16242157621;4799.568038876483;4848.721101082486;4866.416030076378;4705.6942098371555;4778.474367819537;5636.323641163046;5641.351244606882;5661.490465858093;3376.3416133853907;3699.130704284491;3765.9435108473394;3980;4023.396490526415;5583.799483111151;5753.971230143822;5876.265466816648;5886.735096920606;5978.581499295051;4034.798260086984;4044.939325910114;4045.0291929937193;4046.6560342371226;4128.1330920506425;3207.7273431758563;4012.7792971386853;4163.75017498951;4184.184084103632;4187.539370669224;4637.261027114832;4698.2247929092;4707.317438971399;4729.834455794031;4811.542903424169;4847.709137451764;4877.097736918681;5621.8756248750415;5648.548116150698;5672.865426914634;1265.5064524835323;1339.6717804138048;1397.9440822366992;1412.5126831243206;1425.7148570285983;921.7787730944525;941.924646028316;960.5869476125193;963.6627180486773;977.1840513171439;4709.127432266315;4803.423589169252;5329.360476742816;5329.8934021319355;5394.78420863169;4984.4267909190185;5141.485851414904;5765.711714414262;5801.477866991991;5895.469407753323;4000.599940006034;5273.945210957824;5283.339582552181;5399.676019438768;5437.537809286255;2599.9870000650253;3061.5866857974333;3064.647565529993;3080.5047911192005;3093.679740194854;5458.945410545924;5675.829725108253;6033.849153771103;6121.755129794848;6124.112003759519;5384.40771515133;6054.576179667381;6106.664133472702;6111.480524155497;6142.6314421134875;5379.381371142369;5844.970775146097;6151.507879369639;6168.470926919941;6214.627122372672;5649.54803615718;5758.596898217084;5871.356020314319;5902.291724993029;5982.68380956189;5256.789728410974;5594.818020971743;5951.732172052181;5959.76160953557;5968.432998865101;4603.792829322755;4937.530934561211;4957.132501812096;5117.309163262912;6142.04798256271;3962.7622342659533;3973.582773808824;3987.302222111177;3991.261616600938;3995.5005624296964;5050.74746262678;5970.701464926823;6047.606905551125;6124;6174.907376389448;4921.458639549718;5067.771950262173;5582.4726196545;5882.088276317178;5919.644821310735;5105.31078304439;5109.642325037212;5131.743412829418;5540.396013873473;5886.676232807065;5185.288854678022;5484.890302194013;5648.5763567731765;5741.97129014369;5744.942550574441;4836.274558816206;5591.6365436246515;5704.2014118024335;5727.455891690282;5809.680467574155;4955.1576232039915;5534.252875861707;5605.683623609716;5649.54803615718;5650.35020972577 04:45:44 INFO - PROCESS | 2219 | |5;yui.html;665.3246954341341;729.8394353242285;742.9784046935464;750.6772088002159;787.7518581646783;15396.307166177521;15946.84053159468;16570.337186512526;16651.333946642135;16802.243899024543;14907.254637268148;15246.466373676923;15249.39002439904;15251;15251.92374038131;739.8927155562441;752.2515097478017;899.7075950316157;920.7145784806731;922.898481167071;893.053363434758;915.0757734687979;927.5084205371164;928.3779867488765;928.5728564860138;959.2613687460686;961.4471678784691;962.7496850818768;963.2919803944095;964.4502633498909;956.4882787708577;957.2007373842849;957.2581249531634;958.5925981457922;962.672691284963;711.9430445564394;712.672170801432;713.0302788208033;713.9286071392871;715.9904534606233;15096.396144154221;15186.316615752206;15200.46798362063;15212;15266.084034957938;13775.655608609864;14511.492097776527;14812.111273323635;14890.255487225704;14983.925080374638;11219.38293393863;13379.26414047227;13607.272835601594;13657.521986730417;13670.974676899272;4657.930131048037;4708.835190768341;4747.905041899143;4776.044791041805;4949;108551;108874.45562772136;112361;113210.43394782973;117458;10928.836067458995;11368.886311136783;11467.885321146681;11545.095059315287;11622.88377116218;18386.908065459855;18409.790825101074;21390.930453477264;21585.24451644185;21773.45566360822;7824;7952.84094318122;7957.084935232407;8025.59872006409;8193.344532437392;4404.955950440519;4459.0858873930765;4549.135664223787;4689.132510485571;4701.9529804701515;3489.337025965109;3562.091666624994;3595.334863050344;3596.3886139356373;3599.532060832075;648.3807963395041;659.0904551718694;660.1022609251414;669.4176066821799;673.531895332739;562.398233889734;583.9416058394127;623.8253289079065;657.710607332772;681.2608319972786;8525.95737021311;8593.871091933626;9558.808823823485;9563.187129094105;9746.805063898682;544.4773017902778;571.7541457173455;655.8031592343896;701.6737217194029;746.6938555192345;4472.39622650938;4765.332853400527;4970.950290497121;5266.262723218752;5304.177852432879;97453;117859;134092.32953835168;163116.55325170132;164145;135402;139187;140831;141452.2927385377;142188;97802;98293;111574.44212778885;115957;117159;9786.622795027693;9796.434492131677;9878.802423951336;10199.694009179737;10660.786784264426;44327.89180270519;54369.45630543802;62559.6872015637;63369.683151583944;67234.66382668055;91142.54428727814;91524.54237728768;93236.53381733048;94020.76906539085;96564;13744.725105498033;13937.860621393656;14287.414223950242;14749.188794616399;14937.103773773608;15270.389184432499;15948.601284967968;16310.510684679479;16682.416115436386;16938.91530542389;14460.421583136556;14515.709685806014;14718.705625887636;15464.072155670247;15533.689326213187;14328.71342573122;14648.19434931089;14909.17999509994;15193.316300766714;15539.766903496231;14167.64580885486;14601.488947886774;15005;15149.697006060038;15156.924215378853;11113.499892504695;11155.72110697239;11173.888261117285;11394.430278485877;11656.825147622962;9609.519524023632;10867.945660271647;11511.136664750346;11543.5959741412;11559.30644161353 04:45:44 INFO - PROCESS | 2219 | __end_tp_report 04:45:44 INFO - PROCESS | 2219 | __start_cc_report 04:45:44 INFO - PROCESS | 2219 | _x_x_mozilla_cycle_collect,1310 04:45:44 INFO - PROCESS | 2219 | __end_cc_report 04:45:44 INFO - PROCESS | 2219 | __startTimestamp1479818744145__endTimestamp 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | ------- Summary: start ------- 04:45:44 INFO - PROCESS | 2219 | Number of tests: 6 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | [#0] dojo.html Cycles:165 Average:5837.90 Median:6116.45 stddev:635.10 (10.4%) stddev-sans-first:608.45 04:45:44 INFO - PROCESS | 2219 | Values: 3435.7 3436.8 3452.3 3475.5 3515.7 5840.9 5971.6 5982.0 5984.9 5989.5 5851.0 5964.6 5967.9 5990.8 5996.7 5283.2 5332.3 5338.4 5380.3 5406.9 5235.4 5258.0 5264.9 5414.7 5420.1 5323.5 5325.9 5326.1 5328.4 5338.0 5318.7 5333.9 5342.4 5400.7 5403.1 5177.2 5253.7 5305.3 5313.8 5327.8 5815.2 5832.4 5862.4 5880.2 5925.4 6148.8 6202.9 6205.3 6225.0 6233.4 6280.3 6292.0 6295.2 6305.6 6316.5 4884.4 5865.7 5871.4 5878.4 5903.8 6255.8 6279.3 6299.9 6303.2 6312.6 6232.9 6240.5 6248.5 6255.3 6256.7 6194.3 6211.2 6241.7 6289.9 6297.8 6274.0 6304.1 6314.3 6316.1 6345.9 6232.3 6288.7 6292.1 6305.3 6307.3 4934.9 4992.2 5000.4 5076.9 5088.7 4542.0 4560.6 4610.2 4615.0 4639.0 5938.4 5943.6 5947.2 5950.6 5951.1 6215.4 6249.3 6269.5 6287.7 6292.7 5753.1 5829.9 5878.6 5899.9 5959.4 4634.3 5474.6 5505.1 5510.6 5518.9 6413.5 6414.6 6417.7 6428.0 6434.7 6128.3 6206.5 6251.3 6263.7 6284.5 6331.2 6388.0 6429.2 6458.5 6461.2 6326.5 6332.1 6336.3 6340.4 6344.8 6214.1 6223.5 6231.3 6242.8 6278.9 6101.2 6132.9 6251.8 6262.8 6270.4 6253.5 6260.7 6268.8 6271.9 6290.9 5039.6 5942.7 6095.9 6099.3 6119.0 6112.2 6128.6 6147.1 6209.7 6282.0 5761.3 6116.4 6139.0 6148.1 6164.3 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | [#1] ext.html Cycles:180 Average:74499.90 Median:18613.20 stddev:174387.62 (936.9%) stddev-sans-first:174788.37 04:45:44 INFO - PROCESS | 2219 | Values: 523.4 529.1 532.5 538.8 552.2 31910.0 33795.8 33817.2 33825.5 33837.8 43058.4 43965.7 44172.6 45937.0 45939.8 10028.0 10208.7 10212.8 10216.7 10219.0 9395.6 10006.1 10103.7 10110.2 10139.8 9390.2 12215.0 12495.8 12502.9 12679.6 12380.6 12436.7 12441.2 12471.0 12523.0 12338.4 12436.8 12441.2 12444.8 12450.9 42034.6 42332.6 42368.2 42426.5 42488.6 3459.7 3591.8 3700.4 3997.4 4064.3 29695.9 30253.4 30993.7 32335.8 32675.7 3396.2 3445.9 3524.7 3568.1 3570.6 527039.0 533847.0 537158.0 537288.0 537592.0 34615.5 35443.8 61526.7 62119.1 62145.7 36139.9 36390.0 36434.0 36460.8 36471.5 15737.3 15947.8 15950.4 15956.3 15962.7 13321.7 13392.5 13438.3 13441.6 13446.9 7594.3 7727.8 8000.6 8036.8 8125.2 3322.7 3386.7 3389.5 3394.8 3400.3 910.8 1032.4 1034.6 1084.3 1138.7 28827.6 30255.8 30455.5 30649.4 30682.6 1066.7 1093.8 1116.1 1139.9 1205.8 15876.6 15906.4 15919.5 16002.7 16210.6 731497.0 740187.0 740477.0 742636.0 743340.3 52742.2 53332.7 61019.7 61469.4 61811.8 1407.2 1411.5 1451.5 1464.6 1467.9 30008.4 31393.9 31585.8 31600.2 32170.0 43822.0 51669.5 52260.0 52551.2 52607.0 521890.2 526224.0 629818.0 644893.0 883516.0 26836.2 27080.7 27119.9 27219.9 27224.5 33270.0 33404.8 33683.0 33805.8 33839.7 32704.0 37226.3 37849.0 38577.8 38709.6 34344.8 37471.4 39005.8 39773.0 40117.6 31105.0 37556.6 38107.8 38124.4 38516.8 32253.2 34459.5 34529.1 34667.5 34767.0 24644.0 24940.6 25714.8 26385.5 26817.0 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | [#2] jquery.html Cycles:180 Average:35442.24 Median:12201.55 stddev:105729.10 (866.5%) stddev-sans-first:105992.88 04:45:44 INFO - PROCESS | 2219 | Values: 361.8 363.8 384.5 393.2 413.7 19160.0 20856.3 21508.7 21683.5 21689.5 11775.0 12059.6 12243.8 12244.7 12245.0 5332.3 5638.8 5648.1 5649.0 5654.1 5545.6 5558.9 5841.2 6086.5 6164.9 6171.6 6185.2 6195.5 6200.3 6204.4 6107.2 6849.8 6902.6 6914.7 6945.4 5010.7 5342.6 6099.9 6114.8 6118.1 13152.3 13382.0 13391.6 13412.7 20651.2 2192.9 2213.3 2252.4 2307.8 2364.3 9665.6 9929.0 10511.4 10685.7 16335.8 1863.1 1892.6 1892.9 1906.3 1951.1 109155.5 116942.4 122938.2 123248.4 124128.0 11385.7 11394.6 11631.3 11676.2 11897.6 15002.2 15020.2 15036.5 15038.4 15046.4 7768.2 8726.2 8763.5 8985.7 9099.8 8929.0 8953.6 8958.2 9098.4 9104.7 4449.4 4514.2 4530.3 4551.0 4617.5 1616.3 1645.3 1770.3 1821.4 1883.2 720.9 873.3 958.6 959.2 1041.8 20342.8 22089.0 22189.8 22205.6 22333.4 963.3 984.5 1002.4 1002.9 1007.1 10060.5 10974.2 11534.7 11571.2 11585.5 627853.0 628510.0 635126.0 638156.0 648551.0 107381.0 111761.3 124500.0 130882.0 142211.3 852.2 989.8 1004.6 1006.4 1007.3 15171.6 18631.9 18979.5 19304.6 19363.6 50289.5 51227.0 51963.0 52108.0 53116.0 72461.0 73569.6 74452.0 75896.9 77820.0 7989.9 8121.1 8311.5 8447.2 8552.6 12191.8 12754.3 12906.5 13034.7 13189.9 10907.2 10980.1 11286.7 11354.0 11477.4 5075.7 11020.8 11396.5 11477.5 11806.5 6007.5 11359.7 11520.3 11747.5 12071.6 7348.7 7991.8 8082.2 8181.7 8221.9 9743.8 11695.5 11800.7 11921.9 11933.9 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | [#3] mootools.html Cycles:180 Average:5834.39 Median:2582.05 stddev:3303.71 (127.9%) stddev-sans-first:3297.51 04:45:44 INFO - PROCESS | 2219 | Values: 1580.8 1608.1 1825.9 1948.3 1965.8 8638.0 9210.5 9223.2 9225.8 9273.5 8071.4 8324.2 8686.9 8930.1 8998.1 2409.4 2449.4 2451.0 2451.1 2452.1 2412.5 2436.7 2455.0 2455.1 2459.7 2424.9 2431.2 2433.9 2454.3 2456.8 2045.0 2422.3 2430.4 2432.9 2436.4 2405.4 2419.7 2430.2 2430.6 2437.9 9029.9 9055.7 9165.8 9169.4 9185.9 5371.0 5532.6 5536.8 5543.4 5549.4 3432.5 3541.8 3615.5 3619.2 3620.3 1076.3 1104.1 1116.1 1128.1 1132.6 12033.9 12107.5 12112.3 12117.6 12151.5 4744.8 4756.8 4805.9 4862.9 4916.9 10184.9 10185.5 10185.9 10190.8 10239.0 5485.7 5494.3 5495.7 5496.3 5508.8 4536.0 4708.9 4712.6 5011.8 5042.3 3323.7 3427.2 3999.2 4091.9 4125.6 1296.7 1302.1 1304.2 1314.3 1315.2 929.8 931.4 948.4 967.9 1005.7 5720.7 5855.8 5873.4 6019.1 6137.5 404.2 446.4 450.9 452.7 455.2 3954.9 3959.3 4020.5 4054.2 4068.4 10240.5 10956.3 11081.3 11114.8 11115.7 10775.9 11036.0 11049.6 11080.5 11098.9 8222.1 8409.5 8415.2 8438.2 8439.4 5730.4 5779.7 5923.9 5958.4 6007.8 10191.0 10297.0 10355.8 10365.5 10377.9 9952.8 10350.0 10360.8 10490.9 10552.6 7119.4 7375.4 7530.7 7692.0 7892.2 7905.6 8207.0 8214.7 8220.8 8227.1 6559.6 7725.4 7772.4 7777.4 7881.7 7539.6 7559.8 7578.1 7732.4 7761.4 7154.5 7332.7 7334.7 7345.1 7361.5 5000.5 5062.6 5114.0 5117.4 5271.3 5098.7 5146.2 5154.1 5222.5 5227.1 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | [#4] prototype.html Cycles:180 Average:4631.57 Median:5113.48 stddev:1405.13 (27.5%) stddev-sans-first:1371.06 04:45:44 INFO - PROCESS | 2219 | Values: 306.6 309.3 316.1 321.7 323.5 5248.8 5564.4 5599.9 5605.2 5649.3 4567.7 5067.7 5088.8 5201.4 5207.8 4159.3 4166.7 4190.4 4205.0 4247.9 3952.9 4172.1 4183.0 4190.5 4203.6 3573.9 4024.2 4106.6 4190.4 4223.9 3550.7 4169.8 4176.7 4182.2 4194.2 3350.7 3605.7 3606.5 3621.8 3651.0 5119.8 5366.7 5404.7 5411.3 5415.6 4750.2 4786.2 4799.6 4848.7 4866.4 4705.7 4778.5 5636.3 5641.4 5661.5 3376.3 3699.1 3765.9 3980.0 4023.4 5583.8 5754.0 5876.3 5886.7 5978.6 4034.8 4044.9 4045.0 4046.7 4128.1 3207.7 4012.8 4163.8 4184.2 4187.5 4637.3 4698.2 4707.3 4729.8 4811.5 4847.7 4877.1 5621.9 5648.5 5672.9 1265.5 1339.7 1397.9 1412.5 1425.7 921.8 941.9 960.6 963.7 977.2 4709.1 4803.4 5329.4 5329.9 5394.8 4984.4 5141.5 5765.7 5801.5 5895.5 4000.6 5273.9 5283.3 5399.7 5437.5 2600.0 3061.6 3064.6 3080.5 3093.7 5458.9 5675.8 6033.8 6121.8 6124.1 5384.4 6054.6 6106.7 6111.5 6142.6 5379.4 5845.0 6151.5 6168.5 6214.6 5649.5 5758.6 5871.4 5902.3 5982.7 5256.8 5594.8 5951.7 5959.8 5968.4 4603.8 4937.5 4957.1 5117.3 6142.0 3962.8 3973.6 3987.3 3991.3 3995.5 5050.7 5970.7 6047.6 6124.0 6174.9 4921.5 5067.8 5582.5 5882.1 5919.6 5105.3 5109.6 5131.7 5540.4 5886.7 5185.3 5484.9 5648.6 5742.0 5744.9 4836.3 5591.6 5704.2 5727.5 5809.7 4955.2 5534.3 5605.7 5649.5 5650.4 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - PROCESS | 2219 | [#5] yui.html Cycles:180 Average:25078.72 Median:3595.86 stddev:39480.16 (1097.9%) stddev-sans-first:39548.36 04:45:44 INFO - PROCESS | 2219 | Values: 665.3 729.8 743.0 750.7 787.8 15396.3 15946.8 16570.3 16651.3 16802.2 14907.3 15246.5 15249.4 15251.0 15251.9 739.9 752.3 899.7 920.7 922.9 893.1 915.1 927.5 928.4 928.6 959.3 961.4 962.7 963.3 964.5 956.5 957.2 957.3 958.6 962.7 711.9 712.7 713.0 713.9 716.0 15096.4 15186.3 15200.5 15212.0 15266.1 13775.7 14511.5 14812.1 14890.3 14983.9 11219.4 13379.3 13607.3 13657.5 13671.0 4657.9 4708.8 4747.9 4776.0 4949.0 108551.0 108874.5 112361.0 113210.4 117458.0 10928.8 11368.9 11467.9 11545.1 11622.9 18386.9 18409.8 21390.9 21585.2 21773.5 7824.0 7952.8 7957.1 8025.6 8193.3 4405.0 4459.1 4549.1 4689.1 4702.0 3489.3 3562.1 3595.3 3596.4 3599.5 648.4 659.1 660.1 669.4 673.5 562.4 583.9 623.8 657.7 681.3 8526.0 8593.9 9558.8 9563.2 9746.8 544.5 571.8 655.8 701.7 746.7 4472.4 4765.3 4971.0 5266.3 5304.2 97453.0 117859.0 134092.3 163116.6 164145.0 135402.0 139187.0 140831.0 141452.3 142188.0 97802.0 98293.0 111574.4 115957.0 117159.0 9786.6 9796.4 9878.8 10199.7 10660.8 44327.9 54369.5 62559.7 63369.7 67234.7 91142.5 91524.5 93236.5 94020.8 96564.0 13744.7 13937.9 14287.4 14749.2 14937.1 15270.4 15948.6 16310.5 16682.4 16938.9 14460.4 14515.7 14718.7 15464.1 15533.7 14328.7 14648.2 14909.2 15193.3 15539.8 14167.6 14601.5 15005.0 15149.7 15156.9 11113.5 11155.7 11173.9 11394.4 11656.8 9609.5 10867.9 11511.1 11543.6 11559.3 04:45:44 INFO - PROCESS | 2219 | -------- Summary: end -------- 04:45:44 INFO - PROCESS | 2219 | 04:45:44 INFO - TEST-INFO | 2219: exit 0 04:45:44 INFO - TEST-OK | dromaeo_css | took 1114732ms 04:45:44 INFO - TEST-START | kraken 04:45:44 INFO - operating with platform_type : mac_ 04:45:44 INFO - Initialising browser for kraken test... 04:45:44 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpSxGKH5/profile http://localhost:58244/getInfo.html) 04:45:47 INFO - PROCESS | 2222 | __metrics Screen width/height:1600/1200 04:45:47 INFO - PROCESS | 2222 | colorDepth:24 04:45:47 INFO - PROCESS | 2222 | Browser inner width/height: 1024/689 04:45:47 INFO - PROCESS | 2222 | __metrics 04:45:47 INFO - PROCESS | 2222 | 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" 04:45:47 INFO - PROCESS | 2222 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:47 INFO - TEST-INFO | 2222: exit 0 04:45:47 INFO - Browser initialized. 04:45:47 INFO - Running cycle 1/1 for kraken test... 04:45:47 INFO - TEST-INFO | started process 2224 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpSxGKH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:59 INFO - PROCESS | 2224 | RSS: Main: 168316928 04:45:59 INFO - PROCESS | 2224 | 04:46:02 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:03 INFO - PROCESS | 2224 | RSS: Main: 218206208 04:46:03 INFO - PROCESS | 2224 | 04:46:06 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-dft) 04:46:06 INFO - PROCESS | 2224 | RSS: Main: 229896192 04:46:06 INFO - PROCESS | 2224 | 04:46:09 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-fft) 04:46:10 INFO - PROCESS | 2224 | RSS: Main: 327733248 04:46:10 INFO - PROCESS | 2224 | 04:46:12 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58244/tests/kraken/driver.html?testName=audio-oscillator) 04:46:13 INFO - PROCESS | 2224 | RSS: Main: 230051840 04:46:13 INFO - PROCESS | 2224 | 04:46:14 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:15 INFO - PROCESS | 2224 | RSS: Main: 231645184 04:46:15 INFO - PROCESS | 2224 | 04:46:18 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58244/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:18 INFO - PROCESS | 2224 | RSS: Main: 269754368 04:46:18 INFO - PROCESS | 2224 | 04:46:21 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58244/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:22 INFO - PROCESS | 2224 | RSS: Main: 267620352 04:46:22 INFO - PROCESS | 2224 | 04:46:25 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58244/tests/kraken/driver.html?testName=json-parse-financial) 04:46:25 INFO - PROCESS | 2224 | RSS: Main: 266641408 04:46:25 INFO - PROCESS | 2224 | 04:46:27 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:27 INFO - PROCESS | 2224 | RSS: Main: 240992256 04:46:27 INFO - PROCESS | 2224 | 04:46:29 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:30 INFO - PROCESS | 2224 | RSS: Main: 246149120 04:46:30 INFO - PROCESS | 2224 | 04:46:32 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:33 INFO - PROCESS | 2224 | RSS: Main: 253153280 04:46:33 INFO - PROCESS | 2224 | 04:46:35 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:36 INFO - PROCESS | 2224 | RSS: Main: 265588736 04:46:36 INFO - PROCESS | 2224 | 04:46:39 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:39 INFO - PROCESS | 2224 | RSS: Main: 259461120 04:46:39 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | Cycle 1(1): loaded http://localhost:58244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58244/tests/kraken/driver.html?testName=ai-astar) 04:46:41 INFO - PROCESS | 2224 | RSS: Main: 303177728 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | __start_tp_report 04:46:41 INFO - PROCESS | 2224 | _x_x_mozilla_page_load 04:46:41 INFO - PROCESS | 2224 | _x_x_mozilla_page_load_details 04:46:41 INFO - PROCESS | 2224 | |i|pagename|runs| 04:46:41 INFO - PROCESS | 2224 | |0;ai-astar;114;113;114;114;114;115;114;114;114;114 04:46:41 INFO - PROCESS | 2224 | |1;audio-beat-detection;143;109;108;142;107;108;107;107;138;108 04:46:41 INFO - PROCESS | 2224 | |2;audio-dft;181;183;183;186;185;182;185;184;185;184 04:46:41 INFO - PROCESS | 2224 | |3;audio-fft;82;58;60;88;62;58;62;66;106;86 04:46:41 INFO - PROCESS | 2224 | |4;audio-oscillator;85;70;93;68;67;68;90;67;67;90 04:46:41 INFO - PROCESS | 2224 | |5;imaging-gaussian-blur;87;84;88;84;88;85;88;86;88;71 04:46:41 INFO - PROCESS | 2224 | |6;imaging-darkroom;92;104;150;94;93;93;94;94;93;93 04:46:41 INFO - PROCESS | 2224 | |7;imaging-desaturate;87;86;85;86;84;84;85;84;85;86 04:46:41 INFO - PROCESS | 2224 | |8;json-parse-financial;54;51;51;50;55;55;56;59;57;56 04:46:41 INFO - PROCESS | 2224 | |9;json-stringify-tinderbox;63;70;78;79;74;73;70;71;71;77 04:46:41 INFO - PROCESS | 2224 | |10;stanford-crypto-aes;83;80;81;90;80;83;82;80;87;89 04:46:41 INFO - PROCESS | 2224 | |11;stanford-crypto-ccm;140;142;142;145;140;132;136;137;161;168 04:46:41 INFO - PROCESS | 2224 | |12;stanford-crypto-pbkdf2;159;161;158;160;161;159;159;159;159;160 04:46:41 INFO - PROCESS | 2224 | |13;stanford-crypto-sha256-iterative;66;66;80;83;82;83;64;65;64;65 04:46:41 INFO - PROCESS | 2224 | __end_tp_report 04:46:41 INFO - PROCESS | 2224 | __start_cc_report 04:46:41 INFO - PROCESS | 2224 | _x_x_mozilla_cycle_collect,1893 04:46:41 INFO - PROCESS | 2224 | __end_cc_report 04:46:41 INFO - PROCESS | 2224 | __startTimestamp1479818801957__endTimestamp 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | ------- Summary: start ------- 04:46:41 INFO - PROCESS | 2224 | Number of tests: 14 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:46:41 INFO - PROCESS | 2224 | Values: 114.0 113.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:108.50 stddev:16.14 (14.9%) stddev-sans-first:14.29 04:46:41 INFO - PROCESS | 2224 | Values: 143.0 109.0 108.0 142.0 107.0 108.0 107.0 107.0 138.0 108.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.55 (0.8%) stddev-sans-first:1.27 04:46:41 INFO - PROCESS | 2224 | Values: 181.0 183.0 183.0 186.0 185.0 182.0 185.0 184.0 185.0 184.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#3] audio-fft Cycles:10 Average:72.80 Median:64.00 stddev:16.58 (25.9%) stddev-sans-first:17.25 04:46:41 INFO - PROCESS | 2224 | Values: 82.0 58.0 60.0 88.0 62.0 58.0 62.0 66.0 106.0 86.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.50 stddev:11.38 (14.7%) stddev-sans-first:11.65 04:46:41 INFO - PROCESS | 2224 | Values: 85.0 70.0 93.0 68.0 67.0 68.0 90.0 67.0 67.0 90.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:87.50 stddev:5.15 (5.9%) stddev-sans-first:5.41 04:46:41 INFO - PROCESS | 2224 | Values: 87.0 84.0 88.0 84.0 88.0 85.0 88.0 86.0 88.0 71.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:93.00 stddev:17.90 (19.2%) stddev-sans-first:18.75 04:46:41 INFO - PROCESS | 2224 | Values: 92.0 104.0 150.0 94.0 93.0 93.0 94.0 94.0 93.0 93.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.03 (1.2%) stddev-sans-first:0.87 04:46:41 INFO - PROCESS | 2224 | Values: 87.0 86.0 85.0 86.0 84.0 84.0 85.0 84.0 85.0 86.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.50 stddev:2.91 (5.2%) stddev-sans-first:3.09 04:46:41 INFO - PROCESS | 2224 | Values: 54.0 51.0 51.0 50.0 55.0 55.0 56.0 59.0 57.0 56.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.50 stddev:4.74 (6.5%) stddev-sans-first:3.54 04:46:41 INFO - PROCESS | 2224 | Values: 63.0 70.0 78.0 79.0 74.0 73.0 70.0 71.0 71.0 77.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:3.81 (4.6%) stddev-sans-first:4.03 04:46:41 INFO - PROCESS | 2224 | Values: 83.0 80.0 81.0 90.0 80.0 83.0 82.0 80.0 87.0 89.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:142.00 stddev:11.36 (8.0%) stddev-sans-first:11.95 04:46:41 INFO - PROCESS | 2224 | Values: 140.0 142.0 142.0 145.0 140.0 132.0 136.0 137.0 161.0 168.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:46:41 INFO - PROCESS | 2224 | Values: 159.0 161.0 158.0 160.0 161.0 159.0 159.0 159.0 159.0 160.0 04:46:41 INFO - PROCESS | 2224 | 04:46:41 INFO - PROCESS | 2224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:73.00 stddev:8.84 (12.1%) stddev-sans-first:9.13 04:46:41 INFO - PROCESS | 2224 | Values: 66.0 66.0 80.0 83.0 82.0 83.0 64.0 65.0 64.0 65.0 04:46:41 INFO - PROCESS | 2224 | -------- Summary: end -------- 04:46:41 INFO - PROCESS | 2224 | 04:46:42 INFO - TEST-INFO | 2224: exit 0 04:46:42 INFO - TEST-OK | kraken | took 57893ms 04:46:42 INFO - SUITE-END | took 1172s 04:46:43 INFO - Completed test suite (00:19:33) 04:46:43 INFO - javascript benchmark 04:46:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3435.690787829095, 3436.8453419596117, 3452.257764580613, 3475.496053072306, 3515.6835884770367, 5840.861032098743, 5971.641701497908, 5982.0, 5984.88030239395, 5989.490893274077, 5851.034579294422, 5964.642121472714, 5967.88064238716, 5990.760369585222, 5996.730147143378, 5283.233931079991, 5332.280142180794, 5338.439463856297, 5380.300560927074, 5406.864828379303, 5235.397929238129, 5258.0, 5264.947350526484, 5414.702191379492, 5420.105682562373, 5323.520883120518, 5325.920111198335, 5326.121190003645, 5328.387235467932, 5338.039152952467, 5318.680879147244, 5333.946660533384, 5342.439043900412, 5400.675959442407, 5403.081476149064, 5177.171652535576, 5253.737313134367, 5305.283786688786, 5313.787448502056, 5327.840164795062, 5815.185873977646, 5832.416758324176, 5862.355140934494, 5880.206172166788, 5925.377835327272, 6148.78479253224, 6202.875942481125, 6205.255369355661, 6225.0, 6233.438990490878, 6280.277768056686, 6291.968540157316, 6295.181626388586, 6305.621662700252, 6316.526260530479, 4884.3650325457465, 5865.736041878125, 5871.383504731984, 5878.353381128072, 5903.793367232126, 6255.781047663401, 6279.340669229757, 6299.937000630027, 6303.212098487689, 6312.589681670676, 6232.875342493125, 6240.5319601030105, 6248.50011999039, 6255.311915689271, 6256.718447669775, 6194.287656919512, 6211.223597050369, 6241.656708880964, 6289.905651415233, 6297.842553936188, 6273.96863015682, 6304.117423560705, 6314.273858506239, 6316.147320111818, 6345.904811427832, 6232.3144454110015, 6288.717007734663, 6292.119103325538, 6305.306416294204, 6307.306196318401, 4934.8766280843265, 4992.176290911959, 5000.424951130593, 5076.949230507647, 5088.72012039334, 4542.0, 4560.566746159109, 4610.216263235258, 4614.976925115353, 4639.0, 5938.376470470625, 5943.643381397043, 5947.167396564484, 5950.613210141327, 5951.107333899863, 6215.378462153839, 6249.250089989139, 6269.467095296951, 6287.654179020106, 6292.685365731695, 5753.05074662676, 5829.854253643693, 5878.647281163058, 5899.941000589939, 5959.433853783884, 4634.304854271819, 5474.5894057945015, 5505.119180931032, 5510.586705996986, 5518.91721624176, 6413.454856337264, 6414.64719440426, 6417.711202995876, 6428.003659432796, 6434.710438030206, 6128.319797384666, 6206.534509911684, 6251.343608920998, 6263.74945002213, 6284.465820405317, 6331.2085989251345, 6388.041793730978, 6429.22849258092, 6458.451031662361, 6461.160049193575, 6326.493880489457, 6332.145160403286, 6336.3030066693545, 6340.365963403808, 6344.809655710336, 6214.067889816563, 6223.533235007302, 6231.3145553988115, 6242.812715618538, 6278.905816412849, 6101.176341194059, 6132.936844521141, 6251.812445626639, 6262.780802671885, 6270.435660790551, 6253.499720022478, 6260.655663938345, 6268.780592679234, 6271.874562508816, 6290.9056364155485, 5039.596832253337, 5942.732577033958, 6095.878082438415, 6099.2985806632805, 6118.969405152946, 6112.235970503687, 6128.594790794166, 6147.07793830911, 6209.689515524115, 6282.0, 5761.251037365283, 6116.449519543263, 6139.017757158833, 6148.077788331607, 6164.291106522807], "value": 5798.582912211088, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.4268476018759, 529.1163756526602, 532.4994505165145, 538.754866535726, 552.1827695011385, 31910.0, 33795.83102084486, 33817.1545711357, 33825.492617610755, 33837.83081084591, 43058.35412468808, 43965.68102956908, 44172.55827441725, 45937.0, 45939.77030114853, 10027.999999999982, 10208.693739187836, 10212.795744085113, 10216.693499194998, 10218.978102189796, 9395.57719902606, 10006.099451049404, 10103.696889093302, 10110.191184705205, 10139.797204055914, 9390.24878009761, 12215.0, 12495.812562811565, 12502.937485312561, 12679.619611411672, 12380.62858114258, 12436.689082772913, 12441.191322564004, 12471.0, 12522.998160147212, 12338.383080846012, 12436.81344779829, 12441.191322564004, 12444.75110497785, 12450.875491245062, 42034.57965420337, 42332.57667423317, 42368.15263694709, 42426.515071972644, 42488.57511424908, 3459.705924996353, 3591.8204089795668, 3700.4264339027495, 3997.4403583498042, 4064.2887494688607, 29695.851520742475, 30253.394932101233, 30993.690063099304, 32335.838320808245, 32675.6732432675, 3396.235846934445, 3445.87939422119, 3524.7004004659634, 3568.0901370150445, 3570.625084366156, 527039.0, 533847.0, 537158.0, 537288.0, 537591.999999996, 34615.480767788504, 35443.82278088593, 61526.69236653788, 62119.068213976825, 62145.689271553354, 36139.91580252597, 36390.0, 36434.0, 36460.81769591135, 36471.4529282061, 15737.291821868044, 15947.760783588255, 15950.441734539236, 15956.281967311266, 15962.680746385007, 13321.733565328639, 13392.531261405804, 13438.260895650637, 13441.596752097452, 13446.93276533611, 7594.278543538355, 7727.806804829812, 8000.5599692017495, 8036.758897233092, 8125.228103330174, 3322.667733226658, 3386.72906167506, 3389.457686770105, 3394.8472318745717, 3400.268942177444, 910.7905181808221, 1032.4166845732288, 1034.622362837559, 1084.2976526852924, 1138.6925530106826, 28827.56758648622, 30255.848720756254, 30455.543166852516, 30649.38701225963, 30682.563338301043, 1066.7439814444479, 1093.775775965925, 1116.1349953785882, 1139.943002849854, 1205.8191271309374, 15876.60308492297, 15906.363745450284, 15919.522414327588, 16002.719782417378, 16210.59473513148, 731497.0, 740187.0, 740477.0, 742636.0, 743340.2832985909, 52742.208866867026, 53332.73333633307, 61019.6949015261, 61469.38530614637, 61811.763764724456, 1407.240090351199, 1411.5200831717266, 1451.4557041109583, 1464.633841539615, 1467.93394297259, 30008.399832003674, 31393.90121345742, 31585.8420707895, 31600.209994750316, 32170.03489895307, 43822.0, 51669.483305167974, 52260.0, 52551.21173182482, 52607.0, 521890.171647418, 526224.0, 629818.0, 644893.0, 883516.0, 26836.194914152606, 27080.729192707822, 27119.86440067787, 27219.86390068037, 27224.455510890068, 33270.0, 33404.832975834965, 33682.98951031473, 33805.83097084597, 33839.661603383654, 32704.018879433654, 37226.25547488981, 37849.0, 38577.80711096426, 38709.64516241918, 34344.82827585846, 37471.43792843164, 39005.80497097496, 39773.0, 40117.59882401139, 31105.0, 37556.624433755314, 38107.809460952514, 38124.42813357857, 38516.8444946652, 32253.193670158435, 34459.4831077529, 34529.13677158091, 34667.47998780071, 34767.0, 24644.0, 24940.625890612017, 25714.842832072976, 26385.4722905537, 26817.0], "value": 19366.015968377378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.849319165055, 363.8126364922067, 384.50398985308954, 393.1978763322821, 413.6793984661887, 19159.99999999998, 20856.270030548934, 21508.677369839425, 21683.45791355215, 21689.457763555918, 11775.0, 12059.638210853689, 12243.755124897496, 12244.693882652939, 12245.0, 5332.306800115989, 5638.774449022034, 5648.068068768648, 5648.971755141239, 5654.095344744842, 5545.584081193906, 5558.916616250759, 5841.15303281024, 6086.513078953673, 6164.876702465948, 6171.567990240685, 6185.165002724642, 6195.473384762301, 6200.3179650238435, 6204.4105809948205, 6107.175531303284, 6849.7602583909575, 6902.585844849325, 6914.688839002257, 6945.409640180591, 5010.69935803853, 5342.5993050521365, 6099.9085013724825, 6114.755409783604, 6118.082287656843, 13152.342382880817, 13382.0, 13391.598252052454, 13412.664683382896, 20651.17395304186, 2192.9451763706033, 2213.3249358945513, 2252.3693365857584, 2307.8153747700144, 2364.2552595932398, 9665.565049572786, 9928.950355248178, 10511.421871797049, 10685.679429617125, 16335.754963675554, 1863.1429542410508, 1892.6120145370303, 1892.8769629974008, 1906.3423119023914, 1951.1317463728647, 109155.45422272917, 116942.41528792387, 122938.15592766115, 123248.38375808063, 124128.0, 11385.658430247106, 11394.601188958346, 11631.302121872715, 11676.241044332091, 11897.643070707893, 15002.24988750558, 15020.248987550578, 15036.548903532912, 15038.398464061534, 15046.398144074334, 7768.184340644264, 8726.16750482393, 8763.518006509703, 8985.730428087169, 9099.81800363989, 8928.955355223183, 8953.552322383855, 8958.193762561401, 9098.363114582047, 9104.681336153202, 4449.421575195204, 4514.187446259705, 4530.255851497197, 4550.954490455119, 4617.492075871652, 1616.272677295222, 1645.2514106081703, 1770.2918832466858, 1821.3807305516189, 1883.171404582007, 720.92069872314, 873.323174539724, 958.6021800952666, 959.2230293462318, 1041.7864337810731, 20342.79657203409, 22089.0, 22189.778102219094, 22205.555888882456, 22333.441663958532, 963.3352986439335, 984.5471083301618, 1002.4436437777103, 1002.9448380339152, 1007.0584003956325, 10060.49697515136, 10974.176936729777, 11534.653960381202, 11571.247868888495, 11585.478653460614, 627853.0, 628510.0, 635126.0, 638156.0, 648551.0, 107381.0, 111761.32358014636, 124500.0, 130882.0, 142211.28894355462, 852.1989330029752, 989.8020395920701, 1004.6232662751469, 1006.4062203300089, 1007.3049595778889, 15171.620709482351, 18631.906840465712, 18979.525511862314, 19304.613907721487, 19363.612727745647, 50289.49710502994, 51227.0, 51963.01062873059, 52108.0, 53116.0, 72461.0, 73569.63215184104, 74452.0, 75896.86154707795, 77820.0, 7989.880151797844, 8121.106678265268, 8311.501309921425, 8447.197516235949, 8552.615132318937, 12191.756164876475, 12754.298513581842, 12906.483740650268, 13034.739305214032, 13189.93405033007, 10907.181961352771, 10980.07848626503, 11286.717832054264, 11354.0, 11477.426128693698, 5075.670081444694, 11020.842811504677, 11396.48715807774, 11477.540898363972, 11806.527738890692, 6007.549433792396, 11359.659210223706, 11520.251183673034, 11747.47136378848, 12071.57749478799, 7348.669309880961, 7991.760247192594, 8082.19178082187, 8181.67273309061, 8221.876671849808, 9743.756406089904, 11695.532178712756, 11800.704982375166, 11921.927026567651, 11933.940330298294], "value": 9376.653875521357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.8103027636685, 1608.1075003373128, 1825.9269629214832, 1948.318088668966, 1965.8427325813936, 8638.049814520398, 9210.49342286174, 9223.169914707674, 9225.7693557661, 9273.536323183831, 8071.434999550034, 8324.209200125993, 8686.86969695455, 8930.062343453941, 8998.145176208267, 2409.3856066702965, 2449.4243852694603, 2450.9509809803794, 2451.1053465485147, 2452.0682140786475, 2412.541617092747, 2436.683231179944, 2455.017992802875, 2455.1038870812204, 2459.7417271186537, 2424.854508729473, 2431.161249368965, 2433.8904749286235, 2454.288256405649, 2456.778889899909, 2044.9591008179752, 2422.2612103308484, 2430.3559556717305, 2432.8905199266073, 2436.415260337524, 2405.3625789165885, 2419.709634843812, 2430.21018169094, 2430.5503481855912, 2437.914672986437, 9029.864552031724, 9055.728328150166, 9165.816683666357, 9169.40398874071, 9185.862212066824, 5371.006363822667, 5532.640378375393, 5536.75084621193, 5543.362513310981, 5549.361823390281, 3432.4508078707536, 3541.8406171722336, 3615.5119058927235, 3619.1856832212807, 3620.348337299285, 1076.34343050739, 1104.0780947908506, 1116.1182665694091, 1128.1313388690744, 1132.6205721083447, 12033.879661203364, 12107.515699372014, 12112.273263604213, 12117.636470905887, 12151.513939442411, 4744.840235447711, 4756.809727610926, 4805.927911081267, 4862.902741945141, 4916.8770780730765, 10184.949075254724, 10185.541650625739, 10185.898141018642, 10190.847137292947, 10239.0, 5485.6982865942755, 5494.2857428534035, 5495.670259784426, 5496.31296087989, 5508.7521061552325, 4536.047430039728, 4708.929366059512, 4712.575868171881, 5011.774470148852, 5042.294078828967, 3323.651016643266, 3427.246005878703, 3999.1601763629383, 4091.8977025574004, 4125.566815484391, 1296.7471343088007, 1302.1275745250705, 1304.1914013311807, 1314.2968511846116, 1315.1714419915393, 929.762910457829, 931.3945935142211, 948.3645957208687, 967.9274054445945, 1005.7284533176002, 5720.742566584514, 5855.824325270249, 5873.4126587340925, 6019.127226552213, 6137.5449820071435, 404.1976676297547, 446.39290564831805, 450.86474057782533, 452.710265430125, 455.1670443089205, 3954.9011274718364, 3959.346707793182, 4020.537638171589, 4054.189162167578, 4068.389741538793, 10240.539175737109, 10956.34261944286, 11081.279716818543, 11114.777704445865, 11115.666530004113, 10775.892241077645, 11036.006759391694, 11049.613263535737, 11080.501377438035, 11098.944505277583, 8222.095569487352, 8409.453385529921, 8415.200555947175, 8438.156184381636, 8439.409241353047, 5730.398308177581, 5779.739911703899, 5923.940760592512, 5958.40415958418, 6007.789727359522, 10191.0, 10297.02178293061, 10355.84466232992, 10365.533550990072, 10377.9481102594, 9952.751181220527, 10350.016748408889, 10360.844587331045, 10490.947545262225, 10552.630657926935, 7119.430445564239, 7375.409967202718, 7530.736424225126, 7691.961540192263, 7892.210778922062, 7905.56519391439, 8207.015158181057, 8214.712485062993, 8220.753377398687, 8227.053888802624, 6559.573627714183, 7725.381969442544, 7772.417068719756, 7777.377809775091, 7881.684732610861, 7539.623018849145, 7559.8110047247055, 7578.09062912454, 7732.420068494998, 7761.417893658111, 7154.499185057204, 7332.743353982585, 7334.669939852826, 7345.081864766904, 7361.484696071224, 5000.549950504472, 5062.594992400673, 5114.0027694600685, 5117.43708192106, 5271.288376069335, 5098.745062746773, 5146.228065790161, 5154.098032844312, 5222.503862133091, 5227.137522308776], "value": 4610.023885181185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.55855567982104, 309.2762934732725, 316.1448282396118, 321.68956956536937, 323.50342224685113, 5248.816291429801, 5564.415736347686, 5599.860003499909, 5605.178317046961, 5649.293838270211, 4567.725936443816, 5067.670601410906, 5088.847334579959, 5201.375834899817, 5207.755679121513, 4159.272127377697, 4166.708330416872, 4190.371444283352, 4204.978975105136, 4247.893802654928, 3952.881413557598, 4172.123853990651, 4182.958170418303, 4190.518090419595, 4203.642690371322, 3573.8927832165077, 4024.2353952748886, 4106.632561299735, 4190.413342132104, 4223.853229344143, 3550.6626870447394, 4169.791510424467, 4176.665866730655, 4182.184474027566, 4194.224068547329, 3350.664933506654, 3605.6574625410544, 3606.5131207286945, 3621.8370173342264, 3651.0, 5119.820806271762, 5366.70483123428, 5404.702741349224, 5411.269478620376, 5415.588179446962, 4750.192467280571, 4786.16242157621, 4799.568038876483, 4848.721101082486, 4866.416030076378, 4705.6942098371555, 4778.474367819537, 5636.323641163046, 5641.351244606882, 5661.490465858093, 3376.3416133853907, 3699.130704284491, 3765.9435108473394, 3980.0, 4023.396490526415, 5583.799483111151, 5753.971230143822, 5876.265466816648, 5886.735096920606, 5978.581499295051, 4034.798260086984, 4044.939325910114, 4045.0291929937193, 4046.6560342371226, 4128.1330920506425, 3207.7273431758563, 4012.7792971386853, 4163.75017498951, 4184.184084103632, 4187.539370669224, 4637.261027114832, 4698.2247929092, 4707.317438971399, 4729.834455794031, 4811.542903424169, 4847.709137451764, 4877.097736918681, 5621.8756248750415, 5648.548116150698, 5672.865426914634, 1265.5064524835323, 1339.6717804138048, 1397.9440822366992, 1412.5126831243206, 1425.7148570285983, 921.7787730944525, 941.924646028316, 960.5869476125193, 963.6627180486773, 977.1840513171439, 4709.127432266315, 4803.423589169252, 5329.360476742816, 5329.8934021319355, 5394.78420863169, 4984.4267909190185, 5141.485851414904, 5765.711714414262, 5801.477866991991, 5895.469407753323, 4000.599940006034, 5273.945210957824, 5283.339582552181, 5399.676019438768, 5437.537809286255, 2599.9870000650253, 3061.5866857974333, 3064.647565529993, 3080.5047911192005, 3093.679740194854, 5458.945410545924, 5675.829725108253, 6033.849153771103, 6121.755129794848, 6124.112003759519, 5384.40771515133, 6054.576179667381, 6106.664133472702, 6111.480524155497, 6142.6314421134875, 5379.381371142369, 5844.970775146097, 6151.507879369639, 6168.470926919941, 6214.627122372672, 5649.54803615718, 5758.596898217084, 5871.356020314319, 5902.291724993029, 5982.68380956189, 5256.789728410974, 5594.818020971743, 5951.732172052181, 5959.76160953557, 5968.432998865101, 4603.792829322755, 4937.530934561211, 4957.132501812096, 5117.309163262912, 6142.04798256271, 3962.7622342659533, 3973.582773808824, 3987.302222111177, 3991.261616600938, 3995.5005624296964, 5050.74746262678, 5970.701464926823, 6047.606905551125, 6124.0, 6174.907376389448, 4921.458639549718, 5067.771950262173, 5582.4726196545, 5882.088276317178, 5919.644821310735, 5105.31078304439, 5109.642325037212, 5131.743412829418, 5540.396013873473, 5886.676232807065, 5185.288854678022, 5484.890302194013, 5648.5763567731765, 5741.97129014369, 5744.942550574441, 4836.274558816206, 5591.6365436246515, 5704.2014118024335, 5727.455891690282, 5809.680467574155, 4955.1576232039915, 5534.252875861707, 5605.683623609716, 5649.54803615718, 5650.35020972577], "value": 4188.570135821259, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.3246954341341, 729.8394353242285, 742.9784046935464, 750.6772088002159, 787.7518581646783, 15396.307166177521, 15946.84053159468, 16570.337186512526, 16651.333946642135, 16802.243899024543, 14907.254637268148, 15246.466373676923, 15249.39002439904, 15251.0, 15251.92374038131, 739.8927155562441, 752.2515097478017, 899.7075950316157, 920.7145784806731, 922.898481167071, 893.053363434758, 915.0757734687979, 927.5084205371164, 928.3779867488765, 928.5728564860138, 959.2613687460686, 961.4471678784691, 962.7496850818768, 963.2919803944095, 964.4502633498909, 956.4882787708577, 957.2007373842849, 957.2581249531634, 958.5925981457922, 962.672691284963, 711.9430445564394, 712.672170801432, 713.0302788208033, 713.9286071392871, 715.9904534606233, 15096.396144154221, 15186.316615752206, 15200.46798362063, 15212.0, 15266.084034957938, 13775.655608609864, 14511.492097776527, 14812.111273323635, 14890.255487225704, 14983.925080374638, 11219.38293393863, 13379.26414047227, 13607.272835601594, 13657.521986730417, 13670.974676899272, 4657.930131048037, 4708.835190768341, 4747.905041899143, 4776.044791041805, 4949.0, 108551.0, 108874.45562772136, 112361.0, 113210.43394782973, 117458.0, 10928.836067458995, 11368.886311136783, 11467.885321146681, 11545.095059315287, 11622.88377116218, 18386.908065459855, 18409.790825101074, 21390.930453477264, 21585.24451644185, 21773.45566360822, 7824.0, 7952.84094318122, 7957.084935232407, 8025.59872006409, 8193.344532437392, 4404.955950440519, 4459.0858873930765, 4549.135664223787, 4689.132510485571, 4701.9529804701515, 3489.337025965109, 3562.091666624994, 3595.334863050344, 3596.3886139356373, 3599.532060832075, 648.3807963395041, 659.0904551718694, 660.1022609251414, 669.4176066821799, 673.531895332739, 562.398233889734, 583.9416058394127, 623.8253289079065, 657.710607332772, 681.2608319972786, 8525.95737021311, 8593.871091933626, 9558.808823823485, 9563.187129094105, 9746.805063898682, 544.4773017902778, 571.7541457173455, 655.8031592343896, 701.6737217194029, 746.6938555192345, 4472.39622650938, 4765.332853400527, 4970.950290497121, 5266.262723218752, 5304.177852432879, 97453.0, 117859.0, 134092.32953835168, 163116.55325170132, 164145.0, 135402.0, 139187.0, 140831.0, 141452.2927385377, 142188.0, 97802.0, 98293.0, 111574.44212778885, 115957.0, 117159.0, 9786.622795027693, 9796.434492131677, 9878.802423951336, 10199.694009179737, 10660.786784264426, 44327.89180270519, 54369.45630543802, 62559.6872015637, 63369.683151583944, 67234.66382668055, 91142.54428727814, 91524.54237728768, 93236.53381733048, 94020.76906539085, 96564.0, 13744.725105498033, 13937.860621393656, 14287.414223950242, 14749.188794616399, 14937.103773773608, 15270.389184432499, 15948.601284967968, 16310.510684679479, 16682.416115436386, 16938.91530542389, 14460.421583136556, 14515.709685806014, 14718.705625887636, 15464.072155670247, 15533.689326213187, 14328.71342573122, 14648.19434931089, 14909.17999509994, 15193.316300766714, 15539.766903496231, 14167.64580885486, 14601.488947886774, 15005.0, 15149.697006060038, 15156.924215378853, 11113.499892504695, 11155.72110697239, 11173.888261117285, 11394.430278485877, 11656.825147622962, 9609.519524023632, 10867.945660271647, 11511.136664750346, 11543.5959741412, 11559.30644161353], "value": 8125.718725257686, "unit": "score"}], "name": "dromaeo_css", "value": 7407.653602882436, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 108.0, 142.0, 107.0, 108.0, 107.0, 107.0, 138.0, 108.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 186.0, 185.0, 182.0, 185.0, 184.0, 185.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 88.0, 62.0, 58.0, 62.0, 66.0, 106.0, 86.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 93.0, 68.0, 67.0, 68.0, 90.0, 67.0, 67.0, 90.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 84.0, 88.0, 85.0, 88.0, 86.0, 88.0, 71.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 104.0, 150.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 86.0, 84.0, 84.0, 85.0, 84.0, 85.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 50.0, 55.0, 55.0, 56.0, 59.0, 57.0, 56.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 78.0, 79.0, 74.0, 73.0, 70.0, 71.0, 71.0, 77.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 81.0, 90.0, 80.0, 83.0, 82.0, 80.0, 87.0, 89.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 142.0, 145.0, 140.0, 132.0, 136.0, 137.0, 161.0, 168.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 158.0, 160.0, 161.0, 159.0, 159.0, 159.0, 159.0, 160.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 80.0, 83.0, 82.0, 83.0, 64.0, 65.0, 64.0, 65.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1421.0, "alertThreshold": 2.0}]} 04:46:43 INFO - Return code: 0 04:46:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:43 INFO - # TBPL SUCCESS # 04:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:43 INFO - 2016-11-22 04:46:43.275 screenresolution[2228:77149] starting screenresolution argv=screenresolution get 04:46:43 INFO - 2016-11-22 04:46:43.277 screenresolution[2228:77149] Display 0: 1600x1200x32@60 04:46:43 INFO - 2016-11-22 04:46:43.283 screenresolution[2229:77152] starting screenresolution argv=screenresolution list 04:46:43 INFO - Available Modes on Display 0 04:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:43 INFO - Intel Iris: 04:46:43 INFO - Chipset Model: Intel Iris 04:46:43 INFO - Type: GPU 04:46:43 INFO - Bus: Built-In 04:46:43 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:43 INFO - Vendor: Intel (0x8086) 04:46:43 INFO - Device ID: 0x0a2e 04:46:43 INFO - Revision ID: 0x0009 04:46:43 INFO - Displays: 04:46:43 INFO - Display: 04:46:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:43 INFO - Display Serial Number: 1600x1200 60 04:46:43 INFO - Main Display: Yes 04:46:43 INFO - Mirror: Off 04:46:43 INFO - Online: Yes 04:46:43 INFO - Rotation: Supported 04:46:43 INFO - Return code: 0 04:46:43 INFO - Running post-action listener: _resource_record_post_action 04:46:43 INFO - [mozharness: 2016-11-22 12:46:43.520810Z] Finished run-tests step (success) 04:46:43 INFO - Running post-run listener: _resource_record_post_run 04:46:43 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 937984; Write bytes: 492173312; Read time: 5; Write time: 1506 04:46:43 INFO - TinderboxPrint: CPU usage
53.3% 04:46:43 INFO - TinderboxPrint: I/O read bytes / time
937,984 / 5 04:46:43 INFO - TinderboxPrint: I/O write bytes / time
492,173,312 / 1,506 04:46:43 INFO - TinderboxPrint: CPU idle
2,234.7 (46.7%) 04:46:43 INFO - TinderboxPrint: CPU system
957.4 (20.0%) 04:46:43 INFO - TinderboxPrint: CPU user
1,589.5 (33.2%) 04:46:43 INFO - TinderboxPrint: Swap in / out
195,424,256 / 0 04:46:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194228736; Write bytes: 188605952; Read time: 17887; Write time: 395 04:46:43 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 24576; Write bytes: 293208576; Read time: 1; Write time: 1073 04:46:44 INFO - Running post-run listener: _upload_blobber_files 04:46:44 INFO - Blob upload gear active. 04:46:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:44 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 04:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:46:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:46:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:46:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:45 INFO - (blobuploader) - INFO - Done attempting. 04:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:46 INFO - (blobuploader) - INFO - Done attempting. 04:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:49 INFO - (blobuploader) - INFO - Done attempting. 04:46:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:49 INFO - Return code: 0 04:46:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07a755e28f4241093714f277f77c7c3c1f8302147e17b72bed0841c1555a8874022c4441e0486b2d27238253103b6aa463c3642414a8e8b9c3cfaef8a0fb8090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfe29c6d04fb4c4f1ddbd7a41ed8321f704848d8be9a106961da86cb8992412640184fc879d0561d3fa818887163ff5cbacd04378ddbdbd33efe3c4b34407926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3270e20e3c654a253ab362f3b151e1bbfbeea806e8e14b18117bbf7839c3e148a2ef54d8087a3c816cdcb4543167ab865297369c0a66313dbea418fa1724b093"} 04:46:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:49 INFO - Contents: 04:46:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07a755e28f4241093714f277f77c7c3c1f8302147e17b72bed0841c1555a8874022c4441e0486b2d27238253103b6aa463c3642414a8e8b9c3cfaef8a0fb8090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfe29c6d04fb4c4f1ddbd7a41ed8321f704848d8be9a106961da86cb8992412640184fc879d0561d3fa818887163ff5cbacd04378ddbdbd33efe3c4b34407926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3270e20e3c654a253ab362f3b151e1bbfbeea806e8e14b18117bbf7839c3e148a2ef54d8087a3c816cdcb4543167ab865297369c0a66313dbea418fa1724b093"} 04:46:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:49 INFO - Copying logs to upload dir... 04:46:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.583866 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-22 04:46:50.055546) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 04:46:50.062695) ========= 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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/Mozilla-Beta/sha512/07a755e28f4241093714f277f77c7c3c1f8302147e17b72bed0841c1555a8874022c4441e0486b2d27238253103b6aa463c3642414a8e8b9c3cfaef8a0fb8090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfe29c6d04fb4c4f1ddbd7a41ed8321f704848d8be9a106961da86cb8992412640184fc879d0561d3fa818887163ff5cbacd04378ddbdbd33efe3c4b34407926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3270e20e3c654a253ab362f3b151e1bbfbeea806e8e14b18117bbf7839c3e148a2ef54d8087a3c816cdcb4543167ab865297369c0a66313dbea418fa1724b093"} build_url:https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/M0fM7_lJQCWpEZ4CzBZqfw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07a755e28f4241093714f277f77c7c3c1f8302147e17b72bed0841c1555a8874022c4441e0486b2d27238253103b6aa463c3642414a8e8b9c3cfaef8a0fb8090", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfe29c6d04fb4c4f1ddbd7a41ed8321f704848d8be9a106961da86cb8992412640184fc879d0561d3fa818887163ff5cbacd04378ddbdbd33efe3c4b34407926", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3270e20e3c654a253ab362f3b151e1bbfbeea806e8e14b18117bbf7839c3e148a2ef54d8087a3c816cdcb4543167ab865297369c0a66313dbea418fa1724b093"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 04:46:50.268295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:46:50.268715) ========= 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.gP7FyAQZlZ/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.VCJ2COVb2q/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005244 ========= master_lag: 0.38 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:46:50.650414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 04:46:50.650741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 04:46:50.651077) ========= ========= Total master_lag: 0.79 =========