builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0242 starttime: 1485392246.15 results: success (0) buildid: 20170125145631 builduid: 6e7fbdc50fe24eb0a711df44a7530ed9 revision: b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.148453) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.149492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.150010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.177871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.178637) ========= 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.IRrkLzRfK8/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.cozdEw8pmO/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-01-25 16:57: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% 84.8M=0s 2017-01-25 16:57:26 (84.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110588 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.319106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.319925) ========= 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.IRrkLzRfK8/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.cozdEw8pmO/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.025060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:26.373074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 16:57:26.374024) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IRrkLzRfK8/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.cozdEw8pmO/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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-01-25 16:57:26,482 truncating revision to first 12 chars 2017-01-25 16:57:26,482 Setting DEBUG logging. 2017-01-25 16:57:26,482 attempt 1/10 2017-01-25 16:57:26,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b123b9a23ce9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 16:57:27,979 unpacking tar archive at: mozilla-aurora-b123b9a23ce9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.783227 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 16:57:28.186566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:28.187376) ========= script_repo_revision: b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:28.188402) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:28.189124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 16:57:28.209064) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-25 16:57:28.209465) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IRrkLzRfK8/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.cozdEw8pmO/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:57:28 INFO - MultiFileLogger online at 20170125 16:57:28 in /builds/slave/test 16:57:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:28 INFO - {'append_to_log': False, 16:57:28 INFO - 'base_work_dir': '/builds/slave/test', 16:57:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:28 INFO - 'branch': 'Mozilla-Aurora', 16:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:28 INFO - 'config_files': ('talos/mac_config.py',), 16:57:28 INFO - 'default_actions': ('clobber', 16:57:28 INFO - 'read-buildbot-config', 16:57:28 INFO - 'download-and-extract', 16:57:28 INFO - 'populate-webroot', 16:57:28 INFO - 'create-virtualenv', 16:57:28 INFO - 'install', 16:57:28 INFO - 'run-tests'), 16:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:28 INFO - 'download_minidump_stackwalk': True, 16:57:28 INFO - 'download_symbols': 'ondemand', 16:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:28 INFO - 'installer_path': 'installer.exe', 16:57:28 INFO - 'log_level': 'info', 16:57:28 INFO - 'log_name': 'talos', 16:57:28 INFO - 'log_to_console': True, 16:57:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:57:28 INFO - 'opt_config_files': (), 16:57:28 INFO - 'pip_index': False, 16:57:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:57:28 INFO - 'cmd': ('bash', 16:57:28 INFO - '-c', 16:57:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:57:28 INFO - 'enabled': True, 16:57:28 INFO - 'halt_on_failure': False, 16:57:28 INFO - 'name': 'check_screen_resolution'},), 16:57:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:57:28 INFO - 'cmd': ('bash', 16:57:28 INFO - '-c', 16:57:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:57:28 INFO - 'enabled': True, 16:57:28 INFO - 'halt_on_failure': False, 16:57:28 INFO - 'name': 'check_screen_resolution'},), 16:57:28 INFO - 'run_cmd_checks_enabled': True, 16:57:28 INFO - 'sps_profile': False, 16:57:28 INFO - 'sps_profile_interval': 0, 16:57:28 INFO - 'suite': 'dromaeojs', 16:57:28 INFO - 'system_bits': '32', 16:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:28 INFO - 'title': 't-yosemite-r7-0242', 16:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:28 INFO - 'use_talos_json': True, 16:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:28 INFO - 'work_dir': 'build'} 16:57:28 INFO - [mozharness: 2017-01-26 00:57:28.420285Z] Running clobber step. 16:57:28 INFO - Running pre-action listener: _resource_record_pre_action 16:57:28 INFO - Running main action method: clobber 16:57:28 INFO - rmtree: /builds/slave/test/build 16:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:30 INFO - Running post-action listener: _resource_record_post_action 16:57:30 INFO - [mozharness: 2017-01-26 00:57:30.865887Z] Finished clobber step (success) 16:57:30 INFO - [mozharness: 2017-01-26 00:57:30.866050Z] Running read-buildbot-config step. 16:57:30 INFO - Running pre-action listener: _resource_record_pre_action 16:57:30 INFO - Running main action method: read_buildbot_config 16:57:30 INFO - Using buildbot properties: 16:57:30 INFO - { 16:57:30 INFO - "project": "", 16:57:30 INFO - "product": "firefox", 16:57:30 INFO - "script_repo_revision": "production", 16:57:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:57:30 INFO - "repository": "", 16:57:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:57:30 INFO - "buildid": "20170125145631", 16:57:30 INFO - "pgo_build": "False", 16:57:30 INFO - "basedir": "/builds/slave/test", 16:57:30 INFO - "buildnumber": 40, 16:57:30 INFO - "slavename": "t-yosemite-r7-0242", 16:57:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:57:30 INFO - "platform": "yosemite_r7", 16:57:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:57:30 INFO - "branch": "mozilla-aurora", 16:57:30 INFO - "repo_path": "releases/mozilla-aurora", 16:57:30 INFO - "revision": "b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d", 16:57:30 INFO - "stage_platform": "macosx64", 16:57:30 INFO - "builduid": "6e7fbdc50fe24eb0a711df44a7530ed9", 16:57:30 INFO - "slavebuilddir": "test" 16:57:30 INFO - } 16:57:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 16:57:30 INFO - Running post-action listener: _resource_record_post_action 16:57:30 INFO - [mozharness: 2017-01-26 00:57:30.869015Z] Finished read-buildbot-config step (success) 16:57:30 INFO - [mozharness: 2017-01-26 00:57:30.869124Z] Running download-and-extract step. 16:57:30 INFO - Running pre-action listener: _resource_record_pre_action 16:57:30 INFO - Running main action method: download_and_extract 16:57:30 INFO - mkdir: /builds/slave/test/build/tests 16:57: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')]} 16:57:30 INFO - trying https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 16:57:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 16:57:32 INFO - Downloaded 1199 bytes. 16:57:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:57:32 INFO - Using the following test package requirements: 16:57:32 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:57:32 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 16:57:32 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 16:57:32 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'jsshell-mac.zip'], 16:57:32 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 16:57:32 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:57:32 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 16:57:32 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 16:57:32 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 16:57:32 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:57:32 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 16:57:32 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:57:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:57:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:57:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:57:33 INFO - Expected file size: 16349693 16:57:33 INFO - Obtained file size: 16349693 16:57:39 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:57:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:57:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:57:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:57:40 INFO - Expected file size: 16349693 16:57:40 INFO - Obtained file size: 16349693 16:57:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 16:57:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:57:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 16:57:48 INFO - Expected file size: 14403485 16:57:48 INFO - Obtained file size: 14403485 16:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:48 INFO - trying https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:57:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 16:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 16:57:50 INFO - Downloaded 73891627 bytes. 16:57:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:57:50 INFO - mkdir: /builds/slave/test/properties 16:57:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:50 INFO - Contents: 16:57:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:57:51 INFO - Running post-action listener: _resource_record_post_action 16:57:51 INFO - Running post-action listener: set_extra_try_arguments 16:57:51 INFO - [mozharness: 2017-01-26 00:57:51.684865Z] Finished download-and-extract step (success) 16:57:51 INFO - [mozharness: 2017-01-26 00:57:51.684995Z] Running populate-webroot step. 16:57:51 INFO - Running pre-action listener: _resource_record_pre_action 16:57:51 INFO - Running main action method: populate_webroot 16:57:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:51 INFO - '--tppagecycles', 16:57:51 INFO - '7'], 16:57:51 INFO - 'tests': ['tsvgm']}}, 16:57:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['damp', 'tps']}, 16:57:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'tests': ['damp', 'tps']}, 16:57:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['dromaeo_dom']}, 16:57:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['basic_compositor_video']}, 16:57:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:57:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore', 16:57:51 INFO - 'tabpaint']}, 16:57:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore', 16:57:51 INFO - 'tabpaint']}, 16:57:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore', 16:57:51 INFO - 'tabpaint']}, 16:57:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore', 16:57:51 INFO - 'tabpaint']}, 16:57:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore', 16:57:51 INFO - 'tabpaint']}, 16:57:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['a11yr', 16:57:51 INFO - 'ts_paint', 16:57:51 INFO - 'tpaint', 16:57:51 INFO - 'sessionrestore', 16:57:51 INFO - 'sessionrestore_no_auto_restore', 16:57:51 INFO - 'tabpaint']}, 16:57:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['tsvgx', 16:57:51 INFO - 'tsvgr_opacity', 16:57:51 INFO - 'tart', 16:57:51 INFO - 'tscrollx', 16:57:51 INFO - 'cart', 16:57:51 INFO - 'tsvg_static']}, 16:57:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:51 INFO - 'tsvgr_opacity', 16:57:51 INFO - 'tart', 16:57:51 INFO - 'tscrollx', 16:57:51 INFO - 'cart', 16:57:51 INFO - 'tsvg_static']}, 16:57:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'talos_options': ['--disable-e10s'], 16:57:51 INFO - 'tests': ['tp5o']}, 16:57:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:57:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'talos_options': ['--disable-e10s', 16:57:51 INFO - '--xperf_path', 16:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:51 INFO - 'tests': ['tp5n']}, 16:57:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:57:51 INFO - 'talos_options': ['--xperf_path', 16:57:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:51 INFO - 'tests': ['tp5n']}}, 16:57:51 INFO - 'talos.zip': {'path': '', 16:57:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:51 INFO - Running post-action listener: _resource_record_post_action 16:57:51 INFO - [mozharness: 2017-01-26 00:57:51.703222Z] Finished populate-webroot step (success) 16:57:51 INFO - [mozharness: 2017-01-26 00:57:51.703328Z] Running create-virtualenv step. 16:57:51 INFO - Running pre-action listener: _resource_record_pre_action 16:57:51 INFO - Running main action method: create_virtualenv 16:57:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:51 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 16:57:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:51 INFO - Using real prefix '/tools/python27' 16:57:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:55 INFO - Installing pip.................done. 16:57:55 INFO - Return code: 0 16:57:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:57:55 INFO - Reading from file tmpfile_stdout 16:57:55 INFO - Output received: 16:57:55 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) 16:57:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:55 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')]} 16:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:55 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')]} 16:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:55 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:57:55 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 16:57:55 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 16:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:55 INFO - 'HOME': '/Users/cltbld', 16:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:55 INFO - 'LOGNAME': 'cltbld', 16:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:55 INFO - 'MOZ_NO_REMOTE': '1', 16:57:55 INFO - 'NO_EM_RESTART': '1', 16:57:55 INFO - 'PAGER': '/bin/cat', 16:57:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:55 INFO - 'PWD': '/builds/slave/test', 16:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:55 INFO - 'SHELL': '/bin/bash', 16:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:57:55 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:55 INFO - 'USER': 'cltbld', 16:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:55 INFO - 'XPC_FLAGS': '0x0', 16:57:55 INFO - 'XPC_SERVICE_NAME': '0', 16:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:56 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 16:57:56 INFO - Cleaning up... 16:57:56 INFO - Return code: 0 16:57:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57:56 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')]} 16:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:56 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')]} 16:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:56 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:57:56 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 16:57:56 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 16:57:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:57:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:56 INFO - 'HOME': '/Users/cltbld', 16:57:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:56 INFO - 'LOGNAME': 'cltbld', 16:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:56 INFO - 'MOZ_NO_REMOTE': '1', 16:57:56 INFO - 'NO_EM_RESTART': '1', 16:57:56 INFO - 'PAGER': '/bin/cat', 16:57:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:56 INFO - 'PWD': '/builds/slave/test', 16:57:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:56 INFO - 'SHELL': '/bin/bash', 16:57:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:57:56 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:57:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:56 INFO - 'USER': 'cltbld', 16:57:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:56 INFO - 'XPC_FLAGS': '0x0', 16:57:56 INFO - 'XPC_SERVICE_NAME': '0', 16:57:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:56 INFO - Downloading/unpacking psutil>=3.1.1 16:57:56 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 16:57:56 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 16:57:56 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 16:57:56 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 16:57:56 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 16:57:56 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 16:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:59 INFO - Installing collected packages: psutil 16:57:59 INFO - Running setup.py install for psutil 16:58:00 INFO - building 'psutil._psutil_osx' extension 16:58:00 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 16:58:00 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 16:58:00 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 16:58:00 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 16:58:00 INFO - building 'psutil._psutil_posix' extension 16:58:00 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 16:58:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:58:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:58:00 INFO - ^ 16:58:00 INFO - 1 warning generated. 16:58:00 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 16:58:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:01 INFO - Successfully installed psutil 16:58:01 INFO - Cleaning up... 16:58:01 INFO - Return code: 0 16:58:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:01 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:01 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 16:58:01 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 16:58:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:01 INFO - 'HOME': '/Users/cltbld', 16:58:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:01 INFO - 'LOGNAME': 'cltbld', 16:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:01 INFO - 'MOZ_NO_REMOTE': '1', 16:58:01 INFO - 'NO_EM_RESTART': '1', 16:58:01 INFO - 'PAGER': '/bin/cat', 16:58:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:01 INFO - 'PWD': '/builds/slave/test', 16:58:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:01 INFO - 'SHELL': '/bin/bash', 16:58:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:01 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:01 INFO - 'USER': 'cltbld', 16:58:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:01 INFO - 'XPC_FLAGS': '0x0', 16:58:01 INFO - 'XPC_SERVICE_NAME': '0', 16:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:58:01 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 16:58:01 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 16:58:01 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 16:58:01 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 16:58:01 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 16:58:01 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 16:58:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:58:04 INFO - Installing collected packages: mozsystemmonitor 16:58:04 INFO - Running setup.py install for mozsystemmonitor 16:58:04 INFO - Successfully installed mozsystemmonitor 16:58:04 INFO - Cleaning up... 16:58:04 INFO - Return code: 0 16:58:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:58:04 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')]} 16:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:04 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')]} 16:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:04 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:04 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 16:58:04 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 16:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:04 INFO - 'HOME': '/Users/cltbld', 16:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:04 INFO - 'LOGNAME': 'cltbld', 16:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:04 INFO - 'MOZ_NO_REMOTE': '1', 16:58:04 INFO - 'NO_EM_RESTART': '1', 16:58:04 INFO - 'PAGER': '/bin/cat', 16:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:04 INFO - 'PWD': '/builds/slave/test', 16:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:04 INFO - 'SHELL': '/bin/bash', 16:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:04 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:04 INFO - 'USER': 'cltbld', 16:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:04 INFO - 'XPC_FLAGS': '0x0', 16:58:04 INFO - 'XPC_SERVICE_NAME': '0', 16:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:58:04 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 16:58:04 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 16:58:04 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 16:58:04 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 16:58:04 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 16:58:04 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 16:58:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:07 INFO - warning: no files found matching '*.txt' 16:58:07 INFO - no previously-included directories found matching 'build' 16:58:07 INFO - no previously-included directories found matching 'dist' 16:58:07 INFO - no previously-included directories found matching '.git*' 16:58:07 INFO - Installing collected packages: jsonschema, functools32 16:58:07 INFO - Running setup.py install for functools32 16:58:07 INFO - warning: no files found matching '*.txt' 16:58:07 INFO - no previously-included directories found matching 'build' 16:58:07 INFO - no previously-included directories found matching 'dist' 16:58:07 INFO - no previously-included directories found matching '.git*' 16:58:07 INFO - Successfully installed jsonschema functools32 16:58:07 INFO - Cleaning up... 16:58:07 INFO - Return code: 0 16:58:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:58:07 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')]} 16:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:07 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')]} 16:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:07 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:07 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 16:58:07 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 16:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:07 INFO - 'HOME': '/Users/cltbld', 16:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:07 INFO - 'LOGNAME': 'cltbld', 16:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:07 INFO - 'MOZ_NO_REMOTE': '1', 16:58:07 INFO - 'NO_EM_RESTART': '1', 16:58:07 INFO - 'PAGER': '/bin/cat', 16:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:07 INFO - 'PWD': '/builds/slave/test', 16:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:07 INFO - 'SHELL': '/bin/bash', 16:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:07 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:07 INFO - 'USER': 'cltbld', 16:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:07 INFO - 'XPC_FLAGS': '0x0', 16:58:07 INFO - 'XPC_SERVICE_NAME': '0', 16:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:58:08 INFO - Cleaning up... 16:58:08 INFO - Return code: 0 16:58:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58:08 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')]} 16:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:08 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')]} 16:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:08 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:08 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 16:58:08 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 16:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:08 INFO - 'HOME': '/Users/cltbld', 16:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:08 INFO - 'LOGNAME': 'cltbld', 16:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:08 INFO - 'MOZ_NO_REMOTE': '1', 16:58:08 INFO - 'NO_EM_RESTART': '1', 16:58:08 INFO - 'PAGER': '/bin/cat', 16:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:08 INFO - 'PWD': '/builds/slave/test', 16:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:08 INFO - 'SHELL': '/bin/bash', 16:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:08 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:08 INFO - 'USER': 'cltbld', 16:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:08 INFO - 'XPC_FLAGS': '0x0', 16:58:08 INFO - 'XPC_SERVICE_NAME': '0', 16:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:08 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 16:58:08 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 16:58:08 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 16:58:08 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 16:58:08 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 16:58:08 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 16:58:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:12 INFO - Downloading docopt-0.6.1.tar.gz 16:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:12 INFO - Running setup.py install for blobuploader 16:58:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:12 INFO - Running setup.py install for requests 16:58:13 INFO - Running setup.py install for docopt 16:58:13 INFO - Successfully installed blobuploader requests docopt 16:58:13 INFO - Cleaning up... 16:58:13 INFO - Return code: 0 16:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:13 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:13 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 16:58:13 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 16:58:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:13 INFO - 'HOME': '/Users/cltbld', 16:58:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:13 INFO - 'LOGNAME': 'cltbld', 16:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:13 INFO - 'MOZ_NO_REMOTE': '1', 16:58:13 INFO - 'NO_EM_RESTART': '1', 16:58:13 INFO - 'PAGER': '/bin/cat', 16:58:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:13 INFO - 'PWD': '/builds/slave/test', 16:58:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:13 INFO - 'SHELL': '/bin/bash', 16:58:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:13 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:13 INFO - 'USER': 'cltbld', 16:58:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:13 INFO - 'XPC_FLAGS': '0x0', 16:58:13 INFO - 'XPC_SERVICE_NAME': '0', 16:58:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:13 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-7P7QYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:13 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-ZKnsHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:13 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-DfecjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:13 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Z1Ml6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-XnBFSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-3PFiM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-NHdh3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-PUye6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-nzTegg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-xBJEhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-xOTZ_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-OYTSc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-2SYIez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:14 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-XiZY7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-LU9X5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-JoObfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:15 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-kewkou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:15 INFO - Running setup.py install for manifestparser 16:58:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:15 INFO - Running setup.py install for mozcrash 16:58:15 INFO - Running setup.py install for mozdebug 16:58:15 INFO - Running setup.py install for mozdevice 16:58:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Running setup.py install for mozfile 16:58:16 INFO - Running setup.py install for mozhttpd 16:58:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Running setup.py install for mozinfo 16:58:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Running setup.py install for mozInstall 16:58:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Running setup.py install for mozleak 16:58:16 INFO - Running setup.py install for mozlog 16:58:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:16 INFO - Running setup.py install for moznetwork 16:58:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Running setup.py install for mozprocess 16:58:17 INFO - Running setup.py install for mozprofile 16:58:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Running setup.py install for mozrunner 16:58:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Running setup.py install for mozscreenshot 16:58:17 INFO - Running setup.py install for moztest 16:58:17 INFO - Running setup.py install for mozversion 16:58:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:17 INFO - Cleaning up... 16:58:18 INFO - Return code: 0 16:58:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:18 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:18 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 16:58:18 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 16:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:18 INFO - 'HOME': '/Users/cltbld', 16:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:18 INFO - 'LOGNAME': 'cltbld', 16:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:18 INFO - 'MOZ_NO_REMOTE': '1', 16:58:18 INFO - 'NO_EM_RESTART': '1', 16:58:18 INFO - 'PAGER': '/bin/cat', 16:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:18 INFO - 'PWD': '/builds/slave/test', 16:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:18 INFO - 'SHELL': '/bin/bash', 16:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:18 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:18 INFO - 'USER': 'cltbld', 16:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:18 INFO - 'XPC_FLAGS': '0x0', 16:58:18 INFO - 'XPC_SERVICE_NAME': '0', 16:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-oZ3ozs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-YDj0dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-eKMX_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-hnRZOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-iQuDFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-qKo46Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Q7We3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-rL22Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-YtGYvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:19 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)) 16:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:19 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-VFipOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:20 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)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-lVoI6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:20 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)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-toNtnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-GuOPsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:20 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)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-hXzlbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:20 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)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-TlE35N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:20 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)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Sp0Px4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:20 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)) 16:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:20 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-he2bVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:20 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)) 16:58:20 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)) 16:58:20 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)) 16:58:20 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)) 16:58:20 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)) 16:58:20 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)) 16:58:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:20 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 16:58:20 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 16:58:20 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 16:58:20 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 16:58:20 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 16:58:20 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 16:58:23 INFO - Downloading blessings-1.6.tar.gz 16:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:23 INFO - Installing collected packages: blessings 16:58:23 INFO - Running setup.py install for blessings 16:58:24 INFO - Successfully installed blessings 16:58:24 INFO - Cleaning up... 16:58:24 INFO - Return code: 0 16:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:24 INFO - Reading from file tmpfile_stdout 16:58:24 INFO - Current package versions: 16:58:24 INFO - blessings == 1.6 16:58:24 INFO - blobuploader == 1.2.4 16:58:24 INFO - docopt == 0.6.1 16:58:24 INFO - functools32 == 3.2.3-2 16:58:24 INFO - jsonschema == 2.5.1 16:58:24 INFO - manifestparser == 1.1 16:58:24 INFO - mozInstall == 1.12 16:58:24 INFO - mozcrash == 1.0 16:58:24 INFO - mozdebug == 0.1 16:58:24 INFO - mozdevice == 0.49 16:58:24 INFO - mozfile == 1.2 16:58:24 INFO - mozhttpd == 0.7 16:58:24 INFO - mozinfo == 0.9 16:58:24 INFO - mozleak == 0.1 16:58:24 INFO - mozlog == 3.4 16:58:24 INFO - moznetwork == 0.27 16:58:24 INFO - mozprocess == 0.24 16:58:24 INFO - mozprofile == 0.28 16:58:24 INFO - mozrunner == 6.13 16:58:24 INFO - mozscreenshot == 0.1 16:58:24 INFO - mozsystemmonitor == 0.3 16:58:24 INFO - moztest == 0.8 16:58:24 INFO - mozversion == 1.4 16:58:24 INFO - psutil == 3.1.1 16:58:24 INFO - requests == 1.2.3 16:58:24 INFO - wsgiref == 0.1.2 16:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:24 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 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:24 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 16:58:24 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 16:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:24 INFO - 'HOME': '/Users/cltbld', 16:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:24 INFO - 'LOGNAME': 'cltbld', 16:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:24 INFO - 'MOZ_NO_REMOTE': '1', 16:58:24 INFO - 'NO_EM_RESTART': '1', 16:58:24 INFO - 'PAGER': '/bin/cat', 16:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:24 INFO - 'PWD': '/builds/slave/test', 16:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:24 INFO - 'SHELL': '/bin/bash', 16:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:24 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:24 INFO - 'USER': 'cltbld', 16:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:24 INFO - 'XPC_FLAGS': '0x0', 16:58:24 INFO - 'XPC_SERVICE_NAME': '0', 16:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 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)) 16:58:24 INFO - Cleaning up... 16:58:24 INFO - Return code: 0 16:58:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f7db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f80768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe35b4796a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, '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.IRrkLzRfK8/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.cozdEw8pmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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 16:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:24 INFO - 'HOME': '/Users/cltbld', 16:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:24 INFO - 'LOGNAME': 'cltbld', 16:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:24 INFO - 'MOZ_NO_REMOTE': '1', 16:58:24 INFO - 'NO_EM_RESTART': '1', 16:58:24 INFO - 'PAGER': '/bin/cat', 16:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:24 INFO - 'PWD': '/builds/slave/test', 16:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:24 INFO - 'SHELL': '/bin/bash', 16:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:24 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:24 INFO - 'USER': 'cltbld', 16:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:24 INFO - 'XPC_FLAGS': '0x0', 16:58:24 INFO - 'XPC_SERVICE_NAME': '0', 16:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:24 INFO - Cleaning up... 16:58:25 INFO - Return code: 0 16:58:25 INFO - Running post-action listener: _resource_record_post_action 16:58:25 INFO - Running post-action listener: _start_resource_monitoring 16:58:25 INFO - Starting resource monitoring. 16:58:25 INFO - [mozharness: 2017-01-26 00:58:25.043914Z] Finished create-virtualenv step (success) 16:58:25 INFO - [mozharness: 2017-01-26 00:58:25.044986Z] Running install step. 16:58:25 INFO - Running pre-action listener: _resource_record_pre_action 16:58:25 INFO - Running main action method: install 16:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:25 INFO - Reading from file tmpfile_stdout 16:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:25 INFO - Reading from file tmpfile_stdout 16:58:25 INFO - Output received: 16:58:25 INFO - Usage: mozinstall [options] installer 16:58:25 INFO - Options: 16:58:25 INFO - -h, --help show this help message and exit 16:58:25 INFO - -d DEST, --destination=DEST 16:58:25 INFO - Directory to install application into. [default: 16:58:25 INFO - "/builds/slave/test"] 16:58:25 INFO - --app=APP Application being installed. [default: firefox] 16:58:25 INFO - mkdir: /builds/slave/test/build/application 16:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:58:45 INFO - Reading from file tmpfile_stdout 16:58:45 INFO - Output received: 16:58:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:58:45 INFO - Running post-action listener: _resource_record_post_action 16:58:45 INFO - [mozharness: 2017-01-26 00:58:45.644931Z] Finished install step (success) 16:58:45 INFO - [mozharness: 2017-01-26 00:58:45.645102Z] Running run-tests step. 16:58:45 INFO - Running pre-action listener: _resource_record_pre_action 16:58:45 INFO - Running main action method: run_tests 16:58:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:45 INFO - 2017-01-25 16:58:45.660 screenresolution[1629:7398] starting screenresolution argv=screenresolution get 16:58:45 INFO - 2017-01-25 16:58:45.662 screenresolution[1629:7398] Display 0: 1600x1200x32@60 16:58:45 INFO - 2017-01-25 16:58:45.668 screenresolution[1630:7400] starting screenresolution argv=screenresolution list 16:58:45 INFO - Available Modes on Display 0 16:58:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:45 INFO - Intel Iris: 16:58:45 INFO - Chipset Model: Intel Iris 16:58:45 INFO - Type: GPU 16:58:45 INFO - Bus: Built-In 16:58:45 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:45 INFO - Vendor: Intel (0x8086) 16:58:45 INFO - Device ID: 0x0a2e 16:58:45 INFO - Revision ID: 0x0009 16:58:45 INFO - Displays: 16:58:45 INFO - Display: 16:58:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:45 INFO - Display Serial Number: 1600x1200 60 16:58:45 INFO - Main Display: Yes 16:58:45 INFO - Mirror: Off 16:58:45 INFO - Online: Yes 16:58:45 INFO - Rotation: Supported 16:58:45 INFO - Return code: 0 16:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:45 INFO - Python 2.7.3 16:58:45 INFO - Return code: 0 16:58:45 INFO - grabbing minidump binary from tooltool 16:58: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')]} 16:58:45 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 0x107d5bd30>, '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 0x107c82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d50be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:45 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 16:58:45 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 16:58:45 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 16:58:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:46 INFO - Return code: 0 16:58:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:58:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:58:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 16:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --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 16:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IRrkLzRfK8/Render', 16:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:46 INFO - 'HOME': '/Users/cltbld', 16:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:46 INFO - 'LOGNAME': 'cltbld', 16:58:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:46 INFO - 'MOZ_NO_REMOTE': '1', 16:58:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:46 INFO - 'NO_EM_RESTART': '1', 16:58:46 INFO - 'PAGER': '/bin/cat', 16:58:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:46 INFO - 'PWD': '/builds/slave/test', 16:58:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:46 INFO - 'SHELL': '/bin/bash', 16:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cozdEw8pmO/Listeners', 16:58:46 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 16:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:46 INFO - 'USER': 'cltbld', 16:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:46 INFO - 'XPC_FLAGS': '0x0', 16:58:46 INFO - 'XPC_SERVICE_NAME': '0', 16:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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 16:58:46 INFO - mozversion application_buildid: 20170125145631 16:58:46 INFO - mozversion application_changeset: b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d 16:58:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:58:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:46 INFO - mozversion application_name: Firefox 16:58:46 INFO - mozversion application_remotingname: firefox-dev 16:58:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:58:46 INFO - mozversion application_vendor: Mozilla 16:58:46 INFO - mozversion application_version: 53.0a2 16:58:46 INFO - mozversion platform_buildid: 20170125145631 16:58:46 INFO - mozversion platform_changeset: b123b9a23ce95286b60fd9b0bbd27a1cc12f4d1d 16:58:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:58:46 INFO - mozversion platform_version: 53.0a2 16:58:46 INFO - using testdate: 1485392326 16:58:46 INFO - actual date: 1485392326 16:58:46 INFO - starting webserver on 'localhost:49243' 16:58:46 INFO - SUITE-START | Running 2 tests 16:58:46 INFO - TEST-START | dromaeo_css 16:58:46 INFO - operating with platform_type : mac_ 16:58:46 INFO - Initialising browser for dromaeo_css test... 16:58:46 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmps496Bd/profile http://localhost:49243/getInfo.html) 16:58:48 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 16:58:48 INFO - PROCESS | 1640 | colorDepth:24 16:58:48 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 16:58:48 INFO - PROCESS | 1640 | __metrics 16:58:48 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 16:58:48 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:58:48 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:58:49 INFO - TEST-INFO | 1640: exit 0 16:58:49 INFO - Browser initialized. 16:58:49 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:49 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmps496Bd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:01 INFO - PROCESS | 1642 | RSS: Main: 213004288 16:59:01 INFO - PROCESS | 1642 | 17:02:05 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 17:02:07 INFO - PROCESS | 1642 | RSS: Main: 375418880 17:02:07 INFO - PROCESS | 1642 | 17:03:51 INFO - PROCESS | 1642 | ************************* 17:03:51 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 17:03:51 INFO - PROCESS | 1642 | 17:03:51 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:03:51 INFO - PROCESS | 1642 | Full stack: 17:03:51 INFO - PROCESS | 1642 | ************************* 17:05:10 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 17:05:11 INFO - PROCESS | 1642 | RSS: Main: 349351936 17:05:11 INFO - PROCESS | 1642 | 17:08:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 17:08:14 INFO - PROCESS | 1642 | RSS: Main: 324939776 17:08:14 INFO - PROCESS | 1642 | 17:11:16 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 17:11:17 INFO - PROCESS | 1642 | RSS: Main: 323805184 17:11:17 INFO - PROCESS | 1642 | 17:14:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 17:14:21 INFO - PROCESS | 1642 | RSS: Main: 323960832 17:14:21 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 17:17:24 INFO - PROCESS | 1642 | RSS: Main: 484032512 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | __start_tp_report 17:17:24 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 17:17:24 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 17:17:24 INFO - PROCESS | 1642 | |i|pagename|runs| 17:17:24 INFO - PROCESS | 1642 | |0;dojo.html;3133.8119712817233;3383.3402486515124;3388.81361525116;3405.4381027130526;3438.226399060212;5798.420157984199;5803.216565763626;5807.73865176067;5809.302883653957;5820.941790582093;5418.864528386783;5689.857753556153;5768.826935191951;5774.2782152230975;5799.623024503415;5230.163173892169;5265.763040663161;5277.234800953859;5283.762230699608;5328.333958255218;5242.239875218091;5244;5244.763985620656;5362.624616276862;5373.086575282192;5265.315508983846;5294.841154765363;5297.44376840432;5303.018941495817;5355.598330125236;5342.439043900393;5343.145096784496;5343.759530821103;5353.785848566053;5360.91958620621;5128.051310507568;5210.843674689765;5281.287026251445;5298.761555730001;5343.305370301875;5658.264425624684;5703.144528320744;5718.742656580423;5724.198612194296;5749.108888122348;5104.540591346797;6190.907136392958;6199.287081985584;6200.472959798422;6204.7828326008375;6188.81433556994;6210.254769427697;6235.501159907197;6238.719257633417;6249.812505624838;5891.7937872175125;5896.734646940812;5905.379935106795;5911.29064512257;5935.228420305376;6202.81391558254;6325.114483972247;6328.240611126695;6329.620222786648;6332.68336583169;6159.722812473449;6169.383061693795;6208.9689551551955;6219.346968568326;6256.562040657111;6274.592151510137;6288.27684816252;6304.873902521924;6307.463865571386;6318.399752023551;6242.5942313749465;6248.656323902229;6276.811695649138;6277.121203031579;6277.96861015692;6170.568060235741;6219.378062193744;6259.624422534663;6286.811395658137;6300.464460520815;5036.445990940993;5041.344625198701;5050.116229659869;5054.444011158769;5078.949210507922;4472.0608672179205;4485.820567177341;4490.169318676056;4518.43519560055;4538.818447262139;5610.27066481363;5639.069553523705;5695.088785794253;5965.701714914237;6006.339302676702;6206.689665516707;6250.562460627712;6260.342664020303;6265.749370025239;6269.8746025079245;5803;5818.272715910512;5996.820095397145;6001.06983417571;6022.09668549721;5452.182172674131;5455.099908515051;5457.781688732485;5457.945420545744;5496.1755736639825;6228.4705800007505;6240.563160578716;6248.4376406123665;6267.843303917439;6332.176817013758;6262.53031022666;6291.842703932438;6292.3078461368295;6294;6315.90526142099;6212.47193988516;6259.12372267892;6323;6327.778527751507;6331.113644089924;6185.876282474235;6272.247330320391;6284.968575157095;6302.432781049728;6303.149074874833;6247.875042499034;6266.717997690206;6267.749290028348;6308.432241098323;6310.400511951358;6062.575619706578;6129.601575897553;6149.41580549847;6253.530985176039;6264.279607844974;6117.796956032775;6128.442013631005;6132.722655450899;6160.3223645398075;6179.227596550431;5180.766865490987;6096.573239873166;6104.053871649901;6106.267247930276;6143.96928015357;5787.421257874179;6128.417800308964;6195.473384762346;6195.597286176384;6217.253929528486;5879.823605291848;5909.763609455574;5948;6082;6099.512039036955 17:17:24 INFO - PROCESS | 1642 | |1;ext.html;444.9110177964408;483.16171442547176;496.21102447109087;497.8829974955887;513.9743012849357;30909.690903090963;32293.83853080734;40089.99775005622;42471.787641061754;42577.36133957985;35660.64339356605;42547.78726106365;42858.35712464308;42923.78538107313;43031.35452968208;8337.666493340259;8476.406651534395;8933.151350621696;9362.812743745155;9380.90619093807;8276.379271554628;8479.618417171212;8495.95752021239;8500.192481714228;11053.226274160812;9476.241900647932;11336.319820810737;11343.943280283587;11367.829482557727;11390.829137562943;11245.9878610925;11291.604793832177;11340.319580825177;11343.602973895873;11348.773024539505;8296.668133274661;8552.35857310698;11250.943745281304;11279.984801367917;11295.20933534653;42428;42983;43050.78474607638;43055.78472107651;43133.352999704715;4021.577734337882;4034.8991275218355;4049.230646177217;4083.3670781028986;4157.750534967911;29185.124446266647;29681.406371872443;29874.40251194986;29973.400531989457;31043.844780776177;3174.206448387903;3195.0734287056725;3339.899803005914;3370.882019129343;3376.324735052999;488004;491040;493031;493353.53323233157;501384.49307753594;66083.00875486775;66348;66412.00381994274;66667;66717.66641166763;69818.95271570931;69893.65053174701;69962.30037699558;70029.64985175144;70080.2991970084;16405.58986025335;16905;17135.91432042857;17191.656166876593;17244.913775431043;12823.487060517475;12897;12905.677358066123;12910.870891291155;12937.805932911015;15925.761113583305;16576.6684666306;17178.341847050622;18007.549811254823;18795.53011174704;6363.140975968277;6454.483641308684;6492.253390860112;6507.511936604774;6539.869202615921;879.2218886285683;892.5938697892443;898.7438580004667;901.1394118616705;921.1709461484584;29992.400151996837;30181.69818301833;30182.969458482472;30230;30666.386672266875;1084.208527774729;1087.505185140759;1089.4443833644898;1119.9944000279947;1223.2966044524435;15442.536723898302;15835.287412066486;15836.604084897739;16133.193340332937;16260.349586016664;506089;586930;591270.043649779;594425;597252;61185;61249;61268.77462450726;61358;61458;1379.9310034498235;1400.3278426355203;1429.1496559547054;1433.240382597225;1443.8483959184343;27957.30106747266;28883.56674649924;28932;29448;29544.261393464476;46102.61692149241;46644.300335495675;46879.76560117178;46899;46986.76506617445;508048;510407;514342;517936;518037;25079.122230721838;25426;25474;25494.490110198065;25497.10760123461;42858.78570607127;43150.35274470948;43500;44036.33945490884;44355.77822110869;29889;35760.463593045606;35761;35785.821070894475;35888.10279743027;35301.646983529834;35468.645313546534;35512.28975420529;35537.46693799647;35616.64383356237;34896.82551587226;35539.11152221215;35641;35725.64274357327;35813.1046723834;30006.69993300039;32349.51475727819;32401.513977289887;32438.189045274055;32480.187995300308;23822.404439889142;24337.440834015386;24380;24540.386490337885;24564.50870982606 17:17:24 INFO - PROCESS | 1642 | |2;jquery.html;366.80925918522354;389.70966629860754;391.0965669303908;401.89550716813636;423.08191225041656;14945.701085978273;15778.368865245391;18534.980576068327;21096.94515274234;21160.576788464223;20776.376708698725;21796.673049904224;22394.880255987217;22464.775352246474;22578.20976265831;5691.971540142294;5719.742611582468;5908.527317814564;5987.251593550806;5994.1608174855555;4203.810828512709;5802.738876750535;5905.173275741378;5909.734061967221;5909.911351329733;4386.056997745484;6202.41077097675;6434;6508.349165083478;6582.979638156094;6304.148939893102;6485.513586481033;6559.47524198063;6561.2782593914635;6562.93437065628;5618.634788738719;5628.409017053192;5674.432556744293;5762.4525670061275;5769.076947688392;24682.889269982894;25795.74204257952;26041.95832166711;26846;27091.322716932038;2331.63859601762;2628.145852597894;2685.328667833042;2691.111933062085;2692.986535067312;10172.186225101974;10227.38635681854;10602.992715691997;12155.696107597292;16134.273957671932;1725.5082301544126;1799.2083483267452;1810.9909450452794;1850.6298740252003;1850.9814901850943;134673;136782;138886.3055684725;140705.296473518;140750.36998520046;10833.78332433347;11905.285682859056;11962.521499139937;12033.157678962389;12260.203086799329;15965.840341596668;15967.520974370787;15971.44099956496;16008.839911600735;16012.359505619645;8902.109789021046;9041.457512549137;9064.818703625891;9104.089591040844;9184;8816.603252853636;8881.42270752399;8898;9019.684311049083;9032.096790320915;4767.73777442244;4855.36880205571;4874.390701162355;4947.727874966911;4951.133551628523;1976.416956997689;2013.2651582172402;2027.685708715122;2034.7660019097698;2040.60208259388;833.358314098141;861.3238607693056;866.6056944090424;882.8302499188601;887.4409122252939;21812.345629631138;22552.774472255394;22572;22745.658815117786;22775.97508112139;1008.8940661230465;1066.989330106689;1071.121680222226;1100.2408338246585;1101.9724506887233;11104.222704410775;11473.54105835774;11503.137264705181;11571.884281157081;11581.536738530533;533438;546658;586206;600853;605154;151924;154637;162287;166412;166990.1650491764;1003.7490627343165;1027.3322340478749;1045.9738506537396;1047.3349423116376;1058.6559368205365;19486.610267794847;20198.326742314086;20651.17395304171;20697.172113115306;21021.684674729586;48146.27780583224;55267;55810.441895582146;56897;57971;75086.62456687681;77832.2216777825;78860.81708774259;78863;79289.60355198187;8305.626246819029;8360;8517.190866867637;8520.403571749917;8547.307598106825;9364.016778238187;11951.864572865565;12255.264684118982;12477.625671229878;13271.800922986356;11062.38057994836;11351.886481135083;11364.829527557258;11501.194916355775;11510.136739744385;11126.666200014013;11128;11144.2199046066;11297.774044519228;11485.253458525169;11169.273997190157;11302.378369189444;11558;11892.881071189177;11932.522699091938;6996;8334.624941877752;8526.275266602408;8617.0521242662;8657.740267791976;11255.831162532404;11324.886751132382;11391.202615816814;11443.542258309908;11670.591529296435 17:17:24 INFO - PROCESS | 1642 | |3;mootools.html;1440.7766796146595;1448.6305991972044;1451.2018389885561;1466.5600319904029;1469.6032071340737;8082.2725954664065;8516.233538981498;8517.744467665965;8524.27543658789;8528.829423411527;7344.192138864721;7601.049868766404;7608.543487390747;7691.769246922588;8350.874736878937;2087.6451003329435;2135.9145634174615;2139.5720855828818;2266.433391652087;2356.5286942611547;2048.139781291861;2301.919432819852;2358.1628521874745;2370.7273663528745;2372.6559648850907;2278.7265528136645;2313.9884300578474;2322.094383190557;2322.535492901418;2326.895289711967;2286.474110954473;2310.4108452344544;2325.058351367682;2325.418645338657;2336.19401306549;2161.8594791338514;2279.9658005129936;2297.9655305170436;2307.204014614955;2362.7400985891536;8352.206540378655;8437.409381343308;8442.240198382175;8453.535055571941;8464.407491475598;5088.440271570124;5233.319668443078;5248.343957005374;5252.343457067866;5253;2789.623400840881;3286.7863588866885;3492.3713731528314;3509;3597.8201089945396;1098.6099934523209;1197.9700507487296;1203.1277323940074;1241.838560987075;1256.0705078242127;10821;10890;10911.781764364747;10915.126789856871;10921.617743378943;4383.693141480129;4478.2610869206865;4578.198815207325;4660.254359302496;4727.479977202505;9563;9564.76088097803;9576;9602.567884445216;9615.51922403877;5216.06110900034;5216.66091704038;5223.764930578133;5230.320058392384;5241.973790131101;4551.840685576055;4722.881927951828;4823.155947709137;4857.951420485821;4873.269009648581;3628.76413033152;3734.290484807878;3736.4955730976512;3850.7304488685522;3870.3613903706137;1264.7921235220526;1266.2276011632896;1270.0728468218254;1279.8912092472058;1285.736424033071;920.8710780490736;926.6478738079621;936.4942930817418;945.5177859291811;979.1041197304529;5572;5637.098064309691;5790.10253410722;5953.940460595425;5958.612690175125;960.9333639660111;1011.6762635956424;1014.898510148994;1015.6496008876926;1019.2050200843354;3258.332041931398;3868.032991752062;3873;3928.508936382952;3949.6840252779707;9060.320475964198;9545.713628591153;9545.761355966017;10105.545250463747;10125.746856328651;8296.70961516344;10074.647387341407;10080.193584513221;10085.899141008642;10087;7816.10114836801;7902.051753789582;7905.841883162305;7915.406344524184;7946.40401969843;5688.516476099412;5700.771969121189;5833.970830145992;5902.055671092605;6046.909296360646;7216.314450127229;9039.3672442931;9296.977332493285;9369.765755856159;9374.812503750023;8937.150970657776;9361;9365.344425890122;9468.715938521855;9470.289728270545;7225.963870180615;7376.852462950604;7386.778396647895;7389.889151662622;7418.591977441077;7666.846663066819;7824.178461261486;7837.13791482925;7895.921040789519;7930.444868859356;7221.133463984355;7227.313405226495;7277.708891644275;7282.271772822675;7295.088113985752;7157.463190260855;7178.174509931425;7217;7310.707571697072;7331.156916954618;6452.806415807533;6494.772682956074;6496.577722448026;6559.311272316338;6575.408213260829;4760.500147484603;4974.776135073858;5033.295338652665;5142.408623008252;5165.121929271958;5024.974875125601;5057.9378330549525;5064.18972964324;5073.16292811682;5200.2719619252575 17:17:24 INFO - PROCESS | 1642 | |4;prototype.html;353.688753896571;362.3423486372236;363.55464555919;373.7383831318076;374.0517787408919;4442.355858400534;4612.354270402142;4941.975290123544;5200.557952574026;5241.816536421226;4570.154521413541;4650.953490465095;5023.6734612250175;5108.386993560778;5140.4345521992645;3874.9031274218087;4036.959630403695;4067.1865626874596;4131.876043718678;4135.379693046052;3442.6729460701195;3808;4126.246345303249;4131.979340103296;4164.91670166598;3642.1440961374055;3821.503204583414;3910.120222949842;3944.8619298324566;3974.728087012157;3249.6587858275016;3941.3496773032416;3952.229315283535;3989.5412027616903;4016;3309.851056702454;3339.682730140633;3345.3643807676463;3346.540292884728;3358.580177477815;4210.978945105255;5001.89996200074;5052.722100284483;5054.519820617035;5061.670991385548;4500.459944806644;4523.281153161777;4536.228841097021;4537.659675524316;4546.681732278742;5141.665791723526;5456.48163424474;5462.590305727086;5538.6122971392015;5543.750531226105;3239.5464634951127;3447.293304872495;3610.223801882608;3618.2582570572968;3811.27585758705;5329.520343169094;5814.895169917702;5837.416258374171;5842.8539286517325;5897.675627840467;3504.859805607747;3511.85864594008;3814.9618503815163;3859.3246181918053;3895.902602434905;3525.647435256505;3711.9814400928362;3897.5322961244265;3897.5517815451017;3903.531576210873;4180.038591123997;4436.245838207448;4521.61566266871;4523.389342438794;4571.9085618287445;4763.880902977453;5095.77069031887;5539.9169012464845;5549.031268271456;5652.547796176296;1125.4485302201863;1190.8570971483305;1206.06529939296;1223.424990254579;1259.9055070869538;765.6669348833275;776.431608151542;783.9333656639135;799.6321692021735;851.8338923909778;4062.289099407592;4474.507804141542;4566.771661416916;4829.396325459317;4844.467108618049;5018.623603229772;5129.487051294841;5351.598630102758;5353.411124776271;5385.219143224289;4473.6355411599125;4542.568455996675;4805.879853003703;4864.0028794097125;4891.926621100686;2370.7036620422446;2835.8298502089942;2845.502037143533;2854.6574411070806;2857.414230082828;5010.624203184776;5274.525292723673;5601.775928962796;5612.940947183713;5635.915461268084;5190.351206099238;5492.203630473559;5531.574740207818;5590.8043218487155;5615.943840561624;5401.487583476554;5596.860078497989;5599.524040456607;5607.682194684165;5652.604317697804;4613.607843333354;4858.927116093332;5386.515213630635;5389.353277606712;5419.512243898068;4708.505606911225;4964.3298154748645;4997.9750101249265;5016.648834581691;5133.614978876524;5705.62913410627;5866.453498538666;5905.675187864708;5930.466258036798;5948.066878264495;3644.325799727059;4015.3976903464713;4168.645665118499;4191.203671302443;4210.494740631144;4770.332153498443;5368.919466208088;5548;5673.127867803532;5723.141528770718;4439.378487011885;4587.3164198944;4918.3031854010305;5321.308229930084;5354.32283858071;5205.141151709925;5207.609429292894;5327.520523152934;5441.619086663895;5475.890482190413;4458;4704.647151463722;4797.952020479751;4970.155073637418;5273.103572392626;4079.5104587449696;5152.531528514355;5183.870403239949;5392.245085688085;5492.642978206563;4840.540148685869;4993.300937868628;5301.6818990860675;5316.494932981361;5316.840494785162 17:17:24 INFO - PROCESS | 1642 | |5;yui.html;668.8060462465885;711.5462752831814;749.8800191969286;801.535109636411;827.4519347773181;15005.474808381708;15760.211989400541;15869.76195357069;15874.920625396857;15884.84115158848;14329.92835035826;14432;14437.711245775079;14443.711125777478;14468.5659430217;658.733213048716;688.1054628982328;826.6652005937605;861.702712564166;870.3559366069127;848.995755021224;858.1890113842421;858.433433933604;860.4579115157442;863.1282404771164;905.7690288976302;928.1646518133666;929.6839074714595;931.4550987672186;932.5756780664815;917.2295271971543;921.530019689963;922.326701507903;922.9492377919246;924.5100096948628;510.9667871588335;532.7709085093409;535.3655917737455;535.8392482255347;537.5296615461472;14551.3451894665;15113.017653852465;15153.621159470991;15454.61363465911;15468.845311546853;13998.580042598738;14320.785188222186;14554.927225363805;14673.192974386404;14745.041572297874;10029.949850250776;11940.223885447418;12118.636440906786;12153.08326001762;12595.244285342817;3687.8893633191046;3706.870259540903;3735.8879233622765;3816.9427458588143;3859.3824988001784;105969.66634975756;109508;112015;112499.4375028136;112610.87389126085;9850.310478266596;10898.82221923922;10952.123830093573;11134.27627204229;11176.050035747052;22372.32883013512;22532.986015629336;22537.98579063946;22582.20962266313;22593.4351641207;7629.3133617974645;7726.613669316512;7754.980079681275;7801.946737190407;8028.959855200686;4280.571942805756;4313.094250207429;4314.331278651814;4336.111097225062;4527.909441811211;3613.223157021253;3631.673149416565;3687.9815600921825;3720.795356255432;3730.2539492101687;667.1893649216225;669.7454967112466;672.2571558427965;676.668432468097;684.5892464521247;669.1434963246954;677.7458453080095;694.2294053600499;701.1481050523537;722.3967986731034;10376.481175941324;11007.779844403067;11372.943135284271;11415.42922853854;11519.827202591969;587.2307277466447;608.7139044649008;618.8452886778306;649.7758273395671;732.6336831584208;4844.4186697596515;5114.258432527263;5115.87210319745;5153.819616313411;5228.2941802856885;97884.51057744808;97984;98653;98681;99453.50273248732;80731.59634201908;81199;82587;84226.57886710527;85560.71658925121;60469;76504.61747691338;79151.60424197842;80081;80550;7829.804254893673;10331.690049298533;11258.493367798632;11353.829692554453;11649.1263155262;38172.80913595414;40382;47519.28721069256;47679.76160119177;48506.5149348502;55518;64018.35981640124;64364.356356435834;64525;64811.67594161999;12142.392880356123;12769.553065642658;12874.742505149658;12955.5465558705;13308.134971226838;14161.39398415175;14755.852441475878;15093.20775656507;15125.470608528649;15297.46458873934;13497.122687025312;13558.661033473847;13627.727445450837;13943.790843137158;14128.717425651635;11146.49840757184;12877.935610321889;13444.663883402993;14346.56960291193;14425.567232983027;13272.402741876831;13436.328183590585;13529.255890926093;14532.636684082983;14552.708945821236;10938.617148399768;11177.497012634289;11405.201635885409;11957.641270761891;12151.270923744603;10467.528961196613;11014.50434730423;11169.218154729417;11248.212625116163;11287.322760634388 17:17:24 INFO - PROCESS | 1642 | __end_tp_report 17:17:24 INFO - PROCESS | 1642 | __start_cc_report 17:17:24 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1642 17:17:24 INFO - PROCESS | 1642 | __end_cc_report 17:17:24 INFO - PROCESS | 1642 | __startTimestamp1485393444883__endTimestamp 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | ------- Summary: start ------- 17:17:24 INFO - PROCESS | 1642 | Number of tests: 6 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5793.00 Median:6082.00 stddev:634.42 (10.4%) stddev-sans-first:601.09 17:17:24 INFO - PROCESS | 1642 | Values: 3133.8 3383.3 3388.8 3405.4 3438.2 5798.4 5803.2 5807.7 5809.3 5820.9 5418.9 5689.9 5768.8 5774.3 5799.6 5230.2 5265.8 5277.2 5283.8 5328.3 5242.2 5244.0 5244.8 5362.6 5373.1 5265.3 5294.8 5297.4 5303.0 5355.6 5342.4 5343.1 5343.8 5353.8 5360.9 5128.1 5210.8 5281.3 5298.8 5343.3 5658.3 5703.1 5718.7 5724.2 5749.1 5104.5 6190.9 6199.3 6200.5 6204.8 6188.8 6210.3 6235.5 6238.7 6249.8 5891.8 5896.7 5905.4 5911.3 5935.2 6202.8 6325.1 6328.2 6329.6 6332.7 6159.7 6169.4 6209.0 6219.3 6256.6 6274.6 6288.3 6304.9 6307.5 6318.4 6242.6 6248.7 6276.8 6277.1 6278.0 6170.6 6219.4 6259.6 6286.8 6300.5 5036.4 5041.3 5050.1 5054.4 5078.9 4472.1 4485.8 4490.2 4518.4 4538.8 5610.3 5639.1 5695.1 5965.7 6006.3 6206.7 6250.6 6260.3 6265.7 6269.9 5803.0 5818.3 5996.8 6001.1 6022.1 5452.2 5455.1 5457.8 5457.9 5496.2 6228.5 6240.6 6248.4 6267.8 6332.2 6262.5 6291.8 6292.3 6294.0 6315.9 6212.5 6259.1 6323.0 6327.8 6331.1 6185.9 6272.2 6285.0 6302.4 6303.1 6247.9 6266.7 6267.7 6308.4 6310.4 6062.6 6129.6 6149.4 6253.5 6264.3 6117.8 6128.4 6132.7 6160.3 6179.2 5180.8 6096.6 6104.1 6106.3 6144.0 5787.4 6128.4 6195.5 6195.6 6217.3 5879.8 5909.8 5948.0 6082.0 6099.5 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:66662.79 Median:35743.05 stddev:141010.44 (394.5%) stddev-sans-first:141318.37 17:17:24 INFO - PROCESS | 1642 | Values: 444.9 483.2 496.2 497.9 514.0 30909.7 32293.8 40090.0 42471.8 42577.4 35660.6 42547.8 42858.4 42923.8 43031.4 8337.7 8476.4 8933.2 9362.8 9380.9 8276.4 8479.6 8496.0 8500.2 11053.2 9476.2 11336.3 11343.9 11367.8 11390.8 11246.0 11291.6 11340.3 11343.6 11348.8 8296.7 8552.4 11250.9 11280.0 11295.2 42428.0 42983.0 43050.8 43055.8 43133.4 4021.6 4034.9 4049.2 4083.4 4157.8 29185.1 29681.4 29874.4 29973.4 31043.8 3174.2 3195.1 3339.9 3370.9 3376.3 488004.0 491040.0 493031.0 493353.5 501384.5 66083.0 66348.0 66412.0 66667.0 66717.7 69819.0 69893.7 69962.3 70029.6 70080.3 16405.6 16905.0 17135.9 17191.7 17244.9 12823.5 12897.0 12905.7 12910.9 12937.8 15925.8 16576.7 17178.3 18007.5 18795.5 6363.1 6454.5 6492.3 6507.5 6539.9 879.2 892.6 898.7 901.1 921.2 29992.4 30181.7 30183.0 30230.0 30666.4 1084.2 1087.5 1089.4 1120.0 1223.3 15442.5 15835.3 15836.6 16133.2 16260.3 506089.0 586930.0 591270.0 594425.0 597252.0 61185.0 61249.0 61268.8 61358.0 61458.0 1379.9 1400.3 1429.1 1433.2 1443.8 27957.3 28883.6 28932.0 29448.0 29544.3 46102.6 46644.3 46879.8 46899.0 46986.8 508048.0 510407.0 514342.0 517936.0 518037.0 25079.1 25426.0 25474.0 25494.5 25497.1 42858.8 43150.4 43500.0 44036.3 44355.8 29889.0 35760.5 35761.0 35785.8 35888.1 35301.6 35468.6 35512.3 35537.5 35616.6 34896.8 35539.1 35641.0 35725.6 35813.1 30006.7 32349.5 32401.5 32438.2 32480.2 23822.4 24337.4 24380.0 24540.4 24564.5 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:36190.85 Median:22575.10 stddev:97742.24 (433.0%) stddev-sans-first:97979.42 17:17:24 INFO - PROCESS | 1642 | Values: 366.8 389.7 391.1 401.9 423.1 14945.7 15778.4 18535.0 21096.9 21160.6 20776.4 21796.7 22394.9 22464.8 22578.2 5692.0 5719.7 5908.5 5987.3 5994.2 4203.8 5802.7 5905.2 5909.7 5909.9 4386.1 6202.4 6434.0 6508.3 6583.0 6304.1 6485.5 6559.5 6561.3 6562.9 5618.6 5628.4 5674.4 5762.5 5769.1 24682.9 25795.7 26042.0 26846.0 27091.3 2331.6 2628.1 2685.3 2691.1 2693.0 10172.2 10227.4 10603.0 12155.7 16134.3 1725.5 1799.2 1811.0 1850.6 1851.0 134673.0 136782.0 138886.3 140705.3 140750.4 10833.8 11905.3 11962.5 12033.2 12260.2 15965.8 15967.5 15971.4 16008.8 16012.4 8902.1 9041.5 9064.8 9104.1 9184.0 8816.6 8881.4 8898.0 9019.7 9032.1 4767.7 4855.4 4874.4 4947.7 4951.1 1976.4 2013.3 2027.7 2034.8 2040.6 833.4 861.3 866.6 882.8 887.4 21812.3 22552.8 22572.0 22745.7 22776.0 1008.9 1067.0 1071.1 1100.2 1102.0 11104.2 11473.5 11503.1 11571.9 11581.5 533438.0 546658.0 586206.0 600853.0 605154.0 151924.0 154637.0 162287.0 166412.0 166990.2 1003.7 1027.3 1046.0 1047.3 1058.7 19486.6 20198.3 20651.2 20697.2 21021.7 48146.3 55267.0 55810.4 56897.0 57971.0 75086.6 77832.2 78860.8 78863.0 79289.6 8305.6 8360.0 8517.2 8520.4 8547.3 9364.0 11951.9 12255.3 12477.6 13271.8 11062.4 11351.9 11364.8 11501.2 11510.1 11126.7 11128.0 11144.2 11297.8 11485.3 11169.3 11302.4 11558.0 11892.9 11932.5 6996.0 8334.6 8526.3 8617.1 8657.7 11255.8 11324.9 11391.2 11443.5 11670.6 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5455.01 Median:5208.17 stddev:2947.58 (56.6%) stddev-sans-first:2940.41 17:17:24 INFO - PROCESS | 1642 | Values: 1440.8 1448.6 1451.2 1466.6 1469.6 8082.3 8516.2 8517.7 8524.3 8528.8 7344.2 7601.0 7608.5 7691.8 8350.9 2087.6 2135.9 2139.6 2266.4 2356.5 2048.1 2301.9 2358.2 2370.7 2372.7 2278.7 2314.0 2322.1 2322.5 2326.9 2286.5 2310.4 2325.1 2325.4 2336.2 2161.9 2280.0 2298.0 2307.2 2362.7 8352.2 8437.4 8442.2 8453.5 8464.4 5088.4 5233.3 5248.3 5252.3 5253.0 2789.6 3286.8 3492.4 3509.0 3597.8 1098.6 1198.0 1203.1 1241.8 1256.1 10821.0 10890.0 10911.8 10915.1 10921.6 4383.7 4478.3 4578.2 4660.3 4727.5 9563.0 9564.8 9576.0 9602.6 9615.5 5216.1 5216.7 5223.8 5230.3 5242.0 4551.8 4722.9 4823.2 4858.0 4873.3 3628.8 3734.3 3736.5 3850.7 3870.4 1264.8 1266.2 1270.1 1279.9 1285.7 920.9 926.6 936.5 945.5 979.1 5572.0 5637.1 5790.1 5953.9 5958.6 960.9 1011.7 1014.9 1015.6 1019.2 3258.3 3868.0 3873.0 3928.5 3949.7 9060.3 9545.7 9545.8 10105.5 10125.7 8296.7 10074.6 10080.2 10085.9 10087.0 7816.1 7902.1 7905.8 7915.4 7946.4 5688.5 5700.8 5834.0 5902.1 6046.9 7216.3 9039.4 9297.0 9369.8 9374.8 8937.2 9361.0 9365.3 9468.7 9470.3 7226.0 7376.9 7386.8 7389.9 7418.6 7666.8 7824.2 7837.1 7895.9 7930.4 7221.1 7227.3 7277.7 7282.3 7295.1 7157.5 7178.2 7217.0 7310.7 7331.2 6452.8 6494.8 6496.6 6559.3 6575.4 4760.5 4974.8 5033.3 5142.4 5165.1 5025.0 5057.9 5064.2 5073.2 5200.3 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4362.58 Median:4817.64 stddev:1327.22 (27.5%) stddev-sans-first:1296.39 17:17:24 INFO - PROCESS | 1642 | Values: 353.7 362.3 363.6 373.7 374.1 4442.4 4612.4 4942.0 5200.6 5241.8 4570.2 4651.0 5023.7 5108.4 5140.4 3874.9 4037.0 4067.2 4131.9 4135.4 3442.7 3808.0 4126.2 4132.0 4164.9 3642.1 3821.5 3910.1 3944.9 3974.7 3249.7 3941.3 3952.2 3989.5 4016.0 3309.9 3339.7 3345.4 3346.5 3358.6 4211.0 5001.9 5052.7 5054.5 5061.7 4500.5 4523.3 4536.2 4537.7 4546.7 5141.7 5456.5 5462.6 5538.6 5543.8 3239.5 3447.3 3610.2 3618.3 3811.3 5329.5 5814.9 5837.4 5842.9 5897.7 3504.9 3511.9 3815.0 3859.3 3895.9 3525.6 3712.0 3897.5 3897.6 3903.5 4180.0 4436.2 4521.6 4523.4 4571.9 4763.9 5095.8 5539.9 5549.0 5652.5 1125.4 1190.9 1206.1 1223.4 1259.9 765.7 776.4 783.9 799.6 851.8 4062.3 4474.5 4566.8 4829.4 4844.5 5018.6 5129.5 5351.6 5353.4 5385.2 4473.6 4542.6 4805.9 4864.0 4891.9 2370.7 2835.8 2845.5 2854.7 2857.4 5010.6 5274.5 5601.8 5612.9 5635.9 5190.4 5492.2 5531.6 5590.8 5615.9 5401.5 5596.9 5599.5 5607.7 5652.6 4613.6 4858.9 5386.5 5389.4 5419.5 4708.5 4964.3 4998.0 5016.6 5133.6 5705.6 5866.5 5905.7 5930.5 5948.1 3644.3 4015.4 4168.6 4191.2 4210.5 4770.3 5368.9 5548.0 5673.1 5723.1 4439.4 4587.3 4918.3 5321.3 5354.3 5205.1 5207.6 5327.5 5441.6 5475.9 4458.0 4704.6 4798.0 4970.2 5273.1 4079.5 5152.5 5183.9 5392.2 5492.6 4840.5 4993.3 5301.7 5316.5 5316.8 17:17:24 INFO - PROCESS | 1642 | 17:17:24 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20093.33 Median:3776.42 stddev:28540.88 (755.8%) stddev-sans-first:28583.68 17:17:24 INFO - PROCESS | 1642 | Values: 668.8 711.5 749.9 801.5 827.5 15005.5 15760.2 15869.8 15874.9 15884.8 14329.9 14432.0 14437.7 14443.7 14468.6 658.7 688.1 826.7 861.7 870.4 849.0 858.2 858.4 860.5 863.1 905.8 928.2 929.7 931.5 932.6 917.2 921.5 922.3 922.9 924.5 511.0 532.8 535.4 535.8 537.5 14551.3 15113.0 15153.6 15454.6 15468.8 13998.6 14320.8 14554.9 14673.2 14745.0 10029.9 11940.2 12118.6 12153.1 12595.2 3687.9 3706.9 3735.9 3816.9 3859.4 105969.7 109508.0 112015.0 112499.4 112610.9 9850.3 10898.8 10952.1 11134.3 11176.1 22372.3 22533.0 22538.0 22582.2 22593.4 7629.3 7726.6 7755.0 7801.9 8029.0 4280.6 4313.1 4314.3 4336.1 4527.9 3613.2 3631.7 3688.0 3720.8 3730.3 667.2 669.7 672.3 676.7 684.6 669.1 677.7 694.2 701.1 722.4 10376.5 11007.8 11372.9 11415.4 11519.8 587.2 608.7 618.8 649.8 732.6 4844.4 5114.3 5115.9 5153.8 5228.3 97884.5 97984.0 98653.0 98681.0 99453.5 80731.6 81199.0 82587.0 84226.6 85560.7 60469.0 76504.6 79151.6 80081.0 80550.0 7829.8 10331.7 11258.5 11353.8 11649.1 38172.8 40382.0 47519.3 47679.8 48506.5 55518.0 64018.4 64364.4 64525.0 64811.7 12142.4 12769.6 12874.7 12955.5 13308.1 14161.4 14755.9 15093.2 15125.5 15297.5 13497.1 13558.7 13627.7 13943.8 14128.7 11146.5 12877.9 13444.7 14346.6 14425.6 13272.4 13436.3 13529.3 14532.6 14552.7 10938.6 11177.5 11405.2 11957.6 12151.3 10467.5 11014.5 11169.2 11248.2 11287.3 17:17:24 INFO - PROCESS | 1642 | -------- Summary: end -------- 17:17:24 INFO - PROCESS | 1642 | 17:17:25 INFO - TEST-INFO | 1642: exit 0 17:17:25 INFO - TEST-OK | dromaeo_css | took 1119429ms 17:17:25 INFO - TEST-START | kraken 17:17:25 INFO - operating with platform_type : mac_ 17:17:25 INFO - Initialising browser for kraken test... 17:17:25 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpyu073U/profile http://localhost:49243/getInfo.html) 17:17:27 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 17:17:27 INFO - PROCESS | 1652 | colorDepth:24 17:17:27 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 17:17:27 INFO - PROCESS | 1652 | __metrics 17:17:27 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 17:17:27 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:17:27 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:28 INFO - TEST-INFO | 1652: exit 0 17:17:28 INFO - Browser initialized. 17:17:28 INFO - Running cycle 1/1 for kraken test... 17:17:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpyu073U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:40 INFO - PROCESS | 1653 | RSS: Main: 212566016 17:17:40 INFO - PROCESS | 1653 | 17:17:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:44 INFO - PROCESS | 1653 | RSS: Main: 263643136 17:17:44 INFO - PROCESS | 1653 | 17:17:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 17:17:47 INFO - PROCESS | 1653 | RSS: Main: 276443136 17:17:47 INFO - PROCESS | 1653 | 17:17:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 17:17:51 INFO - PROCESS | 1653 | RSS: Main: 373084160 17:17:51 INFO - PROCESS | 1653 | 17:17:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 17:17:54 INFO - PROCESS | 1653 | RSS: Main: 278708224 17:17:54 INFO - PROCESS | 1653 | 17:17:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:56 INFO - PROCESS | 1653 | RSS: Main: 278577152 17:17:56 INFO - PROCESS | 1653 | 17:17:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:00 INFO - PROCESS | 1653 | RSS: Main: 319635456 17:18:00 INFO - PROCESS | 1653 | 17:18:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:03 INFO - PROCESS | 1653 | RSS: Main: 319184896 17:18:03 INFO - PROCESS | 1653 | 17:18:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 17:18:07 INFO - PROCESS | 1653 | RSS: Main: 316436480 17:18:07 INFO - PROCESS | 1653 | 17:18:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:09 INFO - PROCESS | 1653 | RSS: Main: 294473728 17:18:09 INFO - PROCESS | 1653 | 17:18:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:12 INFO - PROCESS | 1653 | RSS: Main: 298147840 17:18:12 INFO - PROCESS | 1653 | 17:18:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:14 INFO - PROCESS | 1653 | RSS: Main: 301043712 17:18:14 INFO - PROCESS | 1653 | 17:18:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:18 INFO - PROCESS | 1653 | RSS: Main: 313638912 17:18:18 INFO - PROCESS | 1653 | 17:18:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:22 INFO - PROCESS | 1653 | RSS: Main: 312385536 17:18:22 INFO - PROCESS | 1653 | 17:18:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 17:18:24 INFO - PROCESS | 1653 | RSS: Main: 357195776 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | __start_tp_report 17:18:24 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 17:18:24 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 17:18:24 INFO - PROCESS | 1653 | |i|pagename|runs| 17:18:24 INFO - PROCESS | 1653 | |0;ai-astar;111;116;113;113;113;113;111;113;113;111 17:18:24 INFO - PROCESS | 1653 | |1;audio-beat-detection;142;109;108;141;110;111;108;110;153;136 17:18:24 INFO - PROCESS | 1653 | |2;audio-dft;257;251;183;185;182;184;183;184;181;184 17:18:24 INFO - PROCESS | 1653 | |3;audio-fft;81;60;59;88;64;60;59;58;74;58 17:18:24 INFO - PROCESS | 1653 | |4;audio-oscillator;87;67;86;70;69;71;82;68;69;82 17:18:24 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;83;87;84;88;83;87;84;86;83 17:18:24 INFO - PROCESS | 1653 | |6;imaging-darkroom;144;134;95;119;164;96;96;95;95;96 17:18:24 INFO - PROCESS | 1653 | |7;imaging-desaturate;88;87;87;88;87;85;88;87;85;84 17:18:24 INFO - PROCESS | 1653 | |8;json-parse-financial;56;53;53;54;54;57;57;56;57;57 17:18:24 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;72;69;68;75;71;69;69;69;69;70 17:18:24 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;84;82;81;85;84;84;84;83;87;83 17:18:24 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;138;119;139;143;148;152;156;153;261;149 17:18:24 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;169;170;168;167;170;174;170;170;166;167 17:18:24 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;67;68;67;64;90;85;83;72;66 17:18:24 INFO - PROCESS | 1653 | __end_tp_report 17:18:24 INFO - PROCESS | 1653 | __start_cc_report 17:18:24 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1954 17:18:24 INFO - PROCESS | 1653 | __end_cc_report 17:18:24 INFO - PROCESS | 1653 | __startTimestamp1485393504187__endTimestamp 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | ------- Summary: start ------- 17:18:24 INFO - PROCESS | 1653 | Number of tests: 14 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.49 (1.3%) stddev-sans-first:1.45 17:18:24 INFO - PROCESS | 1653 | Values: 111.0 116.0 113.0 113.0 113.0 113.0 111.0 113.0 113.0 111.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:123.50 stddev:17.89 (14.5%) stddev-sans-first:17.58 17:18:24 INFO - PROCESS | 1653 | Values: 142.0 109.0 108.0 141.0 110.0 111.0 108.0 110.0 153.0 136.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:197.40 Median:184.00 stddev:29.89 (16.2%) stddev-sans-first:22.62 17:18:24 INFO - PROCESS | 1653 | Values: 257.0 251.0 183.0 185.0 182.0 184.0 183.0 184.0 181.0 184.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.10 Median:62.00 stddev:10.93 (17.6%) stddev-sans-first:10.17 17:18:24 INFO - PROCESS | 1653 | Values: 81.0 60.0 59.0 88.0 64.0 60.0 59.0 58.0 74.0 58.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.50 stddev:8.09 (10.6%) stddev-sans-first:7.34 17:18:24 INFO - PROCESS | 1653 | Values: 87.0 67.0 86.0 70.0 69.0 71.0 82.0 68.0 69.0 82.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.50 stddev:2.11 (2.4%) stddev-sans-first:2.00 17:18:24 INFO - PROCESS | 1653 | Values: 88.0 83.0 87.0 84.0 88.0 83.0 87.0 84.0 86.0 83.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:95.00 stddev:25.55 (26.9%) stddev-sans-first:24.59 17:18:24 INFO - PROCESS | 1653 | Values: 144.0 134.0 95.0 119.0 164.0 96.0 96.0 95.0 95.0 96.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.42 17:18:24 INFO - PROCESS | 1653 | Values: 88.0 87.0 87.0 88.0 87.0 85.0 88.0 87.0 85.0 84.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.50 stddev:1.71 (3.0%) stddev-sans-first:1.80 17:18:24 INFO - PROCESS | 1653 | Values: 56.0 53.0 53.0 54.0 54.0 57.0 57.0 56.0 57.0 57.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:69.50 stddev:2.08 (3.0%) stddev-sans-first:2.09 17:18:24 INFO - PROCESS | 1653 | Values: 72.0 69.0 68.0 75.0 71.0 69.0 69.0 69.0 69.0 70.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.64 (1.9%) stddev-sans-first:1.73 17:18:24 INFO - PROCESS | 1653 | Values: 84.0 82.0 81.0 85.0 84.0 84.0 84.0 83.0 87.0 83.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:150.50 stddev:38.46 (25.6%) stddev-sans-first:40.25 17:18:24 INFO - PROCESS | 1653 | Values: 138.0 119.0 139.0 143.0 148.0 152.0 156.0 153.0 261.0 149.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.00 stddev:2.28 (1.3%) stddev-sans-first:2.42 17:18:24 INFO - PROCESS | 1653 | Values: 169.0 170.0 168.0 167.0 170.0 174.0 170.0 170.0 166.0 167.0 17:18:24 INFO - PROCESS | 1653 | 17:18:24 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:70.00 stddev:9.41 (13.4%) stddev-sans-first:9.74 17:18:24 INFO - PROCESS | 1653 | Values: 67.0 67.0 68.0 67.0 64.0 90.0 85.0 83.0 72.0 66.0 17:18:24 INFO - PROCESS | 1653 | -------- Summary: end -------- 17:18:24 INFO - PROCESS | 1653 | 17:18:25 INFO - TEST-INFO | 1653: exit 0 17:18:25 INFO - TEST-OK | kraken | took 59575ms 17:18:25 INFO - SUITE-END | took 1179s 17:18:25 INFO - Completed test suite (00:19:39) 17:18:25 INFO - javascript benchmark 17:18:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.8119712817233, 3383.3402486515124, 3388.81361525116, 3405.4381027130526, 3438.226399060212, 5798.420157984199, 5803.216565763626, 5807.73865176067, 5809.302883653957, 5820.941790582093, 5418.864528386783, 5689.857753556153, 5768.826935191951, 5774.2782152230975, 5799.623024503415, 5230.163173892169, 5265.763040663161, 5277.234800953859, 5283.762230699608, 5328.333958255218, 5242.239875218091, 5244.0, 5244.763985620656, 5362.624616276862, 5373.086575282192, 5265.315508983846, 5294.841154765363, 5297.44376840432, 5303.018941495817, 5355.598330125236, 5342.439043900393, 5343.145096784496, 5343.759530821103, 5353.785848566053, 5360.91958620621, 5128.051310507568, 5210.843674689765, 5281.287026251445, 5298.761555730001, 5343.305370301875, 5658.264425624684, 5703.144528320744, 5718.742656580423, 5724.198612194296, 5749.108888122348, 5104.540591346797, 6190.907136392958, 6199.287081985584, 6200.472959798422, 6204.7828326008375, 6188.81433556994, 6210.254769427697, 6235.501159907197, 6238.719257633417, 6249.812505624838, 5891.7937872175125, 5896.734646940812, 5905.379935106795, 5911.29064512257, 5935.228420305376, 6202.81391558254, 6325.114483972247, 6328.240611126695, 6329.620222786648, 6332.68336583169, 6159.722812473449, 6169.383061693795, 6208.9689551551955, 6219.346968568326, 6256.562040657111, 6274.592151510137, 6288.27684816252, 6304.873902521924, 6307.463865571386, 6318.399752023551, 6242.5942313749465, 6248.656323902229, 6276.811695649138, 6277.121203031579, 6277.96861015692, 6170.568060235741, 6219.378062193744, 6259.624422534663, 6286.811395658137, 6300.464460520815, 5036.445990940993, 5041.344625198701, 5050.116229659869, 5054.444011158769, 5078.949210507922, 4472.0608672179205, 4485.820567177341, 4490.169318676056, 4518.43519560055, 4538.818447262139, 5610.27066481363, 5639.069553523705, 5695.088785794253, 5965.701714914237, 6006.339302676702, 6206.689665516707, 6250.562460627712, 6260.342664020303, 6265.749370025239, 6269.8746025079245, 5803.0, 5818.272715910512, 5996.820095397145, 6001.06983417571, 6022.09668549721, 5452.182172674131, 5455.099908515051, 5457.781688732485, 5457.945420545744, 5496.1755736639825, 6228.4705800007505, 6240.563160578716, 6248.4376406123665, 6267.843303917439, 6332.176817013758, 6262.53031022666, 6291.842703932438, 6292.3078461368295, 6294.0, 6315.90526142099, 6212.47193988516, 6259.12372267892, 6323.0, 6327.778527751507, 6331.113644089924, 6185.876282474235, 6272.247330320391, 6284.968575157095, 6302.432781049728, 6303.149074874833, 6247.875042499034, 6266.717997690206, 6267.749290028348, 6308.432241098323, 6310.400511951358, 6062.575619706578, 6129.601575897553, 6149.41580549847, 6253.530985176039, 6264.279607844974, 6117.796956032775, 6128.442013631005, 6132.722655450899, 6160.3223645398075, 6179.227596550431, 5180.766865490987, 6096.573239873166, 6104.053871649901, 6106.267247930276, 6143.96928015357, 5787.421257874179, 6128.417800308964, 6195.473384762346, 6195.597286176384, 6217.253929528486, 5879.823605291848, 5909.763609455574, 5948.0, 6082.0, 6099.512039036955], "value": 5752.618702246265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.9110177964408, 483.16171442547176, 496.21102447109087, 497.8829974955887, 513.9743012849357, 30909.690903090963, 32293.83853080734, 40089.99775005622, 42471.787641061754, 42577.36133957985, 35660.64339356605, 42547.78726106365, 42858.35712464308, 42923.78538107313, 43031.35452968208, 8337.666493340259, 8476.406651534395, 8933.151350621696, 9362.812743745155, 9380.90619093807, 8276.379271554628, 8479.618417171212, 8495.95752021239, 8500.192481714228, 11053.226274160812, 9476.241900647932, 11336.319820810737, 11343.943280283587, 11367.829482557727, 11390.829137562943, 11245.9878610925, 11291.604793832177, 11340.319580825177, 11343.602973895873, 11348.773024539505, 8296.668133274661, 8552.35857310698, 11250.943745281304, 11279.984801367917, 11295.20933534653, 42428.0, 42983.0, 43050.78474607638, 43055.78472107651, 43133.352999704715, 4021.577734337882, 4034.8991275218355, 4049.230646177217, 4083.3670781028986, 4157.750534967911, 29185.124446266647, 29681.406371872443, 29874.40251194986, 29973.400531989457, 31043.844780776177, 3174.206448387903, 3195.0734287056725, 3339.899803005914, 3370.882019129343, 3376.324735052999, 488004.0, 491040.0, 493031.0, 493353.53323233157, 501384.49307753594, 66083.00875486775, 66348.0, 66412.00381994274, 66667.0, 66717.66641166763, 69818.95271570931, 69893.65053174701, 69962.30037699558, 70029.64985175144, 70080.2991970084, 16405.58986025335, 16905.0, 17135.91432042857, 17191.656166876593, 17244.913775431043, 12823.487060517475, 12897.0, 12905.677358066123, 12910.870891291155, 12937.805932911015, 15925.761113583305, 16576.6684666306, 17178.341847050622, 18007.549811254823, 18795.53011174704, 6363.140975968277, 6454.483641308684, 6492.253390860112, 6507.511936604774, 6539.869202615921, 879.2218886285683, 892.5938697892443, 898.7438580004667, 901.1394118616705, 921.1709461484584, 29992.400151996837, 30181.69818301833, 30182.969458482472, 30230.0, 30666.386672266875, 1084.208527774729, 1087.505185140759, 1089.4443833644898, 1119.9944000279947, 1223.2966044524435, 15442.536723898302, 15835.287412066486, 15836.604084897739, 16133.193340332937, 16260.349586016664, 506089.0, 586930.0, 591270.043649779, 594425.0, 597252.0, 61185.0, 61249.0, 61268.77462450726, 61358.0, 61458.0, 1379.9310034498235, 1400.3278426355203, 1429.1496559547054, 1433.240382597225, 1443.8483959184343, 27957.30106747266, 28883.56674649924, 28932.0, 29448.0, 29544.261393464476, 46102.61692149241, 46644.300335495675, 46879.76560117178, 46899.0, 46986.76506617445, 508048.0, 510407.0, 514342.0, 517936.0, 518037.0, 25079.122230721838, 25426.0, 25474.0, 25494.490110198065, 25497.10760123461, 42858.78570607127, 43150.35274470948, 43500.0, 44036.33945490884, 44355.77822110869, 29889.0, 35760.463593045606, 35761.0, 35785.821070894475, 35888.10279743027, 35301.646983529834, 35468.645313546534, 35512.28975420529, 35537.46693799647, 35616.64383356237, 34896.82551587226, 35539.11152221215, 35641.0, 35725.64274357327, 35813.1046723834, 30006.69993300039, 32349.51475727819, 32401.513977289887, 32438.189045274055, 32480.187995300308, 23822.404439889142, 24337.440834015386, 24380.0, 24540.386490337885, 24564.50870982606], "value": 19788.178877511586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.80925918522354, 389.70966629860754, 391.0965669303908, 401.89550716813636, 423.08191225041656, 14945.701085978273, 15778.368865245391, 18534.980576068327, 21096.94515274234, 21160.576788464223, 20776.376708698725, 21796.673049904224, 22394.880255987217, 22464.775352246474, 22578.20976265831, 5691.971540142294, 5719.742611582468, 5908.527317814564, 5987.251593550806, 5994.1608174855555, 4203.810828512709, 5802.738876750535, 5905.173275741378, 5909.734061967221, 5909.911351329733, 4386.056997745484, 6202.41077097675, 6434.0, 6508.349165083478, 6582.979638156094, 6304.148939893102, 6485.513586481033, 6559.47524198063, 6561.2782593914635, 6562.93437065628, 5618.634788738719, 5628.409017053192, 5674.432556744293, 5762.4525670061275, 5769.076947688392, 24682.889269982894, 25795.74204257952, 26041.95832166711, 26846.0, 27091.322716932038, 2331.63859601762, 2628.145852597894, 2685.328667833042, 2691.111933062085, 2692.986535067312, 10172.186225101974, 10227.38635681854, 10602.992715691997, 12155.696107597292, 16134.273957671932, 1725.5082301544126, 1799.2083483267452, 1810.9909450452794, 1850.6298740252003, 1850.9814901850943, 134673.0, 136782.0, 138886.3055684725, 140705.296473518, 140750.36998520046, 10833.78332433347, 11905.285682859056, 11962.521499139937, 12033.157678962389, 12260.203086799329, 15965.840341596668, 15967.520974370787, 15971.44099956496, 16008.839911600735, 16012.359505619645, 8902.109789021046, 9041.457512549137, 9064.818703625891, 9104.089591040844, 9184.0, 8816.603252853636, 8881.42270752399, 8898.0, 9019.684311049083, 9032.096790320915, 4767.73777442244, 4855.36880205571, 4874.390701162355, 4947.727874966911, 4951.133551628523, 1976.416956997689, 2013.2651582172402, 2027.685708715122, 2034.7660019097698, 2040.60208259388, 833.358314098141, 861.3238607693056, 866.6056944090424, 882.8302499188601, 887.4409122252939, 21812.345629631138, 22552.774472255394, 22572.0, 22745.658815117786, 22775.97508112139, 1008.8940661230465, 1066.989330106689, 1071.121680222226, 1100.2408338246585, 1101.9724506887233, 11104.222704410775, 11473.54105835774, 11503.137264705181, 11571.884281157081, 11581.536738530533, 533438.0, 546658.0, 586206.0, 600853.0, 605154.0, 151924.0, 154637.0, 162287.0, 166412.0, 166990.1650491764, 1003.7490627343165, 1027.3322340478749, 1045.9738506537396, 1047.3349423116376, 1058.6559368205365, 19486.610267794847, 20198.326742314086, 20651.17395304171, 20697.172113115306, 21021.684674729586, 48146.27780583224, 55267.0, 55810.441895582146, 56897.0, 57971.0, 75086.62456687681, 77832.2216777825, 78860.81708774259, 78863.0, 79289.60355198187, 8305.626246819029, 8360.0, 8517.190866867637, 8520.403571749917, 8547.307598106825, 9364.016778238187, 11951.864572865565, 12255.264684118982, 12477.625671229878, 13271.800922986356, 11062.38057994836, 11351.886481135083, 11364.829527557258, 11501.194916355775, 11510.136739744385, 11126.666200014013, 11128.0, 11144.2199046066, 11297.774044519228, 11485.253458525169, 11169.273997190157, 11302.378369189444, 11558.0, 11892.881071189177, 11932.522699091938, 6996.0, 8334.624941877752, 8526.275266602408, 8617.0521242662, 8657.740267791976, 11255.831162532404, 11324.886751132382, 11391.202615816814, 11443.542258309908, 11670.591529296435], "value": 9991.317893676542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.7766796146595, 1448.6305991972044, 1451.2018389885561, 1466.5600319904029, 1469.6032071340737, 8082.2725954664065, 8516.233538981498, 8517.744467665965, 8524.27543658789, 8528.829423411527, 7344.192138864721, 7601.049868766404, 7608.543487390747, 7691.769246922588, 8350.874736878937, 2087.6451003329435, 2135.9145634174615, 2139.5720855828818, 2266.433391652087, 2356.5286942611547, 2048.139781291861, 2301.919432819852, 2358.1628521874745, 2370.7273663528745, 2372.6559648850907, 2278.7265528136645, 2313.9884300578474, 2322.094383190557, 2322.535492901418, 2326.895289711967, 2286.474110954473, 2310.4108452344544, 2325.058351367682, 2325.418645338657, 2336.19401306549, 2161.8594791338514, 2279.9658005129936, 2297.9655305170436, 2307.204014614955, 2362.7400985891536, 8352.206540378655, 8437.409381343308, 8442.240198382175, 8453.535055571941, 8464.407491475598, 5088.440271570124, 5233.319668443078, 5248.343957005374, 5252.343457067866, 5253.0, 2789.623400840881, 3286.7863588866885, 3492.3713731528314, 3509.0, 3597.8201089945396, 1098.6099934523209, 1197.9700507487296, 1203.1277323940074, 1241.838560987075, 1256.0705078242127, 10821.0, 10890.0, 10911.781764364747, 10915.126789856871, 10921.617743378943, 4383.693141480129, 4478.2610869206865, 4578.198815207325, 4660.254359302496, 4727.479977202505, 9563.0, 9564.76088097803, 9576.0, 9602.567884445216, 9615.51922403877, 5216.06110900034, 5216.66091704038, 5223.764930578133, 5230.320058392384, 5241.973790131101, 4551.840685576055, 4722.881927951828, 4823.155947709137, 4857.951420485821, 4873.269009648581, 3628.76413033152, 3734.290484807878, 3736.4955730976512, 3850.7304488685522, 3870.3613903706137, 1264.7921235220526, 1266.2276011632896, 1270.0728468218254, 1279.8912092472058, 1285.736424033071, 920.8710780490736, 926.6478738079621, 936.4942930817418, 945.5177859291811, 979.1041197304529, 5572.0, 5637.098064309691, 5790.10253410722, 5953.940460595425, 5958.612690175125, 960.9333639660111, 1011.6762635956424, 1014.898510148994, 1015.6496008876926, 1019.2050200843354, 3258.332041931398, 3868.032991752062, 3873.0, 3928.508936382952, 3949.6840252779707, 9060.320475964198, 9545.713628591153, 9545.761355966017, 10105.545250463747, 10125.746856328651, 8296.70961516344, 10074.647387341407, 10080.193584513221, 10085.899141008642, 10087.0, 7816.10114836801, 7902.051753789582, 7905.841883162305, 7915.406344524184, 7946.40401969843, 5688.516476099412, 5700.771969121189, 5833.970830145992, 5902.055671092605, 6046.909296360646, 7216.314450127229, 9039.3672442931, 9296.977332493285, 9369.765755856159, 9374.812503750023, 8937.150970657776, 9361.0, 9365.344425890122, 9468.715938521855, 9470.289728270545, 7225.963870180615, 7376.852462950604, 7386.778396647895, 7389.889151662622, 7418.591977441077, 7666.846663066819, 7824.178461261486, 7837.13791482925, 7895.921040789519, 7930.444868859356, 7221.133463984355, 7227.313405226495, 7277.708891644275, 7282.271772822675, 7295.088113985752, 7157.463190260855, 7178.174509931425, 7217.0, 7310.707571697072, 7331.156916954618, 6452.806415807533, 6494.772682956074, 6496.577722448026, 6559.311272316338, 6575.408213260829, 4760.500147484603, 4974.776135073858, 5033.295338652665, 5142.408623008252, 5165.121929271958, 5024.974875125601, 5057.9378330549525, 5064.18972964324, 5073.16292811682, 5200.2719619252575], "value": 4449.084965194644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.688753896571, 362.3423486372236, 363.55464555919, 373.7383831318076, 374.0517787408919, 4442.355858400534, 4612.354270402142, 4941.975290123544, 5200.557952574026, 5241.816536421226, 4570.154521413541, 4650.953490465095, 5023.6734612250175, 5108.386993560778, 5140.4345521992645, 3874.9031274218087, 4036.959630403695, 4067.1865626874596, 4131.876043718678, 4135.379693046052, 3442.6729460701195, 3808.0, 4126.246345303249, 4131.979340103296, 4164.91670166598, 3642.1440961374055, 3821.503204583414, 3910.120222949842, 3944.8619298324566, 3974.728087012157, 3249.6587858275016, 3941.3496773032416, 3952.229315283535, 3989.5412027616903, 4016.0, 3309.851056702454, 3339.682730140633, 3345.3643807676463, 3346.540292884728, 3358.580177477815, 4210.978945105255, 5001.89996200074, 5052.722100284483, 5054.519820617035, 5061.670991385548, 4500.459944806644, 4523.281153161777, 4536.228841097021, 4537.659675524316, 4546.681732278742, 5141.665791723526, 5456.48163424474, 5462.590305727086, 5538.6122971392015, 5543.750531226105, 3239.5464634951127, 3447.293304872495, 3610.223801882608, 3618.2582570572968, 3811.27585758705, 5329.520343169094, 5814.895169917702, 5837.416258374171, 5842.8539286517325, 5897.675627840467, 3504.859805607747, 3511.85864594008, 3814.9618503815163, 3859.3246181918053, 3895.902602434905, 3525.647435256505, 3711.9814400928362, 3897.5322961244265, 3897.5517815451017, 3903.531576210873, 4180.038591123997, 4436.245838207448, 4521.61566266871, 4523.389342438794, 4571.9085618287445, 4763.880902977453, 5095.77069031887, 5539.9169012464845, 5549.031268271456, 5652.547796176296, 1125.4485302201863, 1190.8570971483305, 1206.06529939296, 1223.424990254579, 1259.9055070869538, 765.6669348833275, 776.431608151542, 783.9333656639135, 799.6321692021735, 851.8338923909778, 4062.289099407592, 4474.507804141542, 4566.771661416916, 4829.396325459317, 4844.467108618049, 5018.623603229772, 5129.487051294841, 5351.598630102758, 5353.411124776271, 5385.219143224289, 4473.6355411599125, 4542.568455996675, 4805.879853003703, 4864.0028794097125, 4891.926621100686, 2370.7036620422446, 2835.8298502089942, 2845.502037143533, 2854.6574411070806, 2857.414230082828, 5010.624203184776, 5274.525292723673, 5601.775928962796, 5612.940947183713, 5635.915461268084, 5190.351206099238, 5492.203630473559, 5531.574740207818, 5590.8043218487155, 5615.943840561624, 5401.487583476554, 5596.860078497989, 5599.524040456607, 5607.682194684165, 5652.604317697804, 4613.607843333354, 4858.927116093332, 5386.515213630635, 5389.353277606712, 5419.512243898068, 4708.505606911225, 4964.3298154748645, 4997.9750101249265, 5016.648834581691, 5133.614978876524, 5705.62913410627, 5866.453498538666, 5905.675187864708, 5930.466258036798, 5948.066878264495, 3644.325799727059, 4015.3976903464713, 4168.645665118499, 4191.203671302443, 4210.494740631144, 4770.332153498443, 5368.919466208088, 5548.0, 5673.127867803532, 5723.141528770718, 4439.378487011885, 4587.3164198944, 4918.3031854010305, 5321.308229930084, 5354.32283858071, 5205.141151709925, 5207.609429292894, 5327.520523152934, 5441.619086663895, 5475.890482190413, 4458.0, 4704.647151463722, 4797.952020479751, 4970.155073637418, 5273.103572392626, 4079.5104587449696, 5152.531528514355, 5183.870403239949, 5392.245085688085, 5492.642978206563, 4840.540148685869, 4993.300937868628, 5301.6818990860675, 5316.494932981361, 5316.840494785162], "value": 3949.891256708748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8060462465885, 711.5462752831814, 749.8800191969286, 801.535109636411, 827.4519347773181, 15005.474808381708, 15760.211989400541, 15869.76195357069, 15874.920625396857, 15884.84115158848, 14329.92835035826, 14432.0, 14437.711245775079, 14443.711125777478, 14468.5659430217, 658.733213048716, 688.1054628982328, 826.6652005937605, 861.702712564166, 870.3559366069127, 848.995755021224, 858.1890113842421, 858.433433933604, 860.4579115157442, 863.1282404771164, 905.7690288976302, 928.1646518133666, 929.6839074714595, 931.4550987672186, 932.5756780664815, 917.2295271971543, 921.530019689963, 922.326701507903, 922.9492377919246, 924.5100096948628, 510.9667871588335, 532.7709085093409, 535.3655917737455, 535.8392482255347, 537.5296615461472, 14551.3451894665, 15113.017653852465, 15153.621159470991, 15454.61363465911, 15468.845311546853, 13998.580042598738, 14320.785188222186, 14554.927225363805, 14673.192974386404, 14745.041572297874, 10029.949850250776, 11940.223885447418, 12118.636440906786, 12153.08326001762, 12595.244285342817, 3687.8893633191046, 3706.870259540903, 3735.8879233622765, 3816.9427458588143, 3859.3824988001784, 105969.66634975756, 109508.0, 112015.0, 112499.4375028136, 112610.87389126085, 9850.310478266596, 10898.82221923922, 10952.123830093573, 11134.27627204229, 11176.050035747052, 22372.32883013512, 22532.986015629336, 22537.98579063946, 22582.20962266313, 22593.4351641207, 7629.3133617974645, 7726.613669316512, 7754.980079681275, 7801.946737190407, 8028.959855200686, 4280.571942805756, 4313.094250207429, 4314.331278651814, 4336.111097225062, 4527.909441811211, 3613.223157021253, 3631.673149416565, 3687.9815600921825, 3720.795356255432, 3730.2539492101687, 667.1893649216225, 669.7454967112466, 672.2571558427965, 676.668432468097, 684.5892464521247, 669.1434963246954, 677.7458453080095, 694.2294053600499, 701.1481050523537, 722.3967986731034, 10376.481175941324, 11007.779844403067, 11372.943135284271, 11415.42922853854, 11519.827202591969, 587.2307277466447, 608.7139044649008, 618.8452886778306, 649.7758273395671, 732.6336831584208, 4844.4186697596515, 5114.258432527263, 5115.87210319745, 5153.819616313411, 5228.2941802856885, 97884.51057744808, 97984.0, 98653.0, 98681.0, 99453.50273248732, 80731.59634201908, 81199.0, 82587.0, 84226.57886710527, 85560.71658925121, 60469.0, 76504.61747691338, 79151.60424197842, 80081.0, 80550.0, 7829.804254893673, 10331.690049298533, 11258.493367798632, 11353.829692554453, 11649.1263155262, 38172.80913595414, 40382.0, 47519.28721069256, 47679.76160119177, 48506.5149348502, 55518.0, 64018.35981640124, 64364.356356435834, 64525.0, 64811.67594161999, 12142.392880356123, 12769.553065642658, 12874.742505149658, 12955.5465558705, 13308.134971226838, 14161.39398415175, 14755.852441475878, 15093.20775656507, 15125.470608528649, 15297.46458873934, 13497.122687025312, 13558.661033473847, 13627.727445450837, 13943.790843137158, 14128.717425651635, 11146.49840757184, 12877.935610321889, 13444.663883402993, 14346.56960291193, 14425.567232983027, 13272.402741876831, 13436.328183590585, 13529.255890926093, 14532.636684082983, 14552.708945821236, 10938.617148399768, 11177.497012634289, 11405.201635885409, 11957.641270761891, 12151.270923744603, 10467.528961196613, 11014.50434730423, 11169.218154729417, 11248.212625116163, 11287.322760634388], "value": 7498.492651468671, "unit": "score"}], "name": "dromaeo_css", "value": 7288.343107662962, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 113.0, 113.0, 113.0, 113.0, 111.0, 113.0, 113.0, 111.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 141.0, 110.0, 111.0, 108.0, 110.0, 153.0, 136.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [257.0, 251.0, 183.0, 185.0, 182.0, 184.0, 183.0, 184.0, 181.0, 184.0], "value": 197.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 88.0, 64.0, 60.0, 59.0, 58.0, 74.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 67.0, 86.0, 70.0, 69.0, 71.0, 82.0, 68.0, 69.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 87.0, 84.0, 88.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 134.0, 95.0, 119.0, 164.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 87.0, 85.0, 88.0, 87.0, 85.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 54.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 68.0, 75.0, 71.0, 69.0, 69.0, 69.0, 69.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 85.0, 84.0, 84.0, 84.0, 83.0, 87.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 119.0, 139.0, 143.0, 148.0, 152.0, 156.0, 153.0, 261.0, 149.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 168.0, 167.0, 170.0, 174.0, 170.0, 170.0, 166.0, 167.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 64.0, 90.0, 85.0, 83.0, 72.0, 66.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1466.3999999999999, "alertThreshold": 2.0}]} 17:18:25 INFO - Return code: 0 17:18:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:25 ERROR - # TBPL SUCCESS # 17:18:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:25 INFO - 2017-01-25 17:18:25.525 screenresolution[1657:10157] starting screenresolution argv=screenresolution get 17:18:25 INFO - 2017-01-25 17:18:25.528 screenresolution[1657:10157] Display 0: 1600x1200x32@60 17:18:25 INFO - 2017-01-25 17:18:25.534 screenresolution[1658:10160] starting screenresolution argv=screenresolution list 17:18:25 INFO - Available Modes on Display 0 17:18:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:25 INFO - Intel Iris: 17:18:25 INFO - Chipset Model: Intel Iris 17:18:25 INFO - Type: GPU 17:18:25 INFO - Bus: Built-In 17:18:25 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:25 INFO - Vendor: Intel (0x8086) 17:18:25 INFO - Device ID: 0x0a2e 17:18:25 INFO - Revision ID: 0x0009 17:18:25 INFO - Displays: 17:18:25 INFO - Display: 17:18:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:25 INFO - Display Serial Number: 1600x1200 60 17:18:25 INFO - Main Display: Yes 17:18:25 INFO - Mirror: Off 17:18:25 INFO - Online: Yes 17:18:25 INFO - Rotation: Supported 17:18:25 INFO - Return code: 0 17:18:25 INFO - Running post-action listener: _resource_record_post_action 17:18:25 INFO - [mozharness: 2017-01-26 01:18:25.780991Z] Finished run-tests step (success) 17:18:25 INFO - Running post-run listener: _resource_record_post_run 17:18:25 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 37868544; Write bytes: 508306432; Read time: 242; Write time: 1576 17:18:25 INFO - TinderboxPrint: CPU usage
53.4% 17:18:25 INFO - TinderboxPrint: I/O read bytes / time
37,868,544 / 242 17:18:25 INFO - TinderboxPrint: I/O write bytes / time
508,306,432 / 1,576 17:18:25 INFO - TinderboxPrint: CPU idle
2,237.4 (46.6%) 17:18:25 INFO - TinderboxPrint: CPU system
955.7 (19.9%) 17:18:25 INFO - TinderboxPrint: CPU user
1,608.6 (33.5%) 17:18:25 INFO - TinderboxPrint: Swap in / out
245,452,800 / 0 17:18:25 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201062912; Write bytes: 198639616; Read time: 15745; Write time: 426 17:18:25 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 36082688; Write bytes: 298984448; Read time: 227; Write time: 1115 17:18:26 INFO - Running post-run listener: _upload_blobber_files 17:18:26 INFO - Blob upload gear active. 17:18:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:26 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 17:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:18:26 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:27 INFO - (blobuploader) - INFO - Done attempting. 17:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:28 INFO - (blobuploader) - INFO - Done attempting. 17:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:29 INFO - (blobuploader) - INFO - Done attempting. 17:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:31 INFO - (blobuploader) - INFO - Done attempting. 17:18:31 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:31 INFO - Return code: 0 17:18:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48a66e6e918f2de602f8f0dbf2e5639e96a9f170f5bc2fd6880692529179b8ea57372dddb80118040b567aafca4bdf57c25a07f2fd2998566373249a64650ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fc0ae95037848d37cb1578b75791259bc9283fed4de683ad6b8d1869af55be31cb51cce1b5e8ad2393604e5c4ecbbd42560bc6eb856d7110c2958d13de7c5eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5d29349846e8a56676ca4f8c3ed92127aeb6efb97ab788254dfb54d19b49ffbf38d7440eab4aab05fae8e4f1670ef50cd3c7ca767f6c592f43b9c3e20844d48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ea7dd64c3e425b125b8f2800b390e41d6e50d9d423fed72404ac68717e04e52d51785bbe77250085ea9e2bfb562fb503b298a78a8e6a000b37f1d32d7974f62"} 17:18:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:31 INFO - Contents: 17:18:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48a66e6e918f2de602f8f0dbf2e5639e96a9f170f5bc2fd6880692529179b8ea57372dddb80118040b567aafca4bdf57c25a07f2fd2998566373249a64650ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fc0ae95037848d37cb1578b75791259bc9283fed4de683ad6b8d1869af55be31cb51cce1b5e8ad2393604e5c4ecbbd42560bc6eb856d7110c2958d13de7c5eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5d29349846e8a56676ca4f8c3ed92127aeb6efb97ab788254dfb54d19b49ffbf38d7440eab4aab05fae8e4f1670ef50cd3c7ca767f6c592f43b9c3e20844d48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ea7dd64c3e425b125b8f2800b390e41d6e50d9d423fed72404ac68717e04e52d51785bbe77250085ea9e2bfb562fb503b298a78a8e6a000b37f1d32d7974f62"} 17:18:31 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:31 INFO - Copying logs to upload dir... 17:18:31 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.123119 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-25 17:18:31.381465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 17:18:31.385185) ========= 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.IRrkLzRfK8/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.cozdEw8pmO/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48a66e6e918f2de602f8f0dbf2e5639e96a9f170f5bc2fd6880692529179b8ea57372dddb80118040b567aafca4bdf57c25a07f2fd2998566373249a64650ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fc0ae95037848d37cb1578b75791259bc9283fed4de683ad6b8d1869af55be31cb51cce1b5e8ad2393604e5c4ecbbd42560bc6eb856d7110c2958d13de7c5eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5d29349846e8a56676ca4f8c3ed92127aeb6efb97ab788254dfb54d19b49ffbf38d7440eab4aab05fae8e4f1670ef50cd3c7ca767f6c592f43b9c3e20844d48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ea7dd64c3e425b125b8f2800b390e41d6e50d9d423fed72404ac68717e04e52d51785bbe77250085ea9e2bfb562fb503b298a78a8e6a000b37f1d32d7974f62"} build_url:https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/Jkp9nLmvRriYxAv7bn6CmA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48a66e6e918f2de602f8f0dbf2e5639e96a9f170f5bc2fd6880692529179b8ea57372dddb80118040b567aafca4bdf57c25a07f2fd2998566373249a64650ef2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fc0ae95037848d37cb1578b75791259bc9283fed4de683ad6b8d1869af55be31cb51cce1b5e8ad2393604e5c4ecbbd42560bc6eb856d7110c2958d13de7c5eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5d29349846e8a56676ca4f8c3ed92127aeb6efb97ab788254dfb54d19b49ffbf38d7440eab4aab05fae8e4f1670ef50cd3c7ca767f6c592f43b9c3e20844d48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ea7dd64c3e425b125b8f2800b390e41d6e50d9d423fed72404ac68717e04e52d51785bbe77250085ea9e2bfb562fb503b298a78a8e6a000b37f1d32d7974f62"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 17:18:31.420252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 17:18:31.420581) ========= 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.IRrkLzRfK8/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.cozdEw8pmO/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.005220 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 17:18:31.472154) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 17:18:31.472967) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 17:18:31.473512) ========= ========= Total master_lag: 0.21 =========