builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0349 starttime: 1485943724.68 results: success (0) buildid: 20170201004003 builduid: 5ce995ad18c248229a7dc0577478b497 revision: 0d5fd88afc55a306466f7d98f895ea9181cc5526 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:44.687548) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:44.688147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:44.688463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:44.990351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:44.990715) ========= 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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners TMPDIR=/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/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 --2017-02-01 02:08:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2017-02-01 02:08:45 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.460875 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:45.476935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:45.477254) ========= 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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners TMPDIR=/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/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.028045 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:45.527903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 02:08:45.528360) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d5fd88afc55a306466f7d98f895ea9181cc5526 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d5fd88afc55a306466f7d98f895ea9181cc5526 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners TMPDIR=/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/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 2017-02-01 02:08:45,636 truncating revision to first 12 chars 2017-02-01 02:08:45,636 Setting DEBUG logging. 2017-02-01 02:08:45,636 attempt 1/10 2017-02-01 02:08:45,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d5fd88afc55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 02:08:46,713 unpacking tar archive at: mozilla-aurora-0d5fd88afc55/testing/mozharness/ program finished with exit code 0 elapsedTime=1.676843 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 02:08:47.232124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:47.232503) ========= script_repo_revision: 0d5fd88afc55a306466f7d98f895ea9181cc5526 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:47.232916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:47.233233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 02:08:47.253020) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-01 02:08:47.253416) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners TMPDIR=/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:08:47 INFO - MultiFileLogger online at 20170201 02:08:47 in /builds/slave/test 02:08:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:08:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:47 INFO - {'append_to_log': False, 02:08:47 INFO - 'base_work_dir': '/builds/slave/test', 02:08:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:08:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:47 INFO - 'branch': 'Mozilla-Aurora', 02:08:47 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:47 INFO - 'config_files': ('talos/mac_config.py',), 02:08:47 INFO - 'default_actions': ('clobber', 02:08:47 INFO - 'read-buildbot-config', 02:08:47 INFO - 'download-and-extract', 02:08:47 INFO - 'populate-webroot', 02:08:47 INFO - 'create-virtualenv', 02:08:47 INFO - 'install', 02:08:47 INFO - 'run-tests'), 02:08:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:47 INFO - 'download_minidump_stackwalk': True, 02:08:47 INFO - 'download_symbols': 'ondemand', 02:08:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:47 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:47 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:47 INFO - 'installer_path': 'installer.exe', 02:08:47 INFO - 'log_level': 'info', 02:08:47 INFO - 'log_name': 'talos', 02:08:47 INFO - 'log_to_console': True, 02:08:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:08:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:08:47 INFO - 'opt_config_files': (), 02:08:47 INFO - 'pip_index': False, 02:08:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:47 INFO - 'cmd': ('bash', 02:08:47 INFO - '-c', 02:08:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:47 INFO - 'enabled': True, 02:08:47 INFO - 'halt_on_failure': False, 02:08:47 INFO - 'name': 'check_screen_resolution'},), 02:08:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:08:47 INFO - 'cmd': ('bash', 02:08:47 INFO - '-c', 02:08:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:08:47 INFO - 'enabled': True, 02:08:47 INFO - 'halt_on_failure': False, 02:08:47 INFO - 'name': 'check_screen_resolution'},), 02:08:47 INFO - 'run_cmd_checks_enabled': True, 02:08:47 INFO - 'sps_profile': False, 02:08:47 INFO - 'sps_profile_interval': 0, 02:08:47 INFO - 'suite': 'dromaeojs', 02:08:47 INFO - 'system_bits': '32', 02:08:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:47 INFO - 'title': 't-yosemite-r7-0349', 02:08:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:47 INFO - 'use_talos_json': True, 02:08:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:47 INFO - 'work_dir': 'build'} 02:08:47 INFO - [mozharness: 2017-02-01 10:08:47.466692Z] Running clobber step. 02:08:47 INFO - Running pre-action listener: _resource_record_pre_action 02:08:47 INFO - Running main action method: clobber 02:08:47 INFO - rmtree: /builds/slave/test/build 02:08:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:49 INFO - Running post-action listener: _resource_record_post_action 02:08:49 INFO - [mozharness: 2017-02-01 10:08:49.962840Z] Finished clobber step (success) 02:08:49 INFO - [mozharness: 2017-02-01 10:08:49.963120Z] Running read-buildbot-config step. 02:08:49 INFO - Running pre-action listener: _resource_record_pre_action 02:08:49 INFO - Running main action method: read_buildbot_config 02:08:49 INFO - Using buildbot properties: 02:08:49 INFO - { 02:08:49 INFO - "project": "", 02:08:49 INFO - "product": "firefox", 02:08:49 INFO - "script_repo_revision": "production", 02:08:49 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:08:49 INFO - "repository": "", 02:08:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:08:49 INFO - "buildid": "20170201004003", 02:08:49 INFO - "stage_platform": "macosx64", 02:08:49 INFO - "basedir": "/builds/slave/test", 02:08:49 INFO - "nightly_build": "True", 02:08:49 INFO - "buildnumber": 4, 02:08:49 INFO - "slavename": "t-yosemite-r7-0349", 02:08:49 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:08:49 INFO - "platform": "yosemite_r7", 02:08:49 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:08:49 INFO - "branch": "mozilla-aurora", 02:08:49 INFO - "repo_path": "releases/mozilla-aurora", 02:08:49 INFO - "revision": "0d5fd88afc55a306466f7d98f895ea9181cc5526", 02:08:49 INFO - "pgo_build": "False", 02:08:49 INFO - "builduid": "5ce995ad18c248229a7dc0577478b497", 02:08:49 INFO - "slavebuilddir": "test" 02:08:49 INFO - } 02:08:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:08:49 INFO - Running post-action listener: _resource_record_post_action 02:08:49 INFO - [mozharness: 2017-02-01 10:08:49.969094Z] Finished read-buildbot-config step (success) 02:08:49 INFO - [mozharness: 2017-02-01 10:08:49.969312Z] Running download-and-extract step. 02:08:49 INFO - Running pre-action listener: _resource_record_pre_action 02:08:49 INFO - Running main action method: download_and_extract 02:08:49 INFO - mkdir: /builds/slave/test/build/tests 02:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:49 INFO - trying https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:08:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:08:51 INFO - Downloaded 1199 bytes. 02:08:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:08:51 INFO - Using the following test package requirements: 02:08:51 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:08:51 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:08:51 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:08:51 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'jsshell-mac.zip'], 02:08:51 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:08:51 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:08:51 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:08:51 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:08:51 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:08:51 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:08:51 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:08:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:08:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:08:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:08:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:08:52 INFO - Expected file size: 16353563 02:08:52 INFO - Obtained file size: 16353563 02:08:59 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:08:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:08:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:08:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:09:05 INFO - Expected file size: 16353563 02:09:05 INFO - Obtained file size: 16353563 02:09:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:09:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:09:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:09:12 INFO - Expected file size: 14403485 02:09:12 INFO - Obtained file size: 14403485 02:09: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')]} 02:09:12 INFO - trying https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:09:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:09:15 INFO - Downloaded 73967559 bytes. 02:09:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:09:15 INFO - mkdir: /builds/slave/test/properties 02:09:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:09:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:09:15 INFO - Contents: 02:09:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:09:16 INFO - Running post-action listener: _resource_record_post_action 02:09:16 INFO - Running post-action listener: set_extra_try_arguments 02:09:16 INFO - [mozharness: 2017-02-01 10:09:16.396635Z] Finished download-and-extract step (success) 02:09:16 INFO - [mozharness: 2017-02-01 10:09:16.396759Z] Running populate-webroot step. 02:09:16 INFO - Running pre-action listener: _resource_record_pre_action 02:09:16 INFO - Running main action method: populate_webroot 02:09:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:16 INFO - '--tppagecycles', 02:09:16 INFO - '7'], 02:09:16 INFO - 'tests': ['tsvgm']}}, 02:09:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:09:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:09:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:09:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['damp', 'tps']}, 02:09:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'tests': ['damp', 'tps']}, 02:09:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['dromaeo_dom']}, 02:09:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['basic_compositor_video']}, 02:09:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:09:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['a11yr', 02:09:16 INFO - 'ts_paint', 02:09:16 INFO - 'tpaint', 02:09:16 INFO - 'sessionrestore', 02:09:16 INFO - 'sessionrestore_no_auto_restore', 02:09:16 INFO - 'tabpaint']}, 02:09:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:09:16 INFO - 'ts_paint', 02:09:16 INFO - 'tpaint', 02:09:16 INFO - 'sessionrestore', 02:09:16 INFO - 'sessionrestore_no_auto_restore', 02:09:16 INFO - 'tabpaint']}, 02:09:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:09:16 INFO - 'ts_paint', 02:09:16 INFO - 'tpaint', 02:09:16 INFO - 'sessionrestore', 02:09:16 INFO - 'sessionrestore_no_auto_restore', 02:09:16 INFO - 'tabpaint']}, 02:09:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:09:16 INFO - 'ts_paint', 02:09:16 INFO - 'tpaint', 02:09:16 INFO - 'sessionrestore', 02:09:16 INFO - 'sessionrestore_no_auto_restore', 02:09:16 INFO - 'tabpaint']}, 02:09:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['a11yr', 02:09:16 INFO - 'ts_paint', 02:09:16 INFO - 'tpaint', 02:09:16 INFO - 'sessionrestore', 02:09:16 INFO - 'sessionrestore_no_auto_restore', 02:09:16 INFO - 'tabpaint']}, 02:09:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['a11yr', 02:09:16 INFO - 'ts_paint', 02:09:16 INFO - 'tpaint', 02:09:16 INFO - 'sessionrestore', 02:09:16 INFO - 'sessionrestore_no_auto_restore', 02:09:16 INFO - 'tabpaint']}, 02:09:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['tsvgx', 02:09:16 INFO - 'tsvgr_opacity', 02:09:16 INFO - 'tart', 02:09:16 INFO - 'tscrollx', 02:09:16 INFO - 'cart', 02:09:16 INFO - 'tsvg_static']}, 02:09:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:09:16 INFO - 'tsvgr_opacity', 02:09:16 INFO - 'tart', 02:09:16 INFO - 'tscrollx', 02:09:16 INFO - 'cart', 02:09:16 INFO - 'tsvg_static']}, 02:09:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'talos_options': ['--disable-e10s'], 02:09:16 INFO - 'tests': ['tp5o']}, 02:09:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:09:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'talos_options': ['--disable-e10s', 02:09:16 INFO - '--xperf_path', 02:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:16 INFO - 'tests': ['tp5n']}, 02:09:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:09:16 INFO - 'talos_options': ['--xperf_path', 02:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:16 INFO - 'tests': ['tp5n']}}, 02:09:16 INFO - 'talos.zip': {'path': '', 02:09:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:16 INFO - Running post-action listener: _resource_record_post_action 02:09:16 INFO - [mozharness: 2017-02-01 10:09:16.415472Z] Finished populate-webroot step (success) 02:09:16 INFO - [mozharness: 2017-02-01 10:09:16.415577Z] Running create-virtualenv step. 02:09:16 INFO - Running pre-action listener: _resource_record_pre_action 02:09:16 INFO - Running main action method: create_virtualenv 02:09:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:09:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:09:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:16 INFO - Using real prefix '/tools/python27' 02:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:20 INFO - Installing pip.................done. 02:09:20 INFO - Return code: 0 02:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:09:20 INFO - Reading from file tmpfile_stdout 02:09:20 INFO - Output received: 02:09:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:09:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:20 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:20 INFO - 'HOME': '/Users/cltbld', 02:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:20 INFO - 'LOGNAME': 'cltbld', 02:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:20 INFO - 'MOZ_NO_REMOTE': '1', 02:09:20 INFO - 'NO_EM_RESTART': '1', 02:09:20 INFO - 'PAGER': '/bin/cat', 02:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:20 INFO - 'PWD': '/builds/slave/test', 02:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:20 INFO - 'SHELL': '/bin/bash', 02:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:20 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:20 INFO - 'USER': 'cltbld', 02:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:20 INFO - 'XPC_FLAGS': '0x0', 02:09:20 INFO - 'XPC_SERVICE_NAME': '0', 02:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:09:21 INFO - Cleaning up... 02:09:21 INFO - Return code: 0 02:09:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:21 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:21 INFO - 'HOME': '/Users/cltbld', 02:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:21 INFO - 'LOGNAME': 'cltbld', 02:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:21 INFO - 'MOZ_NO_REMOTE': '1', 02:09:21 INFO - 'NO_EM_RESTART': '1', 02:09:21 INFO - 'PAGER': '/bin/cat', 02:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:21 INFO - 'PWD': '/builds/slave/test', 02:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:21 INFO - 'SHELL': '/bin/bash', 02:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:21 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:21 INFO - 'USER': 'cltbld', 02:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:21 INFO - 'XPC_FLAGS': '0x0', 02:09:21 INFO - 'XPC_SERVICE_NAME': '0', 02:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:21 INFO - Downloading/unpacking psutil>=3.1.1 02:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:09:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:26 INFO - Installing collected packages: psutil 02:09:26 INFO - Running setup.py install for psutil 02:09:26 INFO - building 'psutil._psutil_osx' extension 02:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:09:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:09:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:09:27 INFO - building 'psutil._psutil_posix' extension 02:09:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:09:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:09:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:09:27 INFO - ^ 02:09:27 INFO - 1 warning generated. 02:09:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:09:27 INFO - Successfully installed psutil 02:09:27 INFO - Cleaning up... 02:09:27 INFO - Return code: 0 02:09:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:09: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')]} 02:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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')]} 02:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:09: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 mozsystemmonitor==0.3 02:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:27 INFO - 'HOME': '/Users/cltbld', 02:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:27 INFO - 'LOGNAME': 'cltbld', 02:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:27 INFO - 'MOZ_NO_REMOTE': '1', 02:09:27 INFO - 'NO_EM_RESTART': '1', 02:09:27 INFO - 'PAGER': '/bin/cat', 02:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:27 INFO - 'PWD': '/builds/slave/test', 02:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:27 INFO - 'SHELL': '/bin/bash', 02:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:27 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:27 INFO - 'USER': 'cltbld', 02:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:27 INFO - 'XPC_FLAGS': '0x0', 02:09:27 INFO - 'XPC_SERVICE_NAME': '0', 02:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:09: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 02:09: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 02:09: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 02:09: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 02:09: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 02:09: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 02:09:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:09:30 INFO - Installing collected packages: mozsystemmonitor 02:09:30 INFO - Running setup.py install for mozsystemmonitor 02:09:30 INFO - Successfully installed mozsystemmonitor 02:09:30 INFO - Cleaning up... 02:09:31 INFO - Return code: 0 02:09:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09: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', '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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:09: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 jsonschema==2.5.1 02:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:31 INFO - 'HOME': '/Users/cltbld', 02:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:31 INFO - 'LOGNAME': 'cltbld', 02:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:31 INFO - 'MOZ_NO_REMOTE': '1', 02:09:31 INFO - 'NO_EM_RESTART': '1', 02:09:31 INFO - 'PAGER': '/bin/cat', 02:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:31 INFO - 'PWD': '/builds/slave/test', 02:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:31 INFO - 'SHELL': '/bin/bash', 02:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:31 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:31 INFO - 'USER': 'cltbld', 02:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:31 INFO - 'XPC_FLAGS': '0x0', 02:09:31 INFO - 'XPC_SERVICE_NAME': '0', 02:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:31 INFO - Downloading/unpacking jsonschema==2.5.1 02:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:09:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:09: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 02:09: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 02:09: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 02:09: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 02:09: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 02:09: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 02:09:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:09:34 INFO - warning: no files found matching '*.txt' 02:09:34 INFO - no previously-included directories found matching 'build' 02:09:34 INFO - no previously-included directories found matching 'dist' 02:09:34 INFO - no previously-included directories found matching '.git*' 02:09:34 INFO - Installing collected packages: jsonschema, functools32 02:09:34 INFO - Running setup.py install for functools32 02:09:34 INFO - warning: no files found matching '*.txt' 02:09:34 INFO - no previously-included directories found matching 'build' 02:09:34 INFO - no previously-included directories found matching 'dist' 02:09:34 INFO - no previously-included directories found matching '.git*' 02:09:34 INFO - Successfully installed jsonschema functools32 02:09:34 INFO - Cleaning up... 02:09:34 INFO - Return code: 0 02:09:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:34 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:34 INFO - 'HOME': '/Users/cltbld', 02:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:34 INFO - 'LOGNAME': 'cltbld', 02:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:34 INFO - 'MOZ_NO_REMOTE': '1', 02:09:34 INFO - 'NO_EM_RESTART': '1', 02:09:34 INFO - 'PAGER': '/bin/cat', 02:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:34 INFO - 'PWD': '/builds/slave/test', 02:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:34 INFO - 'SHELL': '/bin/bash', 02:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:34 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:34 INFO - 'USER': 'cltbld', 02:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:34 INFO - 'XPC_FLAGS': '0x0', 02:09:34 INFO - 'XPC_SERVICE_NAME': '0', 02:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:09:35 INFO - Cleaning up... 02:09:35 INFO - Return code: 0 02:09:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:35 INFO - 'HOME': '/Users/cltbld', 02:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:35 INFO - 'LOGNAME': 'cltbld', 02:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:35 INFO - 'MOZ_NO_REMOTE': '1', 02:09:35 INFO - 'NO_EM_RESTART': '1', 02:09:35 INFO - 'PAGER': '/bin/cat', 02:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:35 INFO - 'PWD': '/builds/slave/test', 02:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:35 INFO - 'SHELL': '/bin/bash', 02:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:35 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:35 INFO - 'USER': 'cltbld', 02:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:35 INFO - 'XPC_FLAGS': '0x0', 02:09:35 INFO - 'XPC_SERVICE_NAME': '0', 02:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:39 INFO - Downloading docopt-0.6.1.tar.gz 02:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:39 INFO - Running setup.py install for blobuploader 02:09:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:39 INFO - Running setup.py install for requests 02:09:39 INFO - Running setup.py install for docopt 02:09:40 INFO - Successfully installed blobuploader requests docopt 02:09:40 INFO - Cleaning up... 02:09:40 INFO - Return code: 0 02:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:40 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:40 INFO - 'HOME': '/Users/cltbld', 02:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:40 INFO - 'LOGNAME': 'cltbld', 02:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:40 INFO - 'MOZ_NO_REMOTE': '1', 02:09:40 INFO - 'NO_EM_RESTART': '1', 02:09:40 INFO - 'PAGER': '/bin/cat', 02:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:40 INFO - 'PWD': '/builds/slave/test', 02:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:40 INFO - 'SHELL': '/bin/bash', 02:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:40 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:40 INFO - 'USER': 'cltbld', 02:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:40 INFO - 'XPC_FLAGS': '0x0', 02:09:40 INFO - 'XPC_SERVICE_NAME': '0', 02:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:40 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-GchRY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:40 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-dfcLNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:40 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-K_PLtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:40 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-Xp5Cuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:40 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-dHZZhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-q5rOym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-9JceAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-OXj6Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-zj50v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-06yNDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-62Ldoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-a47IB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-cujFWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-lcx3rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:41 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-tbVeub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:42 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-6fi_cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:42 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-qmaxmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:42 INFO - Running setup.py install for manifestparser 02:09:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:42 INFO - Running setup.py install for mozcrash 02:09:42 INFO - Running setup.py install for mozdebug 02:09:42 INFO - Running setup.py install for mozdevice 02:09:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:42 INFO - Running setup.py install for mozfile 02:09:43 INFO - Running setup.py install for mozhttpd 02:09:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Running setup.py install for mozinfo 02:09:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Running setup.py install for mozInstall 02:09:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Running setup.py install for mozleak 02:09:43 INFO - Running setup.py install for mozlog 02:09:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Running setup.py install for moznetwork 02:09:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:43 INFO - Running setup.py install for mozprocess 02:09:44 INFO - Running setup.py install for mozprofile 02:09:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:44 INFO - Running setup.py install for mozrunner 02:09:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:44 INFO - Running setup.py install for mozscreenshot 02:09:44 INFO - Running setup.py install for moztest 02:09:44 INFO - Running setup.py install for mozversion 02:09:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:44 INFO - Cleaning up... 02:09:44 INFO - Return code: 0 02:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:44 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:44 INFO - 'HOME': '/Users/cltbld', 02:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:44 INFO - 'LOGNAME': 'cltbld', 02:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:44 INFO - 'MOZ_NO_REMOTE': '1', 02:09:44 INFO - 'NO_EM_RESTART': '1', 02:09:44 INFO - 'PAGER': '/bin/cat', 02:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:44 INFO - 'PWD': '/builds/slave/test', 02:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:44 INFO - 'SHELL': '/bin/bash', 02:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:44 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:44 INFO - 'USER': 'cltbld', 02:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:44 INFO - 'XPC_FLAGS': '0x0', 02:09:44 INFO - 'XPC_SERVICE_NAME': '0', 02:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-uufj63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-01A_8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-_0vv7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-ruwMI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-MY9Ktt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-iXKFoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-bjYS7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-hxVn3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:45 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-vGsEUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-2pQCIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-3a8533-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-sO8QUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-K_HK6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-NDYYSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-inwn0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-B_aunv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:46 INFO - Running setup.py (path:/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/pip-tEyT3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:09:46 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:09:46 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:09:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:49 INFO - Downloading blessings-1.6.tar.gz 02:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:49 INFO - Installing collected packages: blessings 02:09:49 INFO - Running setup.py install for blessings 02:09:49 INFO - Successfully installed blessings 02:09:49 INFO - Cleaning up... 02:09:49 INFO - Return code: 0 02:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:50 INFO - Reading from file tmpfile_stdout 02:09:50 INFO - Current package versions: 02:09:50 INFO - blessings == 1.6 02:09:50 INFO - blobuploader == 1.2.4 02:09:50 INFO - docopt == 0.6.1 02:09:50 INFO - functools32 == 3.2.3-2 02:09:50 INFO - jsonschema == 2.5.1 02:09:50 INFO - manifestparser == 1.1 02:09:50 INFO - mozInstall == 1.12 02:09:50 INFO - mozcrash == 1.0 02:09:50 INFO - mozdebug == 0.1 02:09:50 INFO - mozdevice == 0.49 02:09:50 INFO - mozfile == 1.2 02:09:50 INFO - mozhttpd == 0.7 02:09:50 INFO - mozinfo == 0.9 02:09:50 INFO - mozleak == 0.1 02:09:50 INFO - mozlog == 3.4 02:09:50 INFO - moznetwork == 0.27 02:09:50 INFO - mozprocess == 0.24 02:09:50 INFO - mozprofile == 0.28 02:09:50 INFO - mozrunner == 6.13 02:09:50 INFO - mozscreenshot == 0.1 02:09:50 INFO - mozsystemmonitor == 0.3 02:09:50 INFO - moztest == 0.8 02:09:50 INFO - mozversion == 1.4 02:09:50 INFO - psutil == 3.1.1 02:09:50 INFO - requests == 1.2.3 02:09:50 INFO - wsgiref == 0.1.2 02:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:50 INFO - 'HOME': '/Users/cltbld', 02:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:50 INFO - 'LOGNAME': 'cltbld', 02:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:50 INFO - 'MOZ_NO_REMOTE': '1', 02:09:50 INFO - 'NO_EM_RESTART': '1', 02:09:50 INFO - 'PAGER': '/bin/cat', 02:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:50 INFO - 'PWD': '/builds/slave/test', 02:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:50 INFO - 'SHELL': '/bin/bash', 02:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:50 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:50 INFO - 'USER': 'cltbld', 02:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:50 INFO - 'XPC_FLAGS': '0x0', 02:09:50 INFO - 'XPC_SERVICE_NAME': '0', 02:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:09:50 INFO - Cleaning up... 02:09:50 INFO - Return code: 0 02:09:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:50 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 0x10bf2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae9d964a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, '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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:50 INFO - 'HOME': '/Users/cltbld', 02:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:50 INFO - 'LOGNAME': 'cltbld', 02:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:50 INFO - 'MOZ_NO_REMOTE': '1', 02:09:50 INFO - 'NO_EM_RESTART': '1', 02:09:50 INFO - 'PAGER': '/bin/cat', 02:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:50 INFO - 'PWD': '/builds/slave/test', 02:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:50 INFO - 'SHELL': '/bin/bash', 02:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:09:50 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:50 INFO - 'USER': 'cltbld', 02:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:50 INFO - 'XPC_FLAGS': '0x0', 02:09:50 INFO - 'XPC_SERVICE_NAME': '0', 02:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:09:50 INFO - Cleaning up... 02:09:50 INFO - Return code: 0 02:09:50 INFO - Running post-action listener: _resource_record_post_action 02:09:50 INFO - Running post-action listener: _start_resource_monitoring 02:09:50 INFO - Starting resource monitoring. 02:09:50 INFO - [mozharness: 2017-02-01 10:09:50.714888Z] Finished create-virtualenv step (success) 02:09:50 INFO - [mozharness: 2017-02-01 10:09:50.715653Z] Running install step. 02:09:50 INFO - Running pre-action listener: _resource_record_pre_action 02:09:50 INFO - Running main action method: install 02:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:50 INFO - Reading from file tmpfile_stdout 02:09:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:51 INFO - Reading from file tmpfile_stdout 02:09:51 INFO - Output received: 02:09:51 INFO - Usage: mozinstall [options] installer 02:09:51 INFO - Options: 02:09:51 INFO - -h, --help show this help message and exit 02:09:51 INFO - -d DEST, --destination=DEST 02:09:51 INFO - Directory to install application into. [default: 02:09:51 INFO - "/builds/slave/test"] 02:09:51 INFO - --app=APP Application being installed. [default: firefox] 02:09:51 INFO - mkdir: /builds/slave/test/build/application 02:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:10:11 INFO - Reading from file tmpfile_stdout 02:10:11 INFO - Output received: 02:10:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:10:11 INFO - Running post-action listener: _resource_record_post_action 02:10:11 INFO - [mozharness: 2017-02-01 10:10:11.450615Z] Finished install step (success) 02:10:11 INFO - [mozharness: 2017-02-01 10:10:11.450759Z] Running run-tests step. 02:10:11 INFO - Running pre-action listener: _resource_record_pre_action 02:10:11 INFO - Running main action method: run_tests 02:10:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:10:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:10:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:10:11 INFO - 2017-02-01 02:10:11.465 screenresolution[1636:8414] starting screenresolution argv=screenresolution get 02:10:11 INFO - 2017-02-01 02:10:11.467 screenresolution[1636:8414] Display 0: 1600x1200x32@60 02:10:11 INFO - 2017-02-01 02:10:11.473 screenresolution[1637:8416] starting screenresolution argv=screenresolution list 02:10:11 INFO - Available Modes on Display 0 02:10:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:10:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:10:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:10:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:10:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:10:11 INFO - Intel Iris: 02:10:11 INFO - Chipset Model: Intel Iris 02:10:11 INFO - Type: GPU 02:10:11 INFO - Bus: Built-In 02:10:11 INFO - VRAM (Dynamic, Max): 1536 MB 02:10:11 INFO - Vendor: Intel (0x8086) 02:10:11 INFO - Device ID: 0x0a2e 02:10:11 INFO - Revision ID: 0x0009 02:10:11 INFO - Displays: 02:10:11 INFO - Display: 02:10:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:10:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:10:11 INFO - Display Serial Number: 1600x1200 60 02:10:11 INFO - Main Display: Yes 02:10:11 INFO - Mirror: Off 02:10:11 INFO - Online: Yes 02:10:11 INFO - Rotation: Supported 02:10:11 INFO - Return code: 0 02:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:11 INFO - Python 2.7.3 02:10:11 INFO - Return code: 0 02:10:11 INFO - grabbing minidump binary from tooltool 02:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:11 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 0x10bd0bd30>, '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 0x10bc32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd00be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:10:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:10:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:10:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:11 INFO - Return code: 0 02:10:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:10:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:10:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0349', '--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 02:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0349 --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 02:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lJ0IOzhNpG/Render', 02:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:10:11 INFO - 'HOME': '/Users/cltbld', 02:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:10:11 INFO - 'LOGNAME': 'cltbld', 02:10:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:11 INFO - 'MOZ_NO_REMOTE': '1', 02:10:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:11 INFO - 'NO_EM_RESTART': '1', 02:10:11 INFO - 'PAGER': '/bin/cat', 02:10:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:11 INFO - 'PWD': '/builds/slave/test', 02:10:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:10:11 INFO - 'SHELL': '/bin/bash', 02:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MmuXY75AZQ/Listeners', 02:10:11 INFO - 'TMPDIR': '/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/', 02:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:10:11 INFO - 'USER': 'cltbld', 02:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:11 INFO - 'XPC_FLAGS': '0x0', 02:10:11 INFO - 'XPC_SERVICE_NAME': '0', 02:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:10:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0349', '--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 02:10:12 INFO - mozversion application_buildid: 20170201004003 02:10:12 INFO - mozversion application_changeset: 0d5fd88afc55a306466f7d98f895ea9181cc5526 02:10:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:10:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:12 INFO - mozversion application_name: Firefox 02:10:12 INFO - mozversion application_remotingname: firefox-dev 02:10:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:10:12 INFO - mozversion application_vendor: Mozilla 02:10:12 INFO - mozversion application_version: 53.0a2 02:10:12 INFO - mozversion platform_buildid: 20170201004003 02:10:12 INFO - mozversion platform_changeset: 0d5fd88afc55a306466f7d98f895ea9181cc5526 02:10:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:10:12 INFO - mozversion platform_version: 53.0a2 02:10:12 INFO - using testdate: 1485943812 02:10:12 INFO - actual date: 1485943812 02:10:12 INFO - starting webserver on 'localhost:49241' 02:10:12 INFO - SUITE-START | Running 2 tests 02:10:12 INFO - TEST-START | dromaeo_css 02:10:12 INFO - operating with platform_type : mac_ 02:10:12 INFO - Initialising browser for dromaeo_css test... 02:10:12 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/tmp6Ti7v1/profile http://localhost:49241/getInfo.html) 02:10:14 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 02:10:14 INFO - PROCESS | 1647 | colorDepth:24 02:10:14 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 02:10:14 INFO - PROCESS | 1647 | __metrics 02:10:14 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:10:14 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:10:15 INFO - TEST-INFO | 1647: exit 0 02:10:15 INFO - Browser initialized. 02:10:15 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:15 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/tmp6Ti7v1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:27 INFO - PROCESS | 1651 | RSS: Main: 212893696 02:10:27 INFO - PROCESS | 1651 | 02:13:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:13:33 INFO - PROCESS | 1651 | RSS: Main: 384954368 02:13:33 INFO - PROCESS | 1651 | 02:15:16 INFO - PROCESS | 1651 | ************************* 02:15:16 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 02:15:16 INFO - PROCESS | 1651 | 02:15:16 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:15:16 INFO - PROCESS | 1651 | Full stack: 02:15:16 INFO - PROCESS | 1651 | ************************* 02:16:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:16:36 INFO - PROCESS | 1651 | RSS: Main: 355438592 02:16:36 INFO - PROCESS | 1651 | 02:19:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:19:39 INFO - PROCESS | 1651 | RSS: Main: 329531392 02:19:39 INFO - PROCESS | 1651 | 02:22:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:22:42 INFO - PROCESS | 1651 | RSS: Main: 322756608 02:22:42 INFO - PROCESS | 1651 | 02:25:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:25:46 INFO - PROCESS | 1651 | RSS: Main: 319754240 02:25:46 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:28:49 INFO - PROCESS | 1651 | RSS: Main: 405004288 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | __start_tp_report 02:28:49 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 02:28:49 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 02:28:49 INFO - PROCESS | 1651 | |i|pagename|runs| 02:28:49 INFO - PROCESS | 1651 | |0;dojo.html;3271.574695289612;3277.1315601365636;3307.818070006149;3339.782914110584;3348.882789102382;5643.68959707216;5648.293963254593;5665.8583535411635;5684.772609095637;5687.203791469193;4708.22314318138;5699.487046165844;5707.571932105098;5708.08670612702;5734.627249228808;5178.6892786432745;5211.661242019276;5211.739413029343;5233.712145831978;5277.076511610472;5167.328247327842;5177.197534382177;5177.197534382177;5280.709560974145;5334.22653715213;5233.581313494911;5250;5259.3951695555115;5261.97391508656;5267.499587539178;5246.186841039645;5256.92114618281;5260.210968354739;5266.894662106755;5277.47225277473;4790.089882922233;5102.719350435725;5213.035588416155;5216.37403511581;5220.425753167148;5319.893602127936;5737.340205876294;5750.827475175752;5752.050911599581;5755.568332375088;6109.404666050371;6120.234970628671;6130.203073600448;6142.938570614281;6143.877122457526;6174.475169610589;6214.875702485971;6238.4697300729495;6249.0626406039;6308.936910630927;5061.670991385585;5314.73426328682;5350.010248104113;5746.856328591777;5778.3354914184565;6190.659513726789;6276.121343011982;6278.529110316745;6301.0233413820015;6305.4009869062365;5007.499250074963;5976.8804623908145;5999.730012149464;6058.485028772516;6096.512279017668;6233.812985610439;6239.282482514478;6258.249010118815;6262.029385445263;6264.091706702594;6201.81394558164;6204.534659900525;6221.191245138103;6226.750929962841;6227.532935029891;6014.7594096236535;6022.397760223943;6089.421504957022;6111.633302001894;6247.781327653511;4909.68087074339;4915.975420122876;4930.778114984834;4936.432310284364;4940.258961155855;4416.933745993812;4417.160739459492;4426.3581780641625;4428.180786554498;4446.26636604963;5809.3609702932645;5854.297484301911;5859.912101318484;5864.061750120046;5877.5591830612875;6057.666828324396;6116.755329786848;6130.816075517741;6164.938350616526;6330.651814150174;5705.743241554057;5715.342735585377;5717.142428635655;5733.397993210653;5742.48317651405;5368.248445217672;5368.302120724359;5380.892382152413;5403.594730395236;5417.783288668409;6219.471344935731;6290.276618188784;6299.401556852184;6300.338464461257;6313;6244.438000579969;6332.9366706334185;6352.618842869442;6354.6822658867795;6355.968220158869;6199.473044791243;6217.285012223652;6255.093011513396;6266.467350275096;6276.340984196594;6152.876942461216;6173.506119510339;6188.566800324114;6192.969035154975;6205.22434695663;5976.970115149396;6256.937430625636;6267.9657856455;6277.74889004453;6300.71646775887;5929.347771745019;5931.13998470228;5995.940040599538;6100.908486372619;6107.511399088151;5920.319163296276;6006.87986240264;6009.489193418608;6045.848853778515;6060.333363329942;5850.882982340415;5856.209411729533;5857.619254748428;5859.384764599826;5872.412758724265;5682.37493875665;5906.468417842415;5961.076033214858;6002.189704389852;6004.669743164168;5857.736401862012;5858.121281807763;5864.384239654775;5951.494122999594;5972.432618901197 02:28:49 INFO - PROCESS | 1651 | |1;ext.html;457.89875349783784;486.6787919972818;495.91321518734236;496.1317694035438;497.6441844081482;28550.857245713767;30189.09432717019;31870.72517099319;31893.521597176004;39355.819325420285;39141;42214.78892605533;42247;42308.153836923244;42309.57690423095;9126.54367281635;9321.487318197496;9349.579268932881;9365.76585585359;9380.953095234549;8309.584520773968;8547.401681882271;9337.393069450498;9472.952635236814;9489.478078705668;11034.558617655284;11266.267692599955;11309.49107290174;11423.885761142406;11448.828267575993;10028.896821349646;10938.179636527293;11163.553457861675;11260.662180134608;11268.605598804044;8185.140560241208;8408.159184081604;11071.335719856834;11147.888521114766;11162.274452160666;38894.41658375126;39382.80308598468;39457;41184.79407602973;41294.587054129675;4059.2490389278078;4061.939070913939;4064.7357921734992;4079.571644977294;4103.4050062740735;28700.851965921338;30265.546016809767;30434.391312173633;30647;31161.75352985878;3215.9356812863844;3256.267339848539;3267.379197952381;3267.509873518967;3281.950770738441;360996;363839;365413;366035;366582;58879;59253.70373148193;59304.70347648234;59349.516262092926;59406.405935940085;62698.37301627017;62814;62855.6857215711;62859.371406286264;63016;15620;16124.435644752377;16150.838491614933;16156.192190390433;16161.59596010109;12441.315727635067;12527.749445011048;12529.812052819216;12530.498780048696;12534;13345.599632011055;13710.38303276355;14033.85966140346;14054.016218864786;14113.435462581587;6434.935650643527;6703.687227906365;6706.798796036127;6832.096359047385;6871.14110736158;768.9961550192213;879.2218886285683;879.5250564694993;895.0959530873735;927.1794461901266;28673;29560.408791824044;29594.40811183764;30242.84878575593;30280.84859575732;1020.7448137965508;1031.128696251666;1095.5070218401593;1114.1198453221864;1220.0056953582803;14800.333984970703;14886.553403397915;15412.061004617295;15439.459618913284;15617.921910390376;577094;579870;580067;580797;583521;51927.740361297954;52019.73990130025;52070.739646301525;52138.21792673037;52168;1264.677507235649;1405.1147776900486;1408.6617713172527;1441.4450436581992;1445.6747231872744;23030.193943212576;26620.201393958214;26625.600615990388;27653.58519622167;27798;43354.56645433505;43658.12683746371;43700.34449483324;43704.12591748084;43725;481132;481991;482535;482914;486193;22857.88571057134;23754.287371378887;23763.881180593988;23839.927203275547;23878.283651490485;33986;36054.73808416693;38680.6131938677;39858.60141398549;40435.39346909858;28676.42647147087;33152;33247.66752332446;33269.16827079342;34768.30463390667;33782.83108584442;34083.488747669304;34087.65912340845;34217.65782342145;34508.30983380369;32829.507557387136;33199.83400082984;33316.50025249672;33672.1581960453;34406;29770;31255.84372078125;31480.685193147776;31491.37017259688;31700.5244921331;23838;23900.521989559762;24018.75981240165;24447.26658200257;24521 02:28:49 INFO - PROCESS | 1651 | |2;jquery.html;353.9469079638053;391.14144452925825;393.19983832900056;400.29275141521396;423.31845728377306;15153.090814551135;18088.728669069973;18526.444206673823;20177.899110504444;20965.427592930533;13286.667833304147;16251.91874040631;20756.584868302623;20772.792272077273;20976.790232097712;5742.368339482664;5960.88078238435;6001.309849367335;6025.1564780930485;6044.516438684895;5697.0315046442;5948.226730525047;5968.7015649217365;6062.969685151568;6084.2090528231265;5931.110333449996;5945;5954.255718035246;5970.014947533652;5974.820755377324;5637.182608521762;5803.709814509258;5828.970855145697;5933.5549833762425;5946.345901950782;5136.948630513684;5153.3815942087185;5156.92264616031;5159.22611608258;5175.146100893348;25284.620730689054;25781;25824.354391140183;26230.86884565565;26538.336541586614;3091.8917837875792;3108.4094022135723;3112.25305926576;3112.5486804413235;3113.7041981011766;14899.627509312353;15521.844781552152;15751.133687647174;15792.073526696737;16043.278052487665;1614.4268784581423;1800.2798880447795;1833.367488216563;1864.9440516784518;1870.9251629934786;130792;133736;133832.661673383;135313.3234333822;135632.32183839017;11197.608083717194;11540.422978851191;11548.307101573933;11627.069834413227;11810.232334898375;14135.222562759147;14586.562403127924;14600.34298456572;14622.488212912496;14630.63423414402;6647.135872336566;7315.378192853667;7733.535987840747;7767.766966990999;8417.663293468193;6497.772577959749;7907.2488113629115;8466.661333546712;8492.957535212285;8821.338399620054;7270.5274157180675;7284.307990740871;7286.562806231643;7319.670614822346;7334.779956601311;1917.4343568647282;1926.1412736709142;1950.8146726061002;1965.263026365113;1973.7927517610444;1052.7631282961427;1080.508368692243;1094.1848322999258;1107.4628805029554;1132.1508868348737;23183.76816231816;23225.53548929012;23482.412939676644;23645.527089458457;23678.881605592207;1063.4842101580728;1077.5797438998798;1093.283899046126;1098.7693782962972;1127.1546340244815;11672.70818229534;11771.823422648667;11961.282323060645;12000.819987700192;12062.51749929993;619818;621148;715450;764106;778773;162745.42154759902;164456;166396;169326;171959;1016.4714348538719;1016.8881423043459;1050.7478205230843;1050.8003479338902;1054.0829478353728;18901.621967560848;19058.332958346393;19700;19734.80265197387;19779.109940052444;46981;50186.24720629267;56548.43451565432;58769;59972;80602.19397805947;81630.0658814144;82011;83157.58421207855;85120;8019.278264956182;8170.10128885834;8345.582720864053;8530.232279094911;8698.956505217433;9074.31942604294;12124.757504849676;12321.383930803604;12756.767565675784;12966.80549791735;11002.724931876446;11127;11444.084473241954;11448;11529.135314851588;11056.668299951014;11118.833217501906;11140.220184587;11231.922094412559;11375.43122843838;11363.772724545297;11546.82679759821;11661.53353865836;11737.002354799937;11800.232984855957;7040;7681.462297639335;8218.096009439076;8480.844386250816;8490.575471226537;8204.425690201628;10679.412632305297;10924.235303528676;11249.606263780728;11310.547578097114 02:28:49 INFO - PROCESS | 1651 | |3;mootools.html;1433.125793266108;1438.6267291665633;1446.631109067188;1452.6441021949624;1464.736347457458;8100.635471403786;8496.702615408461;8502.532360720157;8516.914830851689;8520.914790852097;7402.962985185067;7672.808179795508;7674.731384401547;8142.470739401935;8333.749987500369;2299.1148407862966;2338.0530884991604;2338.5322935412987;2339.63735620979;2349.7297810751725;2330.7552706965694;2342.10999820069;2357.964630530543;2359.775821296974;2370.146747171017;2315.455867871049;2321.0947730385165;2330.196082351586;2354.905803767856;2357.705286839145;2302.8848557572137;2306.642470417088;2327.848689835164;2328.3247858121126;2329.173143534038;2296.3570200343765;2349.0134143659534;2351.576716191085;2354.0466111224982;2359.5162991586685;8352.373571982125;8483.109273526314;8499.66001359951;8524.488530688179;8533.701320453754;4923.286123512106;4986.700797952099;5158.587313014949;5164.25118357836;5165.767540460688;3370.915727106842;3484.3902317094407;3489.91275218119;3545.1846075402545;3569.3396721606587;1190.244194936213;1232.4751211535092;1252.7557126360273;1270.754660432781;1270.8602053774077;10885.891141088647;10933.016028557468;10943.83584246229;10960.506777194965;11022.393768342738;3910.276598829226;4445.977425192224;4662.4405071390975;4732.337472753818;4734.313524538922;9329.486878221764;9401.858972115424;9527.952360238292;9533.713988580215;9545.47499887499;5037.622178336639;5054.898902021939;5063.87340316495;5064.417591976896;5065.316182315414;4313.676474264443;4492.910141797146;4533.659975501851;4711.0342379812055;4759.619230461555;3446.379651662725;3722.4416337549583;3772.660460558563;3849.711271654637;3960.207958408272;1243.2043492165021;1247.5820600098887;1247.7130260040242;1259.389196239823;1274.7705413025558;920.4753290624279;927.2350310993457;940.1350757303297;949.8575213717997;985.5318723606373;5510.366307874566;5623.578231632644;5754.6547207167705;5887.8233652990475;5912.497437717842;538.9353277606713;554.3790954131399;554.6422557450422;561.0770282884632;563.259314002086;3796.2976849282973;3809.238152369537;3852.8073596320073;3907.4724912137067;3922.7450215735885;8572.957135214285;9490.90509094914;9805.803883922425;9938.45338506389;10096.848547271797;9907.554160062815;10024.699259022242;10028;10030.498475076363;10066.496675166212;6676.899846502306;7581.962090189514;7852.371810255166;7866.7639970800965;7881.881771773428;5693.629914055573;5759.51044161251;5791.9131213031;5941.405859414197;5991.520678345635;9315.301352398732;9334.766630834283;9416.764580885532;9449.338546301693;9451.952740236255;8958.68644597436;9334.766630834283;9347.672831450867;9416.152546270869;9489.85765213536;6604.273529911609;6833.931660683528;6839.487038472035;7128.322809333105;7318.414526837733;7649.31156195945;7837.216278372117;7946.364290856834;8032.277095061472;8045.9597702011115;7120.928790712233;7239.4932354734665;7285.490015698851;7311.597862117635;7401.666924988281;6257.43683068526;7053.858922821412;7116.359527642537;7172.713091476283;7272.090988626422;6431.035344698333;6456.192975878015;6524.119243902012;6529.183852018497;6545.410913017851;4881.219004959189;5029.7677069116835;5064.7467626619255;5073.92389114171;5110.080185566485;5020.974895125501;5037.974810125926;5159.690418574897;5199.896002080013;5215.634905556574 02:28:49 INFO - PROCESS | 1651 | |4;prototype.html;334.5333260102156;353.5598180265569;360.7078266604049;360.796150175151;372.61758874575327;4726.952730472694;4900.961403929568;4953;5141.280220769086;5167.844964651057;4191.748495090296;4273.337632666934;4524.97737511312;4848.739327774786;4993.3259010033635;4077.1234184650293;4083.2241874043984;4090.9181816363653;4107.856225032125;4124.690648201382;3725.6088110748387;4089.44792453018;4108.794560271989;4139.302885816815;4146.730462519941;3310.4372256716415;3310.966890331102;3633.7638053526566;3905.7461265017682;3916.921661566767;3904.6876249900083;3905.3360928641914;3910.765354078764;3916.647501724844;3925.9214815703813;2983.77621678375;3393.117789374756;3407.8296085195643;3412.7099196568074;3413.5391722117442;4912.631552633567;4995;5020.673656212334;5034.219695947134;5075.796968121271;4255.1915136124035;4487.810730156511;4488.7531185784765;4495.03356778291;4522.299043648207;4585.449746030465;5000.874978125539;5246.239295302198;5451.018816613008;5495.395506494282;3631.782093074424;3747.9063023424633;3755;3762.6049264827348;3783.4135708965155;5602.2717046783655;5658.264425624684;5678.716064196815;5690.231818704505;5708.40061793514;3426.0642736854097;3557.217412169319;3618.873339433107;3764.7364684471822;3783.4892289541112;3838;3871.593482684334;3876.7480113792512;3894.824732887027;3908;4226.020655437909;4412.757298348622;4445.177642136216;4482.462104547475;4490.955090449119;5436.836894893159;5448.003598021072;5478.835634930959;5481.862953426196;5524.779008839601;1190.0241801722677;1194.7311854832594;1206.7345184059493;1206.7345184059668;1249.5314257153568;772.8570214510333;773.9458237923404;822.411975437565;836.6529886882115;851.6210286422482;4184.225918205081;4556.681032327705;4590.691652878913;4777.378940737682;4809.182438985381;4765.7140571565815;4975.278584605212;5053.343065401475;5363.919541206885;5461.972690136524;4380.715253508575;4466.486354069324;4752.714837109785;4819.542143496362;4921.704697718077;2326.674265602817;2547.796176305891;2734.2070799467933;2742.75315221631;2751.408447183865;4754.5245475452175;4846.722040640893;5355.464453554613;5456.836294911159;5503.394626591072;5121.718305493159;5294.642990784745;5376.6505177164145;5827.737751801179;5828.5337173026055;5836.854078648068;5837.6497410155525;5851.180834683233;5862.824115276549;5881.294244690579;5174.430812610685;5304.389995150607;5336.786528538815;5599.160125981135;5653.293338332708;5515.917261241005;5520;5550.27846379968;5561.499465048003;5573.498385145356;4659.464161621457;4965.006998600222;5271.525562699376;5281.762320695501;5804;3499.9475007874394;3880.4373365862357;4144.357624568197;4150.27370210218;4156.376543518376;5435.374931882726;5650.3219613646625;5694.209837179835;5708.54331653475;5739.368669446441;4638.489766125791;5570.387257401601;5580.162975553537;5599.440055994368;5613.101903695389;4804.591609713214;4936.98791747698;5437.4834390734395;5502.367227768857;5528.585356098229;4447.377367168664;4757.452892917358;4770.974240538301;5253.317068781034;5284.886045581798;5348.010618035676;5490.670559766427;5510.586705996986;5536.197251398606;5541.337598720448;4976.527229913152;4979.4438089148025;5336.9466305338;5366.329208848894;5373.140297552529 02:28:49 INFO - PROCESS | 1651 | |5;yui.html;695.172744434123;712.4549719464608;756.357096468002;763.2215140556632;816.734561267588;14411.855881441183;14461.060031097972;14807;14834.777478337834;14922.850771492282;12172.75654486912;14527.78208326876;14546.927265363685;14560.490382836602;14610.707785844277;842.296682270305;859.4113032572692;868.6438560190323;880.828238493494;887.4276091920707;876.6843936183001;877.5480627476854;877.627008521379;878.1481962496368;878.9516576588285;925.6945208081318;926.1664501948233;926.2589928057561;926.9895813563214;927.1979737527058;905.8233644439337;919.6137622198693;920.4523308631353;922.6816748221886;924.1497822003705;689.4139981016147;689.8827199376118;691.339770519153;691.4433880726014;693.836948317145;15184.924075379662;15709.921450392674;15761.448349307833;15912.363505459767;16179.757303640456;13869.4452221911;14028.579142625738;14052.508162214273;14278.428862845578;14432;11315.943420282845;11535.307881527051;11601.07191424684;11805.88194118065;11934.522619095225;3313.784604000756;3335.616404113534;3336.1659585103725;3336.7664263501565;3339.699427051553;106015.46992265066;110282.89717102806;112594.43702781516;114795;115827.42086289599;10507.422091784872;10829.35023898553;10905.499893307106;10956.452177391098;11366.886331136582;22423.32730018102;22862;22875.08499659995;22908.541829163325;22985.195518156783;7309.451791115687;7671.654775535114;7771.184025677222;7772.261635144652;7981.441299109123;4210.59999300066;4266.25340565406;4286.747441524091;4323.718958267703;4416.29339305716;3433.484977253382;3516.2440075383915;3777.660010599059;3935.311320518898;3992.301347264217;704.3132945378318;707.4552594502204;709.4643544124257;713.9785806425815;722.1009842745815;655.4232275597539;655.4919937048825;666.946644268467;681.7716065118142;708.2032713197652;9405.529723513933;10105.14106300958;10143.898561014295;10230.744231394274;10254.179665626732;578.6556998585835;586.571802584116;658.0425480925243;690.4890381117937;691.0015028284182;4639.582437580634;5061.164907790173;5081.517255860687;5169.379674439091;5213.504717051874;87873.12126878777;88431.11568884228;90628;95544.04455955491;114209.42895285471;67911.3208867905;84707;87127.56436217779;91041.08958910458;95578;72504;74655.99999999891;78286.6085669568;80893;82098.58950705208;10221.540030698785;10721.056026995993;10874.238803283693;10917.962793534602;10979.451027448755;51135.26159506545;52198.73900630624;52682.473175267754;53478;54793;69379.3062069393;69517.65241173762;70574;71082.28917710757;72397.63801181171;13605.319734013457;13662.863371366158;13719.588412347646;14092.859071409564;14187.716245675236;14153.575392738234;14223.359948802121;14623;14888.032277901902;15015.249237538297;11871.821922671339;12904.16122952005;13613.659658508617;13990.16059036461;14426.85573144297;13729.588112356645;14208.786868197192;14251.857481425053;14424.206668633326;14891.70882532207;12765.234085954873;13579.321033948461;14056.016078874381;14388.35252413623;14528.346224420138;11242.269252498561;11414.258073225214;11425.428728563706;11623.941880290882;11844.881551184722;11547.480363383836;11585.88414115848;11587.922979609159;11882.821757673815;11890.28658280506 02:28:49 INFO - PROCESS | 1651 | __end_tp_report 02:28:49 INFO - PROCESS | 1651 | __start_cc_report 02:28:49 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1624 02:28:49 INFO - PROCESS | 1651 | __end_cc_report 02:28:49 INFO - PROCESS | 1651 | __startTimestamp1485944929538__endTimestamp 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | ------- Summary: start ------- 02:28:49 INFO - PROCESS | 1651 | Number of tests: 6 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5700.88 Median:5864.38 stddev:640.91 (10.9%) stddev-sans-first:613.89 02:28:49 INFO - PROCESS | 1651 | Values: 3271.6 3277.1 3307.8 3339.8 3348.9 5643.7 5648.3 5665.9 5684.8 5687.2 4708.2 5699.5 5707.6 5708.1 5734.6 5178.7 5211.7 5211.7 5233.7 5277.1 5167.3 5177.2 5177.2 5280.7 5334.2 5233.6 5250.0 5259.4 5262.0 5267.5 5246.2 5256.9 5260.2 5266.9 5277.5 4790.1 5102.7 5213.0 5216.4 5220.4 5319.9 5737.3 5750.8 5752.1 5755.6 6109.4 6120.2 6130.2 6142.9 6143.9 6174.5 6214.9 6238.5 6249.1 6308.9 5061.7 5314.7 5350.0 5746.9 5778.3 6190.7 6276.1 6278.5 6301.0 6305.4 5007.5 5976.9 5999.7 6058.5 6096.5 6233.8 6239.3 6258.2 6262.0 6264.1 6201.8 6204.5 6221.2 6226.8 6227.5 6014.8 6022.4 6089.4 6111.6 6247.8 4909.7 4916.0 4930.8 4936.4 4940.3 4416.9 4417.2 4426.4 4428.2 4446.3 5809.4 5854.3 5859.9 5864.1 5877.6 6057.7 6116.8 6130.8 6164.9 6330.7 5705.7 5715.3 5717.1 5733.4 5742.5 5368.2 5368.3 5380.9 5403.6 5417.8 6219.5 6290.3 6299.4 6300.3 6313.0 6244.4 6332.9 6352.6 6354.7 6356.0 6199.5 6217.3 6255.1 6266.5 6276.3 6152.9 6173.5 6188.6 6193.0 6205.2 5977.0 6256.9 6268.0 6277.7 6300.7 5929.3 5931.1 5995.9 6100.9 6107.5 5920.3 6006.9 6009.5 6045.8 6060.3 5850.9 5856.2 5857.6 5859.4 5872.4 5682.4 5906.5 5961.1 6002.2 6004.7 5857.7 5858.1 5864.4 5951.5 5972.4 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:60803.68 Median:33884.42 stddev:129145.04 (381.1%) stddev-sans-first:129427.84 02:28:49 INFO - PROCESS | 1651 | Values: 457.9 486.7 495.9 496.1 497.6 28550.9 30189.1 31870.7 31893.5 39355.8 39141.0 42214.8 42247.0 42308.2 42309.6 9126.5 9321.5 9349.6 9365.8 9381.0 8309.6 8547.4 9337.4 9473.0 9489.5 11034.6 11266.3 11309.5 11423.9 11448.8 10028.9 10938.2 11163.6 11260.7 11268.6 8185.1 8408.2 11071.3 11147.9 11162.3 38894.4 39382.8 39457.0 41184.8 41294.6 4059.2 4061.9 4064.7 4079.6 4103.4 28700.9 30265.5 30434.4 30647.0 31161.8 3215.9 3256.3 3267.4 3267.5 3282.0 360996.0 363839.0 365413.0 366035.0 366582.0 58879.0 59253.7 59304.7 59349.5 59406.4 62698.4 62814.0 62855.7 62859.4 63016.0 15620.0 16124.4 16150.8 16156.2 16161.6 12441.3 12527.7 12529.8 12530.5 12534.0 13345.6 13710.4 14033.9 14054.0 14113.4 6434.9 6703.7 6706.8 6832.1 6871.1 769.0 879.2 879.5 895.1 927.2 28673.0 29560.4 29594.4 30242.8 30280.8 1020.7 1031.1 1095.5 1114.1 1220.0 14800.3 14886.6 15412.1 15439.5 15617.9 577094.0 579870.0 580067.0 580797.0 583521.0 51927.7 52019.7 52070.7 52138.2 52168.0 1264.7 1405.1 1408.7 1441.4 1445.7 23030.2 26620.2 26625.6 27653.6 27798.0 43354.6 43658.1 43700.3 43704.1 43725.0 481132.0 481991.0 482535.0 482914.0 486193.0 22857.9 23754.3 23763.9 23839.9 23878.3 33986.0 36054.7 38680.6 39858.6 40435.4 28676.4 33152.0 33247.7 33269.2 34768.3 33782.8 34083.5 34087.7 34217.7 34508.3 32829.5 33199.8 33316.5 33672.2 34406.0 29770.0 31255.8 31480.7 31491.4 31700.5 23838.0 23900.5 24018.8 24447.3 24521.0 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:39779.18 Median:20869.11 stddev:117855.73 (564.7%) stddev-sans-first:118149.17 02:28:49 INFO - PROCESS | 1651 | Values: 353.9 391.1 393.2 400.3 423.3 15153.1 18088.7 18526.4 20177.9 20965.4 13286.7 16251.9 20756.6 20772.8 20976.8 5742.4 5960.9 6001.3 6025.2 6044.5 5697.0 5948.2 5968.7 6063.0 6084.2 5931.1 5945.0 5954.3 5970.0 5974.8 5637.2 5803.7 5829.0 5933.6 5946.3 5136.9 5153.4 5156.9 5159.2 5175.1 25284.6 25781.0 25824.4 26230.9 26538.3 3091.9 3108.4 3112.3 3112.5 3113.7 14899.6 15521.8 15751.1 15792.1 16043.3 1614.4 1800.3 1833.4 1864.9 1870.9 130792.0 133736.0 133832.7 135313.3 135632.3 11197.6 11540.4 11548.3 11627.1 11810.2 14135.2 14586.6 14600.3 14622.5 14630.6 6647.1 7315.4 7733.5 7767.8 8417.7 6497.8 7907.2 8466.7 8493.0 8821.3 7270.5 7284.3 7286.6 7319.7 7334.8 1917.4 1926.1 1950.8 1965.3 1973.8 1052.8 1080.5 1094.2 1107.5 1132.2 23183.8 23225.5 23482.4 23645.5 23678.9 1063.5 1077.6 1093.3 1098.8 1127.2 11672.7 11771.8 11961.3 12000.8 12062.5 619818.0 621148.0 715450.0 764106.0 778773.0 162745.4 164456.0 166396.0 169326.0 171959.0 1016.5 1016.9 1050.7 1050.8 1054.1 18901.6 19058.3 19700.0 19734.8 19779.1 46981.0 50186.2 56548.4 58769.0 59972.0 80602.2 81630.1 82011.0 83157.6 85120.0 8019.3 8170.1 8345.6 8530.2 8699.0 9074.3 12124.8 12321.4 12756.8 12966.8 11002.7 11127.0 11444.1 11448.0 11529.1 11056.7 11118.8 11140.2 11231.9 11375.4 11363.8 11546.8 11661.5 11737.0 11800.2 7040.0 7681.5 8218.1 8480.8 8490.6 8204.4 10679.4 10924.2 11249.6 11310.5 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5438.36 Median:5161.97 stddev:2965.97 (57.5%) stddev-sans-first:2959.02 02:28:49 INFO - PROCESS | 1651 | Values: 1433.1 1438.6 1446.6 1452.6 1464.7 8100.6 8496.7 8502.5 8516.9 8520.9 7403.0 7672.8 7674.7 8142.5 8333.7 2299.1 2338.1 2338.5 2339.6 2349.7 2330.8 2342.1 2358.0 2359.8 2370.1 2315.5 2321.1 2330.2 2354.9 2357.7 2302.9 2306.6 2327.8 2328.3 2329.2 2296.4 2349.0 2351.6 2354.0 2359.5 8352.4 8483.1 8499.7 8524.5 8533.7 4923.3 4986.7 5158.6 5164.3 5165.8 3370.9 3484.4 3489.9 3545.2 3569.3 1190.2 1232.5 1252.8 1270.8 1270.9 10885.9 10933.0 10943.8 10960.5 11022.4 3910.3 4446.0 4662.4 4732.3 4734.3 9329.5 9401.9 9528.0 9533.7 9545.5 5037.6 5054.9 5063.9 5064.4 5065.3 4313.7 4492.9 4533.7 4711.0 4759.6 3446.4 3722.4 3772.7 3849.7 3960.2 1243.2 1247.6 1247.7 1259.4 1274.8 920.5 927.2 940.1 949.9 985.5 5510.4 5623.6 5754.7 5887.8 5912.5 538.9 554.4 554.6 561.1 563.3 3796.3 3809.2 3852.8 3907.5 3922.7 8573.0 9490.9 9805.8 9938.5 10096.8 9907.6 10024.7 10028.0 10030.5 10066.5 6676.9 7582.0 7852.4 7866.8 7881.9 5693.6 5759.5 5791.9 5941.4 5991.5 9315.3 9334.8 9416.8 9449.3 9452.0 8958.7 9334.8 9347.7 9416.2 9489.9 6604.3 6833.9 6839.5 7128.3 7318.4 7649.3 7837.2 7946.4 8032.3 8046.0 7120.9 7239.5 7285.5 7311.6 7401.7 6257.4 7053.9 7116.4 7172.7 7272.1 6431.0 6456.2 6524.1 6529.2 6545.4 4881.2 5029.8 5064.7 5073.9 5110.1 5021.0 5038.0 5159.7 5199.9 5215.6 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4384.67 Median:4814.36 stddev:1343.68 (27.9%) stddev-sans-first:1312.61 02:28:49 INFO - PROCESS | 1651 | Values: 334.5 353.6 360.7 360.8 372.6 4727.0 4901.0 4953.0 5141.3 5167.8 4191.7 4273.3 4525.0 4848.7 4993.3 4077.1 4083.2 4090.9 4107.9 4124.7 3725.6 4089.4 4108.8 4139.3 4146.7 3310.4 3311.0 3633.8 3905.7 3916.9 3904.7 3905.3 3910.8 3916.6 3925.9 2983.8 3393.1 3407.8 3412.7 3413.5 4912.6 4995.0 5020.7 5034.2 5075.8 4255.2 4487.8 4488.8 4495.0 4522.3 4585.4 5000.9 5246.2 5451.0 5495.4 3631.8 3747.9 3755.0 3762.6 3783.4 5602.3 5658.3 5678.7 5690.2 5708.4 3426.1 3557.2 3618.9 3764.7 3783.5 3838.0 3871.6 3876.7 3894.8 3908.0 4226.0 4412.8 4445.2 4482.5 4491.0 5436.8 5448.0 5478.8 5481.9 5524.8 1190.0 1194.7 1206.7 1206.7 1249.5 772.9 773.9 822.4 836.7 851.6 4184.2 4556.7 4590.7 4777.4 4809.2 4765.7 4975.3 5053.3 5363.9 5462.0 4380.7 4466.5 4752.7 4819.5 4921.7 2326.7 2547.8 2734.2 2742.8 2751.4 4754.5 4846.7 5355.5 5456.8 5503.4 5121.7 5294.6 5376.7 5827.7 5828.5 5836.9 5837.6 5851.2 5862.8 5881.3 5174.4 5304.4 5336.8 5599.2 5653.3 5515.9 5520.0 5550.3 5561.5 5573.5 4659.5 4965.0 5271.5 5281.8 5804.0 3499.9 3880.4 4144.4 4150.3 4156.4 5435.4 5650.3 5694.2 5708.5 5739.4 4638.5 5570.4 5580.2 5599.4 5613.1 4804.6 4937.0 5437.5 5502.4 5528.6 4447.4 4757.5 4771.0 5253.3 5284.9 5348.0 5490.7 5510.6 5536.2 5541.3 4976.5 4979.4 5336.9 5366.3 5373.1 02:28:49 INFO - PROCESS | 1651 | 02:28:49 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20632.20 Median:3474.86 stddev:29342.33 (844.4%) stddev-sans-first:29386.45 02:28:49 INFO - PROCESS | 1651 | Values: 695.2 712.5 756.4 763.2 816.7 14411.9 14461.1 14807.0 14834.8 14922.9 12172.8 14527.8 14546.9 14560.5 14610.7 842.3 859.4 868.6 880.8 887.4 876.7 877.5 877.6 878.1 879.0 925.7 926.2 926.3 927.0 927.2 905.8 919.6 920.5 922.7 924.1 689.4 689.9 691.3 691.4 693.8 15184.9 15709.9 15761.4 15912.4 16179.8 13869.4 14028.6 14052.5 14278.4 14432.0 11315.9 11535.3 11601.1 11805.9 11934.5 3313.8 3335.6 3336.2 3336.8 3339.7 106015.5 110282.9 112594.4 114795.0 115827.4 10507.4 10829.4 10905.5 10956.5 11366.9 22423.3 22862.0 22875.1 22908.5 22985.2 7309.5 7671.7 7771.2 7772.3 7981.4 4210.6 4266.3 4286.7 4323.7 4416.3 3433.5 3516.2 3777.7 3935.3 3992.3 704.3 707.5 709.5 714.0 722.1 655.4 655.5 666.9 681.8 708.2 9405.5 10105.1 10143.9 10230.7 10254.2 578.7 586.6 658.0 690.5 691.0 4639.6 5061.2 5081.5 5169.4 5213.5 87873.1 88431.1 90628.0 95544.0 114209.4 67911.3 84707.0 87127.6 91041.1 95578.0 72504.0 74656.0 78286.6 80893.0 82098.6 10221.5 10721.1 10874.2 10918.0 10979.5 51135.3 52198.7 52682.5 53478.0 54793.0 69379.3 69517.7 70574.0 71082.3 72397.6 13605.3 13662.9 13719.6 14092.9 14187.7 14153.6 14223.4 14623.0 14888.0 15015.2 11871.8 12904.2 13613.7 13990.2 14426.9 13729.6 14208.8 14251.9 14424.2 14891.7 12765.2 13579.3 14056.0 14388.4 14528.3 11242.3 11414.3 11425.4 11623.9 11844.9 11547.5 11585.9 11587.9 11882.8 11890.3 02:28:49 INFO - PROCESS | 1651 | -------- Summary: end -------- 02:28:49 INFO - PROCESS | 1651 | 02:28:50 INFO - TEST-INFO | 1651: exit 0 02:28:50 INFO - TEST-OK | dromaeo_css | took 1118219ms 02:28:50 INFO - TEST-START | kraken 02:28:50 INFO - operating with platform_type : mac_ 02:28:50 INFO - Initialising browser for kraken test... 02:28:50 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/tmpA3cIyK/profile http://localhost:49241/getInfo.html) 02:28:52 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 02:28:52 INFO - PROCESS | 1658 | colorDepth:24 02:28:52 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 02:28:52 INFO - PROCESS | 1658 | __metrics 02:28:52 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:28:52 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:53 INFO - TEST-INFO | 1658: exit 0 02:28:53 INFO - Browser initialized. 02:28:53 INFO - Running cycle 1/1 for kraken test... 02:28:53 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/T/tmpA3cIyK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:05 INFO - PROCESS | 1660 | RSS: Main: 212738048 02:29:05 INFO - PROCESS | 1660 | 02:29:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:09 INFO - PROCESS | 1660 | RSS: Main: 263835648 02:29:09 INFO - PROCESS | 1660 | 02:29:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:29:12 INFO - PROCESS | 1660 | RSS: Main: 276738048 02:29:12 INFO - PROCESS | 1660 | 02:29:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:29:16 INFO - PROCESS | 1660 | RSS: Main: 373686272 02:29:16 INFO - PROCESS | 1660 | 02:29:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:29:18 INFO - PROCESS | 1660 | RSS: Main: 278683648 02:29:18 INFO - PROCESS | 1660 | 02:29:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:21 INFO - PROCESS | 1660 | RSS: Main: 280854528 02:29:21 INFO - PROCESS | 1660 | 02:29:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:24 INFO - PROCESS | 1660 | RSS: Main: 320475136 02:29:24 INFO - PROCESS | 1660 | 02:29:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:28 INFO - PROCESS | 1660 | RSS: Main: 318951424 02:29:28 INFO - PROCESS | 1660 | 02:29:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:29:31 INFO - PROCESS | 1660 | RSS: Main: 318562304 02:29:31 INFO - PROCESS | 1660 | 02:29:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:29:33 INFO - PROCESS | 1660 | RSS: Main: 294789120 02:29:33 INFO - PROCESS | 1660 | 02:29:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:29:36 INFO - PROCESS | 1660 | RSS: Main: 298504192 02:29:36 INFO - PROCESS | 1660 | 02:29:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:29:39 INFO - PROCESS | 1660 | RSS: Main: 301436928 02:29:39 INFO - PROCESS | 1660 | 02:29:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:29:42 INFO - PROCESS | 1660 | RSS: Main: 311320576 02:29:42 INFO - PROCESS | 1660 | 02:29:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:46 INFO - PROCESS | 1660 | RSS: Main: 310755328 02:29:46 INFO - PROCESS | 1660 | 02:29:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:29:48 INFO - PROCESS | 1660 | RSS: Main: 355356672 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | __start_tp_report 02:29:48 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 02:29:48 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 02:29:48 INFO - PROCESS | 1660 | |i|pagename|runs| 02:29:48 INFO - PROCESS | 1660 | |0;ai-astar;113;116;116;116;115;114;113;114;115;116 02:29:48 INFO - PROCESS | 1660 | |1;audio-beat-detection;159;138;110;139;112;114;141;123;128;108 02:29:48 INFO - PROCESS | 1660 | |2;audio-dft;186;183;184;185;184;184;187;184;186;185 02:29:48 INFO - PROCESS | 1660 | |3;audio-fft;82;63;59;90;60;57;59;60;74;58 02:29:48 INFO - PROCESS | 1660 | |4;audio-oscillator;88;70;87;70;68;71;82;68;69;83 02:29:48 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;87;85;86;84;87;84;89;84;86;85 02:29:48 INFO - PROCESS | 1660 | |6;imaging-darkroom;94;95;93;93;93;94;93;94;92;116 02:29:48 INFO - PROCESS | 1660 | |7;imaging-desaturate;86;88;87;87;86;88;86;88;88;88 02:29:48 INFO - PROCESS | 1660 | |8;json-parse-financial;54;53;56;53;57;56;57;57;57;58 02:29:48 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;66;78;70;76;74;71;71;72;72;73 02:29:48 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;83;82;84;85;87;82;81;83;84;82 02:29:48 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;141;150;144;140;137;134;139;142;260;150 02:29:48 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;193;167;170;165;167;172;169;170;170;170 02:29:48 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;66;66;68;67;66;66;64;66;66;65 02:29:48 INFO - PROCESS | 1660 | __end_tp_report 02:29:48 INFO - PROCESS | 1660 | __start_cc_report 02:29:48 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1948 02:29:48 INFO - PROCESS | 1660 | __end_cc_report 02:29:48 INFO - PROCESS | 1660 | __startTimestamp1485944988198__endTimestamp 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | ------- Summary: start ------- 02:29:48 INFO - PROCESS | 1660 | Number of tests: 14 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:1.23 (1.1%) stddev-sans-first:1.12 02:29:48 INFO - PROCESS | 1660 | Values: 113.0 116.0 116.0 116.0 115.0 114.0 113.0 114.0 115.0 116.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:133.00 stddev:16.82 (12.6%) stddev-sans-first:13.33 02:29:48 INFO - PROCESS | 1660 | Values: 159.0 138.0 110.0 139.0 112.0 114.0 141.0 123.0 128.0 108.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.23 (0.7%) stddev-sans-first:1.22 02:29:48 INFO - PROCESS | 1660 | Values: 186.0 183.0 184.0 185.0 184.0 184.0 187.0 184.0 186.0 185.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.50 stddev:11.64 (18.9%) stddev-sans-first:10.85 02:29:48 INFO - PROCESS | 1660 | Values: 82.0 63.0 59.0 90.0 60.0 57.0 59.0 60.0 74.0 58.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.32 (10.9%) stddev-sans-first:7.51 02:29:48 INFO - PROCESS | 1660 | Values: 88.0 70.0 87.0 70.0 68.0 71.0 82.0 68.0 69.0 83.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.67 02:29:48 INFO - PROCESS | 1660 | Values: 87.0 85.0 86.0 84.0 87.0 84.0 89.0 84.0 86.0 85.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:93.50 stddev:7.18 (7.7%) stddev-sans-first:7.59 02:29:48 INFO - PROCESS | 1660 | Values: 94.0 95.0 93.0 93.0 93.0 94.0 93.0 94.0 92.0 116.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:88.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 02:29:48 INFO - PROCESS | 1660 | Values: 86.0 88.0 87.0 87.0 86.0 88.0 86.0 88.0 88.0 88.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:1.81 (3.2%) stddev-sans-first:1.80 02:29:48 INFO - PROCESS | 1660 | Values: 54.0 53.0 56.0 53.0 57.0 56.0 57.0 57.0 57.0 58.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:3.30 (4.6%) stddev-sans-first:2.60 02:29:48 INFO - PROCESS | 1660 | Values: 66.0 78.0 70.0 76.0 74.0 71.0 71.0 72.0 72.0 73.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.77 (2.1%) stddev-sans-first:1.87 02:29:48 INFO - PROCESS | 1660 | Values: 83.0 82.0 84.0 85.0 87.0 82.0 81.0 83.0 84.0 82.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:143.00 stddev:37.70 (26.4%) stddev-sans-first:39.70 02:29:48 INFO - PROCESS | 1660 | Values: 141.0 150.0 144.0 140.0 137.0 134.0 139.0 142.0 260.0 150.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:170.00 stddev:7.89 (4.6%) stddev-sans-first:2.15 02:29:48 INFO - PROCESS | 1660 | Values: 193.0 167.0 170.0 165.0 167.0 172.0 169.0 170.0 170.0 170.0 02:29:48 INFO - PROCESS | 1660 | 02:29:48 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 02:29:48 INFO - PROCESS | 1660 | Values: 66.0 66.0 68.0 67.0 66.0 66.0 64.0 66.0 66.0 65.0 02:29:48 INFO - PROCESS | 1660 | -------- Summary: end -------- 02:29:48 INFO - PROCESS | 1660 | 02:29:49 INFO - TEST-INFO | 1660: exit 0 02:29:49 INFO - TEST-OK | kraken | took 58810ms 02:29:49 INFO - SUITE-END | took 1177s 02:29:49 INFO - Completed test suite (00:19:37) 02:29:49 INFO - javascript benchmark 02:29:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.574695289612, 3277.1315601365636, 3307.818070006149, 3339.782914110584, 3348.882789102382, 5643.68959707216, 5648.293963254593, 5665.8583535411635, 5684.772609095637, 5687.203791469193, 4708.22314318138, 5699.487046165844, 5707.571932105098, 5708.08670612702, 5734.627249228808, 5178.6892786432745, 5211.661242019276, 5211.739413029343, 5233.712145831978, 5277.076511610472, 5167.328247327842, 5177.197534382177, 5177.197534382177, 5280.709560974145, 5334.22653715213, 5233.581313494911, 5250.0, 5259.3951695555115, 5261.97391508656, 5267.499587539178, 5246.186841039645, 5256.92114618281, 5260.210968354739, 5266.894662106755, 5277.47225277473, 4790.089882922233, 5102.719350435725, 5213.035588416155, 5216.37403511581, 5220.425753167148, 5319.893602127936, 5737.340205876294, 5750.827475175752, 5752.050911599581, 5755.568332375088, 6109.404666050371, 6120.234970628671, 6130.203073600448, 6142.938570614281, 6143.877122457526, 6174.475169610589, 6214.875702485971, 6238.4697300729495, 6249.0626406039, 6308.936910630927, 5061.670991385585, 5314.73426328682, 5350.010248104113, 5746.856328591777, 5778.3354914184565, 6190.659513726789, 6276.121343011982, 6278.529110316745, 6301.0233413820015, 6305.4009869062365, 5007.499250074963, 5976.8804623908145, 5999.730012149464, 6058.485028772516, 6096.512279017668, 6233.812985610439, 6239.282482514478, 6258.249010118815, 6262.029385445263, 6264.091706702594, 6201.81394558164, 6204.534659900525, 6221.191245138103, 6226.750929962841, 6227.532935029891, 6014.7594096236535, 6022.397760223943, 6089.421504957022, 6111.633302001894, 6247.781327653511, 4909.68087074339, 4915.975420122876, 4930.778114984834, 4936.432310284364, 4940.258961155855, 4416.933745993812, 4417.160739459492, 4426.3581780641625, 4428.180786554498, 4446.26636604963, 5809.3609702932645, 5854.297484301911, 5859.912101318484, 5864.061750120046, 5877.5591830612875, 6057.666828324396, 6116.755329786848, 6130.816075517741, 6164.938350616526, 6330.651814150174, 5705.743241554057, 5715.342735585377, 5717.142428635655, 5733.397993210653, 5742.48317651405, 5368.248445217672, 5368.302120724359, 5380.892382152413, 5403.594730395236, 5417.783288668409, 6219.471344935731, 6290.276618188784, 6299.401556852184, 6300.338464461257, 6313.0, 6244.438000579969, 6332.9366706334185, 6352.618842869442, 6354.6822658867795, 6355.968220158869, 6199.473044791243, 6217.285012223652, 6255.093011513396, 6266.467350275096, 6276.340984196594, 6152.876942461216, 6173.506119510339, 6188.566800324114, 6192.969035154975, 6205.22434695663, 5976.970115149396, 6256.937430625636, 6267.9657856455, 6277.74889004453, 6300.71646775887, 5929.347771745019, 5931.13998470228, 5995.940040599538, 6100.908486372619, 6107.511399088151, 5920.319163296276, 6006.87986240264, 6009.489193418608, 6045.848853778515, 6060.333363329942, 5850.882982340415, 5856.209411729533, 5857.619254748428, 5859.384764599826, 5872.412758724265, 5682.37493875665, 5906.468417842415, 5961.076033214858, 6002.189704389852, 6004.669743164168, 5857.736401862012, 5858.121281807763, 5864.384239654775, 5951.494122999594, 5972.432618901197], "value": 5659.741357005366, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.89875349783784, 486.6787919972818, 495.91321518734236, 496.1317694035438, 497.6441844081482, 28550.857245713767, 30189.09432717019, 31870.72517099319, 31893.521597176004, 39355.819325420285, 39141.0, 42214.78892605533, 42247.0, 42308.153836923244, 42309.57690423095, 9126.54367281635, 9321.487318197496, 9349.579268932881, 9365.76585585359, 9380.953095234549, 8309.584520773968, 8547.401681882271, 9337.393069450498, 9472.952635236814, 9489.478078705668, 11034.558617655284, 11266.267692599955, 11309.49107290174, 11423.885761142406, 11448.828267575993, 10028.896821349646, 10938.179636527293, 11163.553457861675, 11260.662180134608, 11268.605598804044, 8185.140560241208, 8408.159184081604, 11071.335719856834, 11147.888521114766, 11162.274452160666, 38894.41658375126, 39382.80308598468, 39457.0, 41184.79407602973, 41294.587054129675, 4059.2490389278078, 4061.939070913939, 4064.7357921734992, 4079.571644977294, 4103.4050062740735, 28700.851965921338, 30265.546016809767, 30434.391312173633, 30647.0, 31161.75352985878, 3215.9356812863844, 3256.267339848539, 3267.379197952381, 3267.509873518967, 3281.950770738441, 360996.0, 363839.0, 365413.0, 366035.0, 366582.0, 58879.0, 59253.70373148193, 59304.70347648234, 59349.516262092926, 59406.405935940085, 62698.37301627017, 62814.0, 62855.6857215711, 62859.371406286264, 63016.0, 15620.0, 16124.435644752377, 16150.838491614933, 16156.192190390433, 16161.59596010109, 12441.315727635067, 12527.749445011048, 12529.812052819216, 12530.498780048696, 12534.0, 13345.599632011055, 13710.38303276355, 14033.85966140346, 14054.016218864786, 14113.435462581587, 6434.935650643527, 6703.687227906365, 6706.798796036127, 6832.096359047385, 6871.14110736158, 768.9961550192213, 879.2218886285683, 879.5250564694993, 895.0959530873735, 927.1794461901266, 28673.0, 29560.408791824044, 29594.40811183764, 30242.84878575593, 30280.84859575732, 1020.7448137965508, 1031.128696251666, 1095.5070218401593, 1114.1198453221864, 1220.0056953582803, 14800.333984970703, 14886.553403397915, 15412.061004617295, 15439.459618913284, 15617.921910390376, 577094.0, 579870.0, 580067.0, 580797.0, 583521.0, 51927.740361297954, 52019.73990130025, 52070.739646301525, 52138.21792673037, 52168.0, 1264.677507235649, 1405.1147776900486, 1408.6617713172527, 1441.4450436581992, 1445.6747231872744, 23030.193943212576, 26620.201393958214, 26625.600615990388, 27653.58519622167, 27798.0, 43354.56645433505, 43658.12683746371, 43700.34449483324, 43704.12591748084, 43725.0, 481132.0, 481991.0, 482535.0, 482914.0, 486193.0, 22857.88571057134, 23754.287371378887, 23763.881180593988, 23839.927203275547, 23878.283651490485, 33986.0, 36054.73808416693, 38680.6131938677, 39858.60141398549, 40435.39346909858, 28676.42647147087, 33152.0, 33247.66752332446, 33269.16827079342, 34768.30463390667, 33782.83108584442, 34083.488747669304, 34087.65912340845, 34217.65782342145, 34508.30983380369, 32829.507557387136, 33199.83400082984, 33316.50025249672, 33672.1581960453, 34406.0, 29770.0, 31255.84372078125, 31480.685193147776, 31491.37017259688, 31700.5244921331, 23838.0, 23900.521989559762, 24018.75981240165, 24447.26658200257, 24521.0], "value": 18772.087133519653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9469079638053, 391.14144452925825, 393.19983832900056, 400.29275141521396, 423.31845728377306, 15153.090814551135, 18088.728669069973, 18526.444206673823, 20177.899110504444, 20965.427592930533, 13286.667833304147, 16251.91874040631, 20756.584868302623, 20772.792272077273, 20976.790232097712, 5742.368339482664, 5960.88078238435, 6001.309849367335, 6025.1564780930485, 6044.516438684895, 5697.0315046442, 5948.226730525047, 5968.7015649217365, 6062.969685151568, 6084.2090528231265, 5931.110333449996, 5945.0, 5954.255718035246, 5970.014947533652, 5974.820755377324, 5637.182608521762, 5803.709814509258, 5828.970855145697, 5933.5549833762425, 5946.345901950782, 5136.948630513684, 5153.3815942087185, 5156.92264616031, 5159.22611608258, 5175.146100893348, 25284.620730689054, 25781.0, 25824.354391140183, 26230.86884565565, 26538.336541586614, 3091.8917837875792, 3108.4094022135723, 3112.25305926576, 3112.5486804413235, 3113.7041981011766, 14899.627509312353, 15521.844781552152, 15751.133687647174, 15792.073526696737, 16043.278052487665, 1614.4268784581423, 1800.2798880447795, 1833.367488216563, 1864.9440516784518, 1870.9251629934786, 130792.0, 133736.0, 133832.661673383, 135313.3234333822, 135632.32183839017, 11197.608083717194, 11540.422978851191, 11548.307101573933, 11627.069834413227, 11810.232334898375, 14135.222562759147, 14586.562403127924, 14600.34298456572, 14622.488212912496, 14630.63423414402, 6647.135872336566, 7315.378192853667, 7733.535987840747, 7767.766966990999, 8417.663293468193, 6497.772577959749, 7907.2488113629115, 8466.661333546712, 8492.957535212285, 8821.338399620054, 7270.5274157180675, 7284.307990740871, 7286.562806231643, 7319.670614822346, 7334.779956601311, 1917.4343568647282, 1926.1412736709142, 1950.8146726061002, 1965.263026365113, 1973.7927517610444, 1052.7631282961427, 1080.508368692243, 1094.1848322999258, 1107.4628805029554, 1132.1508868348737, 23183.76816231816, 23225.53548929012, 23482.412939676644, 23645.527089458457, 23678.881605592207, 1063.4842101580728, 1077.5797438998798, 1093.283899046126, 1098.7693782962972, 1127.1546340244815, 11672.70818229534, 11771.823422648667, 11961.282323060645, 12000.819987700192, 12062.51749929993, 619818.0, 621148.0, 715450.0, 764106.0, 778773.0, 162745.42154759902, 164456.0, 166396.0, 169326.0, 171959.0, 1016.4714348538719, 1016.8881423043459, 1050.7478205230843, 1050.8003479338902, 1054.0829478353728, 18901.621967560848, 19058.332958346393, 19700.0, 19734.80265197387, 19779.109940052444, 46981.0, 50186.24720629267, 56548.43451565432, 58769.0, 59972.0, 80602.19397805947, 81630.0658814144, 82011.0, 83157.58421207855, 85120.0, 8019.278264956182, 8170.10128885834, 8345.582720864053, 8530.232279094911, 8698.956505217433, 9074.31942604294, 12124.757504849676, 12321.383930803604, 12756.767565675784, 12966.80549791735, 11002.724931876446, 11127.0, 11444.084473241954, 11448.0, 11529.135314851588, 11056.668299951014, 11118.833217501906, 11140.220184587, 11231.922094412559, 11375.43122843838, 11363.772724545297, 11546.82679759821, 11661.53353865836, 11737.002354799937, 11800.232984855957, 7040.0, 7681.462297639335, 8218.096009439076, 8480.844386250816, 8490.575471226537, 8204.425690201628, 10679.412632305297, 10924.235303528676, 11249.606263780728, 11310.547578097114], "value": 10133.486360093584, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.125793266108, 1438.6267291665633, 1446.631109067188, 1452.6441021949624, 1464.736347457458, 8100.635471403786, 8496.702615408461, 8502.532360720157, 8516.914830851689, 8520.914790852097, 7402.962985185067, 7672.808179795508, 7674.731384401547, 8142.470739401935, 8333.749987500369, 2299.1148407862966, 2338.0530884991604, 2338.5322935412987, 2339.63735620979, 2349.7297810751725, 2330.7552706965694, 2342.10999820069, 2357.964630530543, 2359.775821296974, 2370.146747171017, 2315.455867871049, 2321.0947730385165, 2330.196082351586, 2354.905803767856, 2357.705286839145, 2302.8848557572137, 2306.642470417088, 2327.848689835164, 2328.3247858121126, 2329.173143534038, 2296.3570200343765, 2349.0134143659534, 2351.576716191085, 2354.0466111224982, 2359.5162991586685, 8352.373571982125, 8483.109273526314, 8499.66001359951, 8524.488530688179, 8533.701320453754, 4923.286123512106, 4986.700797952099, 5158.587313014949, 5164.25118357836, 5165.767540460688, 3370.915727106842, 3484.3902317094407, 3489.91275218119, 3545.1846075402545, 3569.3396721606587, 1190.244194936213, 1232.4751211535092, 1252.7557126360273, 1270.754660432781, 1270.8602053774077, 10885.891141088647, 10933.016028557468, 10943.83584246229, 10960.506777194965, 11022.393768342738, 3910.276598829226, 4445.977425192224, 4662.4405071390975, 4732.337472753818, 4734.313524538922, 9329.486878221764, 9401.858972115424, 9527.952360238292, 9533.713988580215, 9545.47499887499, 5037.622178336639, 5054.898902021939, 5063.87340316495, 5064.417591976896, 5065.316182315414, 4313.676474264443, 4492.910141797146, 4533.659975501851, 4711.0342379812055, 4759.619230461555, 3446.379651662725, 3722.4416337549583, 3772.660460558563, 3849.711271654637, 3960.207958408272, 1243.2043492165021, 1247.5820600098887, 1247.7130260040242, 1259.389196239823, 1274.7705413025558, 920.4753290624279, 927.2350310993457, 940.1350757303297, 949.8575213717997, 985.5318723606373, 5510.366307874566, 5623.578231632644, 5754.6547207167705, 5887.8233652990475, 5912.497437717842, 538.9353277606713, 554.3790954131399, 554.6422557450422, 561.0770282884632, 563.259314002086, 3796.2976849282973, 3809.238152369537, 3852.8073596320073, 3907.4724912137067, 3922.7450215735885, 8572.957135214285, 9490.90509094914, 9805.803883922425, 9938.45338506389, 10096.848547271797, 9907.554160062815, 10024.699259022242, 10028.0, 10030.498475076363, 10066.496675166212, 6676.899846502306, 7581.962090189514, 7852.371810255166, 7866.7639970800965, 7881.881771773428, 5693.629914055573, 5759.51044161251, 5791.9131213031, 5941.405859414197, 5991.520678345635, 9315.301352398732, 9334.766630834283, 9416.764580885532, 9449.338546301693, 9451.952740236255, 8958.68644597436, 9334.766630834283, 9347.672831450867, 9416.152546270869, 9489.85765213536, 6604.273529911609, 6833.931660683528, 6839.487038472035, 7128.322809333105, 7318.414526837733, 7649.31156195945, 7837.216278372117, 7946.364290856834, 8032.277095061472, 8045.9597702011115, 7120.928790712233, 7239.4932354734665, 7285.490015698851, 7311.597862117635, 7401.666924988281, 6257.43683068526, 7053.858922821412, 7116.359527642537, 7172.713091476283, 7272.090988626422, 6431.035344698333, 6456.192975878015, 6524.119243902012, 6529.183852018497, 6545.410913017851, 4881.219004959189, 5029.7677069116835, 5064.7467626619255, 5073.92389114171, 5110.080185566485, 5020.974895125501, 5037.974810125926, 5159.690418574897, 5199.896002080013, 5215.634905556574], "value": 4382.80418414888, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5333260102156, 353.5598180265569, 360.7078266604049, 360.796150175151, 372.61758874575327, 4726.952730472694, 4900.961403929568, 4953.0, 5141.280220769086, 5167.844964651057, 4191.748495090296, 4273.337632666934, 4524.97737511312, 4848.739327774786, 4993.3259010033635, 4077.1234184650293, 4083.2241874043984, 4090.9181816363653, 4107.856225032125, 4124.690648201382, 3725.6088110748387, 4089.44792453018, 4108.794560271989, 4139.302885816815, 4146.730462519941, 3310.4372256716415, 3310.966890331102, 3633.7638053526566, 3905.7461265017682, 3916.921661566767, 3904.6876249900083, 3905.3360928641914, 3910.765354078764, 3916.647501724844, 3925.9214815703813, 2983.77621678375, 3393.117789374756, 3407.8296085195643, 3412.7099196568074, 3413.5391722117442, 4912.631552633567, 4995.0, 5020.673656212334, 5034.219695947134, 5075.796968121271, 4255.1915136124035, 4487.810730156511, 4488.7531185784765, 4495.03356778291, 4522.299043648207, 4585.449746030465, 5000.874978125539, 5246.239295302198, 5451.018816613008, 5495.395506494282, 3631.782093074424, 3747.9063023424633, 3755.0, 3762.6049264827348, 3783.4135708965155, 5602.2717046783655, 5658.264425624684, 5678.716064196815, 5690.231818704505, 5708.40061793514, 3426.0642736854097, 3557.217412169319, 3618.873339433107, 3764.7364684471822, 3783.4892289541112, 3838.0, 3871.593482684334, 3876.7480113792512, 3894.824732887027, 3908.0, 4226.020655437909, 4412.757298348622, 4445.177642136216, 4482.462104547475, 4490.955090449119, 5436.836894893159, 5448.003598021072, 5478.835634930959, 5481.862953426196, 5524.779008839601, 1190.0241801722677, 1194.7311854832594, 1206.7345184059493, 1206.7345184059668, 1249.5314257153568, 772.8570214510333, 773.9458237923404, 822.411975437565, 836.6529886882115, 851.6210286422482, 4184.225918205081, 4556.681032327705, 4590.691652878913, 4777.378940737682, 4809.182438985381, 4765.7140571565815, 4975.278584605212, 5053.343065401475, 5363.919541206885, 5461.972690136524, 4380.715253508575, 4466.486354069324, 4752.714837109785, 4819.542143496362, 4921.704697718077, 2326.674265602817, 2547.796176305891, 2734.2070799467933, 2742.75315221631, 2751.408447183865, 4754.5245475452175, 4846.722040640893, 5355.464453554613, 5456.836294911159, 5503.394626591072, 5121.718305493159, 5294.642990784745, 5376.6505177164145, 5827.737751801179, 5828.5337173026055, 5836.854078648068, 5837.6497410155525, 5851.180834683233, 5862.824115276549, 5881.294244690579, 5174.430812610685, 5304.389995150607, 5336.786528538815, 5599.160125981135, 5653.293338332708, 5515.917261241005, 5520.0, 5550.27846379968, 5561.499465048003, 5573.498385145356, 4659.464161621457, 4965.006998600222, 5271.525562699376, 5281.762320695501, 5804.0, 3499.9475007874394, 3880.4373365862357, 4144.357624568197, 4150.27370210218, 4156.376543518376, 5435.374931882726, 5650.3219613646625, 5694.209837179835, 5708.54331653475, 5739.368669446441, 4638.489766125791, 5570.387257401601, 5580.162975553537, 5599.440055994368, 5613.101903695389, 4804.591609713214, 4936.98791747698, 5437.4834390734395, 5502.367227768857, 5528.585356098229, 4447.377367168664, 4757.452892917358, 4770.974240538301, 5253.317068781034, 5284.886045581798, 5348.010618035676, 5490.670559766427, 5510.586705996986, 5536.197251398606, 5541.337598720448, 4976.527229913152, 4979.4438089148025, 5336.9466305338, 5366.329208848894, 5373.140297552529], "value": 3963.7110809387327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.172744434123, 712.4549719464608, 756.357096468002, 763.2215140556632, 816.734561267588, 14411.855881441183, 14461.060031097972, 14807.0, 14834.777478337834, 14922.850771492282, 12172.75654486912, 14527.78208326876, 14546.927265363685, 14560.490382836602, 14610.707785844277, 842.296682270305, 859.4113032572692, 868.6438560190323, 880.828238493494, 887.4276091920707, 876.6843936183001, 877.5480627476854, 877.627008521379, 878.1481962496368, 878.9516576588285, 925.6945208081318, 926.1664501948233, 926.2589928057561, 926.9895813563214, 927.1979737527058, 905.8233644439337, 919.6137622198693, 920.4523308631353, 922.6816748221886, 924.1497822003705, 689.4139981016147, 689.8827199376118, 691.339770519153, 691.4433880726014, 693.836948317145, 15184.924075379662, 15709.921450392674, 15761.448349307833, 15912.363505459767, 16179.757303640456, 13869.4452221911, 14028.579142625738, 14052.508162214273, 14278.428862845578, 14432.0, 11315.943420282845, 11535.307881527051, 11601.07191424684, 11805.88194118065, 11934.522619095225, 3313.784604000756, 3335.616404113534, 3336.1659585103725, 3336.7664263501565, 3339.699427051553, 106015.46992265066, 110282.89717102806, 112594.43702781516, 114795.0, 115827.42086289599, 10507.422091784872, 10829.35023898553, 10905.499893307106, 10956.452177391098, 11366.886331136582, 22423.32730018102, 22862.0, 22875.08499659995, 22908.541829163325, 22985.195518156783, 7309.451791115687, 7671.654775535114, 7771.184025677222, 7772.261635144652, 7981.441299109123, 4210.59999300066, 4266.25340565406, 4286.747441524091, 4323.718958267703, 4416.29339305716, 3433.484977253382, 3516.2440075383915, 3777.660010599059, 3935.311320518898, 3992.301347264217, 704.3132945378318, 707.4552594502204, 709.4643544124257, 713.9785806425815, 722.1009842745815, 655.4232275597539, 655.4919937048825, 666.946644268467, 681.7716065118142, 708.2032713197652, 9405.529723513933, 10105.14106300958, 10143.898561014295, 10230.744231394274, 10254.179665626732, 578.6556998585835, 586.571802584116, 658.0425480925243, 690.4890381117937, 691.0015028284182, 4639.582437580634, 5061.164907790173, 5081.517255860687, 5169.379674439091, 5213.504717051874, 87873.12126878777, 88431.11568884228, 90628.0, 95544.04455955491, 114209.42895285471, 67911.3208867905, 84707.0, 87127.56436217779, 91041.08958910458, 95578.0, 72504.0, 74655.99999999891, 78286.6085669568, 80893.0, 82098.58950705208, 10221.540030698785, 10721.056026995993, 10874.238803283693, 10917.962793534602, 10979.451027448755, 51135.26159506545, 52198.73900630624, 52682.473175267754, 53478.0, 54793.0, 69379.3062069393, 69517.65241173762, 70574.0, 71082.28917710757, 72397.63801181171, 13605.319734013457, 13662.863371366158, 13719.588412347646, 14092.859071409564, 14187.716245675236, 14153.575392738234, 14223.359948802121, 14623.0, 14888.032277901902, 15015.249237538297, 11871.821922671339, 12904.16122952005, 13613.659658508617, 13990.16059036461, 14426.85573144297, 13729.588112356645, 14208.786868197192, 14251.857481425053, 14424.206668633326, 14891.70882532207, 12765.234085954873, 13579.321033948461, 14056.016078874381, 14388.35252413623, 14528.346224420138, 11242.269252498561, 11414.258073225214, 11425.428728563706, 11623.941880290882, 11844.881551184722, 11547.480363383836, 11585.88414115848, 11587.922979609159, 11882.821757673815, 11890.28658280506], "value": 7629.493868655078, "unit": "score"}], "name": "dromaeo_css", "value": 7228.989750398326, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 116.0, 115.0, 114.0, 113.0, 114.0, 115.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 138.0, 110.0, 139.0, 112.0, 114.0, 141.0, 123.0, 128.0, 108.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 184.0, 185.0, 184.0, 184.0, 187.0, 184.0, 186.0, 185.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 63.0, 59.0, 90.0, 60.0, 57.0, 59.0, 60.0, 74.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 70.0, 68.0, 71.0, 82.0, 68.0, 69.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 87.0, 84.0, 89.0, 84.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 93.0, 93.0, 94.0, 93.0, 94.0, 92.0, 116.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 87.0, 86.0, 88.0, 86.0, 88.0, 88.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 53.0, 57.0, 56.0, 57.0, 57.0, 57.0, 58.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 70.0, 76.0, 74.0, 71.0, 71.0, 72.0, 72.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 85.0, 87.0, 82.0, 81.0, 83.0, 84.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 150.0, 144.0, 140.0, 137.0, 134.0, 139.0, 142.0, 260.0, 150.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 167.0, 170.0, 165.0, 167.0, 172.0, 169.0, 170.0, 170.0, 170.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 66.0, 66.0, 64.0, 66.0, 66.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1439.6000000000001, "alertThreshold": 2.0}]} 02:29:49 INFO - Return code: 0 02:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:29:49 ERROR - # TBPL SUCCESS # 02:29:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:29:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:29:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:29:49 INFO - 2017-02-01 02:29:49.503 screenresolution[1664:10739] starting screenresolution argv=screenresolution get 02:29:49 INFO - 2017-02-01 02:29:49.505 screenresolution[1664:10739] Display 0: 1600x1200x32@60 02:29:49 INFO - 2017-02-01 02:29:49.511 screenresolution[1665:10742] starting screenresolution argv=screenresolution list 02:29:49 INFO - Available Modes on Display 0 02:29:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:29:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:29:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:29:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:29:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:29:49 INFO - Intel Iris: 02:29:49 INFO - Chipset Model: Intel Iris 02:29:49 INFO - Type: GPU 02:29:49 INFO - Bus: Built-In 02:29:49 INFO - VRAM (Dynamic, Max): 1536 MB 02:29:49 INFO - Vendor: Intel (0x8086) 02:29:49 INFO - Device ID: 0x0a2e 02:29:49 INFO - Revision ID: 0x0009 02:29:49 INFO - Displays: 02:29:49 INFO - Display: 02:29:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:29:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:29:49 INFO - Display Serial Number: 1600x1200 60 02:29:49 INFO - Main Display: Yes 02:29:49 INFO - Mirror: Off 02:29:49 INFO - Online: Yes 02:29:49 INFO - Rotation: Supported 02:29:49 INFO - Return code: 0 02:29:49 INFO - Running post-action listener: _resource_record_post_action 02:29:49 INFO - [mozharness: 2017-02-01 10:29:49.749122Z] Finished run-tests step (success) 02:29:49 INFO - Running post-run listener: _resource_record_post_run 02:29:49 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 32627712; Write bytes: 507485696; Read time: 199; Write time: 1574 02:29:49 INFO - TinderboxPrint: CPU usage
53.6% 02:29:49 INFO - TinderboxPrint: I/O read bytes / time
32,627,712 / 199 02:29:49 INFO - TinderboxPrint: I/O write bytes / time
507,485,696 / 1,574 02:29:49 INFO - TinderboxPrint: CPU idle
2,222.0 (46.4%) 02:29:49 INFO - TinderboxPrint: CPU system
960.8 (20.0%) 02:29:49 INFO - TinderboxPrint: CPU user
1,610.9 (33.6%) 02:29:49 INFO - TinderboxPrint: Swap in / out
236,769,280 / 0 02:29:49 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201085440; Write bytes: 198619136; Read time: 16037; Write time: 438 02:29:49 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31702016; Write bytes: 299052544; Read time: 187; Write time: 1102 02:29:50 INFO - Running post-run listener: _upload_blobber_files 02:29:50 INFO - Blob upload gear active. 02:29:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:29:50 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 02:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 02:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:51 INFO - (blobuploader) - INFO - Done attempting. 02:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:53 INFO - (blobuploader) - INFO - Done attempting. 02:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:54 INFO - (blobuploader) - INFO - Done attempting. 02:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:56 INFO - (blobuploader) - INFO - Done attempting. 02:29:56 INFO - (blobuploader) - INFO - Iteration through files over. 02:29:56 INFO - Return code: 0 02:29:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:29:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:29:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce22abae8ef7006194c93677c9cfd50a7330bfa5a92b0a009969ff2c08a365802805a92fdbc8b09cb694a2593444a120eb1269434fea5faef4d775f0a20610c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd7278b935ef5bf19ffed562083b3f73e0406957bf79e8fd029eda47029bf81292748500c3d142acd5a0ac3b3cf84ab6ffda407281ddb63700ba1fbaa98538e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/673df310806240fb332cff7376a24dc9b03ad5b798d12c3072b9c6620e6b2a1b12a493fc444adce08da32271b85f4f7768c5f6a5a250cba897df3a2ba187af12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a9f4d2d43e06cd830f2197c753ecf0c83b8f77d30ab75c884197b5006e0df68bb27b4aed8829e296478caccca9d67b128eda14e12097bd60cecbd0603d07d1"} 02:29:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:29:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:29:56 INFO - Contents: 02:29:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce22abae8ef7006194c93677c9cfd50a7330bfa5a92b0a009969ff2c08a365802805a92fdbc8b09cb694a2593444a120eb1269434fea5faef4d775f0a20610c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd7278b935ef5bf19ffed562083b3f73e0406957bf79e8fd029eda47029bf81292748500c3d142acd5a0ac3b3cf84ab6ffda407281ddb63700ba1fbaa98538e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/673df310806240fb332cff7376a24dc9b03ad5b798d12c3072b9c6620e6b2a1b12a493fc444adce08da32271b85f4f7768c5f6a5a250cba897df3a2ba187af12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a9f4d2d43e06cd830f2197c753ecf0c83b8f77d30ab75c884197b5006e0df68bb27b4aed8829e296478caccca9d67b128eda14e12097bd60cecbd0603d07d1"} 02:29:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:29:56 INFO - Copying logs to upload dir... 02:29:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:29:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.955046 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-01 02:29:56.605367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 02:29:56.609202) ========= 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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners TMPDIR=/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/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-Aurora/sha512/ce22abae8ef7006194c93677c9cfd50a7330bfa5a92b0a009969ff2c08a365802805a92fdbc8b09cb694a2593444a120eb1269434fea5faef4d775f0a20610c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd7278b935ef5bf19ffed562083b3f73e0406957bf79e8fd029eda47029bf81292748500c3d142acd5a0ac3b3cf84ab6ffda407281ddb63700ba1fbaa98538e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/673df310806240fb332cff7376a24dc9b03ad5b798d12c3072b9c6620e6b2a1b12a493fc444adce08da32271b85f4f7768c5f6a5a250cba897df3a2ba187af12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a9f4d2d43e06cd830f2197c753ecf0c83b8f77d30ab75c884197b5006e0df68bb27b4aed8829e296478caccca9d67b128eda14e12097bd60cecbd0603d07d1"} build_url:https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/ZUO_w9SpR4Gcgw6n8Uv28w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce22abae8ef7006194c93677c9cfd50a7330bfa5a92b0a009969ff2c08a365802805a92fdbc8b09cb694a2593444a120eb1269434fea5faef4d775f0a20610c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd7278b935ef5bf19ffed562083b3f73e0406957bf79e8fd029eda47029bf81292748500c3d142acd5a0ac3b3cf84ab6ffda407281ddb63700ba1fbaa98538e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/673df310806240fb332cff7376a24dc9b03ad5b798d12c3072b9c6620e6b2a1b12a493fc444adce08da32271b85f4f7768c5f6a5a250cba897df3a2ba187af12", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a9f4d2d43e06cd830f2197c753ecf0c83b8f77d30ab75c884197b5006e0df68bb27b4aed8829e296478caccca9d67b128eda14e12097bd60cecbd0603d07d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 02:29:56.644497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 02:29:56.644817) ========= 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.lJ0IOzhNpG/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.MmuXY75AZQ/Listeners TMPDIR=/var/folders/4x/n21ccs5d3x9dfwd381rpmnrr00000w/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.004537 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 02:29:56.692714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 02:29:56.693037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 02:29:56.693345) ========= ========= Total master_lag: 0.54 =========