builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0240 starttime: 1489616906.68 results: success (0) buildid: 20170315140636 builduid: 2ce8d55b507a4245bf14896ef4a40eab revision: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.676818) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.677283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.677562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.702984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.703370) ========= 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.dVybP1JbBx/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.KAUjFGZUj5/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-03-15 15:28:26-- 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.9M=0.001s 2017-03-15 15:28:26 (19.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154846 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.881611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.881939) ========= 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.dVybP1JbBx/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.KAUjFGZUj5/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.021668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:26.930631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-15 15:28:26.931011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dVybP1JbBx/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.KAUjFGZUj5/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-03-15 15:28:27,022 truncating revision to first 12 chars 2017-03-15 15:28:27,023 Setting DEBUG logging. 2017-03-15 15:28:27,023 attempt 1/10 2017-03-15 15:28:27,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c4d97d1bc61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 15:28:29,031 unpacking tar archive at: mozilla-central-1c4d97d1bc61/testing/mozharness/ program finished with exit code 0 elapsedTime=2.272710 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-15 15:28:29.227617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:29.227959) ========= script_repo_revision: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:29.228348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:29.228619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:29.248765) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-15 15:28:29.249200) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dVybP1JbBx/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.KAUjFGZUj5/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:28:29 INFO - MultiFileLogger online at 20170315 15:28:29 in /builds/slave/test 15:28:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:28:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:29 INFO - {'append_to_log': False, 15:28:29 INFO - 'base_work_dir': '/builds/slave/test', 15:28:29 INFO - 'blob_upload_branch': 'Firefox', 15:28:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:29 INFO - 'branch': 'Firefox', 15:28:29 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:29 INFO - 'config_files': ('talos/mac_config.py',), 15:28:29 INFO - 'default_actions': ('clobber', 15:28:29 INFO - 'read-buildbot-config', 15:28:29 INFO - 'download-and-extract', 15:28:29 INFO - 'populate-webroot', 15:28:29 INFO - 'create-virtualenv', 15:28:29 INFO - 'install', 15:28:29 INFO - 'run-tests'), 15:28:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:29 INFO - 'download_minidump_stackwalk': True, 15:28:29 INFO - 'download_symbols': 'ondemand', 15:28:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:29 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:29 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:29 INFO - 'gecko_profile': False, 15:28:29 INFO - 'gecko_profile_interval': 0, 15:28:29 INFO - 'installer_path': 'installer.exe', 15:28:29 INFO - 'log_level': 'info', 15:28:29 INFO - 'log_name': 'talos', 15:28:29 INFO - 'log_to_console': True, 15:28:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:28:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:28:29 INFO - 'opt_config_files': (), 15:28:29 INFO - 'pip_index': False, 15:28:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:28:29 INFO - 'cmd': ('bash', 15:28:29 INFO - '-c', 15:28:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:28:29 INFO - 'enabled': True, 15:28:29 INFO - 'halt_on_failure': False, 15:28:29 INFO - 'name': 'check_screen_resolution'},), 15:28:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:28:29 INFO - 'cmd': ('bash', 15:28:29 INFO - '-c', 15:28:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:28:29 INFO - 'enabled': True, 15:28:29 INFO - 'halt_on_failure': False, 15:28:29 INFO - 'name': 'check_screen_resolution'},), 15:28:29 INFO - 'run_cmd_checks_enabled': True, 15:28:29 INFO - 'suite': 'dromaeojs', 15:28:29 INFO - 'system_bits': '32', 15:28:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:29 INFO - 'title': 't-yosemite-r7-0240', 15:28:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:29 INFO - 'use_talos_json': True, 15:28:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:29 INFO - 'work_dir': 'build'} 15:28:29 INFO - [mozharness: 2017-03-15 22:28:29.461134Z] Running clobber step. 15:28:29 INFO - Running pre-action listener: _resource_record_pre_action 15:28:29 INFO - Running main action method: clobber 15:28:29 INFO - rmtree: /builds/slave/test/build 15:28:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:31 INFO - Running post-action listener: _resource_record_post_action 15:28:31 INFO - [mozharness: 2017-03-15 22:28:31.500309Z] Finished clobber step (success) 15:28:31 INFO - [mozharness: 2017-03-15 22:28:31.500438Z] Running read-buildbot-config step. 15:28:31 INFO - Running pre-action listener: _resource_record_pre_action 15:28:31 INFO - Running main action method: read_buildbot_config 15:28:31 INFO - Using buildbot properties: 15:28:31 INFO - { 15:28:31 INFO - "project": "", 15:28:31 INFO - "product": "firefox", 15:28:31 INFO - "script_repo_revision": "production", 15:28:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:28:31 INFO - "repository": "", 15:28:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:28:31 INFO - "buildid": "20170315140636", 15:28:31 INFO - "pgo_build": "False", 15:28:31 INFO - "basedir": "/builds/slave/test", 15:28:31 INFO - "buildnumber": 47, 15:28:31 INFO - "slavename": "t-yosemite-r7-0240", 15:28:31 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:28:31 INFO - "platform": "yosemite_r7", 15:28:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:28:31 INFO - "branch": "mozilla-central", 15:28:31 INFO - "repo_path": "mozilla-central", 15:28:31 INFO - "revision": "1c4d97d1bc61468c82e55a09bab660e52bb2e9b5", 15:28:31 INFO - "stage_platform": "macosx64", 15:28:31 INFO - "builduid": "2ce8d55b507a4245bf14896ef4a40eab", 15:28:31 INFO - "slavebuilddir": "test" 15:28:31 INFO - } 15:28:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:28:31 INFO - Running post-action listener: _resource_record_post_action 15:28:31 INFO - [mozharness: 2017-03-15 22:28:31.503656Z] Finished read-buildbot-config step (success) 15:28:31 INFO - [mozharness: 2017-03-15 22:28:31.503768Z] Running download-and-extract step. 15:28:31 INFO - Running pre-action listener: _resource_record_pre_action 15:28:31 INFO - Running main action method: download_and_extract 15:28:31 INFO - mkdir: /builds/slave/test/build/tests 15:28: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')]} 15:28:31 INFO - trying https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:28:31 INFO - Downloading https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:28:32 INFO - Downloaded 1199 bytes. 15:28:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:28:32 INFO - Using the following test package requirements: 15:28:32 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:28:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:28:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:28:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'jsshell-mac.zip'], 15:28:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:28:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:28:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:28:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:28:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:28:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:28:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:28:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:28:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:28:32 INFO - Fetch https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:28:34 INFO - Expected file size: 52474331 15:28:34 INFO - Obtained file size: 52474331 15:28:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:28:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:28:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:28:50 INFO - Fetch https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:28:52 INFO - Expected file size: 52474331 15:28:52 INFO - Obtained file size: 52474331 15:29:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:29:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:29:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:29:09 INFO - Expected file size: 14404452 15:29:09 INFO - Obtained file size: 14404452 15:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:10 INFO - trying https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:29:10 INFO - Downloading https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:29:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:29:12 INFO - Downloaded 75086874 bytes. 15:29:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:29:12 INFO - mkdir: /builds/slave/test/properties 15:29:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:29:12 INFO - Writing to file /builds/slave/test/properties/build_url 15:29:12 INFO - Contents: 15:29:12 INFO - build_url:https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:29:12 INFO - Running post-action listener: _resource_record_post_action 15:29:12 INFO - Running post-action listener: set_extra_try_arguments 15:29:12 INFO - [mozharness: 2017-03-15 22:29:12.797900Z] Finished download-and-extract step (success) 15:29:12 INFO - [mozharness: 2017-03-15 22:29:12.798023Z] Running populate-webroot step. 15:29:12 INFO - Running pre-action listener: _resource_record_pre_action 15:29:12 INFO - Running main action method: populate_webroot 15:29:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:29:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:29:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:29:12 INFO - '--tppagecycles', 15:29:12 INFO - '7'], 15:29:12 INFO - 'tests': ['tsvgm']}}, 15:29:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:29:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:29:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:29:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:29:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:29:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['damp', 'tps']}, 15:29:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'tests': ['damp', 'tps']}, 15:29:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['dromaeo_dom']}, 15:29:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:29:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['basic_compositor_video']}, 15:29:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:29:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['a11yr', 15:29:12 INFO - 'ts_paint', 15:29:12 INFO - 'tpaint', 15:29:12 INFO - 'sessionrestore', 15:29:12 INFO - 'sessionrestore_no_auto_restore', 15:29:12 INFO - 'tabpaint']}, 15:29:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:29:12 INFO - 'ts_paint', 15:29:12 INFO - 'tpaint', 15:29:12 INFO - 'sessionrestore', 15:29:12 INFO - 'sessionrestore_no_auto_restore', 15:29:12 INFO - 'tabpaint']}, 15:29:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:29:12 INFO - 'ts_paint', 15:29:12 INFO - 'tpaint', 15:29:12 INFO - 'sessionrestore', 15:29:12 INFO - 'sessionrestore_no_auto_restore', 15:29:12 INFO - 'tabpaint']}, 15:29:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:29:12 INFO - 'ts_paint', 15:29:12 INFO - 'tpaint', 15:29:12 INFO - 'sessionrestore', 15:29:12 INFO - 'sessionrestore_no_auto_restore', 15:29:12 INFO - 'tabpaint']}, 15:29:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['a11yr', 15:29:12 INFO - 'ts_paint', 15:29:12 INFO - 'tpaint', 15:29:12 INFO - 'sessionrestore', 15:29:12 INFO - 'sessionrestore_no_auto_restore', 15:29:12 INFO - 'tabpaint']}, 15:29:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['a11yr', 15:29:12 INFO - 'ts_paint', 15:29:12 INFO - 'tpaint', 15:29:12 INFO - 'sessionrestore', 15:29:12 INFO - 'sessionrestore_no_auto_restore', 15:29:12 INFO - 'tabpaint']}, 15:29:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['tsvgx', 15:29:12 INFO - 'tsvgr_opacity', 15:29:12 INFO - 'tart', 15:29:12 INFO - 'tscrollx', 15:29:12 INFO - 'cart', 15:29:12 INFO - 'tsvg_static']}, 15:29:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:29:12 INFO - 'tsvgr_opacity', 15:29:12 INFO - 'tart', 15:29:12 INFO - 'tscrollx', 15:29:12 INFO - 'cart', 15:29:12 INFO - 'tsvg_static']}, 15:29:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'talos_options': ['--disable-e10s'], 15:29:12 INFO - 'tests': ['tp5o']}, 15:29:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:29:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'talos_options': ['--disable-e10s', 15:29:12 INFO - '--xperf_path', 15:29:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:12 INFO - 'tests': ['tp5n']}, 15:29:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:29:12 INFO - 'talos_options': ['--xperf_path', 15:29:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:29:12 INFO - 'tests': ['tp5n']}}, 15:29:12 INFO - 'talos.zip': {'path': '', 15:29:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:29:12 INFO - Running post-action listener: _resource_record_post_action 15:29:12 INFO - [mozharness: 2017-03-15 22:29:12.816546Z] Finished populate-webroot step (success) 15:29:12 INFO - [mozharness: 2017-03-15 22:29:12.816669Z] Running create-virtualenv step. 15:29:12 INFO - Running pre-action listener: _resource_record_pre_action 15:29:12 INFO - Running main action method: create_virtualenv 15:29:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:29:12 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 15:29:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:29:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:29:12 INFO - Using real prefix '/tools/python27' 15:29:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:29:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:29:16 INFO - Installing pip.................done. 15:29:16 INFO - Return code: 0 15:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:29:16 INFO - Reading from file tmpfile_stdout 15:29:16 INFO - Output received: 15:29:16 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) 15:29:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:29:16 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')]} 15:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:16 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')]} 15:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:16 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:16 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 15:29:16 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 15:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:16 INFO - 'HOME': '/Users/cltbld', 15:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:16 INFO - 'LOGNAME': 'cltbld', 15:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:16 INFO - 'MOZ_NO_REMOTE': '1', 15:29:16 INFO - 'NO_EM_RESTART': '1', 15:29:16 INFO - 'PAGER': '/bin/cat', 15:29:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:16 INFO - 'PWD': '/builds/slave/test', 15:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:16 INFO - 'SHELL': '/bin/bash', 15:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:16 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:16 INFO - 'USER': 'cltbld', 15:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:16 INFO - 'XPC_FLAGS': '0x0', 15:29:16 INFO - 'XPC_SERVICE_NAME': '0', 15:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:17 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 15:29:17 INFO - Cleaning up... 15:29:17 INFO - Return code: 0 15:29:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:29:17 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')]} 15:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:17 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')]} 15:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:17 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:17 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 15:29:17 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 15:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:17 INFO - 'HOME': '/Users/cltbld', 15:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:17 INFO - 'LOGNAME': 'cltbld', 15:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:17 INFO - 'MOZ_NO_REMOTE': '1', 15:29:17 INFO - 'NO_EM_RESTART': '1', 15:29:17 INFO - 'PAGER': '/bin/cat', 15:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:17 INFO - 'PWD': '/builds/slave/test', 15:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:17 INFO - 'SHELL': '/bin/bash', 15:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:17 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:17 INFO - 'USER': 'cltbld', 15:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:17 INFO - 'XPC_FLAGS': '0x0', 15:29:17 INFO - 'XPC_SERVICE_NAME': '0', 15:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:17 INFO - Downloading/unpacking psutil>=3.1.1 15:29:17 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 15:29:17 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 15:29:17 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 15:29:17 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 15:29:17 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 15:29:17 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 15:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:20 INFO - Installing collected packages: psutil 15:29:20 INFO - Running setup.py install for psutil 15:29:20 INFO - building 'psutil._psutil_osx' extension 15:29:20 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 15:29:21 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 15:29:21 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 15:29:21 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 15:29:21 INFO - building 'psutil._psutil_posix' extension 15:29:21 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 15:29:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:29:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:29:21 INFO - ^ 15:29:21 INFO - 1 warning generated. 15:29:21 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 15:29:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:21 INFO - Successfully installed psutil 15:29:21 INFO - Cleaning up... 15:29:21 INFO - Return code: 0 15:29:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:29: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')]} 15:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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')]} 15:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:29: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 mozsystemmonitor==0.3 15:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:21 INFO - 'HOME': '/Users/cltbld', 15:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:21 INFO - 'LOGNAME': 'cltbld', 15:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:21 INFO - 'MOZ_NO_REMOTE': '1', 15:29:21 INFO - 'NO_EM_RESTART': '1', 15:29:21 INFO - 'PAGER': '/bin/cat', 15:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:21 INFO - 'PWD': '/builds/slave/test', 15:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:21 INFO - 'SHELL': '/bin/bash', 15:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:21 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:21 INFO - 'USER': 'cltbld', 15:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:21 INFO - 'XPC_FLAGS': '0x0', 15:29:21 INFO - 'XPC_SERVICE_NAME': '0', 15:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:29:22 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 15:29:22 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 15:29:22 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 15:29:22 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 15:29:22 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 15:29:22 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 15:29:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:29:24 INFO - Installing collected packages: mozsystemmonitor 15:29:24 INFO - Running setup.py install for mozsystemmonitor 15:29:24 INFO - Successfully installed mozsystemmonitor 15:29:24 INFO - Cleaning up... 15:29:24 INFO - Return code: 0 15:29:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:25 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')]} 15:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:25 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:25 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 15:29:25 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 15:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:25 INFO - 'HOME': '/Users/cltbld', 15:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:25 INFO - 'LOGNAME': 'cltbld', 15:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:25 INFO - 'MOZ_NO_REMOTE': '1', 15:29:25 INFO - 'NO_EM_RESTART': '1', 15:29:25 INFO - 'PAGER': '/bin/cat', 15:29:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:25 INFO - 'PWD': '/builds/slave/test', 15:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:25 INFO - 'SHELL': '/bin/bash', 15:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:25 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:25 INFO - 'USER': 'cltbld', 15:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:25 INFO - 'XPC_FLAGS': '0x0', 15:29:25 INFO - 'XPC_SERVICE_NAME': '0', 15:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:29:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:29:29 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 15:29:29 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 15:29:29 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 15:29:29 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 15:29:29 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 15:29:29 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 15:29:29 INFO - Downloading functools32-3.2.3-2.tar.gz 15:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:29:29 INFO - warning: no files found matching '*.txt' 15:29:29 INFO - no previously-included directories found matching 'build' 15:29:29 INFO - no previously-included directories found matching 'dist' 15:29:29 INFO - no previously-included directories found matching '.git*' 15:29:29 INFO - Installing collected packages: jsonschema, functools32 15:29:29 INFO - Running setup.py install for functools32 15:29:29 INFO - warning: no files found matching '*.txt' 15:29:29 INFO - no previously-included directories found matching 'build' 15:29:29 INFO - no previously-included directories found matching 'dist' 15:29:29 INFO - no previously-included directories found matching '.git*' 15:29:29 INFO - Successfully installed jsonschema functools32 15:29:29 INFO - Cleaning up... 15:29:29 INFO - Return code: 0 15:29:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:29 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:29 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 15:29:29 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 15:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:29 INFO - 'HOME': '/Users/cltbld', 15:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:29 INFO - 'LOGNAME': 'cltbld', 15:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:29 INFO - 'MOZ_NO_REMOTE': '1', 15:29:29 INFO - 'NO_EM_RESTART': '1', 15:29:29 INFO - 'PAGER': '/bin/cat', 15:29:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:29 INFO - 'PWD': '/builds/slave/test', 15:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:29 INFO - 'SHELL': '/bin/bash', 15:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:29 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:29 INFO - 'USER': 'cltbld', 15:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:29 INFO - 'XPC_FLAGS': '0x0', 15:29:29 INFO - 'XPC_SERVICE_NAME': '0', 15:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:29:30 INFO - Cleaning up... 15:29:30 INFO - Return code: 0 15:29:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:29:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:30 INFO - 'HOME': '/Users/cltbld', 15:29:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:30 INFO - 'LOGNAME': 'cltbld', 15:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:30 INFO - 'MOZ_NO_REMOTE': '1', 15:29:30 INFO - 'NO_EM_RESTART': '1', 15:29:30 INFO - 'PAGER': '/bin/cat', 15:29:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:30 INFO - 'PWD': '/builds/slave/test', 15:29:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:30 INFO - 'SHELL': '/bin/bash', 15:29:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:30 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:30 INFO - 'USER': 'cltbld', 15:29:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:30 INFO - 'XPC_FLAGS': '0x0', 15:29:30 INFO - 'XPC_SERVICE_NAME': '0', 15:29:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:30 INFO - Downloading/unpacking blobuploader==1.2.4 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:32 INFO - Downloading blobuploader-1.2.4.tar.gz 15:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:29:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:29:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 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 15:29:33 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 15:29:34 INFO - Downloading docopt-0.6.1.tar.gz 15:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:29:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:29:34 INFO - Running setup.py install for blobuploader 15:29:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:29:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:29:34 INFO - Running setup.py install for requests 15:29:34 INFO - Running setup.py install for docopt 15:29:35 INFO - Successfully installed blobuploader requests docopt 15:29:35 INFO - Cleaning up... 15:29:35 INFO - Return code: 0 15:29:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29: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')]} 15:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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')]} 15:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:35 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:35 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 15:29:35 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 15:29:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:35 INFO - 'HOME': '/Users/cltbld', 15:29:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:35 INFO - 'LOGNAME': 'cltbld', 15:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:35 INFO - 'MOZ_NO_REMOTE': '1', 15:29:35 INFO - 'NO_EM_RESTART': '1', 15:29:35 INFO - 'PAGER': '/bin/cat', 15:29:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:35 INFO - 'PWD': '/builds/slave/test', 15:29:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:35 INFO - 'SHELL': '/bin/bash', 15:29:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:35 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:35 INFO - 'USER': 'cltbld', 15:29:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:35 INFO - 'XPC_FLAGS': '0x0', 15:29:35 INFO - 'XPC_SERVICE_NAME': '0', 15:29:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-JGwKN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Nt4GoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-cXDCI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-W8t1k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-U3pEzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-mZkWDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-sXX1qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-foG_mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-C2Gisa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-84BoY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-f89F6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-pacH5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-uM6Gy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ear8nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-7g8EzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:37 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-oCwIoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:37 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-79mEop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:29:37 INFO - Running setup.py install for manifestparser 15:29:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Running setup.py install for mozcrash 15:29:37 INFO - Running setup.py install for mozdebug 15:29:37 INFO - Running setup.py install for mozdevice 15:29:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:29:37 INFO - Running setup.py install for mozfile 15:29:38 INFO - Running setup.py install for mozhttpd 15:29:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Running setup.py install for mozinfo 15:29:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Running setup.py install for mozInstall 15:29:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Running setup.py install for mozleak 15:29:38 INFO - Running setup.py install for mozlog 15:29:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Running setup.py install for moznetwork 15:29:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:29:38 INFO - Running setup.py install for mozprocess 15:29:39 INFO - Running setup.py install for mozprofile 15:29:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:29:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:29:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:29:39 INFO - Running setup.py install for mozrunner 15:29:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:29:39 INFO - Running setup.py install for mozscreenshot 15:29:39 INFO - Running setup.py install for moztest 15:29:39 INFO - Running setup.py install for mozversion 15:29:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:29:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:39 INFO - Cleaning up... 15:29:39 INFO - Return code: 0 15:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:39 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')]} 15:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:39 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')]} 15:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:39 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:39 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 15:29:39 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 15:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:39 INFO - 'HOME': '/Users/cltbld', 15:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:39 INFO - 'LOGNAME': 'cltbld', 15:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:39 INFO - 'MOZ_NO_REMOTE': '1', 15:29:39 INFO - 'NO_EM_RESTART': '1', 15:29:39 INFO - 'PAGER': '/bin/cat', 15:29:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:39 INFO - 'PWD': '/builds/slave/test', 15:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:39 INFO - 'SHELL': '/bin/bash', 15:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:39 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:39 INFO - 'USER': 'cltbld', 15:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:39 INFO - 'XPC_FLAGS': '0x0', 15:29:39 INFO - 'XPC_SERVICE_NAME': '0', 15:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Chrv9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-SobQgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Vw9Fzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-AoftH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-DdqzHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-B99a6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-sWVVtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:40 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)) 15:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-amCuNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-UdardT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-AxkXQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-6Mkc8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-0dRXKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-XFiLoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-g1RKf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-bqfpBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-3tgVJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:41 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)) 15:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-_8O31c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:42 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)) 15:29:42 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)) 15:29:42 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)) 15:29:42 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)) 15:29:42 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)) 15:29:42 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)) 15:29:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:44 INFO - Downloading blessings-1.6.tar.gz 15:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:44 INFO - Installing collected packages: blessings 15:29:44 INFO - Running setup.py install for blessings 15:29:44 INFO - Successfully installed blessings 15:29:44 INFO - Cleaning up... 15:29:45 INFO - Return code: 0 15:29:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:45 INFO - Reading from file tmpfile_stdout 15:29:45 INFO - Current package versions: 15:29:45 INFO - blessings == 1.6 15:29:45 INFO - blobuploader == 1.2.4 15:29:45 INFO - docopt == 0.6.1 15:29:45 INFO - functools32 == 3.2.3-2 15:29:45 INFO - jsonschema == 2.5.1 15:29:45 INFO - manifestparser == 1.1 15:29:45 INFO - mozInstall == 1.12 15:29:45 INFO - mozcrash == 1.0 15:29:45 INFO - mozdebug == 0.1 15:29:45 INFO - mozdevice == 0.49 15:29:45 INFO - mozfile == 1.2 15:29:45 INFO - mozhttpd == 0.7 15:29:45 INFO - mozinfo == 0.9 15:29:45 INFO - mozleak == 0.1 15:29:45 INFO - mozlog == 3.4 15:29:45 INFO - moznetwork == 0.27 15:29:45 INFO - mozprocess == 0.25 15:29:45 INFO - mozprofile == 0.28 15:29:45 INFO - mozrunner == 6.13 15:29:45 INFO - mozscreenshot == 0.1 15:29:45 INFO - mozsystemmonitor == 0.3 15:29:45 INFO - moztest == 0.8 15:29:45 INFO - mozversion == 1.4 15:29:45 INFO - psutil == 3.1.1 15:29:45 INFO - requests == 1.2.3 15:29:45 INFO - wsgiref == 0.1.2 15:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:45 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 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:45 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 15:29:45 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 15:29:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:45 INFO - 'HOME': '/Users/cltbld', 15:29:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:45 INFO - 'LOGNAME': 'cltbld', 15:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:45 INFO - 'MOZ_NO_REMOTE': '1', 15:29:45 INFO - 'NO_EM_RESTART': '1', 15:29:45 INFO - 'PAGER': '/bin/cat', 15:29:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:45 INFO - 'PWD': '/builds/slave/test', 15:29:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:45 INFO - 'SHELL': '/bin/bash', 15:29:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:45 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:45 INFO - 'USER': 'cltbld', 15:29:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:45 INFO - 'XPC_FLAGS': '0x0', 15:29:45 INFO - 'XPC_SERVICE_NAME': '0', 15:29:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 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)) 15:29:45 INFO - Cleaning up... 15:29:45 INFO - Return code: 0 15:29:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10292db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102930768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb0849f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, '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.dVybP1JbBx/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.KAUjFGZUj5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 15:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:29:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:29:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:45 INFO - 'HOME': '/Users/cltbld', 15:29:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:45 INFO - 'LOGNAME': 'cltbld', 15:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:45 INFO - 'MOZ_NO_REMOTE': '1', 15:29:45 INFO - 'NO_EM_RESTART': '1', 15:29:45 INFO - 'PAGER': '/bin/cat', 15:29:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:45 INFO - 'PWD': '/builds/slave/test', 15:29:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:45 INFO - 'SHELL': '/bin/bash', 15:29:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:29:45 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:29:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:45 INFO - 'USER': 'cltbld', 15:29:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:45 INFO - 'XPC_FLAGS': '0x0', 15:29:45 INFO - 'XPC_SERVICE_NAME': '0', 15:29:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:29:45 INFO - Cleaning up... 15:29:45 INFO - Return code: 0 15:29:45 INFO - Running post-action listener: _resource_record_post_action 15:29:45 INFO - Running post-action listener: _start_resource_monitoring 15:29:45 INFO - Starting resource monitoring. 15:29:45 INFO - [mozharness: 2017-03-15 22:29:45.876995Z] Finished create-virtualenv step (success) 15:29:45 INFO - [mozharness: 2017-03-15 22:29:45.877978Z] Running install step. 15:29:45 INFO - Running pre-action listener: _resource_record_pre_action 15:29:45 INFO - Running main action method: install 15:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:46 INFO - Reading from file tmpfile_stdout 15:29:46 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:29:46 INFO - Reading from file tmpfile_stdout 15:29:46 INFO - Output received: 15:29:46 INFO - Usage: mozinstall [options] installer 15:29:46 INFO - Options: 15:29:46 INFO - -h, --help show this help message and exit 15:29:46 INFO - -d DEST, --destination=DEST 15:29:46 INFO - Directory to install application into. [default: 15:29:46 INFO - "/builds/slave/test"] 15:29:46 INFO - --app=APP Application being installed. [default: firefox] 15:29:46 INFO - mkdir: /builds/slave/test/build/application 15:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:30:06 INFO - Reading from file tmpfile_stdout 15:30:06 INFO - Output received: 15:30:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:30:06 INFO - Running post-action listener: _resource_record_post_action 15:30:06 INFO - [mozharness: 2017-03-15 22:30:06.263542Z] Finished install step (success) 15:30:06 INFO - [mozharness: 2017-03-15 22:30:06.263687Z] Running run-tests step. 15:30:06 INFO - Running pre-action listener: _resource_record_pre_action 15:30:06 INFO - Running main action method: run_tests 15:30:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:30:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:30:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:30:06 INFO - 2017-03-15 15:30:06.278 screenresolution[2234:25229] starting screenresolution argv=screenresolution get 15:30:06 INFO - 2017-03-15 15:30:06.280 screenresolution[2234:25229] Display 0: 1600x1200x32@60 15:30:06 INFO - 2017-03-15 15:30:06.286 screenresolution[2235:25232] starting screenresolution argv=screenresolution list 15:30:06 INFO - Available Modes on Display 0 15:30:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:30:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:30:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:30:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:30:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:30:06 INFO - Intel Iris: 15:30:06 INFO - Chipset Model: Intel Iris 15:30:06 INFO - Type: GPU 15:30:06 INFO - Bus: Built-In 15:30:06 INFO - VRAM (Dynamic, Max): 1536 MB 15:30:06 INFO - Vendor: Intel (0x8086) 15:30:06 INFO - Device ID: 0x0a2e 15:30:06 INFO - Revision ID: 0x0009 15:30:06 INFO - Displays: 15:30:06 INFO - Display: 15:30:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:30:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:30:06 INFO - Display Serial Number: 1600x1200 60 15:30:06 INFO - Main Display: Yes 15:30:06 INFO - Mirror: Off 15:30:06 INFO - Online: Yes 15:30:06 INFO - Rotation: Supported 15:30:06 INFO - Return code: 0 15:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:30:06 INFO - Python 2.7.3 15:30:06 INFO - Return code: 0 15:30:06 INFO - grabbing minidump binary from tooltool 15:30:06 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')]} 15:30:06 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 0x10270bd30>, '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 0x102632db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102700be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:30:06 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 15:30:06 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 15:30:06 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 15:30:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:30:06 INFO - Return code: 0 15:30:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:30:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:30:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:30:06 INFO - ENV: RUST_BACKTRACE is now 1 15:30:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:30:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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 15:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0240 --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 15:30:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dVybP1JbBx/Render', 15:30:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:30:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:30:06 INFO - 'HOME': '/Users/cltbld', 15:30:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:30:06 INFO - 'LOGNAME': 'cltbld', 15:30:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:30:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:06 INFO - 'MOZ_NO_REMOTE': '1', 15:30:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:30:06 INFO - 'NO_EM_RESTART': '1', 15:30:06 INFO - 'PAGER': '/bin/cat', 15:30:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:06 INFO - 'PWD': '/builds/slave/test', 15:30:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:30:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:30:06 INFO - 'RUST_BACKTRACE': '1', 15:30:06 INFO - 'SHELL': '/bin/bash', 15:30:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KAUjFGZUj5/Listeners', 15:30:06 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 15:30:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:30:06 INFO - 'USER': 'cltbld', 15:30:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:30:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:06 INFO - 'XPC_FLAGS': '0x0', 15:30:06 INFO - 'XPC_SERVICE_NAME': '0', 15:30:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:30:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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 15:30:06 INFO - mozversion application_buildid: 20170315140636 15:30:06 INFO - mozversion application_changeset: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 15:30:06 INFO - mozversion application_display_name: Nightly 15:30:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:30:06 INFO - mozversion application_name: Firefox 15:30:06 INFO - mozversion application_remotingname: firefox 15:30:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:30:06 INFO - mozversion application_vendor: Mozilla 15:30:06 INFO - mozversion application_version: 55.0a1 15:30:06 INFO - mozversion platform_buildid: 20170315140636 15:30:06 INFO - mozversion platform_changeset: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 15:30:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:30:06 INFO - mozversion platform_version: 55.0a1 15:30:06 INFO - using testdate: 1489617006 15:30:06 INFO - actual date: 1489617006 15:30:06 INFO - starting webserver on 'localhost:57439' 15:30:06 INFO - SUITE-START | Running 2 tests 15:30:06 INFO - TEST-START | dromaeo_css 15:30:06 INFO - operating with platform_type : mac_ 15:30:06 INFO - Initialising browser for dromaeo_css test... 15:30:06 INFO - TEST-INFO | started process 2245 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpqskjGS/profile http://localhost:57439/getInfo.html) 15:30:09 INFO - PID 2245 | __metrics Screen width/height:1600/1200 15:30:09 INFO - PID 2245 | colorDepth:24 15:30:09 INFO - PID 2245 | Browser inner width/height: 1024/689 15:30:09 INFO - PID 2245 | __metrics 15:30:09 INFO - PID 2245 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:30:09 INFO - PID 2245 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:30:10 INFO - TEST-INFO | 2245: exit 0 15:30:10 INFO - Browser initialized. 15:30:10 INFO - Running cycle 1/1 for dromaeo_css test... 15:30:10 INFO - TEST-INFO | started process 2247 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpqskjGS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:22 INFO - PID 2247 | RSS: Main: 233684992 15:30:22 INFO - PID 2247 | 15:33:26 INFO - PID 2247 | Cycle 1(1): loaded http://localhost:57439/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57439/tests/dromaeo/cssquery-ext.html) 15:33:28 INFO - PID 2247 | RSS: Main: 400629760 15:33:28 INFO - PID 2247 | 15:35:12 INFO - PID 2247 | ************************* 15:35:12 INFO - PID 2247 | A coding exception was thrown and uncaught in a Task. 15:35:12 INFO - PID 2247 | 15:35:12 ERROR - PID 2247 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:35:12 INFO - PID 2247 | Full stack: 15:35:12 INFO - PID 2247 | ************************* 15:36:31 INFO - PID 2247 | Cycle 1(1): loaded http://localhost:57439/tests/dromaeo/cssquery-ext.html (next: http://localhost:57439/tests/dromaeo/cssquery-jquery.html) 15:36:32 INFO - PID 2247 | RSS: Main: 387637248 15:36:32 INFO - PID 2247 | 15:39:34 INFO - PID 2247 | Cycle 1(1): loaded http://localhost:57439/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57439/tests/dromaeo/cssquery-mootools.html) 15:39:35 INFO - PID 2247 | RSS: Main: 347242496 15:39:35 INFO - PID 2247 | 15:42:37 INFO - PID 2247 | Cycle 1(1): loaded http://localhost:57439/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57439/tests/dromaeo/cssquery-prototype.html) 15:42:38 INFO - PID 2247 | RSS: Main: 343916544 15:42:38 INFO - PID 2247 | 15:45:42 INFO - PID 2247 | Cycle 1(1): loaded http://localhost:57439/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57439/tests/dromaeo/cssquery-yui.html) 15:45:42 INFO - PID 2247 | RSS: Main: 332787712 15:45:42 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | Cycle 1(1): loaded http://localhost:57439/tests/dromaeo/cssquery-yui.html (next: http://localhost:57439/tests/dromaeo/cssquery-dojo.html) 15:48:46 INFO - PID 2247 | RSS: Main: 440643584 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | __start_tp_report 15:48:46 INFO - PID 2247 | _x_x_mozilla_page_load 15:48:46 INFO - PID 2247 | _x_x_mozilla_page_load_details 15:48:46 INFO - PID 2247 | |i|pagename|runs| 15:48:46 INFO - PID 2247 | |0;dojo.html;2754.3114221444653;3193.425183466976;3329.850156742946;3338.7829791063596;3346.782459140156;5545.390007099226;5660.886782264357;5676.403977582346;5680.517156041741;5727.713614319288;4742.668013239075;5704.429557044294;5804.738786754596;5816.651000939946;5830.825075247739;5148.716820574867;5195.116830138885;5224.39919409269;5229.346331708536;5230.163173892178;5337.866553336178;5383.43473935235;5406.864828379283;5425.403205647375;5427.891442171154;5081.898362032757;5151.7681704323395;5167.966406718634;5230.503102205284;5372.462753724616;4347.456567929009;5229.686218826882;5253.343332083489;5303.681779093266;5343.866403339909;5185.585153187736;5192.688438693653;5197.58419326453;5201.45384734605;5242.344706911636;5657.377688454267;5690.772369105231;5822.854428639275;5824.534037277008;5832.737526811304;6139.798803208747;6145.8156255312415;6175;6181.412765787243;6185.907211391833;6167.907481387782;6214.813555593294;6221.906671399933;6230.875382492325;6231.252249730016;5910.320313164041;5955.702214889238;5973.074173503114;5981.461668449817;6037.54718396122;6182.412670796267;6182.752689892444;6234.189555357865;6281.026440901667;6285.622862628165;5116.411612664517;6102.405211622897;6106;6147.323794382614;6163.890499710005;6150.969245153835;6191.226096737908;6194.721237544321;6204.565680402418;6222.408871157233;6107.541934354941;6180;6193.1329613854095;6195.101710252078;6205.348438413992;6125.551374386306;6185.257769067741;6193.411625895533;6203.906941395882;6204.3795620437595;5005.224190250517;5024.924626130538;5030.84907452777;5031.949680503149;5034.773435195425;4477.2164871147415;4509.571590698878;4510.819567217274;4526.841560545365;4530.048689775184;5948.839976204598;5957.731902064417;5963.016102343065;5973.745513442226;6005.279366476051;6169.907451388232;6221.3778622138325;6237.345078766755;6237.376262373727;6252.562320637603;5771.451712087345;5820.24336836217;5826.650400975955;5838.416158384128;5999.160117583542;5448.863778405493;5451.018816613047;5453.972730136324;5454.10007348791;5460.34475862899;6251.9687401562705;6279.937200628026;6283.748650054038;6284.905726414016;6285.779997700059;6181.783637572664;6185.969070154621;6201.534884883562;6203;6205.348438413902;6337.746490140527;6339.619622822645;6341.714622841891;6359.04614307839;6364.427201551697;5207.609429292743;6165.229346331708;6184.5980011299125;6213.099100630293;6219.626822390671;6043.3050199227655;6186.19579454686;6190.721417536131;6194.81415557534;6209.968950155401;6063.787767428119;6160.784372547118;6173.876522469615;6196.597221180609;6199.659018754011;6011.90982135277;6012.338642749207;6112.816615501542;6113.144159817718;6113.816585502442;5950.19672344228;6037.516998640011;6040.305364883095;6119.418655227746;6123.08153776937;6137.597768146302;6177.4749146323065;6200.534959877937;6216.595921265103;6219.595726277777;6091.116788065794;6094.695265236809;6101.786437474667;6103.694815259308;6106.542009349228 15:48:46 INFO - PID 2247 | |1;ext.html;726.4261233625436;773.2229109744706;795.5743677132735;858.098996054143;871.0331531999476;27370.17889463317;37381.43927841084;37663;37762.43356349657;37823.24353512928;38625.45498180069;39029.82910512682;39088.02279943003;39185.60814391855;39230.607693923055;7076.115485564304;8952.999999999984;9175.357724959222;9197.770055748626;9201.539923003857;7232.8191795205275;10490.527926243338;10720.410377429238;10729.980651838101;10738.013467508497;10817.134629229642;10856.78286434271;10876.238663293572;10893.128549716004;10919.781604367909;10771.83842242367;10846.29499082561;10868.6195983141;10869.619563315326;10877.67366978992;7045.612491312976;7216.314450127282;10431.21765867563;10617.57529698811;10648.41433721145;32369.6763032369;36983;37300.62699372999;37334.813325933195;37344.43983340252;3396.3886500429912;3715.491007615267;3799.563050249229;3822.2546603412347;3844.942325865114;27283.41787668297;27510.724892751015;27879.303017424525;28517.857410712815;28577.428451431064;3040.331127152023;3042.7870049096573;3068.4197638216338;3096.4735994880925;3183.8567264473154;232882;299100.99999999785;305503;306838;307720;49027.509724902295;49100.75449622729;49117.77205569889;49136.62950557445;49161.754191228814;51053.48946510562;51139.74430127825;51263.48736512662;51295;51449.742751286;14028;14373;14383.208923509308;14389.920755943345;14400.639984000274;9983.850242246372;11819.88180118205;11840.348780817138;11843.822342664867;11849.933505984503;10401.94799026;10443.216758743125;11556.479958401893;11803.40982950849;11842.467088981017;5380.811671591476;5427.240186373911;5444.754986025639;5457.727113644302;5468.152436372368;888.4180861535705;993.9403635781877;1064.957401703923;1070.812607793633;1118.55816952305;25525.97896084136;25659.48681026369;25716.099936502134;25765.8711706444;25935.22194334173;1044.9895501045044;1137.6359564939305;1144.4506636814376;1184.407796101949;1187.5368606243571;13372.799408008888;13479.393427295796;13722.65693357674;13760.587182384545;14059.71880562383;423645;427656;428894.71105288545;429853;432914;53323;53474.7326263374;53624.46375536195;53624.463755362725;53681.65795855057;1406.585057408067;1442.0914823661026;1446.8553144685447;1447.3920953199681;1462.597785608966;24701.382465438506;25648.102316418837;25725.485490290463;25802;25884.482310354066;42885.57114428816;42936.92657683583;42954.570454295055;43128.78435607802;43256.78371608122;390994;393692.03153984045;394437;394666;395569.0221548874;31152.844235779583;31694;31884.202894927814;32006.879759208317;32179.678203218606;30976.535351969287;31585.684143159193;36572.63427365692;40707;40722;31182.908598198956;31518.527222091227;33144.50283245705;33612;34163;32332.383380831336;32712.509312359856;33419;33537.83231083829;33554;28888.566671500364;34769.053002759094;35077.47383789296;35329.646703532635;35345.46981795224;27740.167794966183;28078.85960570184;29403;30232.48837558069;30527.847360763943;20280;21871;22955.54088918179;23480.76519234786;23602.763972360055 15:48:46 INFO - PID 2247 | |2;jquery.html;400.7335122143773;407.9841195423393;417.7117788725779;418.1699326836231;434.45042021842374;19434.93107879066;20513.897430512847;21126.366209013715;21178.47053823655;21178.89410552947;21108.472288192803;22206.777932220673;22238;23177.768222317813;23309.65035524464;6513.478921686277;6872.450203983694;6879.89680154798;6884.586924784504;6897.379235868771;6433.7426502939825;6543.018547217908;6760.932390676079;6763.864722705543;6764.458843292525;6097;6761.39147476727;6761.763338283161;6775.017622444742;6783.694733736969;7549.811254718621;7675.616219189018;7680;7695.615219239044;7720.729774457867;7227.927720722778;7497.600767754321;7580.9620951894885;7590.8481830363635;7613.276738709814;27746.861265693744;27762.444751105068;28354;28506.429871402663;28908.710912890812;2475;2857.2999615094227;2879.5824605432094;2885.797994140411;2905.7384835364705;16057.437989670305;16587;16879.55246489252;16906.239219235165;17913.835600686045;1959.2163134746215;1998.2107067708318;2011.8591698581106;2029.076770069615;2034.5727397246596;151748;156245.99999999886;157300;159888;161509.3849061506;21822;21939.67090493644;21951.01220445084;21979.670304945437;22112.899274568892;37135.25729485449;37166.07084822847;37381.813090934374;37398.43902341467;37499.4375084374;10079.899201008042;10410.219233557513;10610.840837387444;10646.14830813533;10763.354198747944;8411.411201215979;8413.200745929127;8603.827923441497;8614;8621.827563448696;10229.846552301722;10593.470326483644;10666.573337066586;10761.515731792088;10792.838107428395;3510.280392519527;4046.393041043867;4144.79276036203;4183.226103170923;4194.622483976395;900.0054939292119;948.8719022931954;1020.6070662794729;1025.897410258983;1071.5285274479204;23301.533969320517;23624.29127126189;23962.52074958526;24063.639045414333;24133.51732965331;1065.627030539305;1070.0690399352457;1074.3607553505651;1088.8257878739364;1110.8944650258213;12135.915090353104;12160.817587736192;12201.572944947062;12286.815697764541;12365.319907404999;560956.1952190213;606656;646736;648759;669227;131394.34302828615;133738;136833;140659;144595.2770236142;1148.2192109365712;1211.8242854786006;1225.148521777356;1249.6688377579949;1251.4618713953087;19606;19936.60126797427;20064.598708025467;20079.498012549804;20131.698024529353;47472;55975.88048239094;56124.719376402856;57405.42594574001;58440.123398148215;78650;82591;86744;89892.55053724689;90821;11148.534525583706;11574;11606.187566870238;11841.407929603658;11928.403579821148;12911;12923.935380323039;13148.802767958297;13336.133151345131;13339.932805375352;11333;11533.077353811506;11595.8260626089;11606.24559403636;11800.816848882983;9150.862737059082;10466.639336886155;10517.368957862553;10825;11172.553097875994;10505.317154385246;10586.719405489595;11331.490082946451;11593.6521904343;11741;11494.195406321478;11623.23057291947;11923.403829808649;11951.342676152895;11984.58053968107;11168.944155279172;11372.829407559058;11603.593874214363;11611.88388116108;11645.475953582278 15:48:46 INFO - PID 2247 | |3;mootools.html;1357.8777909988098;1361.1424802374515;1596.8083829940401;1600.599850037491;1668.0658831054607;9013.774655633613;9439.952800235998;9584.424934503935;10793.136549076075;11077.058450031756;10658.253922225427;10881.347119172835;10884.129269658428;10892.128629709625;10925.344479331226;2297.069686776858;2343.7070366204225;2346.835721499496;2350.518143780521;2351.4826738117586;1979.6337677529632;2079.677649964258;2284.4859906521065;2381.6189409694452;2393.9281821545296;2339.2748248043076;2352.9058837646476;2355.9869256219818;2364.125273648752;2366.3137690069857;2311.7225932888077;2345.6716059751648;2355.6348765941393;2357.0689577616918;2360.988195059031;1693.4335739440967;2175.0321107107343;2219.1678120704737;2287.0165828693657;2289.645105008726;10722.517486713117;10818.945905270422;10844.511996960156;10844.566217351297;10853;5420.970015697005;5654.745536450829;5656.858578535528;5656.8868622627315;5664.348599911022;3341.365140623298;3567.661072198137;3589.6948759355487;3656.542932133483;3664.5236119304586;1108.4291589831244;1178.9056875449944;1196.7620549572268;1221.688469440287;1230.796918508445;15088.773668394873;15179.013364131406;15409.30658120376;15424.768628470581;15436.45972390961;4677.251639737626;4743.9721723964;4805.639577031737;4821.614270858393;4881.926771098437;11448.599299024494;11673.88326116745;12515.249085054744;12519.749605007848;12535.93732031334;5733.31200255972;5742.16738572913;5742.885142297131;5745.798897038583;5756.884862302731;4457.242268814244;4968.72672003036;5047.596192304607;5129.64092513528;5151.407588127338;2868.4119755450083;3351.6648335166287;3745.8688945886765;3819.9427008594894;3824.770513769183;1018.1498448795339;1032.7624646331385;1044.7850556819592;1045.3884477580548;1048.3290693955873;888.5690440136528;914.6432891172448;916.5921165081475;943.9987227078637;976.951152442375;5526.706416836968;6319.494440444753;6372.299047104815;6391.456726178234;6518.478521718251;932.8712258167558;976.1019861727228;996.272720913737;1007.9798404031878;1039.7088815131776;3760.4018292225696;4163.188178305201;4256.382824490432;4284.421603083544;4298.935515967263;13303.46786128544;13572.524961626494;13623.523176688768;13838.30808459573;13940.58178254654;13625;13744.175349479063;13856.93071534636;13938.163710177421;14021.158730476203;9890.60437582503;9990.450525221182;10027.247956403446;10146.594136234615;10162.03460671235;6117.3270940197435;6550.7707230246715;6667.599944003376;6790.694418751069;6809;11379.487923043649;11684.766304673689;11789.351585662871;11959.820602691141;12150.149489536001;11962.820557691815;12330.81503777462;12424.37878106073;12542.372881355714;12550.246985180918;8979.910200897908;9065.41074830134;9250.907490925274;9274.536273186179;9274.768130796783;10067.949660251652;10071.093601575893;10155;10177.79644407093;10246.436445995541;8435.83128337442;8630.439021463584;8689.522076285864;8736.56317184151;8845.469271843709;8642.049374568918;8700.477971321741;8718.694845680624;8773.824523509367;8816.911830881609;7689.769306920802;7883.054033516015;7884.4086693497065;7889.566073865993;7901.328387087162;5724.341700704473;5741.511971482304;5876.324222714272;5944.8811023780145;5978.581499295007;5870;6057.212562366864;6066.696665166635;6093.116498107838;6093.360197179232 15:48:46 INFO - PID 2247 | |4;prototype.html;309.4569031349981;373.41933293728255;384.83067450321863;384.85760268700585;389.20796179774163;4497.380942860567;5344.91982620261;5453.972730136349;5744.62659927105;5811.535077193825;4575.611073058794;5153.613478989081;5478.890627108562;5617.915786213473;5677.8580535486635;4656.393544227253;4675.672702910798;4698.624110071186;4706;4745.169595320823;3779.4141908004303;4703.059388122372;4716.669833111683;4722.693024953367;4737.336772851803;3910.022494376406;3999.760014399131;4449.688521803459;4675.976620116895;4723.834665786698;4645.628349732014;4654.208784506642;4656.767161641905;4659.324397962293;4671.48613652498;4287.464066991626;4301.956980430187;4306.461692288464;4330.112326972963;4337.154254920292;5282.705737094398;5460.5085542300985;5545.195946587723;5574.665520068809;5645.209670646072;5106.825430151086;5453.045716999549;5453.318335208099;5477;5484.533814625762;5889.734961926723;6049.183360246355;6100.511959043266;6113.663748493831;6138.938610613882;4738.2892566115015;4789.2097803862325;4831.565159135695;4834.444038935532;4837.137701984726;5848.912266316009;6045.274567051938;6209.161763162006;6309.589876658002;6551.344865513458;3963.7027222958395;4915.311856340115;4937.506249375034;4942.097292542397;4971.37857767779;4730.651764247173;4872.853814385574;5042.369703787027;5056.595472362203;5062.392512898476;4886.438059623118;5038.74031492127;5044.319016932741;5423.996560636295;5452.2094296327605;5371.973140134274;6081.209442772411;6144.109104179869;6147.907781383283;6189.659568723673;1448.717500087473;1710.307325533161;1743.320105158989;1756.2184827751782;1759.5864971731633;1089.0851684584986;1249.3815561297215;1262.4066688656317;1281.2440660010639;1294.3657607772125;4613.500612301015;5082.974585127051;5536.837264174568;5746.655200687972;5747.362001829459;5256.737163141827;6300.21247344082;6350.301466838737;6362.936370636327;6457.3865482779065;4735.479097299294;5164.237133133755;5369.5972802040005;5578.748956296977;5925.851853703605;2690.892364305445;3297.8835000924378;3299.373119107362;3318.8427522110337;3323.5180898769545;6210.534209934273;6496.285408605049;6518.28298887122;6583.934160658332;6617.239017512951;5390.703511306916;6447.323031081669;6451.580647257913;6486.35136486357;6502.967485162639;5498.532624726943;6130.01919692847;6240.219972503528;6240.251169859646;6563.737450502022;4949.232868905326;5727.627704199381;5912.172295878667;6314.494840412848;6339.873202535831;5388.649737767033;5556.111022236423;5888.6456115092915;6253.656048917172;6278.560500764903;5940.732667029907;6281.780137695158;6412.332793473637;6441.871162576816;6488.675566221765;4563.110193512233;4854.101991131652;4921.557059864629;4949.505049495022;4950.801967921243;5033.723145227048;6115.235595550556;6232.875342493216;6299.338569450142;6332.461740751904;5067.493250674903;6076.756929722762;6116.694165291628;6137.60105593135;6138.324784273637;5473.781048758005;5880.470757631833;5892.705364731832;6043.75824967014;6105.48103411215;4954.00919816031;5637.46444087811;5990.711996920683;6042.280973561827;6059.212302400836;5396.703181324908;6131.724072416663;6157.876842463215;6168.290646575701;6196.47329976957;5242.397124330599;5637.351704554028;5890.882182356243;5949.1076338549565;5969.462748352669 15:48:46 INFO - PID 2247 | |5;yui.html;755.5277951280453;763.9961800190998;766.3792328214143;824.8556502612043;833.5207255827896;14995.025323353975;15652.765208521882;15666.843331566695;15681.29434175462;15699.215039248049;14466;14501.637459063528;14657.193854338007;14694.191819449927;14735.26323683817;915.208344781764;954.265215783846;958.6740508227201;960.0639376607821;961.0581630002602;924.7595625137445;948.4451595816456;955.6989548292265;955.7515046087998;968.6416026070364;1024.2113572549133;1025.149126225235;1026.5226669598635;1027.7276521721749;1028.5782829040095;1020.5713600287822;1022.2282176956425;1022.3150489172273;1022.9335093218917;1023.539407266733;761.5164370624638;761.6572542355907;762.3786613909646;762.664427651837;763.904511936008;16148.919255403647;16421.83578164215;16622.25199866009;16675.332986680518;16695.91652041732;14542.491012814606;14650.63373415673;14749.631259218499;14778.778318325234;14819.481318153921;11282.435878206057;11451.484683189277;11464.828027579593;11799.233049851731;11919.463624136848;3245.9188520286943;3738.3831667774784;3761.755485893408;3778.0932576181795;3903.6291552302487;109006.45496772465;111225;111306.44346778296;112614;112747.87252127456;9842.901570984342;11279.210455268216;11349.886501135048;11388;11581.594644187413;25227.74772252291;25242;25253.747462525138;25283.494330113295;25343.493130137664;7728.961355193301;7798.142204357516;7903;7945.324647405036;8016.438849280495;4226.450561426995;4313.396124542566;4338.913221735547;4433.578810013044;4476.686631935799;3502;3573.2317551726505;3574.0528759878134;3594.263176048904;3599.9280014399565;567.4665814134701;616.8095575539163;625.2497003595703;627.1032423634156;650.0476801485846;651.3551583931874;654.1430725749284;663.7046514301186;669.8928171492636;678.59284429342;9919.305648604528;9999.25005624581;10051.597936082475;10156.513794267757;10374.533146008447;646.7639311651213;684.5186200024909;686.8159253573584;693.2547511425238;721.4300702445009;3930.331843586597;4894.437139728905;4902.656814023056;4910.729909854921;4919.90160196794;72842;100297;101421.49289253507;101498;103872;88920.5553972239;89164;90388.5480572593;90569;90837;74948.87576686354;75929.86105208426;78236.21763782403;79375.60312198402;79466.60266698746;9204.631814727336;9488.33954058051;9598.9040109598;9606.615735370786;9618.182454491447;45925;46831.76584117058;46933.76533117313;47305.08686414198;47801.521984779705;58288.12567811571;58856;59241.11138333015;59761;60228.795424092146;11536.480858361227;11546.653600392001;11624.94187529057;11859.940700296444;12381.62855114348;12651.683707907376;12660.366981650697;12841.486340546273;12862.807057894326;13716.108452950526;11832.881671183522;11906.285622862655;11937.224080434744;12194.329311887577;12463.314517701614;11832.52669893229;12240.69398265015;12410.193337433038;13293.335333233494;13755.38100785447;13128.671783205114;13143.60569182926;13244.271565064015;13481.460741570227;13725.313734313044;10940.713958042623;10993.780124397626;11109.388983605979;11330.660080197607;11657.470140392514;9948.39364018731;10079.530515023573;10123.544440500342;11143.888561114285;11263.436828158723 15:48:46 INFO - PID 2247 | __end_tp_report 15:48:46 INFO - PID 2247 | __start_cc_report 15:48:46 INFO - PID 2247 | _x_x_mozilla_cycle_collect,1776 15:48:46 INFO - PID 2247 | __end_cc_report 15:48:46 INFO - PID 2247 | __startTimestamp1489618126575__endTimestamp 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | ------- Summary: start ------- 15:48:46 INFO - PID 2247 | Number of tests: 6 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | [#0] dojo.html Cycles:165 Average:5756.24 Median:6043.31 stddev:658.28 (10.9%) stddev-sans-first:616.74 15:48:46 INFO - PID 2247 | Values: 2754.3 3193.4 3329.9 3338.8 3346.8 5545.4 5660.9 5676.4 5680.5 5727.7 4742.7 5704.4 5804.7 5816.7 5830.8 5148.7 5195.1 5224.4 5229.3 5230.2 5337.9 5383.4 5406.9 5425.4 5427.9 5081.9 5151.8 5168.0 5230.5 5372.5 4347.5 5229.7 5253.3 5303.7 5343.9 5185.6 5192.7 5197.6 5201.5 5242.3 5657.4 5690.8 5822.9 5824.5 5832.7 6139.8 6145.8 6175.0 6181.4 6185.9 6167.9 6214.8 6221.9 6230.9 6231.3 5910.3 5955.7 5973.1 5981.5 6037.5 6182.4 6182.8 6234.2 6281.0 6285.6 5116.4 6102.4 6106.0 6147.3 6163.9 6151.0 6191.2 6194.7 6204.6 6222.4 6107.5 6180.0 6193.1 6195.1 6205.3 6125.6 6185.3 6193.4 6203.9 6204.4 5005.2 5024.9 5030.8 5031.9 5034.8 4477.2 4509.6 4510.8 4526.8 4530.0 5948.8 5957.7 5963.0 5973.7 6005.3 6169.9 6221.4 6237.3 6237.4 6252.6 5771.5 5820.2 5826.7 5838.4 5999.2 5448.9 5451.0 5454.0 5454.1 5460.3 6252.0 6279.9 6283.7 6284.9 6285.8 6181.8 6186.0 6201.5 6203.0 6205.3 6337.7 6339.6 6341.7 6359.0 6364.4 5207.6 6165.2 6184.6 6213.1 6219.6 6043.3 6186.2 6190.7 6194.8 6210.0 6063.8 6160.8 6173.9 6196.6 6199.7 6011.9 6012.3 6112.8 6113.1 6113.8 5950.2 6037.5 6040.3 6119.4 6123.1 6137.6 6177.5 6200.5 6216.6 6219.6 6091.1 6094.7 6101.8 6103.7 6106.5 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | [#1] ext.html Cycles:180 Average:51003.05 Median:17438.93 stddev:99519.50 (570.7%) stddev-sans-first:99727.09 15:48:46 INFO - PID 2247 | Values: 726.4 773.2 795.6 858.1 871.0 27370.2 37381.4 37663.0 37762.4 37823.2 38625.5 39029.8 39088.0 39185.6 39230.6 7076.1 8953.0 9175.4 9197.8 9201.5 7232.8 10490.5 10720.4 10730.0 10738.0 10817.1 10856.8 10876.2 10893.1 10919.8 10771.8 10846.3 10868.6 10869.6 10877.7 7045.6 7216.3 10431.2 10617.6 10648.4 32369.7 36983.0 37300.6 37334.8 37344.4 3396.4 3715.5 3799.6 3822.3 3844.9 27283.4 27510.7 27879.3 28517.9 28577.4 3040.3 3042.8 3068.4 3096.5 3183.9 232882.0 299101.0 305503.0 306838.0 307720.0 49027.5 49100.8 49117.8 49136.6 49161.8 51053.5 51139.7 51263.5 51295.0 51449.7 14028.0 14373.0 14383.2 14389.9 14400.6 9983.9 11819.9 11840.3 11843.8 11849.9 10401.9 10443.2 11556.5 11803.4 11842.5 5380.8 5427.2 5444.8 5457.7 5468.2 888.4 993.9 1065.0 1070.8 1118.6 25526.0 25659.5 25716.1 25765.9 25935.2 1045.0 1137.6 1144.5 1184.4 1187.5 13372.8 13479.4 13722.7 13760.6 14059.7 423645.0 427656.0 428894.7 429853.0 432914.0 53323.0 53474.7 53624.5 53624.5 53681.7 1406.6 1442.1 1446.9 1447.4 1462.6 24701.4 25648.1 25725.5 25802.0 25884.5 42885.6 42936.9 42954.6 43128.8 43256.8 390994.0 393692.0 394437.0 394666.0 395569.0 31152.8 31694.0 31884.2 32006.9 32179.7 30976.5 31585.7 36572.6 40707.0 40722.0 31182.9 31518.5 33144.5 33612.0 34163.0 32332.4 32712.5 33419.0 33537.8 33554.0 28888.6 34769.1 35077.5 35329.6 35345.5 27740.2 28078.9 29403.0 30232.5 30527.8 20280.0 21871.0 22955.5 23480.8 23602.8 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | [#2] jquery.html Cycles:180 Average:39561.10 Median:21152.42 stddev:105469.45 (498.6%) stddev-sans-first:105724.34 15:48:46 INFO - PID 2247 | Values: 400.7 408.0 417.7 418.2 434.5 19434.9 20513.9 21126.4 21178.5 21178.9 21108.5 22206.8 22238.0 23177.8 23309.7 6513.5 6872.5 6879.9 6884.6 6897.4 6433.7 6543.0 6760.9 6763.9 6764.5 6097.0 6761.4 6761.8 6775.0 6783.7 7549.8 7675.6 7680.0 7695.6 7720.7 7227.9 7497.6 7581.0 7590.8 7613.3 27746.9 27762.4 28354.0 28506.4 28908.7 2475.0 2857.3 2879.6 2885.8 2905.7 16057.4 16587.0 16879.6 16906.2 17913.8 1959.2 1998.2 2011.9 2029.1 2034.6 151748.0 156246.0 157300.0 159888.0 161509.4 21822.0 21939.7 21951.0 21979.7 22112.9 37135.3 37166.1 37381.8 37398.4 37499.4 10079.9 10410.2 10610.8 10646.1 10763.4 8411.4 8413.2 8603.8 8614.0 8621.8 10229.8 10593.5 10666.6 10761.5 10792.8 3510.3 4046.4 4144.8 4183.2 4194.6 900.0 948.9 1020.6 1025.9 1071.5 23301.5 23624.3 23962.5 24063.6 24133.5 1065.6 1070.1 1074.4 1088.8 1110.9 12135.9 12160.8 12201.6 12286.8 12365.3 560956.2 606656.0 646736.0 648759.0 669227.0 131394.3 133738.0 136833.0 140659.0 144595.3 1148.2 1211.8 1225.1 1249.7 1251.5 19606.0 19936.6 20064.6 20079.5 20131.7 47472.0 55975.9 56124.7 57405.4 58440.1 78650.0 82591.0 86744.0 89892.6 90821.0 11148.5 11574.0 11606.2 11841.4 11928.4 12911.0 12923.9 13148.8 13336.1 13339.9 11333.0 11533.1 11595.8 11606.2 11800.8 9150.9 10466.6 10517.4 10825.0 11172.6 10505.3 10586.7 11331.5 11593.7 11741.0 11494.2 11623.2 11923.4 11951.3 11984.6 11168.9 11372.8 11603.6 11611.9 11645.5 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | [#3] mootools.html Cycles:180 Average:6650.96 Median:2387.77 stddev:4213.63 (176.5%) stddev-sans-first:4206.68 15:48:46 INFO - PID 2247 | Values: 1357.9 1361.1 1596.8 1600.6 1668.1 9013.8 9440.0 9584.4 10793.1 11077.1 10658.3 10881.3 10884.1 10892.1 10925.3 2297.1 2343.7 2346.8 2350.5 2351.5 1979.6 2079.7 2284.5 2381.6 2393.9 2339.3 2352.9 2356.0 2364.1 2366.3 2311.7 2345.7 2355.6 2357.1 2361.0 1693.4 2175.0 2219.2 2287.0 2289.6 10722.5 10818.9 10844.5 10844.6 10853.0 5421.0 5654.7 5656.9 5656.9 5664.3 3341.4 3567.7 3589.7 3656.5 3664.5 1108.4 1178.9 1196.8 1221.7 1230.8 15088.8 15179.0 15409.3 15424.8 15436.5 4677.3 4744.0 4805.6 4821.6 4881.9 11448.6 11673.9 12515.2 12519.7 12535.9 5733.3 5742.2 5742.9 5745.8 5756.9 4457.2 4968.7 5047.6 5129.6 5151.4 2868.4 3351.7 3745.9 3819.9 3824.8 1018.1 1032.8 1044.8 1045.4 1048.3 888.6 914.6 916.6 944.0 977.0 5526.7 6319.5 6372.3 6391.5 6518.5 932.9 976.1 996.3 1008.0 1039.7 3760.4 4163.2 4256.4 4284.4 4298.9 13303.5 13572.5 13623.5 13838.3 13940.6 13625.0 13744.2 13856.9 13938.2 14021.2 9890.6 9990.5 10027.2 10146.6 10162.0 6117.3 6550.8 6667.6 6790.7 6809.0 11379.5 11684.8 11789.4 11959.8 12150.1 11962.8 12330.8 12424.4 12542.4 12550.2 8979.9 9065.4 9250.9 9274.5 9274.8 10067.9 10071.1 10155.0 10177.8 10246.4 8435.8 8630.4 8689.5 8736.6 8845.5 8642.0 8700.5 8718.7 8773.8 8816.9 7689.8 7883.1 7884.4 7889.6 7901.3 5724.3 5741.5 5876.3 5944.9 5978.6 5870.0 6057.2 6066.7 6093.1 6093.4 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | [#4] prototype.html Cycles:180 Average:5066.17 Median:5452.63 stddev:1430.09 (26.2%) stddev-sans-first:1388.82 15:48:46 INFO - PID 2247 | Values: 309.5 373.4 384.8 384.9 389.2 4497.4 5344.9 5454.0 5744.6 5811.5 4575.6 5153.6 5478.9 5617.9 5677.9 4656.4 4675.7 4698.6 4706.0 4745.2 3779.4 4703.1 4716.7 4722.7 4737.3 3910.0 3999.8 4449.7 4676.0 4723.8 4645.6 4654.2 4656.8 4659.3 4671.5 4287.5 4302.0 4306.5 4330.1 4337.2 5282.7 5460.5 5545.2 5574.7 5645.2 5106.8 5453.0 5453.3 5477.0 5484.5 5889.7 6049.2 6100.5 6113.7 6138.9 4738.3 4789.2 4831.6 4834.4 4837.1 5848.9 6045.3 6209.2 6309.6 6551.3 3963.7 4915.3 4937.5 4942.1 4971.4 4730.7 4872.9 5042.4 5056.6 5062.4 4886.4 5038.7 5044.3 5424.0 5452.2 5372.0 6081.2 6144.1 6147.9 6189.7 1448.7 1710.3 1743.3 1756.2 1759.6 1089.1 1249.4 1262.4 1281.2 1294.4 4613.5 5083.0 5536.8 5746.7 5747.4 5256.7 6300.2 6350.3 6362.9 6457.4 4735.5 5164.2 5369.6 5578.7 5925.9 2690.9 3297.9 3299.4 3318.8 3323.5 6210.5 6496.3 6518.3 6583.9 6617.2 5390.7 6447.3 6451.6 6486.4 6503.0 5498.5 6130.0 6240.2 6240.3 6563.7 4949.2 5727.6 5912.2 6314.5 6339.9 5388.6 5556.1 5888.6 6253.7 6278.6 5940.7 6281.8 6412.3 6441.9 6488.7 4563.1 4854.1 4921.6 4949.5 4950.8 5033.7 6115.2 6232.9 6299.3 6332.5 5067.5 6076.8 6116.7 6137.6 6138.3 5473.8 5880.5 5892.7 6043.8 6105.5 4954.0 5637.5 5990.7 6042.3 6059.2 5396.7 6131.7 6157.9 6168.3 6196.5 5242.4 5637.4 5890.9 5949.1 5969.5 15:48:46 INFO - PID 2247 | 15:48:46 INFO - PID 2247 | [#5] yui.html Cycles:180 Average:20175.74 Median:3373.96 stddev:29015.15 (860.0%) stddev-sans-first:29059.90 15:48:46 INFO - PID 2247 | Values: 755.5 764.0 766.4 824.9 833.5 14995.0 15652.8 15666.8 15681.3 15699.2 14466.0 14501.6 14657.2 14694.2 14735.3 915.2 954.3 958.7 960.1 961.1 924.8 948.4 955.7 955.8 968.6 1024.2 1025.1 1026.5 1027.7 1028.6 1020.6 1022.2 1022.3 1022.9 1023.5 761.5 761.7 762.4 762.7 763.9 16148.9 16421.8 16622.3 16675.3 16695.9 14542.5 14650.6 14749.6 14778.8 14819.5 11282.4 11451.5 11464.8 11799.2 11919.5 3245.9 3738.4 3761.8 3778.1 3903.6 109006.5 111225.0 111306.4 112614.0 112747.9 9842.9 11279.2 11349.9 11388.0 11581.6 25227.7 25242.0 25253.7 25283.5 25343.5 7729.0 7798.1 7903.0 7945.3 8016.4 4226.5 4313.4 4338.9 4433.6 4476.7 3502.0 3573.2 3574.1 3594.3 3599.9 567.5 616.8 625.2 627.1 650.0 651.4 654.1 663.7 669.9 678.6 9919.3 9999.3 10051.6 10156.5 10374.5 646.8 684.5 686.8 693.3 721.4 3930.3 4894.4 4902.7 4910.7 4919.9 72842.0 100297.0 101421.5 101498.0 103872.0 88920.6 89164.0 90388.5 90569.0 90837.0 74948.9 75929.9 78236.2 79375.6 79466.6 9204.6 9488.3 9598.9 9606.6 9618.2 45925.0 46831.8 46933.8 47305.1 47801.5 58288.1 58856.0 59241.1 59761.0 60228.8 11536.5 11546.7 11624.9 11859.9 12381.6 12651.7 12660.4 12841.5 12862.8 13716.1 11832.9 11906.3 11937.2 12194.3 12463.3 11832.5 12240.7 12410.2 13293.3 13755.4 13128.7 13143.6 13244.3 13481.5 13725.3 10940.7 10993.8 11109.4 11330.7 11657.5 9948.4 10079.5 10123.5 11143.9 11263.4 15:48:46 INFO - PID 2247 | -------- Summary: end -------- 15:48:46 INFO - PID 2247 | 15:48:47 INFO - TEST-INFO | 2247: exit 0 15:48:47 INFO - TEST-OK | dromaeo_css | took 1120467ms 15:48:47 INFO - TEST-START | kraken 15:48:47 INFO - operating with platform_type : mac_ 15:48:47 INFO - Initialising browser for kraken test... 15:48:47 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpeugdt8/profile http://localhost:57439/getInfo.html) 15:48:49 INFO - PID 2250 | __metrics Screen width/height:1600/1200 15:48:49 INFO - PID 2250 | colorDepth:24 15:48:49 INFO - PID 2250 | Browser inner width/height: 1024/689 15:48:49 INFO - PID 2250 | __metrics 15:48:49 INFO - PID 2250 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:48:49 INFO - PID 2250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:50 INFO - TEST-INFO | 2250: exit 0 15:48:50 INFO - Browser initialized. 15:48:50 INFO - Running cycle 1/1 for kraken test... 15:48:50 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpeugdt8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:02 INFO - PID 2251 | RSS: Main: 235159552 15:49:02 INFO - PID 2251 | 15:49:05 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57439/tests/kraken/driver.html?testName=audio-beat-detection) 15:49:06 INFO - PID 2251 | RSS: Main: 285052928 15:49:06 INFO - PID 2251 | 15:49:09 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57439/tests/kraken/driver.html?testName=audio-dft) 15:49:09 INFO - PID 2251 | RSS: Main: 286691328 15:49:09 INFO - PID 2251 | 15:49:13 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57439/tests/kraken/driver.html?testName=audio-fft) 15:49:13 INFO - PID 2251 | RSS: Main: 379453440 15:49:13 INFO - PID 2251 | 15:49:15 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57439/tests/kraken/driver.html?testName=audio-oscillator) 15:49:16 INFO - PID 2251 | RSS: Main: 281866240 15:49:16 INFO - PID 2251 | 15:49:18 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57439/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:49:19 INFO - PID 2251 | RSS: Main: 285614080 15:49:19 INFO - PID 2251 | 15:49:22 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57439/tests/kraken/driver.html?testName=imaging-darkroom) 15:49:22 INFO - PID 2251 | RSS: Main: 326656000 15:49:22 INFO - PID 2251 | 15:49:25 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57439/tests/kraken/driver.html?testName=imaging-desaturate) 15:49:26 INFO - PID 2251 | RSS: Main: 333271040 15:49:26 INFO - PID 2251 | 15:49:29 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57439/tests/kraken/driver.html?testName=json-parse-financial) 15:49:29 INFO - PID 2251 | RSS: Main: 335405056 15:49:29 INFO - PID 2251 | 15:49:31 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57439/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:49:32 INFO - PID 2251 | RSS: Main: 304869376 15:49:32 INFO - PID 2251 | 15:49:33 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:49:34 INFO - PID 2251 | RSS: Main: 306888704 15:49:34 INFO - PID 2251 | 15:49:36 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:49:37 INFO - PID 2251 | RSS: Main: 308805632 15:49:37 INFO - PID 2251 | 15:49:40 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:49:41 INFO - PID 2251 | RSS: Main: 326144000 15:49:41 INFO - PID 2251 | 15:49:44 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:49:44 INFO - PID 2251 | RSS: Main: 319623168 15:49:44 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | Cycle 1(1): loaded http://localhost:57439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57439/tests/kraken/driver.html?testName=ai-astar) 15:49:46 INFO - PID 2251 | RSS: Main: 381276160 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | __start_tp_report 15:49:46 INFO - PID 2251 | _x_x_mozilla_page_load 15:49:46 INFO - PID 2251 | _x_x_mozilla_page_load_details 15:49:46 INFO - PID 2251 | |i|pagename|runs| 15:49:46 INFO - PID 2251 | |0;ai-astar;114;115;115;115;116;114;114;116;115;116 15:49:46 INFO - PID 2251 | |1;audio-beat-detection;138;112;113;147;125;92;131;141;167;140 15:49:46 INFO - PID 2251 | |2;audio-dft;186;185;184;187;184;184;179;185;184;183 15:49:46 INFO - PID 2251 | |3;audio-fft;80;61;63;120;87;89;50;78;103;87 15:49:46 INFO - PID 2251 | |4;audio-oscillator;87;70;87;70;70;70;84;71;70;85 15:49:46 INFO - PID 2251 | |5;imaging-gaussian-blur;89;89;89;89;89;88;89;89;88;88 15:49:46 INFO - PID 2251 | |6;imaging-darkroom;94;94;96;95;95;95;95;95;102;125 15:49:46 INFO - PID 2251 | |7;imaging-desaturate;84;84;85;84;84;85;84;83;84;85 15:49:46 INFO - PID 2251 | |8;json-parse-financial;60;61;61;61;62;61;62;62;64;61 15:49:46 INFO - PID 2251 | |9;json-stringify-tinderbox;55;55;65;58;62;56;58;58;57;58 15:49:46 INFO - PID 2251 | |10;stanford-crypto-aes;84;83;82;83;81;82;82;82;83;82 15:49:46 INFO - PID 2251 | |11;stanford-crypto-ccm;142;139;136;136;137;139;136;140;181;135 15:49:46 INFO - PID 2251 | |12;stanford-crypto-pbkdf2;183;185;187;187;190;183;193;185;190;231 15:49:46 INFO - PID 2251 | |13;stanford-crypto-sha256-iterative;72;67;68;68;68;69;67;68;69;69 15:49:46 INFO - PID 2251 | __end_tp_report 15:49:46 INFO - PID 2251 | __start_cc_report 15:49:46 INFO - PID 2251 | _x_x_mozilla_cycle_collect,2145 15:49:46 INFO - PID 2251 | __end_cc_report 15:49:46 INFO - PID 2251 | __startTimestamp1489618186807__endTimestamp 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | ------- Summary: start ------- 15:49:46 INFO - PID 2251 | Number of tests: 14 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 15:49:46 INFO - PID 2251 | Values: 114.0 115.0 115.0 115.0 116.0 114.0 114.0 116.0 115.0 116.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:140.50 stddev:21.14 (15.0%) stddev-sans-first:22.25 15:49:46 INFO - PID 2251 | Values: 138.0 112.0 113.0 147.0 125.0 92.0 131.0 141.0 167.0 140.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:2.13 (1.2%) stddev-sans-first:2.15 15:49:46 INFO - PID 2251 | Values: 186.0 185.0 184.0 187.0 184.0 184.0 179.0 185.0 184.0 183.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#3] audio-fft Cycles:10 Average:81.80 Median:79.00 stddev:20.63 (26.1%) stddev-sans-first:21.87 15:49:46 INFO - PID 2251 | Values: 80.0 61.0 63.0 120.0 87.0 89.0 50.0 78.0 103.0 87.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.50 stddev:8.10 (10.5%) stddev-sans-first:7.63 15:49:46 INFO - PID 2251 | Values: 87.0 70.0 87.0 70.0 70.0 70.0 84.0 71.0 70.0 85.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:49:46 INFO - PID 2251 | Values: 89.0 89.0 89.0 89.0 89.0 88.0 89.0 89.0 88.0 88.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:95.00 stddev:9.56 (10.1%) stddev-sans-first:9.99 15:49:46 INFO - PID 2251 | Values: 94.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 102.0 125.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 15:49:46 INFO - PID 2251 | Values: 84.0 84.0 85.0 84.0 84.0 85.0 84.0 83.0 84.0 85.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.50 stddev:1.08 (1.8%) stddev-sans-first:1.00 15:49:46 INFO - PID 2251 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 62.0 62.0 64.0 61.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:3.12 (5.4%) stddev-sans-first:3.09 15:49:46 INFO - PID 2251 | Values: 55.0 55.0 65.0 58.0 62.0 56.0 58.0 58.0 57.0 58.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 15:49:46 INFO - PID 2251 | Values: 84.0 83.0 82.0 83.0 81.0 82.0 82.0 82.0 83.0 82.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:139.00 stddev:13.84 (10.0%) stddev-sans-first:14.68 15:49:46 INFO - PID 2251 | Values: 142.0 139.0 136.0 136.0 137.0 139.0 136.0 140.0 181.0 135.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:188.50 stddev:14.28 (7.6%) stddev-sans-first:14.82 15:49:46 INFO - PID 2251 | Values: 183.0 185.0 187.0 187.0 190.0 183.0 193.0 185.0 190.0 231.0 15:49:46 INFO - PID 2251 | 15:49:46 INFO - PID 2251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.43 (2.1%) stddev-sans-first:0.78 15:49:46 INFO - PID 2251 | Values: 72.0 67.0 68.0 68.0 68.0 69.0 67.0 68.0 69.0 69.0 15:49:46 INFO - PID 2251 | -------- Summary: end -------- 15:49:46 INFO - PID 2251 | 15:49:47 INFO - TEST-INFO | 2251: exit 0 15:49:47 INFO - TEST-OK | kraken | took 60401ms 15:49:47 INFO - SUITE-END | took 1180s 15:49:47 INFO - Completed test suite (00:19:41) 15:49:47 INFO - javascript benchmark 15:49:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7737.366707089215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2754.3114221444653, 3193.425183466976, 3329.850156742946, 3338.7829791063596, 3346.782459140156, 5545.390007099226, 5660.886782264357, 5676.403977582346, 5680.517156041741, 5727.713614319288, 4742.668013239075, 5704.429557044294, 5804.738786754596, 5816.651000939946, 5830.825075247739, 5148.716820574867, 5195.116830138885, 5224.39919409269, 5229.346331708536, 5230.163173892178, 5337.866553336178, 5383.43473935235, 5406.864828379283, 5425.403205647375, 5427.891442171154, 5081.898362032757, 5151.7681704323395, 5167.966406718634, 5230.503102205284, 5372.462753724616, 4347.456567929009, 5229.686218826882, 5253.343332083489, 5303.681779093266, 5343.866403339909, 5185.585153187736, 5192.688438693653, 5197.58419326453, 5201.45384734605, 5242.344706911636, 5657.377688454267, 5690.772369105231, 5822.854428639275, 5824.534037277008, 5832.737526811304, 6139.798803208747, 6145.8156255312415, 6175.0, 6181.412765787243, 6185.907211391833, 6167.907481387782, 6214.813555593294, 6221.906671399933, 6230.875382492325, 6231.252249730016, 5910.320313164041, 5955.702214889238, 5973.074173503114, 5981.461668449817, 6037.54718396122, 6182.412670796267, 6182.752689892444, 6234.189555357865, 6281.026440901667, 6285.622862628165, 5116.411612664517, 6102.405211622897, 6106.0, 6147.323794382614, 6163.890499710005, 6150.969245153835, 6191.226096737908, 6194.721237544321, 6204.565680402418, 6222.408871157233, 6107.541934354941, 6180.0, 6193.1329613854095, 6195.101710252078, 6205.348438413992, 6125.551374386306, 6185.257769067741, 6193.411625895533, 6203.906941395882, 6204.3795620437595, 5005.224190250517, 5024.924626130538, 5030.84907452777, 5031.949680503149, 5034.773435195425, 4477.2164871147415, 4509.571590698878, 4510.819567217274, 4526.841560545365, 4530.048689775184, 5948.839976204598, 5957.731902064417, 5963.016102343065, 5973.745513442226, 6005.279366476051, 6169.907451388232, 6221.3778622138325, 6237.345078766755, 6237.376262373727, 6252.562320637603, 5771.451712087345, 5820.24336836217, 5826.650400975955, 5838.416158384128, 5999.160117583542, 5448.863778405493, 5451.018816613047, 5453.972730136324, 5454.10007348791, 5460.34475862899, 6251.9687401562705, 6279.937200628026, 6283.748650054038, 6284.905726414016, 6285.779997700059, 6181.783637572664, 6185.969070154621, 6201.534884883562, 6203.0, 6205.348438413902, 6337.746490140527, 6339.619622822645, 6341.714622841891, 6359.04614307839, 6364.427201551697, 5207.609429292743, 6165.229346331708, 6184.5980011299125, 6213.099100630293, 6219.626822390671, 6043.3050199227655, 6186.19579454686, 6190.721417536131, 6194.81415557534, 6209.968950155401, 6063.787767428119, 6160.784372547118, 6173.876522469615, 6196.597221180609, 6199.659018754011, 6011.90982135277, 6012.338642749207, 6112.816615501542, 6113.144159817718, 6113.816585502442, 5950.19672344228, 6037.516998640011, 6040.305364883095, 6119.418655227746, 6123.08153776937, 6137.597768146302, 6177.4749146323065, 6200.534959877937, 6216.595921265103, 6219.595726277777, 6091.116788065794, 6094.695265236809, 6101.786437474667, 6103.694815259308, 6106.542009349228], "value": 5712.403650624652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4261233625436, 773.2229109744706, 795.5743677132735, 858.098996054143, 871.0331531999476, 27370.17889463317, 37381.43927841084, 37663.0, 37762.43356349657, 37823.24353512928, 38625.45498180069, 39029.82910512682, 39088.02279943003, 39185.60814391855, 39230.607693923055, 7076.115485564304, 8952.999999999984, 9175.357724959222, 9197.770055748626, 9201.539923003857, 7232.8191795205275, 10490.527926243338, 10720.410377429238, 10729.980651838101, 10738.013467508497, 10817.134629229642, 10856.78286434271, 10876.238663293572, 10893.128549716004, 10919.781604367909, 10771.83842242367, 10846.29499082561, 10868.6195983141, 10869.619563315326, 10877.67366978992, 7045.612491312976, 7216.314450127282, 10431.21765867563, 10617.57529698811, 10648.41433721145, 32369.6763032369, 36983.0, 37300.62699372999, 37334.813325933195, 37344.43983340252, 3396.3886500429912, 3715.491007615267, 3799.563050249229, 3822.2546603412347, 3844.942325865114, 27283.41787668297, 27510.724892751015, 27879.303017424525, 28517.857410712815, 28577.428451431064, 3040.331127152023, 3042.7870049096573, 3068.4197638216338, 3096.4735994880925, 3183.8567264473154, 232882.0, 299100.99999999785, 305503.0, 306838.0, 307720.0, 49027.509724902295, 49100.75449622729, 49117.77205569889, 49136.62950557445, 49161.754191228814, 51053.48946510562, 51139.74430127825, 51263.48736512662, 51295.0, 51449.742751286, 14028.0, 14373.0, 14383.208923509308, 14389.920755943345, 14400.639984000274, 9983.850242246372, 11819.88180118205, 11840.348780817138, 11843.822342664867, 11849.933505984503, 10401.94799026, 10443.216758743125, 11556.479958401893, 11803.40982950849, 11842.467088981017, 5380.811671591476, 5427.240186373911, 5444.754986025639, 5457.727113644302, 5468.152436372368, 888.4180861535705, 993.9403635781877, 1064.957401703923, 1070.812607793633, 1118.55816952305, 25525.97896084136, 25659.48681026369, 25716.099936502134, 25765.8711706444, 25935.22194334173, 1044.9895501045044, 1137.6359564939305, 1144.4506636814376, 1184.407796101949, 1187.5368606243571, 13372.799408008888, 13479.393427295796, 13722.65693357674, 13760.587182384545, 14059.71880562383, 423645.0, 427656.0, 428894.71105288545, 429853.0, 432914.0, 53323.0, 53474.7326263374, 53624.46375536195, 53624.463755362725, 53681.65795855057, 1406.585057408067, 1442.0914823661026, 1446.8553144685447, 1447.3920953199681, 1462.597785608966, 24701.382465438506, 25648.102316418837, 25725.485490290463, 25802.0, 25884.482310354066, 42885.57114428816, 42936.92657683583, 42954.570454295055, 43128.78435607802, 43256.78371608122, 390994.0, 393692.03153984045, 394437.0, 394666.0, 395569.0221548874, 31152.844235779583, 31694.0, 31884.202894927814, 32006.879759208317, 32179.678203218606, 30976.535351969287, 31585.684143159193, 36572.63427365692, 40707.0, 40722.0, 31182.908598198956, 31518.527222091227, 33144.50283245705, 33612.0, 34163.0, 32332.383380831336, 32712.509312359856, 33419.0, 33537.83231083829, 33554.0, 28888.566671500364, 34769.053002759094, 35077.47383789296, 35329.646703532635, 35345.46981795224, 27740.167794966183, 28078.85960570184, 29403.0, 30232.48837558069, 30527.847360763943, 20280.0, 21871.0, 22955.54088918179, 23480.76519234786, 23602.763972360055], "value": 17973.01711212766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.7335122143773, 407.9841195423393, 417.7117788725779, 418.1699326836231, 434.45042021842374, 19434.93107879066, 20513.897430512847, 21126.366209013715, 21178.47053823655, 21178.89410552947, 21108.472288192803, 22206.777932220673, 22238.0, 23177.768222317813, 23309.65035524464, 6513.478921686277, 6872.450203983694, 6879.89680154798, 6884.586924784504, 6897.379235868771, 6433.7426502939825, 6543.018547217908, 6760.932390676079, 6763.864722705543, 6764.458843292525, 6097.0, 6761.39147476727, 6761.763338283161, 6775.017622444742, 6783.694733736969, 7549.811254718621, 7675.616219189018, 7680.0, 7695.615219239044, 7720.729774457867, 7227.927720722778, 7497.600767754321, 7580.9620951894885, 7590.8481830363635, 7613.276738709814, 27746.861265693744, 27762.444751105068, 28354.0, 28506.429871402663, 28908.710912890812, 2475.0, 2857.2999615094227, 2879.5824605432094, 2885.797994140411, 2905.7384835364705, 16057.437989670305, 16587.0, 16879.55246489252, 16906.239219235165, 17913.835600686045, 1959.2163134746215, 1998.2107067708318, 2011.8591698581106, 2029.076770069615, 2034.5727397246596, 151748.0, 156245.99999999886, 157300.0, 159888.0, 161509.3849061506, 21822.0, 21939.67090493644, 21951.01220445084, 21979.670304945437, 22112.899274568892, 37135.25729485449, 37166.07084822847, 37381.813090934374, 37398.43902341467, 37499.4375084374, 10079.899201008042, 10410.219233557513, 10610.840837387444, 10646.14830813533, 10763.354198747944, 8411.411201215979, 8413.200745929127, 8603.827923441497, 8614.0, 8621.827563448696, 10229.846552301722, 10593.470326483644, 10666.573337066586, 10761.515731792088, 10792.838107428395, 3510.280392519527, 4046.393041043867, 4144.79276036203, 4183.226103170923, 4194.622483976395, 900.0054939292119, 948.8719022931954, 1020.6070662794729, 1025.897410258983, 1071.5285274479204, 23301.533969320517, 23624.29127126189, 23962.52074958526, 24063.639045414333, 24133.51732965331, 1065.627030539305, 1070.0690399352457, 1074.3607553505651, 1088.8257878739364, 1110.8944650258213, 12135.915090353104, 12160.817587736192, 12201.572944947062, 12286.815697764541, 12365.319907404999, 560956.1952190213, 606656.0, 646736.0, 648759.0, 669227.0, 131394.34302828615, 133738.0, 136833.0, 140659.0, 144595.2770236142, 1148.2192109365712, 1211.8242854786006, 1225.148521777356, 1249.6688377579949, 1251.4618713953087, 19606.0, 19936.60126797427, 20064.598708025467, 20079.498012549804, 20131.698024529353, 47472.0, 55975.88048239094, 56124.719376402856, 57405.42594574001, 58440.123398148215, 78650.0, 82591.0, 86744.0, 89892.55053724689, 90821.0, 11148.534525583706, 11574.0, 11606.187566870238, 11841.407929603658, 11928.403579821148, 12911.0, 12923.935380323039, 13148.802767958297, 13336.133151345131, 13339.932805375352, 11333.0, 11533.077353811506, 11595.8260626089, 11606.24559403636, 11800.816848882983, 9150.862737059082, 10466.639336886155, 10517.368957862553, 10825.0, 11172.553097875994, 10505.317154385246, 10586.719405489595, 11331.490082946451, 11593.6521904343, 11741.0, 11494.195406321478, 11623.23057291947, 11923.403829808649, 11951.342676152895, 11984.58053968107, 11168.944155279172, 11372.829407559058, 11603.593874214363, 11611.88388116108, 11645.475953582278], "value": 11793.967426905594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.8777909988098, 1361.1424802374515, 1596.8083829940401, 1600.599850037491, 1668.0658831054607, 9013.774655633613, 9439.952800235998, 9584.424934503935, 10793.136549076075, 11077.058450031756, 10658.253922225427, 10881.347119172835, 10884.129269658428, 10892.128629709625, 10925.344479331226, 2297.069686776858, 2343.7070366204225, 2346.835721499496, 2350.518143780521, 2351.4826738117586, 1979.6337677529632, 2079.677649964258, 2284.4859906521065, 2381.6189409694452, 2393.9281821545296, 2339.2748248043076, 2352.9058837646476, 2355.9869256219818, 2364.125273648752, 2366.3137690069857, 2311.7225932888077, 2345.6716059751648, 2355.6348765941393, 2357.0689577616918, 2360.988195059031, 1693.4335739440967, 2175.0321107107343, 2219.1678120704737, 2287.0165828693657, 2289.645105008726, 10722.517486713117, 10818.945905270422, 10844.511996960156, 10844.566217351297, 10853.0, 5420.970015697005, 5654.745536450829, 5656.858578535528, 5656.8868622627315, 5664.348599911022, 3341.365140623298, 3567.661072198137, 3589.6948759355487, 3656.542932133483, 3664.5236119304586, 1108.4291589831244, 1178.9056875449944, 1196.7620549572268, 1221.688469440287, 1230.796918508445, 15088.773668394873, 15179.013364131406, 15409.30658120376, 15424.768628470581, 15436.45972390961, 4677.251639737626, 4743.9721723964, 4805.639577031737, 4821.614270858393, 4881.926771098437, 11448.599299024494, 11673.88326116745, 12515.249085054744, 12519.749605007848, 12535.93732031334, 5733.31200255972, 5742.16738572913, 5742.885142297131, 5745.798897038583, 5756.884862302731, 4457.242268814244, 4968.72672003036, 5047.596192304607, 5129.64092513528, 5151.407588127338, 2868.4119755450083, 3351.6648335166287, 3745.8688945886765, 3819.9427008594894, 3824.770513769183, 1018.1498448795339, 1032.7624646331385, 1044.7850556819592, 1045.3884477580548, 1048.3290693955873, 888.5690440136528, 914.6432891172448, 916.5921165081475, 943.9987227078637, 976.951152442375, 5526.706416836968, 6319.494440444753, 6372.299047104815, 6391.456726178234, 6518.478521718251, 932.8712258167558, 976.1019861727228, 996.272720913737, 1007.9798404031878, 1039.7088815131776, 3760.4018292225696, 4163.188178305201, 4256.382824490432, 4284.421603083544, 4298.935515967263, 13303.46786128544, 13572.524961626494, 13623.523176688768, 13838.30808459573, 13940.58178254654, 13625.0, 13744.175349479063, 13856.93071534636, 13938.163710177421, 14021.158730476203, 9890.60437582503, 9990.450525221182, 10027.247956403446, 10146.594136234615, 10162.03460671235, 6117.3270940197435, 6550.7707230246715, 6667.599944003376, 6790.694418751069, 6809.0, 11379.487923043649, 11684.766304673689, 11789.351585662871, 11959.820602691141, 12150.149489536001, 11962.820557691815, 12330.81503777462, 12424.37878106073, 12542.372881355714, 12550.246985180918, 8979.910200897908, 9065.41074830134, 9250.907490925274, 9274.536273186179, 9274.768130796783, 10067.949660251652, 10071.093601575893, 10155.0, 10177.79644407093, 10246.436445995541, 8435.83128337442, 8630.439021463584, 8689.522076285864, 8736.56317184151, 8845.469271843709, 8642.049374568918, 8700.477971321741, 8718.694845680624, 8773.824523509367, 8816.911830881609, 7689.769306920802, 7883.054033516015, 7884.4086693497065, 7889.566073865993, 7901.328387087162, 5724.341700704473, 5741.511971482304, 5876.324222714272, 5944.8811023780145, 5978.581499295007, 5870.0, 6057.212562366864, 6066.696665166635, 6093.116498107838, 6093.360197179232], "value": 5046.281699336955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.4569031349981, 373.41933293728255, 384.83067450321863, 384.85760268700585, 389.20796179774163, 4497.380942860567, 5344.91982620261, 5453.972730136349, 5744.62659927105, 5811.535077193825, 4575.611073058794, 5153.613478989081, 5478.890627108562, 5617.915786213473, 5677.8580535486635, 4656.393544227253, 4675.672702910798, 4698.624110071186, 4706.0, 4745.169595320823, 3779.4141908004303, 4703.059388122372, 4716.669833111683, 4722.693024953367, 4737.336772851803, 3910.022494376406, 3999.760014399131, 4449.688521803459, 4675.976620116895, 4723.834665786698, 4645.628349732014, 4654.208784506642, 4656.767161641905, 4659.324397962293, 4671.48613652498, 4287.464066991626, 4301.956980430187, 4306.461692288464, 4330.112326972963, 4337.154254920292, 5282.705737094398, 5460.5085542300985, 5545.195946587723, 5574.665520068809, 5645.209670646072, 5106.825430151086, 5453.045716999549, 5453.318335208099, 5477.0, 5484.533814625762, 5889.734961926723, 6049.183360246355, 6100.511959043266, 6113.663748493831, 6138.938610613882, 4738.2892566115015, 4789.2097803862325, 4831.565159135695, 4834.444038935532, 4837.137701984726, 5848.912266316009, 6045.274567051938, 6209.161763162006, 6309.589876658002, 6551.344865513458, 3963.7027222958395, 4915.311856340115, 4937.506249375034, 4942.097292542397, 4971.37857767779, 4730.651764247173, 4872.853814385574, 5042.369703787027, 5056.595472362203, 5062.392512898476, 4886.438059623118, 5038.74031492127, 5044.319016932741, 5423.996560636295, 5452.2094296327605, 5371.973140134274, 6081.209442772411, 6144.109104179869, 6147.907781383283, 6189.659568723673, 1448.717500087473, 1710.307325533161, 1743.320105158989, 1756.2184827751782, 1759.5864971731633, 1089.0851684584986, 1249.3815561297215, 1262.4066688656317, 1281.2440660010639, 1294.3657607772125, 4613.500612301015, 5082.974585127051, 5536.837264174568, 5746.655200687972, 5747.362001829459, 5256.737163141827, 6300.21247344082, 6350.301466838737, 6362.936370636327, 6457.3865482779065, 4735.479097299294, 5164.237133133755, 5369.5972802040005, 5578.748956296977, 5925.851853703605, 2690.892364305445, 3297.8835000924378, 3299.373119107362, 3318.8427522110337, 3323.5180898769545, 6210.534209934273, 6496.285408605049, 6518.28298887122, 6583.934160658332, 6617.239017512951, 5390.703511306916, 6447.323031081669, 6451.580647257913, 6486.35136486357, 6502.967485162639, 5498.532624726943, 6130.01919692847, 6240.219972503528, 6240.251169859646, 6563.737450502022, 4949.232868905326, 5727.627704199381, 5912.172295878667, 6314.494840412848, 6339.873202535831, 5388.649737767033, 5556.111022236423, 5888.6456115092915, 6253.656048917172, 6278.560500764903, 5940.732667029907, 6281.780137695158, 6412.332793473637, 6441.871162576816, 6488.675566221765, 4563.110193512233, 4854.101991131652, 4921.557059864629, 4949.505049495022, 4950.801967921243, 5033.723145227048, 6115.235595550556, 6232.875342493216, 6299.338569450142, 6332.461740751904, 5067.493250674903, 6076.756929722762, 6116.694165291628, 6137.60105593135, 6138.324784273637, 5473.781048758005, 5880.470757631833, 5892.705364731832, 6043.75824967014, 6105.48103411215, 4954.00919816031, 5637.46444087811, 5990.711996920683, 6042.280973561827, 6059.212302400836, 5396.703181324908, 6131.724072416663, 6157.876842463215, 6168.290646575701, 6196.47329976957, 5242.397124330599, 5637.351704554028, 5890.882182356243, 5949.1076338549565, 5969.462748352669], "value": 4636.045924900431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.5277951280453, 763.9961800190998, 766.3792328214143, 824.8556502612043, 833.5207255827896, 14995.025323353975, 15652.765208521882, 15666.843331566695, 15681.29434175462, 15699.215039248049, 14466.0, 14501.637459063528, 14657.193854338007, 14694.191819449927, 14735.26323683817, 915.208344781764, 954.265215783846, 958.6740508227201, 960.0639376607821, 961.0581630002602, 924.7595625137445, 948.4451595816456, 955.6989548292265, 955.7515046087998, 968.6416026070364, 1024.2113572549133, 1025.149126225235, 1026.5226669598635, 1027.7276521721749, 1028.5782829040095, 1020.5713600287822, 1022.2282176956425, 1022.3150489172273, 1022.9335093218917, 1023.539407266733, 761.5164370624638, 761.6572542355907, 762.3786613909646, 762.664427651837, 763.904511936008, 16148.919255403647, 16421.83578164215, 16622.25199866009, 16675.332986680518, 16695.91652041732, 14542.491012814606, 14650.63373415673, 14749.631259218499, 14778.778318325234, 14819.481318153921, 11282.435878206057, 11451.484683189277, 11464.828027579593, 11799.233049851731, 11919.463624136848, 3245.9188520286943, 3738.3831667774784, 3761.755485893408, 3778.0932576181795, 3903.6291552302487, 109006.45496772465, 111225.0, 111306.44346778296, 112614.0, 112747.87252127456, 9842.901570984342, 11279.210455268216, 11349.886501135048, 11388.0, 11581.594644187413, 25227.74772252291, 25242.0, 25253.747462525138, 25283.494330113295, 25343.493130137664, 7728.961355193301, 7798.142204357516, 7903.0, 7945.324647405036, 8016.438849280495, 4226.450561426995, 4313.396124542566, 4338.913221735547, 4433.578810013044, 4476.686631935799, 3502.0, 3573.2317551726505, 3574.0528759878134, 3594.263176048904, 3599.9280014399565, 567.4665814134701, 616.8095575539163, 625.2497003595703, 627.1032423634156, 650.0476801485846, 651.3551583931874, 654.1430725749284, 663.7046514301186, 669.8928171492636, 678.59284429342, 9919.305648604528, 9999.25005624581, 10051.597936082475, 10156.513794267757, 10374.533146008447, 646.7639311651213, 684.5186200024909, 686.8159253573584, 693.2547511425238, 721.4300702445009, 3930.331843586597, 4894.437139728905, 4902.656814023056, 4910.729909854921, 4919.90160196794, 72842.0, 100297.0, 101421.49289253507, 101498.0, 103872.0, 88920.5553972239, 89164.0, 90388.5480572593, 90569.0, 90837.0, 74948.87576686354, 75929.86105208426, 78236.21763782403, 79375.60312198402, 79466.60266698746, 9204.631814727336, 9488.33954058051, 9598.9040109598, 9606.615735370786, 9618.182454491447, 45925.0, 46831.76584117058, 46933.76533117313, 47305.08686414198, 47801.521984779705, 58288.12567811571, 58856.0, 59241.11138333015, 59761.0, 60228.795424092146, 11536.480858361227, 11546.653600392001, 11624.94187529057, 11859.940700296444, 12381.62855114348, 12651.683707907376, 12660.366981650697, 12841.486340546273, 12862.807057894326, 13716.108452950526, 11832.881671183522, 11906.285622862655, 11937.224080434744, 12194.329311887577, 12463.314517701614, 11832.52669893229, 12240.69398265015, 12410.193337433038, 13293.335333233494, 13755.38100785447, 13128.671783205114, 13143.60569182926, 13244.271565064015, 13481.460741570227, 13725.313734313044, 10940.713958042623, 10993.780124397626, 11109.388983605979, 11330.660080197607, 11657.470140392514, 9948.39364018731, 10079.530515023573, 10123.544440500342, 11143.888561114285, 11263.436828158723], "value": 7573.606770397612, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 116.0, 114.0, 114.0, 116.0, 115.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 112.0, 113.0, 147.0, 125.0, 92.0, 131.0, 141.0, 167.0, 140.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 184.0, 187.0, 184.0, 184.0, 179.0, 185.0, 184.0, 183.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 63.0, 120.0, 87.0, 89.0, 50.0, 78.0, 103.0, 87.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 87.0, 70.0, 70.0, 70.0, 84.0, 71.0, 70.0, 85.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 89.0, 88.0, 89.0, 89.0, 88.0, 88.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 102.0, 125.0], "value": 98.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 83.0, 84.0, 85.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 64.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 65.0, 58.0, 62.0, 56.0, 58.0, 58.0, 57.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 83.0, 81.0, 82.0, 82.0, 82.0, 83.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 136.0, 136.0, 137.0, 139.0, 136.0, 140.0, 181.0, 135.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 187.0, 187.0, 190.0, 183.0, 193.0, 185.0, 190.0, 231.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 69.0, 69.0], "value": 68.5, "unit": "score"}]}]} 15:49:48 INFO - Return code: 0 15:49:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:49:48 ERROR - # TBPL SUCCESS # 15:49:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:49:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:49:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:49:48 INFO - 2017-03-15 15:49:48.147 screenresolution[2255:27543] starting screenresolution argv=screenresolution get 15:49:48 INFO - 2017-03-15 15:49:48.150 screenresolution[2255:27543] Display 0: 1600x1200x32@60 15:49:48 INFO - 2017-03-15 15:49:48.156 screenresolution[2256:27546] starting screenresolution argv=screenresolution list 15:49:48 INFO - Available Modes on Display 0 15:49:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:49:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:49:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:49:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:49:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:49:48 INFO - Intel Iris: 15:49:48 INFO - Chipset Model: Intel Iris 15:49:48 INFO - Type: GPU 15:49:48 INFO - Bus: Built-In 15:49:48 INFO - VRAM (Dynamic, Max): 1536 MB 15:49:48 INFO - Vendor: Intel (0x8086) 15:49:48 INFO - Device ID: 0x0a2e 15:49:48 INFO - Revision ID: 0x0009 15:49:48 INFO - Displays: 15:49:48 INFO - Display: 15:49:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:49:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:49:48 INFO - Display Serial Number: 1600x1200 60 15:49:48 INFO - Main Display: Yes 15:49:48 INFO - Mirror: Off 15:49:48 INFO - Online: Yes 15:49:48 INFO - Rotation: Supported 15:49:48 INFO - Return code: 0 15:49:48 INFO - Running post-action listener: _resource_record_post_action 15:49:48 INFO - [mozharness: 2017-03-15 22:49:48.385834Z] Finished run-tests step (success) 15:49:48 INFO - Running post-run listener: _resource_record_post_run 15:49:48 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 1536000; Write bytes: 513680384; Read time: 8; Write time: 1595 15:49:48 INFO - TinderboxPrint: CPU usage
53.4% 15:49:48 INFO - TinderboxPrint: I/O read bytes / time
1,536,000 / 8 15:49:48 INFO - TinderboxPrint: I/O write bytes / time
513,680,384 / 1,595 15:49:48 INFO - TinderboxPrint: CPU idle
2,242.0 (46.6%) 15:49:48 INFO - TinderboxPrint: CPU system
957.0 (19.9%) 15:49:48 INFO - TinderboxPrint: CPU user
1,610.6 (33.5%) 15:49:48 INFO - TinderboxPrint: Swap in / out
211,140,608 / 0 15:49:48 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207747584; Write bytes: 201293824; Read time: 15768; Write time: 436 15:49:48 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 1507328; Write bytes: 301306880; Read time: 7; Write time: 1120 15:49:48 INFO - Running post-run listener: _upload_blobber_files 15:49:48 INFO - Blob upload gear active. 15:49:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:49:48 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 15:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:49:49 INFO - (blobuploader) - INFO - Open directory for files ... 15:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:50 INFO - (blobuploader) - INFO - Done attempting. 15:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:51 INFO - (blobuploader) - INFO - Done attempting. 15:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:52 INFO - (blobuploader) - INFO - Done attempting. 15:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:54 INFO - (blobuploader) - INFO - Done attempting. 15:49:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:49:54 INFO - Return code: 0 15:49:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:49:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:49:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5bf309be233f4a7ba29dc269f15e2cfa0d358445bed034b5e8655da1d3e12a94e800d8d11593645a28399810c653459497c9c9718825288786c6c17f5f87850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ace9d173b78d5b6eea0895f0caf576a5ebcdf915593e2a6a7b5e41233320bd9d1a045094fd8e1d754e6d37b7043e3b230524aad8a6a5f9613204e75e6e76ba5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b67aaaf26719bd7b7c8636f124091e6ccd744d7711f8cface83302f07d5b410c5590726743e0061dfb6e7b82b9790ea7c4b68a365345072bfdf8d74b0a561e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6e92bc9c6d109673608ce327e8013c738fd4df4044ae2e2cdd1dff48a5ee93a233e24cae65b08d816c8753a619c66f8afd4eb74ab36e9a54dc4b7a1ba5c45a"} 15:49:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:49:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:49:54 INFO - Contents: 15:49:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5bf309be233f4a7ba29dc269f15e2cfa0d358445bed034b5e8655da1d3e12a94e800d8d11593645a28399810c653459497c9c9718825288786c6c17f5f87850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ace9d173b78d5b6eea0895f0caf576a5ebcdf915593e2a6a7b5e41233320bd9d1a045094fd8e1d754e6d37b7043e3b230524aad8a6a5f9613204e75e6e76ba5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b67aaaf26719bd7b7c8636f124091e6ccd744d7711f8cface83302f07d5b410c5590726743e0061dfb6e7b82b9790ea7c4b68a365345072bfdf8d74b0a561e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6e92bc9c6d109673608ce327e8013c738fd4df4044ae2e2cdd1dff48a5ee93a233e24cae65b08d816c8753a619c66f8afd4eb74ab36e9a54dc4b7a1ba5c45a"} 15:49:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:49:54 INFO - Copying logs to upload dir... 15:49:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:49:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.540073 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-15 15:49:54.827616) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:54.831360) ========= 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.dVybP1JbBx/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.KAUjFGZUj5/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5bf309be233f4a7ba29dc269f15e2cfa0d358445bed034b5e8655da1d3e12a94e800d8d11593645a28399810c653459497c9c9718825288786c6c17f5f87850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ace9d173b78d5b6eea0895f0caf576a5ebcdf915593e2a6a7b5e41233320bd9d1a045094fd8e1d754e6d37b7043e3b230524aad8a6a5f9613204e75e6e76ba5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b67aaaf26719bd7b7c8636f124091e6ccd744d7711f8cface83302f07d5b410c5590726743e0061dfb6e7b82b9790ea7c4b68a365345072bfdf8d74b0a561e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6e92bc9c6d109673608ce327e8013c738fd4df4044ae2e2cdd1dff48a5ee93a233e24cae65b08d816c8753a619c66f8afd4eb74ab36e9a54dc4b7a1ba5c45a"} build_url:https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5bf309be233f4a7ba29dc269f15e2cfa0d358445bed034b5e8655da1d3e12a94e800d8d11593645a28399810c653459497c9c9718825288786c6c17f5f87850", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ace9d173b78d5b6eea0895f0caf576a5ebcdf915593e2a6a7b5e41233320bd9d1a045094fd8e1d754e6d37b7043e3b230524aad8a6a5f9613204e75e6e76ba5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b67aaaf26719bd7b7c8636f124091e6ccd744d7711f8cface83302f07d5b410c5590726743e0061dfb6e7b82b9790ea7c4b68a365345072bfdf8d74b0a561e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e6e92bc9c6d109673608ce327e8013c738fd4df4044ae2e2cdd1dff48a5ee93a233e24cae65b08d816c8753a619c66f8afd4eb74ab36e9a54dc4b7a1ba5c45a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:54.866729) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:54.867072) ========= 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.dVybP1JbBx/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.KAUjFGZUj5/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.005166 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:54.915838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 15:49:54.916166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 15:49:54.916511) ========= ========= Total master_lag: 0.18 =========