builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0295 starttime: 1490033108.66 results: success (0) buildid: 20170320091724 builduid: 94d62a3716694bf5a2155245fdbe15c7 revision: c50649fdad5e9bc395626590a8212d1dd7717870 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.662279) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.662730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.663008) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.688313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.688698) ========= 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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-20 11:05:08-- 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% 8.28M=0.001s 2017-03-20 11:05:08 (8.28 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.835706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.836144) ========= 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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.021215 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:08.886310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 11:05:08.886652) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c50649fdad5e9bc395626590a8212d1dd7717870 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c50649fdad5e9bc395626590a8212d1dd7717870 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0fYF00W2Uv/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.CzdBhSAN2b/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-20 11:05:08,976 truncating revision to first 12 chars 2017-03-20 11:05:08,976 Setting DEBUG logging. 2017-03-20 11:05:08,976 attempt 1/10 2017-03-20 11:05:08,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c50649fdad5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 11:05:10,359 unpacking tar archive at: mozilla-beta-c50649fdad5e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.658565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 11:05:10.568984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:10.569363) ========= script_repo_revision: c50649fdad5e9bc395626590a8212d1dd7717870 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:10.569834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:10.570114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 11:05:10.590101) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-20 11:05:10.590607) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0fYF00W2Uv/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.CzdBhSAN2b/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:10 INFO - MultiFileLogger online at 20170320 11:05:10 in /builds/slave/test 11:05:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:05:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:10 INFO - {'append_to_log': False, 11:05:10 INFO - 'base_work_dir': '/builds/slave/test', 11:05:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:05:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:10 INFO - 'branch': 'Mozilla-Beta', 11:05:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:10 INFO - 'config_files': ('talos/mac_config.py',), 11:05:10 INFO - 'default_actions': ('clobber', 11:05:10 INFO - 'read-buildbot-config', 11:05:10 INFO - 'download-and-extract', 11:05:10 INFO - 'populate-webroot', 11:05:10 INFO - 'create-virtualenv', 11:05:10 INFO - 'install', 11:05:10 INFO - 'run-tests'), 11:05:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:10 INFO - 'download_minidump_stackwalk': True, 11:05:10 INFO - 'download_symbols': 'ondemand', 11:05:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:10 INFO - 'installer_path': 'installer.exe', 11:05:10 INFO - 'log_level': 'info', 11:05:10 INFO - 'log_name': 'talos', 11:05:10 INFO - 'log_to_console': True, 11:05:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:05:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:05:10 INFO - 'opt_config_files': (), 11:05:10 INFO - 'pip_index': False, 11:05:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:10 INFO - 'cmd': ('bash', 11:05:10 INFO - '-c', 11:05:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:10 INFO - 'enabled': True, 11:05:10 INFO - 'halt_on_failure': False, 11:05:10 INFO - 'name': 'check_screen_resolution'},), 11:05:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:10 INFO - 'cmd': ('bash', 11:05:10 INFO - '-c', 11:05:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:10 INFO - 'enabled': True, 11:05:10 INFO - 'halt_on_failure': False, 11:05:10 INFO - 'name': 'check_screen_resolution'},), 11:05:10 INFO - 'run_cmd_checks_enabled': True, 11:05:10 INFO - 'sps_profile': False, 11:05:10 INFO - 'sps_profile_interval': 0, 11:05:10 INFO - 'suite': 'dromaeojs', 11:05:10 INFO - 'system_bits': '32', 11:05:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:10 INFO - 'title': 't-yosemite-r7-0295', 11:05:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:10 INFO - 'use_talos_json': True, 11:05:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:10 INFO - 'work_dir': 'build'} 11:05:10 INFO - [mozharness: 2017-03-20 18:05:10.798661Z] Running clobber step. 11:05:10 INFO - Running pre-action listener: _resource_record_pre_action 11:05:10 INFO - Running main action method: clobber 11:05:10 INFO - rmtree: /builds/slave/test/build 11:05:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:12 INFO - Running post-action listener: _resource_record_post_action 11:05:12 INFO - [mozharness: 2017-03-20 18:05:12.513626Z] Finished clobber step (success) 11:05:12 INFO - [mozharness: 2017-03-20 18:05:12.513762Z] Running read-buildbot-config step. 11:05:12 INFO - Running pre-action listener: _resource_record_pre_action 11:05:12 INFO - Running main action method: read_buildbot_config 11:05:12 INFO - Using buildbot properties: 11:05:12 INFO - { 11:05:12 INFO - "project": "", 11:05:12 INFO - "product": "firefox", 11:05:12 INFO - "script_repo_revision": "production", 11:05:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:05:12 INFO - "repository": "", 11:05:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:05:12 INFO - "buildid": "20170320091724", 11:05:12 INFO - "pgo_build": "False", 11:05:12 INFO - "basedir": "/builds/slave/test", 11:05:12 INFO - "buildnumber": 11, 11:05:12 INFO - "slavename": "t-yosemite-r7-0295", 11:05:12 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:05:12 INFO - "platform": "yosemite_r7", 11:05:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:05:12 INFO - "branch": "mozilla-beta", 11:05:12 INFO - "repo_path": "releases/mozilla-beta", 11:05:12 INFO - "revision": "c50649fdad5e9bc395626590a8212d1dd7717870", 11:05:12 INFO - "stage_platform": "macosx64", 11:05:12 INFO - "builduid": "94d62a3716694bf5a2155245fdbe15c7", 11:05:12 INFO - "slavebuilddir": "test" 11:05:12 INFO - } 11:05:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 11:05:12 INFO - Running post-action listener: _resource_record_post_action 11:05:12 INFO - [mozharness: 2017-03-20 18:05:12.517020Z] Finished read-buildbot-config step (success) 11:05:12 INFO - [mozharness: 2017-03-20 18:05:12.517128Z] Running download-and-extract step. 11:05:12 INFO - Running pre-action listener: _resource_record_pre_action 11:05:12 INFO - Running main action method: download_and_extract 11:05:12 INFO - mkdir: /builds/slave/test/build/tests 11:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:12 INFO - trying https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 11:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 11:05:13 INFO - Downloaded 1165 bytes. 11:05:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 11:05:13 INFO - Using the following test package requirements: 11:05:13 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:05:13 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 11:05:13 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 11:05:13 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:05:13 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 11:05:13 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 11:05:13 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 11:05:13 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 11:05:13 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 11:05:13 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 11:05:13 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 11:05:13 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 11:05:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:05:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:05:13 INFO - Fetch https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:05:14 INFO - Expected file size: 16108170 11:05:14 INFO - Obtained file size: 16108170 11:05:21 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:05:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 11:05:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 11:05:21 INFO - Fetch https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 11:05:21 INFO - Expected file size: 16108170 11:05:21 INFO - Obtained file size: 16108170 11:05:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 11:05:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 11:05:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 11:05:28 INFO - Expected file size: 14403663 11:05:28 INFO - Obtained file size: 14403663 11:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:29 INFO - trying https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 11:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 11:05:31 INFO - Downloaded 58726883 bytes. 11:05:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:05:31 INFO - mkdir: /builds/slave/test/properties 11:05:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:31 INFO - Contents: 11:05:31 INFO - build_url:https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - Running post-action listener: set_extra_try_arguments 11:05:32 INFO - [mozharness: 2017-03-20 18:05:32.115457Z] Finished download-and-extract step (success) 11:05:32 INFO - [mozharness: 2017-03-20 18:05:32.115621Z] Running populate-webroot step. 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: populate_webroot 11:05:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:32 INFO - '--tppagecycles', 11:05:32 INFO - '7'], 11:05:32 INFO - 'tests': ['tsvgm']}}, 11:05:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['damp', 'tps']}, 11:05:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'tests': ['damp', 'tps']}, 11:05:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['dromaeo_dom']}, 11:05:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['basic_compositor_video']}, 11:05:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:05:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['a11yr', 11:05:32 INFO - 'ts_paint', 11:05:32 INFO - 'tpaint', 11:05:32 INFO - 'sessionrestore', 11:05:32 INFO - 'sessionrestore_no_auto_restore', 11:05:32 INFO - 'tabpaint']}, 11:05:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:32 INFO - 'ts_paint', 11:05:32 INFO - 'tpaint', 11:05:32 INFO - 'sessionrestore', 11:05:32 INFO - 'sessionrestore_no_auto_restore', 11:05:32 INFO - 'tabpaint']}, 11:05:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:05:32 INFO - 'ts_paint', 11:05:32 INFO - 'tpaint', 11:05:32 INFO - 'sessionrestore', 11:05:32 INFO - 'sessionrestore_no_auto_restore', 11:05:32 INFO - 'tabpaint']}, 11:05:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:05:32 INFO - 'ts_paint', 11:05:32 INFO - 'tpaint', 11:05:32 INFO - 'sessionrestore', 11:05:32 INFO - 'sessionrestore_no_auto_restore', 11:05:32 INFO - 'tabpaint']}, 11:05:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['a11yr', 11:05:32 INFO - 'ts_paint', 11:05:32 INFO - 'tpaint', 11:05:32 INFO - 'sessionrestore', 11:05:32 INFO - 'sessionrestore_no_auto_restore', 11:05:32 INFO - 'tabpaint']}, 11:05:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['a11yr', 11:05:32 INFO - 'ts_paint', 11:05:32 INFO - 'tpaint', 11:05:32 INFO - 'sessionrestore', 11:05:32 INFO - 'sessionrestore_no_auto_restore', 11:05:32 INFO - 'tabpaint']}, 11:05:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['tsvgx', 11:05:32 INFO - 'tsvgr_opacity', 11:05:32 INFO - 'tart', 11:05:32 INFO - 'tscrollx', 11:05:32 INFO - 'cart', 11:05:32 INFO - 'tsvg_static']}, 11:05:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:32 INFO - 'tsvgr_opacity', 11:05:32 INFO - 'tart', 11:05:32 INFO - 'tscrollx', 11:05:32 INFO - 'cart', 11:05:32 INFO - 'tsvg_static']}, 11:05:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'talos_options': ['--disable-e10s'], 11:05:32 INFO - 'tests': ['tp5o']}, 11:05:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:05:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'talos_options': ['--disable-e10s', 11:05:32 INFO - '--xperf_path', 11:05:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:32 INFO - 'tests': ['tp5n']}, 11:05:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:05:32 INFO - 'talos_options': ['--xperf_path', 11:05:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:32 INFO - 'tests': ['tp5n']}}, 11:05:32 INFO - 'talos.zip': {'path': '', 11:05:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - [mozharness: 2017-03-20 18:05:32.134966Z] Finished populate-webroot step (success) 11:05:32 INFO - [mozharness: 2017-03-20 18:05:32.135104Z] Running create-virtualenv step. 11:05:32 INFO - Running pre-action listener: _resource_record_pre_action 11:05:32 INFO - Running main action method: create_virtualenv 11:05:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:32 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 11:05:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:32 INFO - Using real prefix '/tools/python27' 11:05:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:35 INFO - Installing pip.................done. 11:05:35 INFO - Return code: 0 11:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:05:36 INFO - Reading from file tmpfile_stdout 11:05:36 INFO - Output received: 11:05:36 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) 11:05:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:36 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:36 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 11:05:36 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 11:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:36 INFO - 'HOME': '/Users/cltbld', 11:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:36 INFO - 'LOGNAME': 'cltbld', 11:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:36 INFO - 'MOZ_NO_REMOTE': '1', 11:05:36 INFO - 'NO_EM_RESTART': '1', 11:05:36 INFO - 'PAGER': '/bin/cat', 11:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:36 INFO - 'PWD': '/builds/slave/test', 11:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:36 INFO - 'SHELL': '/bin/bash', 11:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:36 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:36 INFO - 'USER': 'cltbld', 11:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:36 INFO - 'XPC_FLAGS': '0x0', 11:05:36 INFO - 'XPC_SERVICE_NAME': '0', 11:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:36 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 11:05:36 INFO - Cleaning up... 11:05:36 INFO - Return code: 0 11:05:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:36 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:36 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 11:05:36 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 11:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:36 INFO - 'HOME': '/Users/cltbld', 11:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:36 INFO - 'LOGNAME': 'cltbld', 11:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:36 INFO - 'MOZ_NO_REMOTE': '1', 11:05:36 INFO - 'NO_EM_RESTART': '1', 11:05:36 INFO - 'PAGER': '/bin/cat', 11:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:36 INFO - 'PWD': '/builds/slave/test', 11:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:36 INFO - 'SHELL': '/bin/bash', 11:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:36 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:36 INFO - 'USER': 'cltbld', 11:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:36 INFO - 'XPC_FLAGS': '0x0', 11:05:36 INFO - 'XPC_SERVICE_NAME': '0', 11:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:36 INFO - Downloading/unpacking psutil>=3.1.1 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:36 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 11:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:40 INFO - Installing collected packages: psutil 11:05:40 INFO - Running setup.py install for psutil 11:05:40 INFO - building 'psutil._psutil_osx' extension 11:05:40 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 11:05:40 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 11:05:40 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 11:05:40 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 11:05:40 INFO - building 'psutil._psutil_posix' extension 11:05:40 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 11:05:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:05:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:05:40 INFO - ^ 11:05:41 INFO - 1 warning generated. 11:05:41 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 11:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:41 INFO - Successfully installed psutil 11:05:41 INFO - Cleaning up... 11:05:41 INFO - Return code: 0 11:05:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:41 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:41 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 11:05:41 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 11:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:41 INFO - 'HOME': '/Users/cltbld', 11:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:41 INFO - 'LOGNAME': 'cltbld', 11:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:41 INFO - 'MOZ_NO_REMOTE': '1', 11:05:41 INFO - 'NO_EM_RESTART': '1', 11:05:41 INFO - 'PAGER': '/bin/cat', 11:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:41 INFO - 'PWD': '/builds/slave/test', 11:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:41 INFO - 'SHELL': '/bin/bash', 11:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:41 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:41 INFO - 'USER': 'cltbld', 11:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:41 INFO - 'XPC_FLAGS': '0x0', 11:05:41 INFO - 'XPC_SERVICE_NAME': '0', 11:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:05:41 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 11:05:41 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 11:05:41 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 11:05:41 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 11:05:41 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 11:05:41 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 11:05:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:05:44 INFO - Installing collected packages: mozsystemmonitor 11:05:44 INFO - Running setup.py install for mozsystemmonitor 11:05:44 INFO - Successfully installed mozsystemmonitor 11:05:44 INFO - Cleaning up... 11:05:44 INFO - Return code: 0 11:05:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:44 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:44 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 11:05:44 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 11:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:44 INFO - 'HOME': '/Users/cltbld', 11:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:44 INFO - 'LOGNAME': 'cltbld', 11:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:44 INFO - 'MOZ_NO_REMOTE': '1', 11:05:44 INFO - 'NO_EM_RESTART': '1', 11:05:44 INFO - 'PAGER': '/bin/cat', 11:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:44 INFO - 'PWD': '/builds/slave/test', 11:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:44 INFO - 'SHELL': '/bin/bash', 11:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:44 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:44 INFO - 'USER': 'cltbld', 11:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:44 INFO - 'XPC_FLAGS': '0x0', 11:05:44 INFO - 'XPC_SERVICE_NAME': '0', 11:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:44 INFO - Downloading/unpacking jsonschema==2.5.1 11:05:44 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 11:05:44 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 11:05:44 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 11:05:44 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 11:05:44 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 11:05:44 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 11:05:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:05:47 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 11:05:47 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 11:05:47 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 11:05:47 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 11:05:47 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 11:05:47 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 11:05:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:47 INFO - warning: no files found matching '*.txt' 11:05:47 INFO - no previously-included directories found matching 'build' 11:05:47 INFO - no previously-included directories found matching 'dist' 11:05:47 INFO - no previously-included directories found matching '.git*' 11:05:47 INFO - Installing collected packages: jsonschema, functools32 11:05:47 INFO - Running setup.py install for functools32 11:05:48 INFO - warning: no files found matching '*.txt' 11:05:48 INFO - no previously-included directories found matching 'build' 11:05:48 INFO - no previously-included directories found matching 'dist' 11:05:48 INFO - no previously-included directories found matching '.git*' 11:05:48 INFO - Successfully installed jsonschema functools32 11:05:48 INFO - Cleaning up... 11:05:48 INFO - Return code: 0 11:05:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:48 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:48 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 11:05:48 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 11:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:48 INFO - 'HOME': '/Users/cltbld', 11:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:48 INFO - 'LOGNAME': 'cltbld', 11:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:48 INFO - 'MOZ_NO_REMOTE': '1', 11:05:48 INFO - 'NO_EM_RESTART': '1', 11:05:48 INFO - 'PAGER': '/bin/cat', 11:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:48 INFO - 'PWD': '/builds/slave/test', 11:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:48 INFO - 'SHELL': '/bin/bash', 11:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:48 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:48 INFO - 'USER': 'cltbld', 11:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:48 INFO - 'XPC_FLAGS': '0x0', 11:05:48 INFO - 'XPC_SERVICE_NAME': '0', 11:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:05:48 INFO - Cleaning up... 11:05:48 INFO - Return code: 0 11:05:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:48 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:48 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 11:05:48 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 11:05:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:48 INFO - 'HOME': '/Users/cltbld', 11:05:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:48 INFO - 'LOGNAME': 'cltbld', 11:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:48 INFO - 'MOZ_NO_REMOTE': '1', 11:05:48 INFO - 'NO_EM_RESTART': '1', 11:05:48 INFO - 'PAGER': '/bin/cat', 11:05:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:48 INFO - 'PWD': '/builds/slave/test', 11:05:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:48 INFO - 'SHELL': '/bin/bash', 11:05:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:48 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:48 INFO - 'USER': 'cltbld', 11:05:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:48 INFO - 'XPC_FLAGS': '0x0', 11:05:48 INFO - 'XPC_SERVICE_NAME': '0', 11:05:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:51 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 11:05:51 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 11:05:51 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 11:05:51 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 11:05:51 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 11:05:51 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 11:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:52 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 11:05:52 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 11:05:52 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 11:05:52 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 11:05:52 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 11:05:52 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 11:05:52 INFO - Downloading docopt-0.6.1.tar.gz 11:05:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:52 INFO - Running setup.py install for blobuploader 11:05:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:52 INFO - Running setup.py install for requests 11:05:53 INFO - Running setup.py install for docopt 11:05:53 INFO - Successfully installed blobuploader requests docopt 11:05:53 INFO - Cleaning up... 11:05:53 INFO - Return code: 0 11:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:53 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')]} 11:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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')]} 11:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:53 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 11:05:53 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 11:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:53 INFO - 'HOME': '/Users/cltbld', 11:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:53 INFO - 'LOGNAME': 'cltbld', 11:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:53 INFO - 'MOZ_NO_REMOTE': '1', 11:05:53 INFO - 'NO_EM_RESTART': '1', 11:05:53 INFO - 'PAGER': '/bin/cat', 11:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:53 INFO - 'PWD': '/builds/slave/test', 11:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:53 INFO - 'SHELL': '/bin/bash', 11:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:53 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:53 INFO - 'USER': 'cltbld', 11:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:53 INFO - 'XPC_FLAGS': '0x0', 11:05:53 INFO - 'XPC_SERVICE_NAME': '0', 11:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-FG3fMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-QcJR0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:53 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-_4Ri6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-M51U7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-PGMfsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Hra4v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-WSUXX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-YJiTSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5OF_tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-BcAd9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dv4Ddj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-kwXx4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:54 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Haly5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-f8KHgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-IBOllX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Wl1lqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-TO1w8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:55 INFO - Running setup.py install for manifestparser 11:05:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:55 INFO - Running setup.py install for mozcrash 11:05:55 INFO - Running setup.py install for mozdebug 11:05:55 INFO - Running setup.py install for mozdevice 11:05:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Running setup.py install for mozfile 11:05:56 INFO - Running setup.py install for mozhttpd 11:05:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Running setup.py install for mozinfo 11:05:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Running setup.py install for mozInstall 11:05:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Running setup.py install for mozleak 11:05:56 INFO - Running setup.py install for mozlog 11:05:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:56 INFO - Running setup.py install for moznetwork 11:05:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:57 INFO - Running setup.py install for mozprocess 11:05:57 INFO - Running setup.py install for mozprofile 11:05:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:57 INFO - Running setup.py install for mozrunner 11:05:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:57 INFO - Running setup.py install for mozscreenshot 11:05:57 INFO - Running setup.py install for moztest 11:05:57 INFO - Running setup.py install for mozversion 11:05:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:58 INFO - Cleaning up... 11:05:58 INFO - Return code: 0 11:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:58 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')]} 11:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:58 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')]} 11:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:58 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:05:58 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 11:05:58 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 11:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:58 INFO - 'HOME': '/Users/cltbld', 11:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:58 INFO - 'LOGNAME': 'cltbld', 11:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:58 INFO - 'MOZ_NO_REMOTE': '1', 11:05:58 INFO - 'NO_EM_RESTART': '1', 11:05:58 INFO - 'PAGER': '/bin/cat', 11:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:58 INFO - 'PWD': '/builds/slave/test', 11:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:58 INFO - 'SHELL': '/bin/bash', 11:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:05:58 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:58 INFO - 'USER': 'cltbld', 11:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:58 INFO - 'XPC_FLAGS': '0x0', 11:05:58 INFO - 'XPC_SERVICE_NAME': '0', 11:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-MpFtbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-oS6wPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-JpWRap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-D0A_wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-X3XD7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-i7G4sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:58 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)) 11:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:58 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ADUPVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-rYXLNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-OF7Slj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-WsAehI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-S8T1Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-zdLKZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-QyLxZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-BYn2bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dw8d4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:59 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)) 11:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:59 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-II2SVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:00 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)) 11:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Y9pHUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 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)) 11:06:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:00 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 11:06:00 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 11:06:00 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 11:06:00 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 11:06:00 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 11:06:00 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 11:06:02 INFO - Downloading blessings-1.6.tar.gz 11:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:02 INFO - Installing collected packages: blessings 11:06:02 INFO - Running setup.py install for blessings 11:06:02 INFO - Successfully installed blessings 11:06:02 INFO - Cleaning up... 11:06:03 INFO - Return code: 0 11:06:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:03 INFO - Reading from file tmpfile_stdout 11:06:03 INFO - Current package versions: 11:06:03 INFO - blessings == 1.6 11:06:03 INFO - blobuploader == 1.2.4 11:06:03 INFO - docopt == 0.6.1 11:06:03 INFO - functools32 == 3.2.3-2 11:06:03 INFO - jsonschema == 2.5.1 11:06:03 INFO - manifestparser == 1.1 11:06:03 INFO - mozInstall == 1.12 11:06:03 INFO - mozcrash == 1.0 11:06:03 INFO - mozdebug == 0.1 11:06:03 INFO - mozdevice == 0.49 11:06:03 INFO - mozfile == 1.2 11:06:03 INFO - mozhttpd == 0.7 11:06:03 INFO - mozinfo == 0.9 11:06:03 INFO - mozleak == 0.1 11:06:03 INFO - mozlog == 3.4 11:06:03 INFO - moznetwork == 0.27 11:06:03 INFO - mozprocess == 0.24 11:06:03 INFO - mozprofile == 0.28 11:06:03 INFO - mozrunner == 6.13 11:06:03 INFO - mozscreenshot == 0.1 11:06:03 INFO - mozsystemmonitor == 0.3 11:06:03 INFO - moztest == 0.8 11:06:03 INFO - mozversion == 1.4 11:06:03 INFO - psutil == 3.1.1 11:06:03 INFO - requests == 1.2.3 11:06:03 INFO - wsgiref == 0.1.2 11:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:03 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')]} 11:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:03 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')]} 11:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:03 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:06:03 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 11:06:03 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 11:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:03 INFO - 'HOME': '/Users/cltbld', 11:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:03 INFO - 'LOGNAME': 'cltbld', 11:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:03 INFO - 'MOZ_NO_REMOTE': '1', 11:06:03 INFO - 'NO_EM_RESTART': '1', 11:06:03 INFO - 'PAGER': '/bin/cat', 11:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:03 INFO - 'PWD': '/builds/slave/test', 11:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:03 INFO - 'SHELL': '/bin/bash', 11:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:06:03 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:03 INFO - 'USER': 'cltbld', 11:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:03 INFO - 'XPC_FLAGS': '0x0', 11:06:03 INFO - 'XPC_SERVICE_NAME': '0', 11:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 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)) 11:06:03 INFO - Cleaning up... 11:06:03 INFO - Return code: 0 11:06:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:03 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')]} 11:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:03 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')]} 11:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:03 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 0x108ea0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff88acbcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, '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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 11:06:03 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 11:06:03 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 11:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:03 INFO - 'HOME': '/Users/cltbld', 11:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:03 INFO - 'LOGNAME': 'cltbld', 11:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:03 INFO - 'MOZ_NO_REMOTE': '1', 11:06:03 INFO - 'NO_EM_RESTART': '1', 11:06:03 INFO - 'PAGER': '/bin/cat', 11:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:03 INFO - 'PWD': '/builds/slave/test', 11:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:03 INFO - 'SHELL': '/bin/bash', 11:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:06:03 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:03 INFO - 'USER': 'cltbld', 11:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:03 INFO - 'XPC_FLAGS': '0x0', 11:06:03 INFO - 'XPC_SERVICE_NAME': '0', 11:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:03 INFO - Cleaning up... 11:06:03 INFO - Return code: 0 11:06:03 INFO - Running post-action listener: _resource_record_post_action 11:06:03 INFO - Running post-action listener: _start_resource_monitoring 11:06:03 INFO - Starting resource monitoring. 11:06:03 INFO - [mozharness: 2017-03-20 18:06:03.935261Z] Finished create-virtualenv step (success) 11:06:03 INFO - [mozharness: 2017-03-20 18:06:03.936221Z] Running install step. 11:06:03 INFO - Running pre-action listener: _resource_record_pre_action 11:06:03 INFO - Running main action method: install 11:06:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:04 INFO - Reading from file tmpfile_stdout 11:06:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:04 INFO - Reading from file tmpfile_stdout 11:06:04 INFO - Output received: 11:06:04 INFO - Usage: mozinstall [options] installer 11:06:04 INFO - Options: 11:06:04 INFO - -h, --help show this help message and exit 11:06:04 INFO - -d DEST, --destination=DEST 11:06:04 INFO - Directory to install application into. [default: 11:06:04 INFO - "/builds/slave/test"] 11:06:04 INFO - --app=APP Application being installed. [default: firefox] 11:06:04 INFO - mkdir: /builds/slave/test/build/application 11:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:06:19 INFO - Reading from file tmpfile_stdout 11:06:19 INFO - Output received: 11:06:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:06:19 INFO - Running post-action listener: _resource_record_post_action 11:06:19 INFO - [mozharness: 2017-03-20 18:06:19.296580Z] Finished install step (success) 11:06:19 INFO - [mozharness: 2017-03-20 18:06:19.296702Z] Running run-tests step. 11:06:19 INFO - Running pre-action listener: _resource_record_pre_action 11:06:19 INFO - Running main action method: run_tests 11:06:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:19 INFO - 2017-03-20 11:06:19.311 screenresolution[1920:16725] starting screenresolution argv=screenresolution get 11:06:19 INFO - 2017-03-20 11:06:19.314 screenresolution[1920:16725] Display 0: 1600x1200x32@60 11:06:19 INFO - 2017-03-20 11:06:19.319 screenresolution[1921:16727] starting screenresolution argv=screenresolution list 11:06:19 INFO - Available Modes on Display 0 11:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:19 INFO - Intel Iris: 11:06:19 INFO - Chipset Model: Intel Iris 11:06:19 INFO - Type: GPU 11:06:19 INFO - Bus: Built-In 11:06:19 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:19 INFO - Vendor: Intel (0x8086) 11:06:19 INFO - Device ID: 0x0a2e 11:06:19 INFO - Revision ID: 0x0009 11:06:19 INFO - Displays: 11:06:19 INFO - Display: 11:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:19 INFO - Display Serial Number: 1600x1200 60 11:06:19 INFO - Main Display: Yes 11:06:19 INFO - Mirror: Off 11:06:19 INFO - Online: Yes 11:06:19 INFO - Rotation: Supported 11:06:19 INFO - Return code: 0 11:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:19 INFO - Python 2.7.3 11:06:19 INFO - Return code: 0 11:06:19 INFO - grabbing minidump binary from tooltool 11:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:19 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 0x108c7ed30>, '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 0x108ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c73be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:19 INFO - Return code: 0 11:06:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 11:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --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 11:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0fYF00W2Uv/Render', 11:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:19 INFO - 'HOME': '/Users/cltbld', 11:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:19 INFO - 'LOGNAME': 'cltbld', 11:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:19 INFO - 'MOZ_NO_REMOTE': '1', 11:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:19 INFO - 'NO_EM_RESTART': '1', 11:06:19 INFO - 'PAGER': '/bin/cat', 11:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:19 INFO - 'PWD': '/builds/slave/test', 11:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:19 INFO - 'SHELL': '/bin/bash', 11:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CzdBhSAN2b/Listeners', 11:06:19 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:19 INFO - 'USER': 'cltbld', 11:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:19 INFO - 'XPC_FLAGS': '0x0', 11:06:19 INFO - 'XPC_SERVICE_NAME': '0', 11:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 11:06:19 INFO - mozversion application_buildid: 20170320091724 11:06:19 INFO - mozversion application_changeset: c50649fdad5e9bc395626590a8212d1dd7717870 11:06:19 INFO - mozversion application_display_name: Firefox 11:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:19 INFO - mozversion application_name: Firefox 11:06:19 INFO - mozversion application_remotingname: firefox 11:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:19 INFO - mozversion application_vendor: Mozilla 11:06:19 INFO - mozversion application_version: 53.0 11:06:19 INFO - mozversion platform_buildid: 20170320091724 11:06:19 INFO - mozversion platform_changeset: c50649fdad5e9bc395626590a8212d1dd7717870 11:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:19 INFO - mozversion platform_version: 53.0 11:06:19 INFO - using testdate: 1490033179 11:06:19 INFO - actual date: 1490033179 11:06:19 INFO - starting webserver on 'localhost:53098' 11:06:19 INFO - SUITE-START | Running 2 tests 11:06:19 INFO - TEST-START | dromaeo_css 11:06:19 INFO - operating with platform_type : mac_ 11:06:19 INFO - Initialising browser for dromaeo_css test... 11:06:19 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpwJ4Pj9/profile http://localhost:53098/getInfo.html) 11:06:22 INFO - PROCESS | 1931 | __metrics Screen width/height:1600/1200 11:06:22 INFO - PROCESS | 1931 | colorDepth:24 11:06:22 INFO - PROCESS | 1931 | Browser inner width/height: 1024/689 11:06:22 INFO - PROCESS | 1931 | __metrics 11:06:22 INFO - PROCESS | 1931 | 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" 11:06:22 INFO - PROCESS | 1931 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:22 INFO - TEST-INFO | 1931: exit 0 11:06:22 INFO - Browser initialized. 11:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:22 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpwJ4Pj9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:34 INFO - PROCESS | 1934 | RSS: Main: 163508224 11:06:34 INFO - PROCESS | 1934 | 11:09:38 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:53098/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53098/tests/dromaeo/cssquery-ext.html) 11:09:39 INFO - PROCESS | 1934 | RSS: Main: 304001024 11:09:39 INFO - PROCESS | 1934 | 11:12:42 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:53098/tests/dromaeo/cssquery-ext.html (next: http://localhost:53098/tests/dromaeo/cssquery-jquery.html) 11:12:43 INFO - PROCESS | 1934 | RSS: Main: 314720256 11:12:43 INFO - PROCESS | 1934 | 11:15:45 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:53098/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53098/tests/dromaeo/cssquery-mootools.html) 11:15:46 INFO - PROCESS | 1934 | RSS: Main: 279957504 11:15:46 INFO - PROCESS | 1934 | 11:18:48 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:53098/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53098/tests/dromaeo/cssquery-prototype.html) 11:18:49 INFO - PROCESS | 1934 | RSS: Main: 291192832 11:18:49 INFO - PROCESS | 1934 | 11:21:52 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:53098/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53098/tests/dromaeo/cssquery-yui.html) 11:21:52 INFO - PROCESS | 1934 | RSS: Main: 271814656 11:21:52 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:53098/tests/dromaeo/cssquery-yui.html (next: http://localhost:53098/tests/dromaeo/cssquery-dojo.html) 11:24:56 INFO - PROCESS | 1934 | RSS: Main: 340795392 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | __start_tp_report 11:24:56 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 11:24:56 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 11:24:56 INFO - PROCESS | 1934 | |i|pagename|runs| 11:24:56 INFO - PROCESS | 1934 | |0;dojo.html;3035.119815253576;3285.40862644724;3466.7746596471243;3511.4908338290948;3515.894523164303;5825.679587622679;5850.4734573888345;5858.824235272938;5886.941130588698;5922.200502932103;5790.82627521174;5863.355030946603;5877.617954832933;5899.233099697033;5914.319853216882;5327.014502317074;5370.113931201347;5394.946050539504;5401.675899446026;5448.073827449323;5257.447967963366;5258.2638430619745;5270;5429.294191755086;5436.755346009439;5353.03645343838;5360.705161216131;5374.005808925342;5375.650582712111;5375.838724838261;5356.9732151339385;5360.142377219626;5360.222767698681;5366.168243922199;5370.785168593252;5183.948160518385;5294.735263236823;5296.126139187029;5300.893982120375;5335.146376579767;5852.912206316866;5858.76564937402;5872.29532456108;5872.324682661506;5874.588778785486;6229.96885015572;6271.717772700239;6274.152989346471;6294.087357333161;6324.051392291147;6261.186045814061;6267.561270711052;6270.372962703693;6272.749090036393;6277.905831412532;5966.791162309299;5970.2537182852575;5973.342932277446;5997.940020599782;6040.305364883006;6191.9690401547705;6266.342034086447;6270;6336.144620476177;6342.904856427157;6225.128482012522;6251.437370636573;6266.404691554295;6272.341404152589;6281.59169653971;6292.993121100602;6318.936810631835;6322.683865806784;6339.302676705559;6359.1733074700915;6279.623222606659;6295.338989406138;6296.590721603081;6301.52738544611;6303.464205542488;6098.0852872069545;6246.593971391845;6258.968705156445;6282.403171698681;6286.4342209201395;4329.783510824446;5049.293098966147;5079.5428411443145;5083;5102;4522.072975040174;4593.816247350069;4601.72389656615;4614.146382919171;4646.3727396801;5965.850853728604;5968.283805943314;5990.880182396328;5995.61028533144;6015.488683461867;6218.06728990655;6256.311805701369;6332.271788744353;6341.143945567382;6416.550841441148;5864.765409383662;5904.881902361929;5924.259467566554;5948.434898684618;5994.910076348859;5531.363893152258;5536.889262214814;5539;5544.417836127229;5545.528630066409;4940.6788558743565;6249.000159974382;6297.685115744194;6409.230892292955;6431.678416079084;5268.81559145428;6213.844653883689;6250.4374606285655;6263.248410190807;6278.215223097113;6420.871582568416;6433.613983161025;6450.451711604378;6456.160699109086;6477.611343319416;6245.7189426476825;6258.311585725475;6266.436020758154;6275.780347687809;6283.622982620875;6111.348653136637;6199.225096862892;6220.284667263322;6244.2819075806865;6244.46922011616;6165.784197553064;6196.659183744938;6196.845078872884;6234.096056071753;6249.531285153723;6200.100985357189;6208.751649933952;6210.720517576629;6231.439170474498;6234.096056071935;6058.818235452944;6119.143319935301;6123.908141377794;6125.05061715417;6125.479334256638;5165.586753059671;6157.476614487819;6178.41305076017;6232.594881332699;6255.280642726145;6043.12374705674;6161.291451483136;6176.722047507783;6177.783777567944;6195.535334849995 11:24:56 INFO - PROCESS | 1934 | |1;ext.html;466.17719724685935;504.6997036763127;510.0640325003618;513.2634669249626;513.8381409855892;29988.550171747414;33357.499637505425;41010;42932.35601465973;43093.138137237234;44498.77750611251;44673;44789;44833.7758311208;44862.32706509405;9579.377340472864;9769.218462523017;9788.55951482185;9791.461469619167;9795.853062204073;9043.366964312501;9285.396449230779;11805.996490298292;12002.399880006009;12062.457189426454;11995.16033877629;12001.099917506179;12086.274823510574;12113.33376664283;12121.515139394414;11823.704407389798;11902.404879755977;11902.880971190263;11918.702032449171;11921.582744603984;11806.46870890812;11878.584249551224;11878.881211187863;11878.990285825716;11888.881111188864;42161;42249.36625950613;42295.365569516485;42355.7882210587;42417.57582424167;4022.7988600570147;4103.835846566134;4109.075458021951;4110.77390743509;4131.421600975866;29920.102396928127;30194;30659.846700766575;31312.885628198466;31708.682913170804;3014.427258820817;3055.709707577799;3188.7289580385464;3232.7737058405687;3257.299680568689;479737.6013119947;486488;486802;488118;490586;63531;64016.35983640197;64060.67969660122;64112.35887641157;64116;64831;64897.35102648913;65017;65050;65214.673926630065;17056.914715426592;17556.561085972953;17567.912160439115;17575.384861529787;17625.911870440566;11992.400379980965;13467.595972120853;13594.32028398576;13598.980076494105;13599.524016659567;14078.592140785839;14684.632884177981;15079.698406031817;15113.924430377778;15178.620534486505;5777.266819953997;6390.584612000205;6435.74257029723;6478.190226221723;6548.508861835381;880.3705350674298;881.5680316644798;886.3308202307217;916.3173435790245;925.8194652042922;28274.575881361798;29404.558931616044;30115;30699.2325191872;30997.845010774803;1044.5404022230193;1067.0823092140752;1082.8375743638517;1120.6245907620876;1131.191198293208;14527.709445811024;15753.527394177963;15755.291011904492;15787.36850525989;16006.519804405654;573061;605409;628675;633607;636589;55270.72364638151;56194;62091;62930;63270.050949235796;1262.419287127913;1484.5991582272725;1500.18240059168;1505.6085417791235;1508.894377393594;30220.186788792744;31853.36293274168;32050.839745802055;32499.675003249664;32652.34695306033;50734.746326268134;51145;51342.74328628333;51372;51424.48575514347;420776.8961155297;423506;434520;595089;605608;38916;39453.605463944994;39531;39969.40045899372;40040.799796002;47305;47652.523474766196;48091.519084810105;48248.03503929972;48399.79000525015;37799.81100094482;37838.810805945795;38358.84923452301;39160.43358265638;39831.601683982786;37886.431703523915;38094.61905380911;38194.61805382022;39041.80479097586;39357.409638854864;37569.81215093907;38136.618633813305;38534.80732596431;38548;38558.42162367623;26546.469070618867;30128.54807177938;31775.52336714905;34032.48951265684;34173.65826341705;24507.50984980326;24785.25644230676;24831.875840621404;24844.875775621007;25011.374715631526 11:24:56 INFO - PROCESS | 1934 | |2;jquery.html;379.5199073172436;399.5784447407983;407.2181411689556;413.5595590695909;431.3745069649008;20996.89501552492;21236.787632123694;21861;22150.33548993529;22448.43878903026;22433.878306084713;22789.860506974666;22926.541469170606;23169.073237070497;23216.535669286648;5912.379200183973;6180.660063696495;6193.597416167935;6210.472109870644;6213.471854892339;5911.290645122592;6087.4825639820665;6095.451409373156;6140.324564297924;6140.35526269742;6064.848378790522;6088.512918966472;6089.0866370044405;6090.421409966046;6103.542234332421;5728.112142617901;5825.825225243249;6073.726682299307;6085.574009819315;6089.238845144335;5145.897082058338;5205.479452054802;5336.813211537577;5341.172118321666;5372.140457526777;26752.86623566889;26864.97142714534;26876.462470750477;26933.037365889737;27118.91524339024;2763.668359796817;2806.8456234907276;2833.943321133566;2842.488352096622;2886.480433521965;15784.684306313924;15784.92107539455;15819;15968.441104561285;16795.32818687251;1611.5729331727102;1857.7399164117035;1860.9348672796523;1908.6850669639493;1914.176903931309;125882;137325.31337343348;139039;148193;150298.9999999989;11060.612878549213;11640.417979101012;11727;11768.94115529434;11931.164818462625;15380.61548461275;15399.692006160038;15408.383664653513;15410.383584656713;15482.22588870552;8778.692745753995;9034.412763170372;9036.186743193144;9042.547872606343;9162.404443711137;8965.551722413853;8970.147835955573;9039.322050846213;9151.17639412456;9167.908320916838;6252.937470625327;6920.065791118134;7348.448866334939;7462;7500.512466689648;1562.9531114066597;1699.4731633193749;1990.5521257716898;1994.7606287245333;2005.5387260930067;1062.877769056553;1089.3463921646949;1098.818694915346;1129.4014172488594;1131.7816385539734;20462.283820066226;23157.53684926292;23314.417139571648;23316;23347.649785253234;878.9516576588348;1104.9005589496983;1122.0798944865296;1141.8858114188515;1143.656902929118;11635.941820290844;11847.882489122941;12001.699957501132;12045.277283363026;12049.578264760692;744335;748974;753960;756559;764075;144225;146153;148274;148593;149179.25410373096;1044.5299615173203;1052.1425038593675;1071.8552995345528;1082.967510974672;1083.5124194112682;15315.693686126438;15608.609784755472;18823;19682.819030858194;19808.603827923074;64051.35948640454;66274.66862665655;66275.66862165659;67301.3269867295;68586.314136858;94454.52772736092;95133.92455433446;95385;96467;97556;7353.816154595964;8368.87446688288;8638.17937295956;8669.089745576875;9075.092490750872;9991.850122248317;13157.868421315665;13502.324883755577;13735;13749.656258593215;11584.942075289906;11597.478113485082;11786.823197652213;12025.158238923192;12108.515659373526;10481;10797.29817561856;10900.727481813017;10906.291091079054;11070.335779853234;6039.607425517503;11612.76774464489;11687.669508668436;12017.339046352534;12162.939185304016;7572.924270757222;7835.37317014626;8478.32173426112;8533.701320453754;8945;11146.888531114586;11401.20191586581;11645.301281922773;12035.338056406981;12130.818037729618 11:24:56 INFO - PROCESS | 1934 | |3;mootools.html;1304.354344599423;1376.208680008995;1468.1411374346008;1488.6278430392401;1503.8947273690842;7638.197989211136;7986.520808751479;8283.71007014754;8534.146585341463;8596.656133754643;8369.665213391472;8443.113473085314;8447.28198103162;8468.703595374163;8469.78825529362;2370.6918100646935;2422.8546287222734;2426.4297889995837;2429.8906549205326;2430.7933825624755;2173.6956826044366;2255.2670382125793;2358.988205058981;2436.926892193237;2450.2113457176274;2170.1427935965285;2336.0188720737333;2418.854868707874;2425.6846609940685;2438.9878050609723;2357.5638506876285;2388.020911426307;2392.760723927611;2396.161343529768;2397.85612863227;2345.57779599672;2356.7171939367386;2439.731629520751;2446.510697860417;2446.804255659543;8417.537035463047;8454.957725211334;8467;8472.74581762548;8508.574571271412;5108.5402313791565;5258.395284542288;5260.842174734726;5263.631545791796;5267.683938963636;2905.4334404791075;2923.8684259208385;3285.917852053694;3522.8590856365713;3541.4333706606817;1177.7350096228365;1233.0751936047964;1237.7153254751368;1277.3804704718204;1286.9034822388264;10906.182036347305;10913.563457461692;10914.890851091466;10923.726906827313;10981.011708946153;4516.23224051912;4670.743109129031;4748.738819364969;4749.833755818529;4752.572268495852;9549.140577347933;9549.61801527945;9551.14039736427;9556.522173891277;9563.09150630689;5306.734663266821;5307.203919412119;5308.044551980681;5308.840734777886;5313.388960269618;4397.230484665235;4704.600108990706;4800.807967681323;4856.465788763233;4903.117438861039;3697.149655579232;3799.2781371539872;3801.9429708554394;3803.4484999675446;3805.7526260793516;1115.0597959550487;1274.4583551990552;1302.7003789128553;1307.66654503103;1309.8035294705871;921.4709701815635;929.9953500232456;949.8242825077244;958.4536814015944;987.1411871671692;4774.809007639725;5631.2397826293745;5686.5735069869925;5769.624974376652;5931.051031834972;1013.022433351819;1022.3508072374096;1032.8192566300868;1044.2846650044744;1077.0360527328155;3388.3900897838625;3835.463035175078;3874.9806250969127;3890.90272743178;4018.477597912253;9782.021797820304;10085.394876307299;10098.747531311776;10120.392776433437;10142.630744849352;9976.2517811163;10067.496625168713;10082.04220599042;10082.395056296646;10096;7592.013038304985;7922.207779222147;7922.4850384724805;7947.205279472007;7962.960185199037;5771.96104701141;5795.188673585617;5831.475167234969;5838.32859221178;5947.405259474191;9150.725478235398;9348.95325523368;9349.439033658002;9363.969963303894;9373.765655858386;9104.317176211678;9340.252779777466;9428.10433008863;9437.81124377495;9523.761905952406;7023.648817559204;7219.927800721925;7246.239144889922;7342.412606991321;7345.155307139534;8051.83896322082;8111.878321825296;8113.432059755761;8118.107008228972;8123.187681232066;5860.970695146497;7101.2898710128575;7231.132264128339;7273.3453989141235;7311.305425984523;7025.859482810418;7112.466565007541;7156.355927966508;7169.103862017248;7300.45246606496;6473.2232132144445;6506.219253689587;6507.381798729113;6509.869802603826;6511.446527045254;4929.5563399292805;5031.597472202142;5052.368453943257;5118.539331460186;5143.074246635641;4994.150994331045;5070.645054846125;5170.43125256229;5194.506521880416;5227.1636538155235 11:24:56 INFO - PROCESS | 1934 | |4;prototype.html;368.2836882263996;371.78622292181984;378.8579282768961;386.5612529778702;387.6627334219226;4784;5096.311997880285;5448.700321482317;5505.651115476704;5545.500904918562;4551.294549344857;5284.550813180875;5308.389535203452;5401.4328495508;5409.918851217235;3428.9485657715154;3586.9059936719423;4212.452381190441;4244.1140024783135;4279.636230920368;3407.914802129942;3430.53687752154;4231.301835197189;4285.635720963706;4296.5391766799285;4203.810828512709;4213.705040647156;4224.197402493516;4249.68127390447;4264.594863487963;3553.982230088859;4154.210699966997;4179.895502612459;4199.9370009449885;4255.6169944705125;3163.3198862244726;3477.5479187705437;3749.850005999757;3774.226283611853;3805.8582425272307;4470.776461176928;4537.500874903758;4864.1974074277705;5066.721330326831;5240.2401651760665;4191.218732038871;4309.612134907842;4858.076965376603;4905.730184839832;4933.605311575066;5167.870803229912;5239.528442440161;5725.627834190765;5757.827265182052;5771.336296325892;3545.2909418116224;3661.7802931824176;3731.4962480065115;3950.3876899080688;4192.643625291854;5964.582479226456;5971.761129554812;5981.491573216325;6000.789972350947;6008.969955150196;3995.9200815983518;4012.1914659737718;4012.498437695288;4017.9397309040387;4027.718059735849;3354.9496757548654;3676.852925882935;3839.347310957144;4041.2523683118716;4046.6210714053504;3866.8839934802;4655.11552804966;4676.462206846256;4682.531746825291;4688.249880019249;4639.605633521189;5750.6262092963825;5767.445574598475;5772.132671110367;5787;1156.1040193849833;1249.9625011249677;1251.48689037496;1262.6843289177705;1273.1279073834453;984.3208186351395;991.4745185051934;1008.2589296866797;1014.523174108168;1027.527337424793;4371.912561748747;4802.567768900746;4993.475685053089;5002;5027.838029647287;4957.4794646561595;5238.528532432099;5468.945310546923;5471.5896307777075;5527.806526771624;4595.012072404449;4838.564529192319;4989.925151122736;5006.924896126561;5025.773840177201;2785.804993650425;2880.380718145567;2899;2902.6371703537056;2910.3742695320607;4975.328330675385;5267.71027593486;5331.986922484715;5584.636998595079;5600.887982240414;5328.946710532922;5490.478404551562;5703.173039909273;5975.40245975399;6033.698315084228;5370.91943620846;5552.167784631062;5662.150677398423;6069;6084.969575152184;5009.949900500948;5826.388229235869;5882.323532793613;5896.729759042713;5977.7310021050025;5017.54842064216;5051.873703157304;5597.888042239214;5801.680907550125;5855.648661080349;5772.3650398456975;5984.341722410444;6035.305939816802;6077.842365960198;6115.899138154997;3840.385538313856;3871.8838434847;3968.9603103969744;3992.843864313238;4041.2927737645205;5889.5582831286965;5914.757900840699;5930.28836539618;5947.375525569926;5978.342382338026;4982.427020892644;5335.67985920846;5464.672119672832;5576.553875690016;5641.138424320046;4961.5286547777905;5665.628950774283;5673.74468148926;5681.375048744718;5709.173064619282;5123.820666276662;5221.660592061504;5232.848773269875;5348.786048558014;5503.504684578407;4428.734275943454;4787.832425865078;4947.876303092451;5376.435474275301;5478.356493051989;5345.732713364394;5566.526845218202;5579.6652200868075;5611.242482264842;5623.3814280428305 11:24:56 INFO - PROCESS | 1934 | |5;yui.html;644.9064885591587;660.6366498425865;724.4494184419839;772.5171767645222;896.4890012692764;14722.411103555858;15572.688546229068;15589.922050389732;15595.298211580492;15604.063756174637;13696.863031369683;14366.928165359159;14413.279336033183;14418.639534011629;14471.92764036181;875.6409871952485;887.2369762004671;892.477900428247;901.73849583621;902.6615019367737;892.5894088719197;894.1907573645829;895.1496078725237;895.9875340864813;896.7489103051156;760.163819798223;781.5701364249668;937.1284705224139;957.7892863570004;966.3090890013674;952.7665721898145;953.0897992417225;953.3612479638658;953.5280036381967;954.6420092465326;705.0517054561607;708.412018025038;708.946828987828;709.2056896276152;709.6912842913349;15269.694606107927;15673.764893526606;15813.446529371417;15859;15870.841291587052;14430.855691443056;14552.92723536386;14574.927125364306;14626.335758293022;14651.487197948021;9202.493862837542;11850.22973506728;12000.459979300953;12176.147669663127;12257.57098501557;3724.1434470071763;3867.361885288952;3867.671247943928;3889.9416508752392;3902.4731661225655;111721.44139279252;117688.41155794167;117869;120890.79109208884;121576.3133027683;10764.838527422095;10780.622678206226;10919.181061420426;11078.224524283383;11088.057515111306;23951.922163502684;24259.7574024261;24261.636075458882;24265.39336516601;24320.148794792098;7950.880736788953;8039;8063.798405039921;8072.959635201786;8241.752747417588;4421.7789110544345;4536.56902594253;4610.147122782296;4657.883552911137;4662.347271382009;3700.7409481336585;3804.353259945816;3814.1990182061522;3815.389537673959;3816.2939856126704;588.4615576747314;660.8215781738903;685.8011176758685;700.2927043685914;717.1716667249335;699.5487910297829;706.2795948132979;725.9637018149177;744.6016381236012;759.4418102694625;10199.54102065409;10540.420276884692;10811.243212975016;10941.781164376667;10963.50664220096;565.5582910647726;596.2368168744015;628.1739512541085;686.2519853359862;702.6943279673359;4845.176320025604;5020.623453241022;5080.923786143211;5090.287359769635;5195.714235716996;100798;103592.48203758933;106871.46564267129;107926.92073079325;108339.45830270957;91575;91882.54058729664;92159.5392023049;93366.66583335471;94197.52901235587;76671.61664191644;80686.5965670168;82779;83903.16096838954;84814.7277790846;10518.631847885288;10592.364458132537;11173.217874749014;11224.607138750105;11345.978861902468;46037.84905377393;48804;52166.73916630392;52597.94804103973;53328;65222;69987;70149;70821;72874.27125728675;12643.367831608566;12670.429830657458;12680.23918564889;12760.489580416679;13450.798238026242;13942.874263457667;14720.852791471949;15472.5358239253;15603.453879114177;15775.447859324868;12599.244045357307;13564.728705426034;13604.387802548712;13683.589492315246;14203.64490887736;13259;14218.649228323293;14271.357788899317;14634.926825365805;14759.557213283619;13282.535111271445;13472.932635336761;13849.099808512414;14116.153030818185;14498.492552760603;10735.302205356627;11236.66290011301;11542.480588373375;11577.826332604849;11711.824322635337;11182.384968826467;11375.13140408993;11428;11428.828567571327;11514.827277590675 11:24:56 INFO - PROCESS | 1934 | __end_tp_report 11:24:56 INFO - PROCESS | 1934 | __start_cc_report 11:24:56 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,1202 11:24:56 INFO - PROCESS | 1934 | __end_cc_report 11:24:56 INFO - PROCESS | 1934 | __startTimestamp1490034296452__endTimestamp 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | ------- Summary: start ------- 11:24:56 INFO - PROCESS | 1934 | Number of tests: 6 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | [#0] dojo.html Cycles:165 Average:5837.84 Median:6119.14 stddev:642.14 (10.5%) stddev-sans-first:605.30 11:24:56 INFO - PROCESS | 1934 | Values: 3035.1 3285.4 3466.8 3511.5 3515.9 5825.7 5850.5 5858.8 5886.9 5922.2 5790.8 5863.4 5877.6 5899.2 5914.3 5327.0 5370.1 5394.9 5401.7 5448.1 5257.4 5258.3 5270.0 5429.3 5436.8 5353.0 5360.7 5374.0 5375.7 5375.8 5357.0 5360.1 5360.2 5366.2 5370.8 5183.9 5294.7 5296.1 5300.9 5335.1 5852.9 5858.8 5872.3 5872.3 5874.6 6230.0 6271.7 6274.2 6294.1 6324.1 6261.2 6267.6 6270.4 6272.7 6277.9 5966.8 5970.3 5973.3 5997.9 6040.3 6192.0 6266.3 6270.0 6336.1 6342.9 6225.1 6251.4 6266.4 6272.3 6281.6 6293.0 6318.9 6322.7 6339.3 6359.2 6279.6 6295.3 6296.6 6301.5 6303.5 6098.1 6246.6 6259.0 6282.4 6286.4 4329.8 5049.3 5079.5 5083.0 5102.0 4522.1 4593.8 4601.7 4614.1 4646.4 5965.9 5968.3 5990.9 5995.6 6015.5 6218.1 6256.3 6332.3 6341.1 6416.6 5864.8 5904.9 5924.3 5948.4 5994.9 5531.4 5536.9 5539.0 5544.4 5545.5 4940.7 6249.0 6297.7 6409.2 6431.7 5268.8 6213.8 6250.4 6263.2 6278.2 6420.9 6433.6 6450.5 6456.2 6477.6 6245.7 6258.3 6266.4 6275.8 6283.6 6111.3 6199.2 6220.3 6244.3 6244.5 6165.8 6196.7 6196.8 6234.1 6249.5 6200.1 6208.8 6210.7 6231.4 6234.1 6058.8 6119.1 6123.9 6125.1 6125.5 5165.6 6157.5 6178.4 6232.6 6255.3 6043.1 6161.3 6176.7 6177.8 6195.5 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | [#1] ext.html Cycles:180 Average:68042.44 Median:38737.21 stddev:143451.44 (370.3%) stddev-sans-first:143764.14 11:24:56 INFO - PROCESS | 1934 | Values: 466.2 504.7 510.1 513.3 513.8 29988.6 33357.5 41010.0 42932.4 43093.1 44498.8 44673.0 44789.0 44833.8 44862.3 9579.4 9769.2 9788.6 9791.5 9795.9 9043.4 9285.4 11806.0 12002.4 12062.5 11995.2 12001.1 12086.3 12113.3 12121.5 11823.7 11902.4 11902.9 11918.7 11921.6 11806.5 11878.6 11878.9 11879.0 11888.9 42161.0 42249.4 42295.4 42355.8 42417.6 4022.8 4103.8 4109.1 4110.8 4131.4 29920.1 30194.0 30659.8 31312.9 31708.7 3014.4 3055.7 3188.7 3232.8 3257.3 479737.6 486488.0 486802.0 488118.0 490586.0 63531.0 64016.4 64060.7 64112.4 64116.0 64831.0 64897.4 65017.0 65050.0 65214.7 17056.9 17556.6 17567.9 17575.4 17625.9 11992.4 13467.6 13594.3 13599.0 13599.5 14078.6 14684.6 15079.7 15113.9 15178.6 5777.3 6390.6 6435.7 6478.2 6548.5 880.4 881.6 886.3 916.3 925.8 28274.6 29404.6 30115.0 30699.2 30997.8 1044.5 1067.1 1082.8 1120.6 1131.2 14527.7 15753.5 15755.3 15787.4 16006.5 573061.0 605409.0 628675.0 633607.0 636589.0 55270.7 56194.0 62091.0 62930.0 63270.1 1262.4 1484.6 1500.2 1505.6 1508.9 30220.2 31853.4 32050.8 32499.7 32652.3 50734.7 51145.0 51342.7 51372.0 51424.5 420776.9 423506.0 434520.0 595089.0 605608.0 38916.0 39453.6 39531.0 39969.4 40040.8 47305.0 47652.5 48091.5 48248.0 48399.8 37799.8 37838.8 38358.8 39160.4 39831.6 37886.4 38094.6 38194.6 39041.8 39357.4 37569.8 38136.6 38534.8 38548.0 38558.4 26546.5 30128.5 31775.5 34032.5 34173.7 24507.5 24785.3 24831.9 24844.9 25011.4 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | [#2] jquery.html Cycles:180 Average:41940.11 Median:23042.04 stddev:125536.15 (544.8%) stddev-sans-first:125849.52 11:24:56 INFO - PROCESS | 1934 | Values: 379.5 399.6 407.2 413.6 431.4 20996.9 21236.8 21861.0 22150.3 22448.4 22433.9 22789.9 22926.5 23169.1 23216.5 5912.4 6180.7 6193.6 6210.5 6213.5 5911.3 6087.5 6095.5 6140.3 6140.4 6064.8 6088.5 6089.1 6090.4 6103.5 5728.1 5825.8 6073.7 6085.6 6089.2 5145.9 5205.5 5336.8 5341.2 5372.1 26752.9 26865.0 26876.5 26933.0 27118.9 2763.7 2806.8 2833.9 2842.5 2886.5 15784.7 15784.9 15819.0 15968.4 16795.3 1611.6 1857.7 1860.9 1908.7 1914.2 125882.0 137325.3 139039.0 148193.0 150299.0 11060.6 11640.4 11727.0 11768.9 11931.2 15380.6 15399.7 15408.4 15410.4 15482.2 8778.7 9034.4 9036.2 9042.5 9162.4 8965.6 8970.1 9039.3 9151.2 9167.9 6252.9 6920.1 7348.4 7462.0 7500.5 1563.0 1699.5 1990.6 1994.8 2005.5 1062.9 1089.3 1098.8 1129.4 1131.8 20462.3 23157.5 23314.4 23316.0 23347.6 879.0 1104.9 1122.1 1141.9 1143.7 11635.9 11847.9 12001.7 12045.3 12049.6 744335.0 748974.0 753960.0 756559.0 764075.0 144225.0 146153.0 148274.0 148593.0 149179.3 1044.5 1052.1 1071.9 1083.0 1083.5 15315.7 15608.6 18823.0 19682.8 19808.6 64051.4 66274.7 66275.7 67301.3 68586.3 94454.5 95133.9 95385.0 96467.0 97556.0 7353.8 8368.9 8638.2 8669.1 9075.1 9991.9 13157.9 13502.3 13735.0 13749.7 11584.9 11597.5 11786.8 12025.2 12108.5 10481.0 10797.3 10900.7 10906.3 11070.3 6039.6 11612.8 11687.7 12017.3 12162.9 7572.9 7835.4 8478.3 8533.7 8945.0 11146.9 11401.2 11645.3 12035.3 12130.8 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | [#3] mootools.html Cycles:180 Average:5510.76 Median:5130.81 stddev:2982.87 (58.1%) stddev-sans-first:2974.49 11:24:56 INFO - PROCESS | 1934 | Values: 1304.4 1376.2 1468.1 1488.6 1503.9 7638.2 7986.5 8283.7 8534.1 8596.7 8369.7 8443.1 8447.3 8468.7 8469.8 2370.7 2422.9 2426.4 2429.9 2430.8 2173.7 2255.3 2359.0 2436.9 2450.2 2170.1 2336.0 2418.9 2425.7 2439.0 2357.6 2388.0 2392.8 2396.2 2397.9 2345.6 2356.7 2439.7 2446.5 2446.8 8417.5 8455.0 8467.0 8472.7 8508.6 5108.5 5258.4 5260.8 5263.6 5267.7 2905.4 2923.9 3285.9 3522.9 3541.4 1177.7 1233.1 1237.7 1277.4 1286.9 10906.2 10913.6 10914.9 10923.7 10981.0 4516.2 4670.7 4748.7 4749.8 4752.6 9549.1 9549.6 9551.1 9556.5 9563.1 5306.7 5307.2 5308.0 5308.8 5313.4 4397.2 4704.6 4800.8 4856.5 4903.1 3697.1 3799.3 3801.9 3803.4 3805.8 1115.1 1274.5 1302.7 1307.7 1309.8 921.5 930.0 949.8 958.5 987.1 4774.8 5631.2 5686.6 5769.6 5931.1 1013.0 1022.4 1032.8 1044.3 1077.0 3388.4 3835.5 3875.0 3890.9 4018.5 9782.0 10085.4 10098.7 10120.4 10142.6 9976.3 10067.5 10082.0 10082.4 10096.0 7592.0 7922.2 7922.5 7947.2 7963.0 5772.0 5795.2 5831.5 5838.3 5947.4 9150.7 9349.0 9349.4 9364.0 9373.8 9104.3 9340.3 9428.1 9437.8 9523.8 7023.6 7219.9 7246.2 7342.4 7345.2 8051.8 8111.9 8113.4 8118.1 8123.2 5861.0 7101.3 7231.1 7273.3 7311.3 7025.9 7112.5 7156.4 7169.1 7300.5 6473.2 6506.2 6507.4 6509.9 6511.4 4929.6 5031.6 5052.4 5118.5 5143.1 4994.2 5070.6 5170.4 5194.5 5227.2 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | [#4] prototype.html Cycles:180 Average:4558.66 Median:4991.70 stddev:1384.92 (27.7%) stddev-sans-first:1352.62 11:24:56 INFO - PROCESS | 1934 | Values: 368.3 371.8 378.9 386.6 387.7 4784.0 5096.3 5448.7 5505.7 5545.5 4551.3 5284.6 5308.4 5401.4 5409.9 3428.9 3586.9 4212.5 4244.1 4279.6 3407.9 3430.5 4231.3 4285.6 4296.5 4203.8 4213.7 4224.2 4249.7 4264.6 3554.0 4154.2 4179.9 4199.9 4255.6 3163.3 3477.5 3749.9 3774.2 3805.9 4470.8 4537.5 4864.2 5066.7 5240.2 4191.2 4309.6 4858.1 4905.7 4933.6 5167.9 5239.5 5725.6 5757.8 5771.3 3545.3 3661.8 3731.5 3950.4 4192.6 5964.6 5971.8 5981.5 6000.8 6009.0 3995.9 4012.2 4012.5 4017.9 4027.7 3354.9 3676.9 3839.3 4041.3 4046.6 3866.9 4655.1 4676.5 4682.5 4688.2 4639.6 5750.6 5767.4 5772.1 5787.0 1156.1 1250.0 1251.5 1262.7 1273.1 984.3 991.5 1008.3 1014.5 1027.5 4371.9 4802.6 4993.5 5002.0 5027.8 4957.5 5238.5 5468.9 5471.6 5527.8 4595.0 4838.6 4989.9 5006.9 5025.8 2785.8 2880.4 2899.0 2902.6 2910.4 4975.3 5267.7 5332.0 5584.6 5600.9 5328.9 5490.5 5703.2 5975.4 6033.7 5370.9 5552.2 5662.2 6069.0 6085.0 5009.9 5826.4 5882.3 5896.7 5977.7 5017.5 5051.9 5597.9 5801.7 5855.6 5772.4 5984.3 6035.3 6077.8 6115.9 3840.4 3871.9 3969.0 3992.8 4041.3 5889.6 5914.8 5930.3 5947.4 5978.3 4982.4 5335.7 5464.7 5576.6 5641.1 4961.5 5665.6 5673.7 5681.4 5709.2 5123.8 5221.7 5232.8 5348.8 5503.5 4428.7 4787.8 4947.9 5376.4 5478.4 5345.7 5566.5 5579.7 5611.2 5623.4 11:24:56 INFO - PROCESS | 1934 | 11:24:56 INFO - PROCESS | 1934 | [#5] yui.html Cycles:180 Average:21423.55 Median:3764.25 stddev:31095.49 (826.1%) stddev-sans-first:31143.58 11:24:56 INFO - PROCESS | 1934 | Values: 644.9 660.6 724.4 772.5 896.5 14722.4 15572.7 15589.9 15595.3 15604.1 13696.9 14366.9 14413.3 14418.6 14471.9 875.6 887.2 892.5 901.7 902.7 892.6 894.2 895.1 896.0 896.7 760.2 781.6 937.1 957.8 966.3 952.8 953.1 953.4 953.5 954.6 705.1 708.4 708.9 709.2 709.7 15269.7 15673.8 15813.4 15859.0 15870.8 14430.9 14552.9 14574.9 14626.3 14651.5 9202.5 11850.2 12000.5 12176.1 12257.6 3724.1 3867.4 3867.7 3889.9 3902.5 111721.4 117688.4 117869.0 120890.8 121576.3 10764.8 10780.6 10919.2 11078.2 11088.1 23951.9 24259.8 24261.6 24265.4 24320.1 7950.9 8039.0 8063.8 8073.0 8241.8 4421.8 4536.6 4610.1 4657.9 4662.3 3700.7 3804.4 3814.2 3815.4 3816.3 588.5 660.8 685.8 700.3 717.2 699.5 706.3 726.0 744.6 759.4 10199.5 10540.4 10811.2 10941.8 10963.5 565.6 596.2 628.2 686.3 702.7 4845.2 5020.6 5080.9 5090.3 5195.7 100798.0 103592.5 106871.5 107926.9 108339.5 91575.0 91882.5 92159.5 93366.7 94197.5 76671.6 80686.6 82779.0 83903.2 84814.7 10518.6 10592.4 11173.2 11224.6 11346.0 46037.8 48804.0 52166.7 52597.9 53328.0 65222.0 69987.0 70149.0 70821.0 72874.3 12643.4 12670.4 12680.2 12760.5 13450.8 13942.9 14720.9 15472.5 15603.5 15775.4 12599.2 13564.7 13604.4 13683.6 14203.6 13259.0 14218.6 14271.4 14634.9 14759.6 13282.5 13472.9 13849.1 14116.2 14498.5 10735.3 11236.7 11542.5 11577.8 11711.8 11182.4 11375.1 11428.0 11428.8 11514.8 11:24:56 INFO - PROCESS | 1934 | -------- Summary: end -------- 11:24:56 INFO - PROCESS | 1934 | 11:24:57 INFO - TEST-INFO | 1934: exit 0 11:24:57 INFO - TEST-OK | dromaeo_css | took 1117184ms 11:24:57 INFO - TEST-START | kraken 11:24:57 INFO - operating with platform_type : mac_ 11:24:57 INFO - Initialising browser for kraken test... 11:24:57 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpWKPvrA/profile http://localhost:53098/getInfo.html) 11:24:59 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 11:24:59 INFO - PROCESS | 1937 | colorDepth:24 11:24:59 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 11:24:59 INFO - PROCESS | 1937 | __metrics 11:24:59 INFO - PROCESS | 1937 | 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" 11:24:59 INFO - PROCESS | 1937 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:00 INFO - TEST-INFO | 1937: exit 0 11:25:00 INFO - Browser initialized. 11:25:00 INFO - Running cycle 1/1 for kraken test... 11:25:00 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpWKPvrA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:12 INFO - PROCESS | 1939 | RSS: Main: 163782656 11:25:12 INFO - PROCESS | 1939 | 11:25:15 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53098/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:16 INFO - PROCESS | 1939 | RSS: Main: 215121920 11:25:16 INFO - PROCESS | 1939 | 11:25:18 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53098/tests/kraken/driver.html?testName=audio-dft) 11:25:19 INFO - PROCESS | 1939 | RSS: Main: 230174720 11:25:19 INFO - PROCESS | 1939 | 11:25:22 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53098/tests/kraken/driver.html?testName=audio-fft) 11:25:22 INFO - PROCESS | 1939 | RSS: Main: 326914048 11:25:22 INFO - PROCESS | 1939 | 11:25:24 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53098/tests/kraken/driver.html?testName=audio-oscillator) 11:25:25 INFO - PROCESS | 1939 | RSS: Main: 229675008 11:25:25 INFO - PROCESS | 1939 | 11:25:27 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53098/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:27 INFO - PROCESS | 1939 | RSS: Main: 230936576 11:25:27 INFO - PROCESS | 1939 | 11:25:30 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53098/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:31 INFO - PROCESS | 1939 | RSS: Main: 270331904 11:25:31 INFO - PROCESS | 1939 | 11:25:34 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53098/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:35 INFO - PROCESS | 1939 | RSS: Main: 270336000 11:25:35 INFO - PROCESS | 1939 | 11:25:38 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53098/tests/kraken/driver.html?testName=json-parse-financial) 11:25:38 INFO - PROCESS | 1939 | RSS: Main: 265650176 11:25:38 INFO - PROCESS | 1939 | 11:25:40 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53098/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:40 INFO - PROCESS | 1939 | RSS: Main: 244355072 11:25:40 INFO - PROCESS | 1939 | 11:25:42 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:43 INFO - PROCESS | 1939 | RSS: Main: 246079488 11:25:43 INFO - PROCESS | 1939 | 11:25:45 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:46 INFO - PROCESS | 1939 | RSS: Main: 254590976 11:25:46 INFO - PROCESS | 1939 | 11:25:48 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:49 INFO - PROCESS | 1939 | RSS: Main: 269889536 11:25:49 INFO - PROCESS | 1939 | 11:25:52 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:53 INFO - PROCESS | 1939 | RSS: Main: 264183808 11:25:53 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:53098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53098/tests/kraken/driver.html?testName=ai-astar) 11:25:54 INFO - PROCESS | 1939 | RSS: Main: 308604928 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | __start_tp_report 11:25:54 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 11:25:54 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 11:25:54 INFO - PROCESS | 1939 | |i|pagename|runs| 11:25:54 INFO - PROCESS | 1939 | |0;ai-astar;104;114;113;113;121;165;154;113;130;154 11:25:54 INFO - PROCESS | 1939 | |1;audio-beat-detection;137;107;105;144;107;107;109;107;126;106 11:25:54 INFO - PROCESS | 1939 | |2;audio-dft;185;183;180;185;183;183;181;185;183;182 11:25:54 INFO - PROCESS | 1939 | |3;audio-fft;80;57;59;88;61;59;58;58;73;57 11:25:54 INFO - PROCESS | 1939 | |4;audio-oscillator;87;70;84;69;69;67;81;68;68;84 11:25:54 INFO - PROCESS | 1939 | |5;imaging-gaussian-blur;89;86;89;87;89;86;89;88;134;110 11:25:54 INFO - PROCESS | 1939 | |6;imaging-darkroom;95;95;95;96;108;151;150;118;145;151 11:25:54 INFO - PROCESS | 1939 | |7;imaging-desaturate;89;87;87;95;88;84;88;87;83;86 11:25:54 INFO - PROCESS | 1939 | |8;json-parse-financial;54;51;51;51;54;56;56;55;55;53 11:25:54 INFO - PROCESS | 1939 | |9;json-stringify-tinderbox;65;65;76;76;72;69;70;70;71;71 11:25:54 INFO - PROCESS | 1939 | |10;stanford-crypto-aes;84;81;83;81;84;82;81;81;82;82 11:25:54 INFO - PROCESS | 1939 | |11;stanford-crypto-ccm;138;141;127;136;135;142;124;134;165;132 11:25:54 INFO - PROCESS | 1939 | |12;stanford-crypto-pbkdf2;162;163;164;160;154;160;163;161;164;158 11:25:54 INFO - PROCESS | 1939 | |13;stanford-crypto-sha256-iterative;65;64;67;64;64;64;63;63;63;62 11:25:54 INFO - PROCESS | 1939 | __end_tp_report 11:25:54 INFO - PROCESS | 1939 | __start_cc_report 11:25:54 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,2037 11:25:54 INFO - PROCESS | 1939 | __end_cc_report 11:25:54 INFO - PROCESS | 1939 | __startTimestamp1490034354933__endTimestamp 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | ------- Summary: start ------- 11:25:54 INFO - PROCESS | 1939 | Number of tests: 14 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#0] ai-astar Cycles:10 Average:128.10 Median:125.50 stddev:21.66 (17.3%) stddev-sans-first:21.14 11:25:54 INFO - PROCESS | 1939 | Values: 104.0 114.0 113.0 113.0 121.0 165.0 154.0 113.0 130.0 154.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:108.00 stddev:14.59 (13.5%) stddev-sans-first:13.24 11:25:54 INFO - PROCESS | 1939 | Values: 137.0 107.0 105.0 144.0 107.0 107.0 109.0 107.0 126.0 106.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.70 (0.9%) stddev-sans-first:1.64 11:25:54 INFO - PROCESS | 1939 | Values: 185.0 183.0 180.0 185.0 183.0 183.0 181.0 185.0 183.0 182.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#3] audio-fft Cycles:10 Average:65.00 Median:60.00 stddev:11.22 (18.7%) stddev-sans-first:10.50 11:25:54 INFO - PROCESS | 1939 | Values: 80.0 57.0 59.0 88.0 61.0 59.0 58.0 58.0 73.0 57.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:75.50 stddev:8.17 (10.8%) stddev-sans-first:7.35 11:25:54 INFO - PROCESS | 1939 | Values: 87.0 70.0 84.0 69.0 69.0 67.0 81.0 68.0 68.0 84.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:88.50 stddev:15.51 (17.5%) stddev-sans-first:16.31 11:25:54 INFO - PROCESS | 1939 | Values: 89.0 86.0 89.0 87.0 89.0 86.0 89.0 88.0 134.0 110.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#6] imaging-darkroom Cycles:10 Average:120.40 Median:123.00 stddev:25.92 (21.1%) stddev-sans-first:25.81 11:25:54 INFO - PROCESS | 1939 | Values: 95.0 95.0 95.0 96.0 108.0 151.0 150.0 118.0 145.0 151.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:87.50 stddev:3.24 (3.7%) stddev-sans-first:3.38 11:25:54 INFO - PROCESS | 1939 | Values: 89.0 87.0 87.0 95.0 88.0 84.0 88.0 87.0 83.0 86.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.50 stddev:2.01 (3.7%) stddev-sans-first:2.13 11:25:54 INFO - PROCESS | 1939 | Values: 54.0 51.0 51.0 51.0 54.0 56.0 56.0 55.0 55.0 53.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:3.75 (5.3%) stddev-sans-first:3.41 11:25:54 INFO - PROCESS | 1939 | Values: 65.0 65.0 76.0 76.0 72.0 69.0 70.0 70.0 71.0 71.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.20 (1.5%) stddev-sans-first:1.05 11:25:54 INFO - PROCESS | 1939 | Values: 84.0 81.0 83.0 81.0 84.0 82.0 81.0 81.0 82.0 82.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:137.00 stddev:11.22 (8.2%) stddev-sans-first:11.90 11:25:54 INFO - PROCESS | 1939 | Values: 138.0 141.0 127.0 136.0 135.0 142.0 124.0 134.0 165.0 132.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.50 stddev:3.11 (1.9%) stddev-sans-first:3.27 11:25:54 INFO - PROCESS | 1939 | Values: 162.0 163.0 164.0 160.0 154.0 160.0 163.0 161.0 164.0 158.0 11:25:54 INFO - PROCESS | 1939 | 11:25:54 INFO - PROCESS | 1939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.39 11:25:54 INFO - PROCESS | 1939 | Values: 65.0 64.0 67.0 64.0 64.0 64.0 63.0 63.0 63.0 62.0 11:25:54 INFO - PROCESS | 1939 | -------- Summary: end -------- 11:25:54 INFO - PROCESS | 1939 | 11:25:55 INFO - TEST-INFO | 1939: exit 0 11:25:55 INFO - TEST-OK | kraken | took 58679ms 11:25:55 INFO - SUITE-END | took 1175s 11:25:56 INFO - Completed test suite (00:19:36) 11:25:56 INFO - javascript benchmark 11:25:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.119815253576, 3285.40862644724, 3466.7746596471243, 3511.4908338290948, 3515.894523164303, 5825.679587622679, 5850.4734573888345, 5858.824235272938, 5886.941130588698, 5922.200502932103, 5790.82627521174, 5863.355030946603, 5877.617954832933, 5899.233099697033, 5914.319853216882, 5327.014502317074, 5370.113931201347, 5394.946050539504, 5401.675899446026, 5448.073827449323, 5257.447967963366, 5258.2638430619745, 5270.0, 5429.294191755086, 5436.755346009439, 5353.03645343838, 5360.705161216131, 5374.005808925342, 5375.650582712111, 5375.838724838261, 5356.9732151339385, 5360.142377219626, 5360.222767698681, 5366.168243922199, 5370.785168593252, 5183.948160518385, 5294.735263236823, 5296.126139187029, 5300.893982120375, 5335.146376579767, 5852.912206316866, 5858.76564937402, 5872.29532456108, 5872.324682661506, 5874.588778785486, 6229.96885015572, 6271.717772700239, 6274.152989346471, 6294.087357333161, 6324.051392291147, 6261.186045814061, 6267.561270711052, 6270.372962703693, 6272.749090036393, 6277.905831412532, 5966.791162309299, 5970.2537182852575, 5973.342932277446, 5997.940020599782, 6040.305364883006, 6191.9690401547705, 6266.342034086447, 6270.0, 6336.144620476177, 6342.904856427157, 6225.128482012522, 6251.437370636573, 6266.404691554295, 6272.341404152589, 6281.59169653971, 6292.993121100602, 6318.936810631835, 6322.683865806784, 6339.302676705559, 6359.1733074700915, 6279.623222606659, 6295.338989406138, 6296.590721603081, 6301.52738544611, 6303.464205542488, 6098.0852872069545, 6246.593971391845, 6258.968705156445, 6282.403171698681, 6286.4342209201395, 4329.783510824446, 5049.293098966147, 5079.5428411443145, 5083.0, 5102.0, 4522.072975040174, 4593.816247350069, 4601.72389656615, 4614.146382919171, 4646.3727396801, 5965.850853728604, 5968.283805943314, 5990.880182396328, 5995.61028533144, 6015.488683461867, 6218.06728990655, 6256.311805701369, 6332.271788744353, 6341.143945567382, 6416.550841441148, 5864.765409383662, 5904.881902361929, 5924.259467566554, 5948.434898684618, 5994.910076348859, 5531.363893152258, 5536.889262214814, 5539.0, 5544.417836127229, 5545.528630066409, 4940.6788558743565, 6249.000159974382, 6297.685115744194, 6409.230892292955, 6431.678416079084, 5268.81559145428, 6213.844653883689, 6250.4374606285655, 6263.248410190807, 6278.215223097113, 6420.871582568416, 6433.613983161025, 6450.451711604378, 6456.160699109086, 6477.611343319416, 6245.7189426476825, 6258.311585725475, 6266.436020758154, 6275.780347687809, 6283.622982620875, 6111.348653136637, 6199.225096862892, 6220.284667263322, 6244.2819075806865, 6244.46922011616, 6165.784197553064, 6196.659183744938, 6196.845078872884, 6234.096056071753, 6249.531285153723, 6200.100985357189, 6208.751649933952, 6210.720517576629, 6231.439170474498, 6234.096056071935, 6058.818235452944, 6119.143319935301, 6123.908141377794, 6125.05061715417, 6125.479334256638, 5165.586753059671, 6157.476614487819, 6178.41305076017, 6232.594881332699, 6255.280642726145, 6043.12374705674, 6161.291451483136, 6176.722047507783, 6177.783777567944, 6195.535334849995], "value": 5797.549363099359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.17719724685935, 504.6997036763127, 510.0640325003618, 513.2634669249626, 513.8381409855892, 29988.550171747414, 33357.499637505425, 41010.0, 42932.35601465973, 43093.138137237234, 44498.77750611251, 44673.0, 44789.0, 44833.7758311208, 44862.32706509405, 9579.377340472864, 9769.218462523017, 9788.55951482185, 9791.461469619167, 9795.853062204073, 9043.366964312501, 9285.396449230779, 11805.996490298292, 12002.399880006009, 12062.457189426454, 11995.16033877629, 12001.099917506179, 12086.274823510574, 12113.33376664283, 12121.515139394414, 11823.704407389798, 11902.404879755977, 11902.880971190263, 11918.702032449171, 11921.582744603984, 11806.46870890812, 11878.584249551224, 11878.881211187863, 11878.990285825716, 11888.881111188864, 42161.0, 42249.36625950613, 42295.365569516485, 42355.7882210587, 42417.57582424167, 4022.7988600570147, 4103.835846566134, 4109.075458021951, 4110.77390743509, 4131.421600975866, 29920.102396928127, 30194.0, 30659.846700766575, 31312.885628198466, 31708.682913170804, 3014.427258820817, 3055.709707577799, 3188.7289580385464, 3232.7737058405687, 3257.299680568689, 479737.6013119947, 486488.0, 486802.0, 488118.0, 490586.0, 63531.0, 64016.35983640197, 64060.67969660122, 64112.35887641157, 64116.0, 64831.0, 64897.35102648913, 65017.0, 65050.0, 65214.673926630065, 17056.914715426592, 17556.561085972953, 17567.912160439115, 17575.384861529787, 17625.911870440566, 11992.400379980965, 13467.595972120853, 13594.32028398576, 13598.980076494105, 13599.524016659567, 14078.592140785839, 14684.632884177981, 15079.698406031817, 15113.924430377778, 15178.620534486505, 5777.266819953997, 6390.584612000205, 6435.74257029723, 6478.190226221723, 6548.508861835381, 880.3705350674298, 881.5680316644798, 886.3308202307217, 916.3173435790245, 925.8194652042922, 28274.575881361798, 29404.558931616044, 30115.0, 30699.2325191872, 30997.845010774803, 1044.5404022230193, 1067.0823092140752, 1082.8375743638517, 1120.6245907620876, 1131.191198293208, 14527.709445811024, 15753.527394177963, 15755.291011904492, 15787.36850525989, 16006.519804405654, 573061.0, 605409.0, 628675.0, 633607.0, 636589.0, 55270.72364638151, 56194.0, 62091.0, 62930.0, 63270.050949235796, 1262.419287127913, 1484.5991582272725, 1500.18240059168, 1505.6085417791235, 1508.894377393594, 30220.186788792744, 31853.36293274168, 32050.839745802055, 32499.675003249664, 32652.34695306033, 50734.746326268134, 51145.0, 51342.74328628333, 51372.0, 51424.48575514347, 420776.8961155297, 423506.0, 434520.0, 595089.0, 605608.0, 38916.0, 39453.605463944994, 39531.0, 39969.40045899372, 40040.799796002, 47305.0, 47652.523474766196, 48091.519084810105, 48248.03503929972, 48399.79000525015, 37799.81100094482, 37838.810805945795, 38358.84923452301, 39160.43358265638, 39831.601683982786, 37886.431703523915, 38094.61905380911, 38194.61805382022, 39041.80479097586, 39357.409638854864, 37569.81215093907, 38136.618633813305, 38534.80732596431, 38548.0, 38558.42162367623, 26546.469070618867, 30128.54807177938, 31775.52336714905, 34032.48951265684, 34173.65826341705, 24507.50984980326, 24785.25644230676, 24831.875840621404, 24844.875775621007, 25011.374715631526], "value": 20568.170924234866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5199073172436, 399.5784447407983, 407.2181411689556, 413.5595590695909, 431.3745069649008, 20996.89501552492, 21236.787632123694, 21861.0, 22150.33548993529, 22448.43878903026, 22433.878306084713, 22789.860506974666, 22926.541469170606, 23169.073237070497, 23216.535669286648, 5912.379200183973, 6180.660063696495, 6193.597416167935, 6210.472109870644, 6213.471854892339, 5911.290645122592, 6087.4825639820665, 6095.451409373156, 6140.324564297924, 6140.35526269742, 6064.848378790522, 6088.512918966472, 6089.0866370044405, 6090.421409966046, 6103.542234332421, 5728.112142617901, 5825.825225243249, 6073.726682299307, 6085.574009819315, 6089.238845144335, 5145.897082058338, 5205.479452054802, 5336.813211537577, 5341.172118321666, 5372.140457526777, 26752.86623566889, 26864.97142714534, 26876.462470750477, 26933.037365889737, 27118.91524339024, 2763.668359796817, 2806.8456234907276, 2833.943321133566, 2842.488352096622, 2886.480433521965, 15784.684306313924, 15784.92107539455, 15819.0, 15968.441104561285, 16795.32818687251, 1611.5729331727102, 1857.7399164117035, 1860.9348672796523, 1908.6850669639493, 1914.176903931309, 125882.0, 137325.31337343348, 139039.0, 148193.0, 150298.9999999989, 11060.612878549213, 11640.417979101012, 11727.0, 11768.94115529434, 11931.164818462625, 15380.61548461275, 15399.692006160038, 15408.383664653513, 15410.383584656713, 15482.22588870552, 8778.692745753995, 9034.412763170372, 9036.186743193144, 9042.547872606343, 9162.404443711137, 8965.551722413853, 8970.147835955573, 9039.322050846213, 9151.17639412456, 9167.908320916838, 6252.937470625327, 6920.065791118134, 7348.448866334939, 7462.0, 7500.512466689648, 1562.9531114066597, 1699.4731633193749, 1990.5521257716898, 1994.7606287245333, 2005.5387260930067, 1062.877769056553, 1089.3463921646949, 1098.818694915346, 1129.4014172488594, 1131.7816385539734, 20462.283820066226, 23157.53684926292, 23314.417139571648, 23316.0, 23347.649785253234, 878.9516576588348, 1104.9005589496983, 1122.0798944865296, 1141.8858114188515, 1143.656902929118, 11635.941820290844, 11847.882489122941, 12001.699957501132, 12045.277283363026, 12049.578264760692, 744335.0, 748974.0, 753960.0, 756559.0, 764075.0, 144225.0, 146153.0, 148274.0, 148593.0, 149179.25410373096, 1044.5299615173203, 1052.1425038593675, 1071.8552995345528, 1082.967510974672, 1083.5124194112682, 15315.693686126438, 15608.609784755472, 18823.0, 19682.819030858194, 19808.603827923074, 64051.35948640454, 66274.66862665655, 66275.66862165659, 67301.3269867295, 68586.314136858, 94454.52772736092, 95133.92455433446, 95385.0, 96467.0, 97556.0, 7353.816154595964, 8368.87446688288, 8638.17937295956, 8669.089745576875, 9075.092490750872, 9991.850122248317, 13157.868421315665, 13502.324883755577, 13735.0, 13749.656258593215, 11584.942075289906, 11597.478113485082, 11786.823197652213, 12025.158238923192, 12108.515659373526, 10481.0, 10797.29817561856, 10900.727481813017, 10906.291091079054, 11070.335779853234, 6039.607425517503, 11612.76774464489, 11687.669508668436, 12017.339046352534, 12162.939185304016, 7572.924270757222, 7835.37317014626, 8478.32173426112, 8533.701320453754, 8945.0, 11146.888531114586, 11401.20191586581, 11645.301281922773, 12035.338056406981, 12130.818037729618], "value": 10480.41783367696, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.354344599423, 1376.208680008995, 1468.1411374346008, 1488.6278430392401, 1503.8947273690842, 7638.197989211136, 7986.520808751479, 8283.71007014754, 8534.146585341463, 8596.656133754643, 8369.665213391472, 8443.113473085314, 8447.28198103162, 8468.703595374163, 8469.78825529362, 2370.6918100646935, 2422.8546287222734, 2426.4297889995837, 2429.8906549205326, 2430.7933825624755, 2173.6956826044366, 2255.2670382125793, 2358.988205058981, 2436.926892193237, 2450.2113457176274, 2170.1427935965285, 2336.0188720737333, 2418.854868707874, 2425.6846609940685, 2438.9878050609723, 2357.5638506876285, 2388.020911426307, 2392.760723927611, 2396.161343529768, 2397.85612863227, 2345.57779599672, 2356.7171939367386, 2439.731629520751, 2446.510697860417, 2446.804255659543, 8417.537035463047, 8454.957725211334, 8467.0, 8472.74581762548, 8508.574571271412, 5108.5402313791565, 5258.395284542288, 5260.842174734726, 5263.631545791796, 5267.683938963636, 2905.4334404791075, 2923.8684259208385, 3285.917852053694, 3522.8590856365713, 3541.4333706606817, 1177.7350096228365, 1233.0751936047964, 1237.7153254751368, 1277.3804704718204, 1286.9034822388264, 10906.182036347305, 10913.563457461692, 10914.890851091466, 10923.726906827313, 10981.011708946153, 4516.23224051912, 4670.743109129031, 4748.738819364969, 4749.833755818529, 4752.572268495852, 9549.140577347933, 9549.61801527945, 9551.14039736427, 9556.522173891277, 9563.09150630689, 5306.734663266821, 5307.203919412119, 5308.044551980681, 5308.840734777886, 5313.388960269618, 4397.230484665235, 4704.600108990706, 4800.807967681323, 4856.465788763233, 4903.117438861039, 3697.149655579232, 3799.2781371539872, 3801.9429708554394, 3803.4484999675446, 3805.7526260793516, 1115.0597959550487, 1274.4583551990552, 1302.7003789128553, 1307.66654503103, 1309.8035294705871, 921.4709701815635, 929.9953500232456, 949.8242825077244, 958.4536814015944, 987.1411871671692, 4774.809007639725, 5631.2397826293745, 5686.5735069869925, 5769.624974376652, 5931.051031834972, 1013.022433351819, 1022.3508072374096, 1032.8192566300868, 1044.2846650044744, 1077.0360527328155, 3388.3900897838625, 3835.463035175078, 3874.9806250969127, 3890.90272743178, 4018.477597912253, 9782.021797820304, 10085.394876307299, 10098.747531311776, 10120.392776433437, 10142.630744849352, 9976.2517811163, 10067.496625168713, 10082.04220599042, 10082.395056296646, 10096.0, 7592.013038304985, 7922.207779222147, 7922.4850384724805, 7947.205279472007, 7962.960185199037, 5771.96104701141, 5795.188673585617, 5831.475167234969, 5838.32859221178, 5947.405259474191, 9150.725478235398, 9348.95325523368, 9349.439033658002, 9363.969963303894, 9373.765655858386, 9104.317176211678, 9340.252779777466, 9428.10433008863, 9437.81124377495, 9523.761905952406, 7023.648817559204, 7219.927800721925, 7246.239144889922, 7342.412606991321, 7345.155307139534, 8051.83896322082, 8111.878321825296, 8113.432059755761, 8118.107008228972, 8123.187681232066, 5860.970695146497, 7101.2898710128575, 7231.132264128339, 7273.3453989141235, 7311.305425984523, 7025.859482810418, 7112.466565007541, 7156.355927966508, 7169.103862017248, 7300.45246606496, 6473.2232132144445, 6506.219253689587, 6507.381798729113, 6509.869802603826, 6511.446527045254, 4929.5563399292805, 5031.597472202142, 5052.368453943257, 5118.539331460186, 5143.074246635641, 4994.150994331045, 5070.645054846125, 5170.43125256229, 5194.506521880416, 5227.1636538155235], "value": 4500.327962076065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.2836882263996, 371.78622292181984, 378.8579282768961, 386.5612529778702, 387.6627334219226, 4784.0, 5096.311997880285, 5448.700321482317, 5505.651115476704, 5545.500904918562, 4551.294549344857, 5284.550813180875, 5308.389535203452, 5401.4328495508, 5409.918851217235, 3428.9485657715154, 3586.9059936719423, 4212.452381190441, 4244.1140024783135, 4279.636230920368, 3407.914802129942, 3430.53687752154, 4231.301835197189, 4285.635720963706, 4296.5391766799285, 4203.810828512709, 4213.705040647156, 4224.197402493516, 4249.68127390447, 4264.594863487963, 3553.982230088859, 4154.210699966997, 4179.895502612459, 4199.9370009449885, 4255.6169944705125, 3163.3198862244726, 3477.5479187705437, 3749.850005999757, 3774.226283611853, 3805.8582425272307, 4470.776461176928, 4537.500874903758, 4864.1974074277705, 5066.721330326831, 5240.2401651760665, 4191.218732038871, 4309.612134907842, 4858.076965376603, 4905.730184839832, 4933.605311575066, 5167.870803229912, 5239.528442440161, 5725.627834190765, 5757.827265182052, 5771.336296325892, 3545.2909418116224, 3661.7802931824176, 3731.4962480065115, 3950.3876899080688, 4192.643625291854, 5964.582479226456, 5971.761129554812, 5981.491573216325, 6000.789972350947, 6008.969955150196, 3995.9200815983518, 4012.1914659737718, 4012.498437695288, 4017.9397309040387, 4027.718059735849, 3354.9496757548654, 3676.852925882935, 3839.347310957144, 4041.2523683118716, 4046.6210714053504, 3866.8839934802, 4655.11552804966, 4676.462206846256, 4682.531746825291, 4688.249880019249, 4639.605633521189, 5750.6262092963825, 5767.445574598475, 5772.132671110367, 5787.0, 1156.1040193849833, 1249.9625011249677, 1251.48689037496, 1262.6843289177705, 1273.1279073834453, 984.3208186351395, 991.4745185051934, 1008.2589296866797, 1014.523174108168, 1027.527337424793, 4371.912561748747, 4802.567768900746, 4993.475685053089, 5002.0, 5027.838029647287, 4957.4794646561595, 5238.528532432099, 5468.945310546923, 5471.5896307777075, 5527.806526771624, 4595.012072404449, 4838.564529192319, 4989.925151122736, 5006.924896126561, 5025.773840177201, 2785.804993650425, 2880.380718145567, 2899.0, 2902.6371703537056, 2910.3742695320607, 4975.328330675385, 5267.71027593486, 5331.986922484715, 5584.636998595079, 5600.887982240414, 5328.946710532922, 5490.478404551562, 5703.173039909273, 5975.40245975399, 6033.698315084228, 5370.91943620846, 5552.167784631062, 5662.150677398423, 6069.0, 6084.969575152184, 5009.949900500948, 5826.388229235869, 5882.323532793613, 5896.729759042713, 5977.7310021050025, 5017.54842064216, 5051.873703157304, 5597.888042239214, 5801.680907550125, 5855.648661080349, 5772.3650398456975, 5984.341722410444, 6035.305939816802, 6077.842365960198, 6115.899138154997, 3840.385538313856, 3871.8838434847, 3968.9603103969744, 3992.843864313238, 4041.2927737645205, 5889.5582831286965, 5914.757900840699, 5930.28836539618, 5947.375525569926, 5978.342382338026, 4982.427020892644, 5335.67985920846, 5464.672119672832, 5576.553875690016, 5641.138424320046, 4961.5286547777905, 5665.628950774283, 5673.74468148926, 5681.375048744718, 5709.173064619282, 5123.820666276662, 5221.660592061504, 5232.848773269875, 5348.786048558014, 5503.504684578407, 4428.734275943454, 4787.832425865078, 4947.876303092451, 5376.435474275301, 5478.356493051989, 5345.732713364394, 5566.526845218202, 5579.6652200868075, 5611.242482264842, 5623.3814280428305], "value": 4141.155549597287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.9064885591587, 660.6366498425865, 724.4494184419839, 772.5171767645222, 896.4890012692764, 14722.411103555858, 15572.688546229068, 15589.922050389732, 15595.298211580492, 15604.063756174637, 13696.863031369683, 14366.928165359159, 14413.279336033183, 14418.639534011629, 14471.92764036181, 875.6409871952485, 887.2369762004671, 892.477900428247, 901.73849583621, 902.6615019367737, 892.5894088719197, 894.1907573645829, 895.1496078725237, 895.9875340864813, 896.7489103051156, 760.163819798223, 781.5701364249668, 937.1284705224139, 957.7892863570004, 966.3090890013674, 952.7665721898145, 953.0897992417225, 953.3612479638658, 953.5280036381967, 954.6420092465326, 705.0517054561607, 708.412018025038, 708.946828987828, 709.2056896276152, 709.6912842913349, 15269.694606107927, 15673.764893526606, 15813.446529371417, 15859.0, 15870.841291587052, 14430.855691443056, 14552.92723536386, 14574.927125364306, 14626.335758293022, 14651.487197948021, 9202.493862837542, 11850.22973506728, 12000.459979300953, 12176.147669663127, 12257.57098501557, 3724.1434470071763, 3867.361885288952, 3867.671247943928, 3889.9416508752392, 3902.4731661225655, 111721.44139279252, 117688.41155794167, 117869.0, 120890.79109208884, 121576.3133027683, 10764.838527422095, 10780.622678206226, 10919.181061420426, 11078.224524283383, 11088.057515111306, 23951.922163502684, 24259.7574024261, 24261.636075458882, 24265.39336516601, 24320.148794792098, 7950.880736788953, 8039.0, 8063.798405039921, 8072.959635201786, 8241.752747417588, 4421.7789110544345, 4536.56902594253, 4610.147122782296, 4657.883552911137, 4662.347271382009, 3700.7409481336585, 3804.353259945816, 3814.1990182061522, 3815.389537673959, 3816.2939856126704, 588.4615576747314, 660.8215781738903, 685.8011176758685, 700.2927043685914, 717.1716667249335, 699.5487910297829, 706.2795948132979, 725.9637018149177, 744.6016381236012, 759.4418102694625, 10199.54102065409, 10540.420276884692, 10811.243212975016, 10941.781164376667, 10963.50664220096, 565.5582910647726, 596.2368168744015, 628.1739512541085, 686.2519853359862, 702.6943279673359, 4845.176320025604, 5020.623453241022, 5080.923786143211, 5090.287359769635, 5195.714235716996, 100798.0, 103592.48203758933, 106871.46564267129, 107926.92073079325, 108339.45830270957, 91575.0, 91882.54058729664, 92159.5392023049, 93366.66583335471, 94197.52901235587, 76671.61664191644, 80686.5965670168, 82779.0, 83903.16096838954, 84814.7277790846, 10518.631847885288, 10592.364458132537, 11173.217874749014, 11224.607138750105, 11345.978861902468, 46037.84905377393, 48804.0, 52166.73916630392, 52597.94804103973, 53328.0, 65222.0, 69987.0, 70149.0, 70821.0, 72874.27125728675, 12643.367831608566, 12670.429830657458, 12680.23918564889, 12760.489580416679, 13450.798238026242, 13942.874263457667, 14720.852791471949, 15472.5358239253, 15603.453879114177, 15775.447859324868, 12599.244045357307, 13564.728705426034, 13604.387802548712, 13683.589492315246, 14203.64490887736, 13259.0, 14218.649228323293, 14271.357788899317, 14634.926825365805, 14759.557213283619, 13282.535111271445, 13472.932635336761, 13849.099808512414, 14116.153030818185, 14498.492552760603, 10735.302205356627, 11236.66290011301, 11542.480588373375, 11577.826332604849, 11711.824322635337, 11182.384968826467, 11375.13140408993, 11428.0, 11428.828567571327, 11514.827277590675], "value": 7781.068752458138, "unit": "score"}], "name": "dromaeo_css", "value": 7522.7851258400015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 113.0, 121.0, 165.0, 154.0, 113.0, 130.0, 154.0], "value": 128.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 107.0, 105.0, 144.0, 107.0, 107.0, 109.0, 107.0, 126.0, 106.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 180.0, 185.0, 183.0, 183.0, 181.0, 185.0, 183.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 88.0, 61.0, 59.0, 58.0, 58.0, 73.0, 57.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 84.0, 69.0, 69.0, 67.0, 81.0, 68.0, 68.0, 84.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 86.0, 89.0, 88.0, 134.0, 110.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 108.0, 151.0, 150.0, 118.0, 145.0, 151.0], "value": 120.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 95.0, 88.0, 84.0, 88.0, 87.0, 83.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 51.0, 54.0, 56.0, 56.0, 55.0, 55.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 76.0, 76.0, 72.0, 69.0, 70.0, 70.0, 71.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 81.0, 84.0, 82.0, 81.0, 81.0, 82.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 127.0, 136.0, 135.0, 142.0, 124.0, 134.0, 165.0, 132.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 160.0, 154.0, 160.0, 163.0, 161.0, 164.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1437.2000000000003, "alertThreshold": 2.0}]} 11:25:56 INFO - Return code: 0 11:25:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:25:56 INFO - # TBPL SUCCESS # 11:25:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:25:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:25:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:25:56 INFO - 2017-03-20 11:25:56.234 screenresolution[1943:18722] starting screenresolution argv=screenresolution get 11:25:56 INFO - 2017-03-20 11:25:56.237 screenresolution[1943:18722] Display 0: 1600x1200x32@60 11:25:56 INFO - 2017-03-20 11:25:56.242 screenresolution[1944:18725] starting screenresolution argv=screenresolution list 11:25:56 INFO - Available Modes on Display 0 11:25:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:25:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:25:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:25:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:25:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:25:56 INFO - Intel Iris: 11:25:56 INFO - Chipset Model: Intel Iris 11:25:56 INFO - Type: GPU 11:25:56 INFO - Bus: Built-In 11:25:56 INFO - VRAM (Dynamic, Max): 1536 MB 11:25:56 INFO - Vendor: Intel (0x8086) 11:25:56 INFO - Device ID: 0x0a2e 11:25:56 INFO - Revision ID: 0x0009 11:25:56 INFO - Displays: 11:25:56 INFO - Display: 11:25:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:25:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:25:56 INFO - Display Serial Number: 1600x1200 60 11:25:56 INFO - Main Display: Yes 11:25:56 INFO - Mirror: Off 11:25:56 INFO - Online: Yes 11:25:56 INFO - Rotation: Supported 11:25:56 INFO - Return code: 0 11:25:56 INFO - Running post-action listener: _resource_record_post_action 11:25:56 INFO - [mozharness: 2017-03-20 18:25:56.476321Z] Finished run-tests step (success) 11:25:56 INFO - Running post-run listener: _resource_record_post_run 11:25:56 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 503808; Write bytes: 420149760; Read time: 6; Write time: 1390 11:25:56 INFO - TinderboxPrint: CPU usage
53.5% 11:25:56 INFO - TinderboxPrint: I/O read bytes / time
503,808 / 6 11:25:56 INFO - TinderboxPrint: I/O write bytes / time
420,149,760 / 1,390 11:25:56 INFO - TinderboxPrint: CPU idle
2,217.5 (46.5%) 11:25:56 INFO - TinderboxPrint: CPU system
952.3 (20.0%) 11:25:56 INFO - TinderboxPrint: CPU user
1,599.8 (33.5%) 11:25:56 INFO - TinderboxPrint: Swap in / out
122,327,040 / 0 11:25:56 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119333376; Write bytes: 112951296; Read time: 11197; Write time: 254 11:25:56 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 458752; Write bytes: 296221184; Read time: 5; Write time: 1096 11:25:56 INFO - Running post-run listener: _upload_blobber_files 11:25:56 INFO - Blob upload gear active. 11:25:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:25:56 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 11:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:25:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:25:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:25:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:25:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:58 INFO - (blobuploader) - INFO - Done attempting. 11:25:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:25:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:59 INFO - (blobuploader) - INFO - Done attempting. 11:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:00 INFO - (blobuploader) - INFO - Done attempting. 11:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:03 INFO - (blobuploader) - INFO - Done attempting. 11:26:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:03 INFO - Return code: 0 11:26:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdfb1df48efd94801bf17d9558cb06a0b30c726a822cc8389633a9f8ebf2e346525682cbe881a6467c75ce0a72f644098a6b6d5b75edeea5ad8b06ee6cbb9b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef82493f85d854cafed5de7587cc3e190688e347b5d3f54e271a1a272f8d31eedd3dd6ac075f4a160cf5c9a8107ea7d5b4e6ae8ca19e78ff675c5e6fb78782f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/047110fbdf14813837bdaf6e7aec40d1e0ce47606e47eb49ca67019b55e8577e6d5c7951daf1d8ca27a75bfc78ac59570b36a5073df32b94192978bed5310275", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e26d98647aed6b121da7e13de3d417442d4604d9cf162e7841c9a3c03284b88d91c1efa0f635e0777661b293df9d6d49eee76b5a1fcecdc634e2d3f070138892"} 11:26:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:03 INFO - Contents: 11:26:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdfb1df48efd94801bf17d9558cb06a0b30c726a822cc8389633a9f8ebf2e346525682cbe881a6467c75ce0a72f644098a6b6d5b75edeea5ad8b06ee6cbb9b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef82493f85d854cafed5de7587cc3e190688e347b5d3f54e271a1a272f8d31eedd3dd6ac075f4a160cf5c9a8107ea7d5b4e6ae8ca19e78ff675c5e6fb78782f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/047110fbdf14813837bdaf6e7aec40d1e0ce47606e47eb49ca67019b55e8577e6d5c7951daf1d8ca27a75bfc78ac59570b36a5073df32b94192978bed5310275", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e26d98647aed6b121da7e13de3d417442d4604d9cf162e7841c9a3c03284b88d91c1efa0f635e0777661b293df9d6d49eee76b5a1fcecdc634e2d3f070138892"} 11:26:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:03 INFO - Copying logs to upload dir... 11:26:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.464196 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-20 11:26:03.099176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 11:26:03.102637) ========= 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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdfb1df48efd94801bf17d9558cb06a0b30c726a822cc8389633a9f8ebf2e346525682cbe881a6467c75ce0a72f644098a6b6d5b75edeea5ad8b06ee6cbb9b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef82493f85d854cafed5de7587cc3e190688e347b5d3f54e271a1a272f8d31eedd3dd6ac075f4a160cf5c9a8107ea7d5b4e6ae8ca19e78ff675c5e6fb78782f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/047110fbdf14813837bdaf6e7aec40d1e0ce47606e47eb49ca67019b55e8577e6d5c7951daf1d8ca27a75bfc78ac59570b36a5073df32b94192978bed5310275", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e26d98647aed6b121da7e13de3d417442d4604d9cf162e7841c9a3c03284b88d91c1efa0f635e0777661b293df9d6d49eee76b5a1fcecdc634e2d3f070138892"} build_url:https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/fEdv00XWT1uHL9Z_DXjMjw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8cdfb1df48efd94801bf17d9558cb06a0b30c726a822cc8389633a9f8ebf2e346525682cbe881a6467c75ce0a72f644098a6b6d5b75edeea5ad8b06ee6cbb9b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef82493f85d854cafed5de7587cc3e190688e347b5d3f54e271a1a272f8d31eedd3dd6ac075f4a160cf5c9a8107ea7d5b4e6ae8ca19e78ff675c5e6fb78782f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/047110fbdf14813837bdaf6e7aec40d1e0ce47606e47eb49ca67019b55e8577e6d5c7951daf1d8ca27a75bfc78ac59570b36a5073df32b94192978bed5310275", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e26d98647aed6b121da7e13de3d417442d4604d9cf162e7841c9a3c03284b88d91c1efa0f635e0777661b293df9d6d49eee76b5a1fcecdc634e2d3f070138892"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 11:26:03.142015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 11:26:03.142943) ========= 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.0fYF00W2Uv/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.CzdBhSAN2b/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.005399 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 11:26:03.194582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 11:26:03.195313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 11:26:03.196015) ========= ========= Total master_lag: 0.20 =========