builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0377 starttime: 1493681522.93 results: success (0) buildid: 20170501140320 builduid: 93e007b2e35f4f7287707898bdb9ae58 revision: 6fda76d96a51fdc876ba07639fc164d56ae034a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:02.934333) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:02.934826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:02.935162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:02.962176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:02.962565) ========= 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.iKmKDh0JfH/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.xy6h25QrPB/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-05-01 16:32:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 3.48M=0.003s 2017-05-01 16:32:03 (3.48 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.358047 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:03.345725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:03.346077) ========= 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.iKmKDh0JfH/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.xy6h25QrPB/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.026330 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:03.395376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 16:32:03.395737) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 6fda76d96a51fdc876ba07639fc164d56ae034a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 6fda76d96a51fdc876ba07639fc164d56ae034a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iKmKDh0JfH/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.xy6h25QrPB/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-05-01 16:32:03,512 truncating revision to first 12 chars 2017-05-01 16:32:03,512 Setting DEBUG logging. 2017-05-01 16:32:03,512 attempt 1/10 2017-05-01 16:32:03,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/6fda76d96a51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 16:32:05,173 unpacking tar archive at: pine-6fda76d96a51/testing/mozharness/ program finished with exit code 0 elapsedTime=1.928609 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 16:32:05.348688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:05.349022) ========= script_repo_revision: 6fda76d96a51fdc876ba07639fc164d56ae034a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:05.349437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:05.349810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 16:32:05.370256) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-05-01 16:32:05.370694) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iKmKDh0JfH/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.xy6h25QrPB/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:32:05 INFO - MultiFileLogger online at 20170501 16:32:05 in /builds/slave/test 16:32:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 16:32:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:32:05 INFO - {'append_to_log': False, 16:32:05 INFO - 'base_work_dir': '/builds/slave/test', 16:32:05 INFO - 'blob_upload_branch': 'Pine', 16:32:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:32:05 INFO - 'branch': 'Pine', 16:32:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:32:05 INFO - 'config_files': ('talos/mac_config.py',), 16:32:05 INFO - 'default_actions': ('clobber', 16:32:05 INFO - 'read-buildbot-config', 16:32:05 INFO - 'download-and-extract', 16:32:05 INFO - 'populate-webroot', 16:32:05 INFO - 'create-virtualenv', 16:32:05 INFO - 'install', 16:32:05 INFO - 'run-tests'), 16:32:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:32:05 INFO - 'download_minidump_stackwalk': True, 16:32:05 INFO - 'download_symbols': 'ondemand', 16:32:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:32:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:32:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:32:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:32:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:32:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:32:05 INFO - 'gecko_profile': False, 16:32:05 INFO - 'gecko_profile_interval': 0, 16:32:05 INFO - 'installer_path': 'installer.exe', 16:32:05 INFO - 'log_level': 'info', 16:32:05 INFO - 'log_name': 'talos', 16:32:05 INFO - 'log_to_console': True, 16:32:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:32:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:32:05 INFO - 'opt_config_files': (), 16:32:05 INFO - 'pip_index': False, 16:32:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:32:05 INFO - 'cmd': ('bash', 16:32:05 INFO - '-c', 16:32:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:32:05 INFO - 'enabled': True, 16:32:05 INFO - 'halt_on_failure': False, 16:32:05 INFO - 'name': 'check_screen_resolution'},), 16:32:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:32:05 INFO - 'cmd': ('bash', 16:32:05 INFO - '-c', 16:32:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:32:05 INFO - 'enabled': True, 16:32:05 INFO - 'halt_on_failure': False, 16:32:05 INFO - 'name': 'check_screen_resolution'},), 16:32:05 INFO - 'run_cmd_checks_enabled': True, 16:32:05 INFO - 'suite': 'dromaeojs', 16:32:05 INFO - 'system_bits': '32', 16:32:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:32:05 INFO - 'title': 't-yosemite-r7-0377', 16:32:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:32:05 INFO - 'use_talos_json': True, 16:32:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:32:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:32:05 INFO - 'work_dir': 'build'} 16:32:05 INFO - [mozharness: 2017-05-01 23:32:05.597134Z] Running clobber step. 16:32:05 INFO - Running pre-action listener: _resource_record_pre_action 16:32:05 INFO - Running main action method: clobber 16:32:05 INFO - rmtree: /builds/slave/test/build 16:32:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:32:07 INFO - Running post-action listener: _resource_record_post_action 16:32:07 INFO - [mozharness: 2017-05-01 23:32:07.993854Z] Finished clobber step (success) 16:32:07 INFO - [mozharness: 2017-05-01 23:32:07.994092Z] Running read-buildbot-config step. 16:32:07 INFO - Running pre-action listener: _resource_record_pre_action 16:32:07 INFO - Running main action method: read_buildbot_config 16:32:07 INFO - Using buildbot properties: 16:32:07 INFO - { 16:32:07 INFO - "project": "", 16:32:07 INFO - "product": "firefox", 16:32:07 INFO - "script_repo_revision": "default", 16:32:07 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 16:32:07 INFO - "repository": "", 16:32:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 16:32:07 INFO - "buildid": "20170501140320", 16:32:07 INFO - "pgo_build": "False", 16:32:07 INFO - "basedir": "/builds/slave/test", 16:32:07 INFO - "buildnumber": 0, 16:32:07 INFO - "slavename": "t-yosemite-r7-0377", 16:32:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:32:07 INFO - "platform": "yosemite_r7", 16:32:07 INFO - "scheduler": "tests-pine-macosx64-talos", 16:32:07 INFO - "branch": "pine", 16:32:07 INFO - "repo_path": "projects/pine", 16:32:07 INFO - "revision": "6fda76d96a51fdc876ba07639fc164d56ae034a1", 16:32:07 INFO - "stage_platform": "macosx64", 16:32:07 INFO - "builduid": "93e007b2e35f4f7287707898bdb9ae58", 16:32:07 INFO - "slavebuilddir": "test" 16:32:07 INFO - } 16:32:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:32:07 INFO - Running post-action listener: _resource_record_post_action 16:32:07 INFO - [mozharness: 2017-05-01 23:32:07.999898Z] Finished read-buildbot-config step (success) 16:32:08 INFO - [mozharness: 2017-05-01 23:32:08.000127Z] Running download-and-extract step. 16:32:08 INFO - Running pre-action listener: _resource_record_pre_action 16:32:08 INFO - Running main action method: download_and_extract 16:32:08 INFO - mkdir: /builds/slave/test/build/tests 16:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:08 INFO - trying https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:32:08 INFO - Downloading https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:32:08 INFO - Downloaded 1325 bytes. 16:32:08 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:32:08 INFO - Using the following test package requirements: 16:32:08 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:32:08 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:32:08 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:32:08 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:32:08 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'jsshell-mac.zip'], 16:32:08 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:32:08 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:32:08 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:32:08 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:32:08 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:32:08 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:32:08 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:32:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:32:10 INFO - Content-Length response header: 52702378 16:32:10 INFO - Bytes received: 52702378 16:32:27 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:32:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:32:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:32:27 INFO - Fetch https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:32:29 INFO - Content-Length response header: 52702378 16:32:29 INFO - Bytes received: 52702378 16:32:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:32:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:32:45 INFO - Fetch https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:32:46 INFO - Content-Length response header: 14408811 16:32:46 INFO - Bytes received: 14408811 16:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:46 INFO - trying https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:32:46 INFO - Downloading https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:32:48 INFO - Downloaded 71268166 bytes. 16:32:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:32:48 INFO - mkdir: /builds/slave/test/properties 16:32:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:48 INFO - Contents: 16:32:48 INFO - build_url:https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:32:49 INFO - Running post-action listener: _resource_record_post_action 16:32:49 INFO - Running post-action listener: set_extra_try_arguments 16:32:49 INFO - [mozharness: 2017-05-01 23:32:49.034245Z] Finished download-and-extract step (success) 16:32:49 INFO - [mozharness: 2017-05-01 23:32:49.034394Z] Running populate-webroot step. 16:32:49 INFO - Running pre-action listener: _resource_record_pre_action 16:32:49 INFO - Running main action method: populate_webroot 16:32:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:49 INFO - '--tppagecycles', 16:32:49 INFO - '7'], 16:32:49 INFO - 'tests': ['tsvgm']}}, 16:32:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['damp', 'tps']}, 16:32:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'tests': ['damp', 'tps']}, 16:32:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['dromaeo_dom']}, 16:32:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:32:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:32:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['a11yr', 16:32:49 INFO - 'ts_paint', 16:32:49 INFO - 'tpaint', 16:32:49 INFO - 'sessionrestore', 16:32:49 INFO - 'sessionrestore_no_auto_restore', 16:32:49 INFO - 'tabpaint']}, 16:32:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:49 INFO - 'ts_paint', 16:32:49 INFO - 'tpaint', 16:32:49 INFO - 'sessionrestore', 16:32:49 INFO - 'sessionrestore_no_auto_restore', 16:32:49 INFO - 'tabpaint']}, 16:32:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:49 INFO - 'ts_paint', 16:32:49 INFO - 'tpaint', 16:32:49 INFO - 'sessionrestore', 16:32:49 INFO - 'sessionrestore_no_auto_restore', 16:32:49 INFO - 'tabpaint']}, 16:32:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:49 INFO - 'ts_paint', 16:32:49 INFO - 'tpaint', 16:32:49 INFO - 'sessionrestore', 16:32:49 INFO - 'sessionrestore_no_auto_restore', 16:32:49 INFO - 'tabpaint']}, 16:32:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['a11yr', 16:32:49 INFO - 'ts_paint', 16:32:49 INFO - 'tpaint', 16:32:49 INFO - 'sessionrestore', 16:32:49 INFO - 'sessionrestore_no_auto_restore', 16:32:49 INFO - 'tabpaint']}, 16:32:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['a11yr', 16:32:49 INFO - 'ts_paint', 16:32:49 INFO - 'tpaint', 16:32:49 INFO - 'sessionrestore', 16:32:49 INFO - 'sessionrestore_no_auto_restore', 16:32:49 INFO - 'tabpaint']}, 16:32:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:32:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:32:49 INFO - 'bloom_basic_ref']}, 16:32:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['tsvgx', 16:32:49 INFO - 'tsvgr_opacity', 16:32:49 INFO - 'tart', 16:32:49 INFO - 'tscrollx', 16:32:49 INFO - 'cart', 16:32:49 INFO - 'tsvg_static']}, 16:32:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:49 INFO - 'tsvgr_opacity', 16:32:49 INFO - 'tart', 16:32:49 INFO - 'tscrollx', 16:32:49 INFO - 'cart', 16:32:49 INFO - 'tsvg_static']}, 16:32:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'talos_options': ['--disable-e10s'], 16:32:49 INFO - 'tests': ['tp5o']}, 16:32:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:32:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'talos_options': ['--disable-e10s', 16:32:49 INFO - '--xperf_path', 16:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:49 INFO - 'tests': ['tp5n']}, 16:32:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:32:49 INFO - 'talos_options': ['--xperf_path', 16:32:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:49 INFO - 'tests': ['tp5n']}}, 16:32:49 INFO - 'talos.zip': {'path': '', 16:32:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:49 INFO - Running post-action listener: _resource_record_post_action 16:32:49 INFO - [mozharness: 2017-05-01 23:32:49.053745Z] Finished populate-webroot step (success) 16:32:49 INFO - [mozharness: 2017-05-01 23:32:49.053840Z] Running create-virtualenv step. 16:32:49 INFO - Running pre-action listener: _resource_record_pre_action 16:32:49 INFO - Running main action method: create_virtualenv 16:32:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:32:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:49 INFO - Using real prefix '/tools/python27' 16:32:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:52 INFO - Installing pip.................done. 16:32:52 INFO - Return code: 0 16:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:32:53 INFO - Reading from file tmpfile_stdout 16:32:53 INFO - Output received: 16:32:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:32:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:53 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:53 INFO - 'HOME': '/Users/cltbld', 16:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:53 INFO - 'LOGNAME': 'cltbld', 16:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:53 INFO - 'MOZ_NO_REMOTE': '1', 16:32:53 INFO - 'NO_EM_RESTART': '1', 16:32:53 INFO - 'PAGER': '/bin/cat', 16:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:53 INFO - 'PWD': '/builds/slave/test', 16:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:53 INFO - 'SHELL': '/bin/bash', 16:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:32:53 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:53 INFO - 'USER': 'cltbld', 16:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:53 INFO - 'XPC_FLAGS': '0x0', 16:32:53 INFO - 'XPC_SERVICE_NAME': '0', 16:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:32:53 INFO - Cleaning up... 16:32:53 INFO - Return code: 0 16:32:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:53 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:53 INFO - 'HOME': '/Users/cltbld', 16:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:53 INFO - 'LOGNAME': 'cltbld', 16:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:53 INFO - 'MOZ_NO_REMOTE': '1', 16:32:53 INFO - 'NO_EM_RESTART': '1', 16:32:53 INFO - 'PAGER': '/bin/cat', 16:32:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:53 INFO - 'PWD': '/builds/slave/test', 16:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:53 INFO - 'SHELL': '/bin/bash', 16:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:32:53 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:53 INFO - 'USER': 'cltbld', 16:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:53 INFO - 'XPC_FLAGS': '0x0', 16:32:53 INFO - 'XPC_SERVICE_NAME': '0', 16:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:53 INFO - Downloading/unpacking psutil>=3.1.1 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:57 INFO - Installing collected packages: psutil 16:32:57 INFO - Running setup.py install for psutil 16:32:57 INFO - building 'psutil._psutil_osx' extension 16:32:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:32:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:32:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:32:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:32:57 INFO - building 'psutil._psutil_posix' extension 16:32:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:32:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:32:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:32:57 INFO - ^ 16:32:58 INFO - 1 warning generated. 16:32:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:58 INFO - Successfully installed psutil 16:32:58 INFO - Cleaning up... 16:32:58 INFO - Return code: 0 16:32:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:58 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:58 INFO - 'HOME': '/Users/cltbld', 16:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:58 INFO - 'LOGNAME': 'cltbld', 16:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:58 INFO - 'MOZ_NO_REMOTE': '1', 16:32:58 INFO - 'NO_EM_RESTART': '1', 16:32:58 INFO - 'PAGER': '/bin/cat', 16:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:58 INFO - 'PWD': '/builds/slave/test', 16:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:58 INFO - 'SHELL': '/bin/bash', 16:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:32:58 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:58 INFO - 'USER': 'cltbld', 16:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:58 INFO - 'XPC_FLAGS': '0x0', 16:32:58 INFO - 'XPC_SERVICE_NAME': '0', 16:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:33:01 INFO - Installing collected packages: mozsystemmonitor 16:33:01 INFO - Running setup.py install for mozsystemmonitor 16:33:01 INFO - Successfully installed mozsystemmonitor 16:33:01 INFO - Cleaning up... 16:33:01 INFO - Return code: 0 16:33:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:02 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:02 INFO - 'HOME': '/Users/cltbld', 16:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:02 INFO - 'LOGNAME': 'cltbld', 16:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:02 INFO - 'MOZ_NO_REMOTE': '1', 16:33:02 INFO - 'NO_EM_RESTART': '1', 16:33:02 INFO - 'PAGER': '/bin/cat', 16:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:02 INFO - 'PWD': '/builds/slave/test', 16:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:02 INFO - 'SHELL': '/bin/bash', 16:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:02 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:02 INFO - 'USER': 'cltbld', 16:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:02 INFO - 'XPC_FLAGS': '0x0', 16:33:02 INFO - 'XPC_SERVICE_NAME': '0', 16:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:02 INFO - Downloading/unpacking jsonschema==2.5.1 16:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:33:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:05 INFO - Downloading functools32-3.2.3-2.tar.gz 16:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:33:05 INFO - warning: no files found matching '*.txt' 16:33:05 INFO - no previously-included directories found matching 'build' 16:33:05 INFO - no previously-included directories found matching 'dist' 16:33:05 INFO - no previously-included directories found matching '.git*' 16:33:05 INFO - Installing collected packages: jsonschema, functools32 16:33:05 INFO - Running setup.py install for functools32 16:33:06 INFO - warning: no files found matching '*.txt' 16:33:06 INFO - no previously-included directories found matching 'build' 16:33:06 INFO - no previously-included directories found matching 'dist' 16:33:06 INFO - no previously-included directories found matching '.git*' 16:33:06 INFO - Successfully installed jsonschema functools32 16:33:06 INFO - Cleaning up... 16:33:06 INFO - Return code: 0 16:33:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:06 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:06 INFO - 'HOME': '/Users/cltbld', 16:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:06 INFO - 'LOGNAME': 'cltbld', 16:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:06 INFO - 'MOZ_NO_REMOTE': '1', 16:33:06 INFO - 'NO_EM_RESTART': '1', 16:33:06 INFO - 'PAGER': '/bin/cat', 16:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:06 INFO - 'PWD': '/builds/slave/test', 16:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:06 INFO - 'SHELL': '/bin/bash', 16:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:06 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:06 INFO - 'USER': 'cltbld', 16:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:06 INFO - 'XPC_FLAGS': '0x0', 16:33:06 INFO - 'XPC_SERVICE_NAME': '0', 16:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:33:06 INFO - Cleaning up... 16:33:06 INFO - Return code: 0 16:33:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:06 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:06 INFO - 'HOME': '/Users/cltbld', 16:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:06 INFO - 'LOGNAME': 'cltbld', 16:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:06 INFO - 'MOZ_NO_REMOTE': '1', 16:33:06 INFO - 'NO_EM_RESTART': '1', 16:33:06 INFO - 'PAGER': '/bin/cat', 16:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:06 INFO - 'PWD': '/builds/slave/test', 16:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:06 INFO - 'SHELL': '/bin/bash', 16:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:06 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:06 INFO - 'USER': 'cltbld', 16:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:06 INFO - 'XPC_FLAGS': '0x0', 16:33:06 INFO - 'XPC_SERVICE_NAME': '0', 16:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:33:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:33:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:10 INFO - Downloading docopt-0.6.1.tar.gz 16:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:33:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:33:10 INFO - Running setup.py install for blobuploader 16:33:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:33:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:33:10 INFO - Running setup.py install for requests 16:33:11 INFO - Running setup.py install for docopt 16:33:11 INFO - Successfully installed blobuploader requests docopt 16:33:11 INFO - Cleaning up... 16:33:11 INFO - Return code: 0 16:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:11 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:11 INFO - 'HOME': '/Users/cltbld', 16:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:11 INFO - 'LOGNAME': 'cltbld', 16:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:11 INFO - 'MOZ_NO_REMOTE': '1', 16:33:11 INFO - 'NO_EM_RESTART': '1', 16:33:11 INFO - 'PAGER': '/bin/cat', 16:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:11 INFO - 'PWD': '/builds/slave/test', 16:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:11 INFO - 'SHELL': '/bin/bash', 16:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:11 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:11 INFO - 'USER': 'cltbld', 16:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:11 INFO - 'XPC_FLAGS': '0x0', 16:33:11 INFO - 'XPC_SERVICE_NAME': '0', 16:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:11 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-jgUW1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:11 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Hrrrtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:11 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-vFAHFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:11 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-uLbd6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-NlzEpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-HGW_gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5gR_y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-JI70fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-tekoxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-7gHoyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-8YiY_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-7lhExv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:12 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-V7Fixl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:13 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5xEIzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:13 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-63fsdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:13 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-YB54GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:13 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-hTk0JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:33:13 INFO - Running setup.py install for manifestparser 16:33:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:33:13 INFO - Running setup.py install for mozcrash 16:33:13 INFO - Running setup.py install for mozdebug 16:33:13 INFO - Running setup.py install for mozdevice 16:33:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Running setup.py install for mozfile 16:33:14 INFO - Running setup.py install for mozhttpd 16:33:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Running setup.py install for mozinfo 16:33:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Running setup.py install for mozInstall 16:33:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Running setup.py install for mozleak 16:33:14 INFO - Running setup.py install for mozlog 16:33:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:33:14 INFO - Running setup.py install for moznetwork 16:33:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:33:15 INFO - Running setup.py install for mozprocess 16:33:15 INFO - Running setup.py install for mozprofile 16:33:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:33:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:33:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:33:15 INFO - Running setup.py install for mozrunner 16:33:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:33:15 INFO - Running setup.py install for mozscreenshot 16:33:15 INFO - Running setup.py install for moztest 16:33:15 INFO - Running setup.py install for mozversion 16:33:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:33:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:33:15 INFO - Cleaning up... 16:33:15 INFO - Return code: 0 16:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:15 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:33:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:15 INFO - 'HOME': '/Users/cltbld', 16:33:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:15 INFO - 'LOGNAME': 'cltbld', 16:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:15 INFO - 'MOZ_NO_REMOTE': '1', 16:33:15 INFO - 'NO_EM_RESTART': '1', 16:33:15 INFO - 'PAGER': '/bin/cat', 16:33:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:15 INFO - 'PWD': '/builds/slave/test', 16:33:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:15 INFO - 'SHELL': '/bin/bash', 16:33:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:15 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:15 INFO - 'USER': 'cltbld', 16:33:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:15 INFO - 'XPC_FLAGS': '0x0', 16:33:15 INFO - 'XPC_SERVICE_NAME': '0', 16:33:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-O_O5Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-xzuHvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-z_xTnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-YfFSUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-GzpWFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Qr8KOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-CvA2mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:16 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-iPBAne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ebhfxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5deNmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-sKunzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ezVRE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-wBeGF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-maI8CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-E_J4aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-up0W0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:17 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-4j5ckw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:33:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:33:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:33:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:20 INFO - Downloading blessings-1.6.tar.gz 16:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:33:20 INFO - Installing collected packages: blessings 16:33:20 INFO - Running setup.py install for blessings 16:33:20 INFO - Successfully installed blessings 16:33:20 INFO - Cleaning up... 16:33:21 INFO - Return code: 0 16:33:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:33:21 INFO - Reading from file tmpfile_stdout 16:33:21 INFO - Current package versions: 16:33:21 INFO - blessings == 1.6 16:33:21 INFO - blobuploader == 1.2.4 16:33:21 INFO - docopt == 0.6.1 16:33:21 INFO - functools32 == 3.2.3-2 16:33:21 INFO - jsonschema == 2.5.1 16:33:21 INFO - manifestparser == 1.1 16:33:21 INFO - mozInstall == 1.12 16:33:21 INFO - mozcrash == 1.0 16:33:21 INFO - mozdebug == 0.1 16:33:21 INFO - mozdevice == 0.50 16:33:21 INFO - mozfile == 1.2 16:33:21 INFO - mozhttpd == 0.7 16:33:21 INFO - mozinfo == 0.9 16:33:21 INFO - mozleak == 0.1 16:33:21 INFO - mozlog == 3.4 16:33:21 INFO - moznetwork == 0.27 16:33:21 INFO - mozprocess == 0.25 16:33:21 INFO - mozprofile == 0.28 16:33:21 INFO - mozrunner == 6.13 16:33:21 INFO - mozscreenshot == 0.1 16:33:21 INFO - mozsystemmonitor == 0.3 16:33:21 INFO - moztest == 0.8 16:33:21 INFO - mozversion == 1.4 16:33:21 INFO - psutil == 3.1.1 16:33:21 INFO - requests == 1.2.3 16:33:21 INFO - wsgiref == 0.1.2 16:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:21 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 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:21 INFO - 'HOME': '/Users/cltbld', 16:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:21 INFO - 'LOGNAME': 'cltbld', 16:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:21 INFO - 'MOZ_NO_REMOTE': '1', 16:33:21 INFO - 'NO_EM_RESTART': '1', 16:33:21 INFO - 'PAGER': '/bin/cat', 16:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:21 INFO - 'PWD': '/builds/slave/test', 16:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:21 INFO - 'SHELL': '/bin/bash', 16:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:21 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:21 INFO - 'USER': 'cltbld', 16:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:21 INFO - 'XPC_FLAGS': '0x0', 16:33:21 INFO - 'XPC_SERVICE_NAME': '0', 16:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:33:21 INFO - Cleaning up... 16:33:21 INFO - Return code: 0 16:33:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056dfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056e2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6284cbf50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, '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.iKmKDh0JfH/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.xy6h25QrPB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:21 INFO - 'HOME': '/Users/cltbld', 16:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:21 INFO - 'LOGNAME': 'cltbld', 16:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:21 INFO - 'MOZ_NO_REMOTE': '1', 16:33:21 INFO - 'NO_EM_RESTART': '1', 16:33:21 INFO - 'PAGER': '/bin/cat', 16:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:21 INFO - 'PWD': '/builds/slave/test', 16:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:21 INFO - 'SHELL': '/bin/bash', 16:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:21 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:21 INFO - 'USER': 'cltbld', 16:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:21 INFO - 'XPC_FLAGS': '0x0', 16:33:21 INFO - 'XPC_SERVICE_NAME': '0', 16:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:33:21 INFO - Cleaning up... 16:33:21 INFO - Return code: 0 16:33:21 INFO - Running post-action listener: _resource_record_post_action 16:33:21 INFO - Running post-action listener: _start_resource_monitoring 16:33:21 INFO - Starting resource monitoring. 16:33:21 INFO - [mozharness: 2017-05-01 23:33:21.873291Z] Finished create-virtualenv step (success) 16:33:21 INFO - [mozharness: 2017-05-01 23:33:21.874257Z] Running install step. 16:33:21 INFO - Running pre-action listener: _resource_record_pre_action 16:33:21 INFO - Running main action method: install 16:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:33:22 INFO - Reading from file tmpfile_stdout 16:33:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:33:22 INFO - Reading from file tmpfile_stdout 16:33:22 INFO - Output received: 16:33:22 INFO - Usage: mozinstall [options] installer 16:33:22 INFO - Options: 16:33:22 INFO - -h, --help show this help message and exit 16:33:22 INFO - -d DEST, --destination=DEST 16:33:22 INFO - Directory to install application into. [default: 16:33:22 INFO - "/builds/slave/test"] 16:33:22 INFO - --app=APP Application being installed. [default: firefox] 16:33:22 INFO - mkdir: /builds/slave/test/build/application 16:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:33:41 INFO - Reading from file tmpfile_stdout 16:33:41 INFO - Output received: 16:33:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:33:41 INFO - Running post-action listener: _resource_record_post_action 16:33:41 INFO - [mozharness: 2017-05-01 23:33:41.724972Z] Finished install step (success) 16:33:41 INFO - [mozharness: 2017-05-01 23:33:41.725124Z] Running run-tests step. 16:33:41 INFO - Running pre-action listener: _resource_record_pre_action 16:33:41 INFO - Running main action method: run_tests 16:33:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:33:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:33:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:33:41 INFO - 2017-05-01 16:33:41.739 screenresolution[1626:7487] starting screenresolution argv=screenresolution get 16:33:41 INFO - 2017-05-01 16:33:41.742 screenresolution[1626:7487] Display 0: 1600x1200x32@60 16:33:41 INFO - 2017-05-01 16:33:41.748 screenresolution[1627:7490] starting screenresolution argv=screenresolution list 16:33:41 INFO - Available Modes on Display 0 16:33:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:33:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:33:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:33:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:33:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:33:41 INFO - Intel Iris: 16:33:41 INFO - Chipset Model: Intel Iris 16:33:41 INFO - Type: GPU 16:33:41 INFO - Bus: Built-In 16:33:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:33:41 INFO - Vendor: Intel (0x8086) 16:33:41 INFO - Device ID: 0x0a2e 16:33:41 INFO - Revision ID: 0x0009 16:33:41 INFO - Displays: 16:33:41 INFO - Display: 16:33:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:33:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:33:41 INFO - Display Serial Number: 1600x1200 60 16:33:41 INFO - Main Display: Yes 16:33:41 INFO - Mirror: Off 16:33:41 INFO - Online: Yes 16:33:41 INFO - Rotation: Supported 16:33:41 INFO - Return code: 0 16:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:33:41 INFO - Python 2.7.3 16:33:41 INFO - Return code: 0 16:33:41 INFO - grabbing minidump binary from tooltool 16:33: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')]} 16:33:41 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 0x1054bdd30>, '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 0x1053e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:33:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:33:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:33:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:33:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:33:42 INFO - Return code: 0 16:33:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:33:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:33:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:33:42 INFO - ENV: RUST_BACKTRACE is now 1 16:33:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:33:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKmKDh0JfH/Render', 16:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:33:42 INFO - 'HOME': '/Users/cltbld', 16:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:33:42 INFO - 'LOGNAME': 'cltbld', 16:33:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:33:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:42 INFO - 'MOZ_NO_REMOTE': '1', 16:33:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:33:42 INFO - 'NO_EM_RESTART': '1', 16:33:42 INFO - 'PAGER': '/bin/cat', 16:33:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:42 INFO - 'PWD': '/builds/slave/test', 16:33:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:33:42 INFO - 'RUST_BACKTRACE': '1', 16:33:42 INFO - 'SHELL': '/bin/bash', 16:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xy6h25QrPB/Listeners', 16:33:42 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 16:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:33:42 INFO - 'USER': 'cltbld', 16:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:42 INFO - 'XPC_FLAGS': '0x0', 16:33:42 INFO - 'XPC_SERVICE_NAME': '0', 16:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:33:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:33:42 INFO - mozversion application_buildid: 20170501140320 16:33:42 INFO - mozversion application_changeset: 6fda76d96a51fdc876ba07639fc164d56ae034a1 16:33:42 INFO - mozversion application_display_name: Nightly 16:33:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:33:42 INFO - mozversion application_name: Firefox 16:33:42 INFO - mozversion application_remotingname: firefox 16:33:42 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 16:33:42 INFO - mozversion application_vendor: Mozilla 16:33:42 INFO - mozversion application_version: 55.0a1 16:33:42 INFO - mozversion platform_buildid: 20170501140320 16:33:42 INFO - mozversion platform_changeset: 6fda76d96a51fdc876ba07639fc164d56ae034a1 16:33:42 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 16:33:42 INFO - mozversion platform_version: 55.0a1 16:33:42 INFO - using testdate: 1493681622 16:33:42 INFO - actual date: 1493681622 16:33:42 INFO - starting webserver on 'localhost:49236' 16:33:42 INFO - SUITE-START | Running 2 tests 16:33:42 INFO - TEST-START | dromaeo_css 16:33:42 INFO - operating with platform_type : mac_ 16:33:42 INFO - Initialising browser for dromaeo_css test... 16:33:42 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpQmi3RP/profile http://localhost:49236/getInfo.html) 16:33:45 INFO - PID 1637 | __metrics Screen width/height:1600/1200 16:33:45 INFO - PID 1637 | colorDepth:24 16:33:45 INFO - PID 1637 | Browser inner width/height: 1024/689 16:33:45 INFO - PID 1637 | __metrics 16:33:45 INFO - PID 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:33:45 INFO - PID 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:46 INFO - TEST-INFO | 1637: exit 0 16:33:46 INFO - Browser initialized. 16:33:46 INFO - Running cycle 1/1 for dromaeo_css test... 16:33:46 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpQmi3RP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:58 INFO - PID 1639 | RSS: Main: 241147904 16:33:58 INFO - PID 1639 | 16:37:03 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 16:37:05 INFO - PID 1639 | RSS: Main: 450293760 16:37:05 INFO - PID 1639 | 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 16:38:48 INFO - PID 1639 | 16:38:48 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:48 INFO - PID 1639 | Full stack: 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 16:38:48 INFO - PID 1639 | 16:38:48 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:48 INFO - PID 1639 | Full stack: 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 16:38:48 INFO - PID 1639 | 16:38:48 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:48 INFO - PID 1639 | Full stack: 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | ************************* 16:38:48 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 16:38:48 INFO - PID 1639 | 16:38:48 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:48 INFO - PID 1639 | Full stack: 16:38:48 INFO - PID 1639 | ************************* 16:40:08 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 16:40:08 INFO - PID 1639 | RSS: Main: 371134464 16:40:08 INFO - PID 1639 | 16:43:11 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 16:43:11 INFO - PID 1639 | RSS: Main: 336338944 16:43:11 INFO - PID 1639 | 16:46:13 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 16:46:14 INFO - PID 1639 | RSS: Main: 361222144 16:46:14 INFO - PID 1639 | 16:49:18 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 16:49:18 INFO - PID 1639 | RSS: Main: 335863808 16:49:18 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 16:52:21 INFO - PID 1639 | RSS: Main: 377528320 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | __start_tp_report 16:52:21 INFO - PID 1639 | _x_x_mozilla_page_load 16:52:21 INFO - PID 1639 | _x_x_mozilla_page_load_details 16:52:21 INFO - PID 1639 | |i|pagename|runs| 16:52:21 INFO - PID 1639 | |0;dojo.html;3479.599846017709;3487.825608719563;3501.684848363647;3513.4554144107665;3547.988823185391;5888.852778680535;5985.371535988724;6109.1447197392345;6115.2050233469645;6143.262808462985;5857;5898.410158984099;5933.584649074566;5944.959632064393;5970.223870896788;4328.935065974013;4917.45907950127;5192.013517431676;5200.4019537753165;5216.504432078947;4674.485806561275;5325.840224793243;5328.333958255218;5330.013947419739;5330.253764472977;5304.283921670583;5309.256704061435;5311.601629877755;5320.707361095138;5323.467653234665;5301.628885977983;5318.521333080042;5321.73391330432;5321.733913304358;5332.3601167859915;5160.664556803796;5269.973650131763;5286.286351342596;5286.735663216862;5316.494932981361;6048.304444988838;6080.270367555878;6087.299960504554;6114.388561143895;6128.111423843562;6399.456046236076;6424.03639454081;6425.100485931974;6442.806715798487;6453.612783232974;5947.185585864547;6310.148130002437;6383.521235907326;6386.776462823826;6387.520935929824;6077.726502307407;6100.708853721966;6117.602355846856;6139.785107521216;6144.354842741537;6530.216374035146;6533.281339052701;6733.42765864907;6743.089682892747;6750.966245168743;6394.264659564116;6396.776112836028;6397.840053998594;6400.263969643457;6405.839854003687;6276.121343011982;6406.199225096863;6539.934600653933;6571.2771595124495;6571.474282057424;5301.3373328333955;6287.622742635456;6368.490520758328;6390.233172019294;6390.329015453403;6268.4671802897265;6329.4303512683155;6363.872722545523;6391.648459334689;6400.97584386496;5080.212567052113;5174.404943431478;5190.740462976836;5191.428942816287;5231.581473482112;4605.102005108972;4628.722276663411;4634.351190833286;4663.463701674283;4684.4378674559275;6102.359252278536;6111.51107911366;6113.052476866093;6119.326874043852;6126.509879209652;6391.6804159792755;6392.872142557123;6531.281559028503;6617.404433600999;6619.271880093186;5273.920891186635;6160.353162917919;6188.4739797116845;6240.968795155995;6245.219347581552;5723.055695810228;5726.599138060295;5729.427057294237;5730.828075157752;5798.565107616945;5614.29821272341;5839.737211825478;6510.414062734377;6751.898721519083;6771.830704232433;5446.482584154499;6369.394907483782;6594.802155935329;6609.867802644017;6635.2037755469655;6749.831254218684;6767.526273160832;6773.424258938046;6779.93220067793;6780.389764920984;6407.487401008001;6411.903821442776;6429.7428102875365;6434.67826608677;6444.871102577828;6301.338359472189;6333.20834895638;6371.585846919936;6371.808845734636;6382.6170429774365;5188.325517682828;5494.80768173112;6274.403931626488;6319.778807741891;6326.525510586633;5444;6246.937530624636;6307.337729538516;6342.334054924167;6353.301136875032;5295.576353891756;6242.1261023455845;6288.654124023223;6296.181496405438;6311.747530098744;6247.562670613013;6332.430081292706;6337.714802833976;6349.238091429058;6373.521985850987;6117.705611546597;6146.446819786241;6149.385061493815;6154.78458253959;6224.533160013108 16:52:21 INFO - PID 1639 | |1;ext.html;796.8087658961849;805.1183953570838;1103.0293341859162;1121.96634100977;1122.7137080044592;31353.372932541337;34368;34495.82752086236;34569.48145777809;34843.477347839806;36381.45427818585;36735.08162295937;36737.448938265945;36739;36749.44875826865;5234.319538459995;5356.866078348053;8007.239312265326;8159.796005099861;8170.264676179143;5338.652987555816;7302.963485182567;8055.234752698484;8125.59372031399;8132.064812546574;8163.918360816375;8203.26170644642;8204.343652507814;8206.548639824807;8214.548199849007;8128.59357032149;8171.754847354559;8179.791456306823;8193.426460147792;8201.507909525448;5233.450487698813;5352.57179425645;5361.249425080492;5363.168708850135;5365.892682146336;33485.49771753426;33805.830970845236;33896.32207355864;33898.81354152593;33921.49117763236;3565.108722819295;3580.5703315602036;3582.910427239314;3588.784672919607;3591.6587924147166;28371.57442638362;28686.713132868612;28709.71290287112;28753.137405877857;28769.856150719323;3063.2495038715656;3110.2535391506103;3135.561021456998;3146.7010633989735;3147.8268695221755;297489.0251097483;306854;307283;307286.9271307303;307459.46270268504;37208.44187337192;37509.62490375116;42340;45344.3198352025;45629.54370456253;45556.54443455589;45572.54427455749;45628.08743825105;45730.08539829185;45736;13044.608661740163;13123.934380328037;13129.080964332405;13130.080894337496;13136.40886160125;9954.855191652909;10407.739806504747;10919.836202456969;10944.890551094388;10967.50646220922;9427.858582121273;11465.770684586429;11468.655940321803;11581.363025033535;11594.76810463786;4432;5143.916713730945;5146.6911985281;5190;5196.194589838581;819.3404309530765;959.9808003840024;965.2856885904521;975.8926518083006;1008.7427705935087;22877.428064298194;23334.64998025031;23350.64974025391;23402.297931062094;23688.88155559211;877.2236570635034;1076.1605947360915;1084.430673896195;1107.9335239885472;1127.7293449572207;10331.8303156338;11071;11906.404679765978;11944.22362546449;12033.759324813454;308691;309826;310236;310761;310923;48080.5191948083;48139.5186048135;48145;48198;48337;1466.6260103673494;1516.0676184146892;1519.51375559822;1528.7630417285338;1538.6461113943856;18671.90664046671;20141.791492510496;21989.560208795414;22975.65536516987;23094.845257737383;36123.63876361308;36189.819050904574;36193.81903090573;36232.456513151796;36344.45483317805;288699;289594;289699;290269;290512;27650;27706.44587108287;30829.845850770602;31936.840315798272;32012.67987320097;39855.00362490845;40457.59542404538;40555.59444405518;40565.1886962265;40588.79705601453;26493.584004774235;27284.863575681993;28748.281292967844;29137.85431072831;29630.85184574063;28072.29819254535;28217.012404565743;28795.42409151847;29144.854275729333;29208.415831683673;33575;33704.1573960653;33720.662793371754;33764.32471350608;33774.49338259977;26705.866470667523;27208;29359.7064029357;29465.410691786474;29546.852265738533;18249;20191.394258172277;21791.78208217961;22823.771762282166;22906.65640015368 16:52:21 INFO - PID 1639 | |2;jquery.html;387.13668519202196;429.6402135301938;437.13665510616534;438.8332433675203;458.1455585333354;17151.39970101045;20977.58044839102;21272.936353182355;22541.54916901661;22778.2027629033;22153.335399937987;22374.440638983993;22818.08727650892;23289.767102328973;23642.172523961664;4269.551697071809;5945.4946329562035;6117.938820611804;6171.352008039158;6184.165137706397;3351.631320554737;3468.826558672069;3472.496488009237;3474.339875423674;3474.7393945454064;3471.2710330830555;3490.075130090528;5824.213731146305;6131.7240724167295;6135.539834512407;5838.532917366621;5901.970490147564;5902.468777809975;5969.164316995624;6115.510759139258;5310.62825602208;5313.787448502094;5317.574594032468;5319.175527793198;5321.973390133025;26591;26944.787484563047;27329.590056149173;27604;27736.029238976742;2184.159098746978;2187.55155193185;2191.37545799448;2219.7780221977832;2220.877851718155;16547.503574892773;17672.734908976374;17769.04540500544;17983.460496185005;18312.90843545787;1945.5816999345209;2040.5204776877422;2134.157007981854;2141.0579345088267;2143.2605751015876;124475.26574202788;146920;147581;147779.26110369488;148659.82370969592;9829.508524573743;11691.649250522498;12120.333381664093;12203.681300552866;12393.938030309791;16378.344866205456;16404;16414.83585164157;16431.671366572602;16443.83556164423;8689.522076285739;8983.640654373883;9010.504422256708;9028.819423611621;9221.123993220768;8594.44136131162;8613.913860861436;8754.737357879274;8795.868061979076;8810.647574097093;6685.490117688252;7570.318671319607;7679.500832445873;7734.419918506134;7851.646675899598;2057.79422057796;2199.3951663292723;2209.4807720185745;2238.496338323864;2371.3004663624274;940.1209868772719;943.2925306020485;981.4847205217318;989.2432289298692;991.8165139449225;17922.820771792114;20085.698714519294;21379.144834206767;21394.35816925495;21506.784932150476;948.118250027481;971.8396464583406;1002.3534820041178;1006.3458751811235;1012.4583347908981;10425.530851111718;11001.889981100247;11020.338779673086;11020.393878336768;11074.833877491845;559634;561015;562207;570677;574090;129345.35327323303;132963.3351833254;134624;135741;139706.30146849202;1180.1856718863955;1187.524990003988;1196.5676619919047;1197.74237051096;1234.5370486067545;20204.59590808205;20292.492687682927;21733.456663583536;21972.230971915906;21988.450288742908;54993;55549.61125971883;56054.87890242091;56193.71903140458;57423.71288143533;54694;76700.61649691939;76747.61626191833;77615.83576246248;78394.60802696178;7039.964800175966;7928.167542407964;7990.920090799018;8481.957590212256;8682.956585217033;12284.324362160167;12640.936795315965;13098.607041788762;13231.206127632373;13734.038617296694;11212.887871121184;11776;11805.704857378634;11868.10989175798;11870.52517899309;10629.521671524646;11299.943500282447;11375.943120284346;11470.965616059977;11752.059835212991;9858.359206651545;10781.460926953778;11678.824817627572;12109.818352724893;12168.148229624196;8622;8702.825943480968;8795;8812.559372031501;8880.822383552422;11468.483918223534;11688.298702077902;11979.28124312544;12010.75978480408;12094.274343539415 16:52:21 INFO - PID 1639 | |3;mootools.html;1318.9406476708548;1427.6288165077076;1446.6907448758877;1454.9272536373178;1454.9709005819884;11246.606368777095;11778.411079446025;11781.587644432446;11786.705332366695;11816.7636647267;11231.157663175274;11398.202125851194;11969.102317326191;11991;11996.220245684024;2124.915003399862;2506.4736405354897;2553.923382298534;2554.552953233186;2557.9872100639473;2462.4336402627405;2479.78921791647;2514.3462699698025;2515.195137555983;2515.421453065787;2343.4650304050874;2518.609615509599;2519.962200566993;2524.0534799450206;2524.3436706456364;2483.205374280231;2484.3789052736815;2504.4490212153296;2515.710693270279;2518.3452302401415;2077.5948690005457;2468.0127948820436;2497.725250222474;2500.1374525788574;2506.5738824399896;11441.199116061878;11707.94146029273;11722.238054526428;11725.648230553097;11734.354610496419;6525.804225873231;6773.695183716744;6780.457563394966;6780.864382712368;6786.185657721105;3913.7064720146104;4233.407322974786;4284.400183974246;4286.614204721559;4312.417823593806;1089.7657003744155;1243.1422318600137;1277.4506962006333;1288.632739669199;1292.8965682745359;15177.924110379488;15559.222038898122;15560.766588501181;16398.75401868961;16548.255328510248;5284.339457567804;5407.486288802557;5550;5551.056320425538;5560.638558493685;9240.445573265626;11847.703807404883;11856.170068095324;11859.58491452795;11893.702657433634;5648.661080335193;5826.067829147316;6576.86846263072;6586.37429444202;6588.835279117964;4505.504394516601;5169.689818610896;5258.474152584711;6216.564840461215;6219.346968568326;4180.352045432963;4361.738295702268;4372.978135109304;4403.669724770591;4431.357453169272;1223.4494477485168;1257.6289994451658;1272.166730791333;1275.8660340664283;1277.3740866975115;780.9414293927978;792.7978365516872;795.2087672765635;796;799.8880156778056;5583.441655834466;6537.215534135934;6669.133012708414;6931.930680693229;6939.514234003672;910.8523260691576;933.8085692433035;936.2369668719972;942.3933627027759;968.9176420004237;3876.5541962674088;4013.297672907288;4171.3325867860995;4290.806913688892;4384.386185933972;14841.628959276104;15279.312430940412;15380.769288460682;15401.768973465407;15402.537923862077;14491.420343186366;15246.771298430533;15254.542363729106;15277.38890444392;15295.464658736892;8331.208535189147;8600.268977137013;8607.397482176188;8611.052784193733;8612.224899759052;5430.565554755689;5740.512056475246;5941.67320797343;6960.035255727722;7124.145102587722;12829.358532073546;13352.732945341233;13451.125676830974;13704.246266455042;13966;12029.518819247482;13502.189868607915;13679.179249244678;13689.86310136886;14107.647308817363;8986;9286.907130928605;9337.299702522474;9452;9474.95262523683;10739;10952.397618131079;10956.945215273872;10961.849005854589;10966.670999870017;8912.064233255414;9035.909640903506;9174.587143578688;9182.265418766616;9193.126652967958;7346.77959661211;7393.371563417169;8738.475691458532;8798.560071996502;9021.639134434548;8118.634661440367;8132.024157101186;8178.304844088319;8242.876356854771;8272.37957153204;5390.730463476889;5566.025945459447;5660.462256085665;5678.296511046752;5801.738921748616;5910.70446477683;5927.8221653350465;6138.263408391022;6200.7519699211525;6317.4630156437215 16:52:21 INFO - PID 1639 | |4;prototype.html;362.3170323939375;399.59640762829537;412.4123124547519;413.45424040266823;416.496039791852;5040.672356296838;5793.82618521444;5966.313873904492;6011.549133814965;6076.605020673659;5752.827415177541;5795.971020144904;5849.864799348228;5863.179154918304;5866.325372582154;3853.7109716771283;4438.42300500936;4546.590307137222;4547.113312903985;4576.4737055238575;4303.849365272216;4554.931676024862;4555.20283950309;4572.291294849304;4578.793954272049;4031.455753473273;4148.543660197376;4253.404523366731;4281.785910704468;4574;3462.9653703462895;4261.041265715205;4545.931811022804;4576.679632425731;4584.358189853423;3539.0975301298004;4017.3973903914352;4062.857799976987;4068.3694027425795;4071.676705070834;5076.416212135615;5812.244408226946;5832;5833.504152147073;5842.620229685057;3633.5639723233116;5056.544910957995;5069.493050694901;5110.95225478776;5121.385433747974;6324.462420694246;6354.459870910978;6355.741653092439;6367.675798333621;6384.872302553969;4123.443335149776;4227.957720422787;4230.534641189467;4232.957670423287;4235.53409124996;5779.450952159496;6356.215843582318;6617.735290588419;6636.303188165221;6818.795436136874;4090.550039495653;4123.690723195772;4248.617624413818;4250.489941207075;4268.935965960513;3776.584575696671;4261.722988005769;4307;4328.242557552416;4339.652827773771;4471.374007638933;4503.797329120198;4596.37948876904;4803.903921921542;5111.642185047011;6335.778247761306;6337.334579869047;6345.714442850082;6354.3010268870385;6360.332165122595;1384.7161331926932;1451.1945870042227;1476.372541669786;1476.5644134980207;1485.569184936378;787.6140691061453;963.7301555564453;963.9951800241095;969.7236287658125;986.7665418227216;5696.715164241771;5990.341062483123;6018.247719035121;6024.939750602525;6038.33578306386;6423.197100362455;6553.934460655332;6578.901316480256;6589.604623722592;6592.472602191813;5770.019096753562;5885.234919460443;5976.641401515923;6022.560862850552;6030.33666296707;3141.2146963259183;3391.762576619613;3441.9483707744403;3457.429524128541;3463.2207753255316;6013.579049466495;6053.51571874249;6453.838309104406;6707.094542236736;6800.115984922028;5622.457851553495;6361.5546911716665;6628.602283862983;6729.207378937784;6766.424853887376;5638.718064096696;6234.470070044097;6430.871382572323;6754.121964144728;6770.93229067703;5900.173975643327;6114.5414093942245;6568.47452203813;6577.013447982841;6617.735290588515;5992.131140984446;6023.48800351975;6190.3190649029475;6471.385218404244;6495.74017039332;5674.943250567441;6106.755729770759;6137.263528376623;6809.65951702403;6816.659167041727;4228.70399072062;4244.363345498076;4247.808848601759;4268.01835577825;4270.231358355526;4997.575206107522;6597.835054123685;6612;6637.369449902251;6701.1623547056615;6372.235331760218;6404.231492220963;6404.615723056631;6410.820321090851;6467.805965821033;6054.848628784315;6400.839979000562;6447.194100737408;6463.806085817433;6473.611583305017;5315.126784902627;6315.747370105328;6324.968375158095;6337.65142917144;6351.491880649629;6265.530085243716;6411.455026322815;6429.4856411486035;6487.675616219264;6488.967555162194;5759.827205183851;6297.937020629918;6308.52686048539;6313.46335561464;6320.462760665211 16:52:21 INFO - PID 1639 | |5;yui.html;708.5748550869482;861.7587075618829;863.4603372891943;868.4572142410993;885.1104639836965;12644.431000604973;17535.736963945536;17887.195076221567;18458.538536536576;18546;14437;17287.30850765968;17864.55338616532;17919.283228670836;17933.10334483274;910.5037754423855;935;936.8735220745215;937.9062093790635;940.7789169545185;665.1120753793691;691.4468425259797;985.9112679858812;986.9555869985832;989.0999190736432;936.6347124621403;1021.4484178543578;1022.1567207054173;1026.3123707116213;1042.5777560088177;1012.5443550402275;1013.1135256650431;1018.4245901065874;1020.6427750287414;1045.6862941117672;746.2686567164155;748.7304570354668;749.8237914090184;754.1327473405572;774.0633833062002;16106.033637981758;16389;16422.75365869513;16727.414540491023;16739.16304184798;16480.752788708178;16637.084960327178;17009.659806803793;17071.146442677815;17096.658066838594;13731.24478153701;13871.4451421943;13895.444182232699;14022.158670479805;14104.365303561364;3505.4040813061843;3535.734819888519;3537.7523573349877;3546.184377593168;3546.5034895114704;125529;125883.11175332377;126373.36813315966;127089.03030999782;127909.36045319807;8870.379073464925;12896.161749486253;12980.091393602357;13010.349482525837;13157.736845263042;19328.226870925286;19674.21303147858;22882.42793930165;24388;24715.752842471346;7600.771976840593;7859.253370929752;7864.882026769603;7879.724209652634;7879.881801772978;3727.4781530585738;3781.905452363713;3797.9430308544843;3819.694424446038;3837.2901013312626;4123.2165888481695;4269.551697071763;4271.209826182167;4274.893127671771;4275.743455392686;885.2630600756157;887.1882227761525;923.6720964057797;925.0656836595087;926.2266007883493;645.1612903225788;645.3224114679567;656.5502630697891;663.5952069237761;677.3328271652418;10996.23026388161;11866;12024;12076.637700868989;12247.877521224673;634.1312402009277;640.0942666127471;640.3596403596404;649.389573800626;660.9537332386783;5405.324334458192;5548;5593.916091258634;5600.187972744011;5628.04323265046;107609.46195268973;109729.90270097356;110345;110670.46647667585;112661;93151;94591;96157.51921240489;96487.51756241314;97632.51183744035;71806.64096679483;73033.26966730371;76742;78435.99999999886;79931;11368.94315528417;11917.642470725892;12268;12451.750964980469;12453.439595218419;33167.83416082904;35547.82226088853;39892.401613975235;41159;41203.58796412117;50651.493485064675;50873.23690144725;51087;51254;51474;15980.440684575984;16002.599935001717;16114.194290285204;16475.093869836794;16588.66822663516;17540.386086486913;17610.295588176843;18296.359627412978;18355.724664130317;18384.540386490444;13985.790213146607;15773.526794196192;16437;16915.407960721317;17185.570360741083;16347.59131021734;16413.261403236644;16845.494635160965;17036.48890533286;17166.570835729206;15721;16244.350225990827;16255.756163657317;16590.66818663644;16760;11784.351860647746;11860;12130.878691212974;12187.720289369843;12314.445849936596;12893.419796109385;13206.471741130246;13236.801447978482;13253.66865828362;13257.734845303234 16:52:21 INFO - PID 1639 | __end_tp_report 16:52:21 INFO - PID 1639 | __start_cc_report 16:52:21 INFO - PID 1639 | _x_x_mozilla_cycle_collect,2240 16:52:21 INFO - PID 1639 | __end_cc_report 16:52:21 INFO - PID 1639 | __startTimestamp1493682741384__endTimestamp 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | ------- Summary: start ------- 16:52:21 INFO - PID 1639 | Number of tests: 6 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:5924.39 Median:6149.39 stddev:701.38 (11.4%) stddev-sans-first:676.80 16:52:21 INFO - PID 1639 | Values: 3479.6 3487.8 3501.7 3513.5 3548.0 5888.9 5985.4 6109.1 6115.2 6143.3 5857.0 5898.4 5933.6 5945.0 5970.2 4328.9 4917.5 5192.0 5200.4 5216.5 4674.5 5325.8 5328.3 5330.0 5330.3 5304.3 5309.3 5311.6 5320.7 5323.5 5301.6 5318.5 5321.7 5321.7 5332.4 5160.7 5270.0 5286.3 5286.7 5316.5 6048.3 6080.3 6087.3 6114.4 6128.1 6399.5 6424.0 6425.1 6442.8 6453.6 5947.2 6310.1 6383.5 6386.8 6387.5 6077.7 6100.7 6117.6 6139.8 6144.4 6530.2 6533.3 6733.4 6743.1 6751.0 6394.3 6396.8 6397.8 6400.3 6405.8 6276.1 6406.2 6539.9 6571.3 6571.5 5301.3 6287.6 6368.5 6390.2 6390.3 6268.5 6329.4 6363.9 6391.6 6401.0 5080.2 5174.4 5190.7 5191.4 5231.6 4605.1 4628.7 4634.4 4663.5 4684.4 6102.4 6111.5 6113.1 6119.3 6126.5 6391.7 6392.9 6531.3 6617.4 6619.3 5273.9 6160.4 6188.5 6241.0 6245.2 5723.1 5726.6 5729.4 5730.8 5798.6 5614.3 5839.7 6510.4 6751.9 6771.8 5446.5 6369.4 6594.8 6609.9 6635.2 6749.8 6767.5 6773.4 6779.9 6780.4 6407.5 6411.9 6429.7 6434.7 6444.9 6301.3 6333.2 6371.6 6371.8 6382.6 5188.3 5494.8 6274.4 6319.8 6326.5 5444.0 6246.9 6307.3 6342.3 6353.3 5295.6 6242.1 6288.7 6296.2 6311.7 6247.6 6332.4 6337.7 6349.2 6373.5 6117.7 6146.4 6149.4 6154.8 6224.5 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43441.41 Median:31974.76 stddev:79406.60 (248.3%) stddev-sans-first:79564.80 16:52:21 INFO - PID 1639 | Values: 796.8 805.1 1103.0 1122.0 1122.7 31353.4 34368.0 34495.8 34569.5 34843.5 36381.5 36735.1 36737.4 36739.0 36749.4 5234.3 5356.9 8007.2 8159.8 8170.3 5338.7 7303.0 8055.2 8125.6 8132.1 8163.9 8203.3 8204.3 8206.5 8214.5 8128.6 8171.8 8179.8 8193.4 8201.5 5233.5 5352.6 5361.2 5363.2 5365.9 33485.5 33805.8 33896.3 33898.8 33921.5 3565.1 3580.6 3582.9 3588.8 3591.7 28371.6 28686.7 28709.7 28753.1 28769.9 3063.2 3110.3 3135.6 3146.7 3147.8 297489.0 306854.0 307283.0 307286.9 307459.5 37208.4 37509.6 42340.0 45344.3 45629.5 45556.5 45572.5 45628.1 45730.1 45736.0 13044.6 13123.9 13129.1 13130.1 13136.4 9954.9 10407.7 10919.8 10944.9 10967.5 9427.9 11465.8 11468.7 11581.4 11594.8 4432.0 5143.9 5146.7 5190.0 5196.2 819.3 960.0 965.3 975.9 1008.7 22877.4 23334.6 23350.6 23402.3 23688.9 877.2 1076.2 1084.4 1107.9 1127.7 10331.8 11071.0 11906.4 11944.2 12033.8 308691.0 309826.0 310236.0 310761.0 310923.0 48080.5 48139.5 48145.0 48198.0 48337.0 1466.6 1516.1 1519.5 1528.8 1538.6 18671.9 20141.8 21989.6 22975.7 23094.8 36123.6 36189.8 36193.8 36232.5 36344.5 288699.0 289594.0 289699.0 290269.0 290512.0 27650.0 27706.4 30829.8 31936.8 32012.7 39855.0 40457.6 40555.6 40565.2 40588.8 26493.6 27284.9 28748.3 29137.9 29630.9 28072.3 28217.0 28795.4 29144.9 29208.4 33575.0 33704.2 33720.7 33764.3 33774.5 26705.9 27208.0 29359.7 29465.4 29546.9 18249.0 20191.4 21791.8 22823.8 22906.7 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:35500.97 Median:22659.88 stddev:95468.81 (421.3%) stddev-sans-first:95700.22 16:52:21 INFO - PID 1639 | Values: 387.1 429.6 437.1 438.8 458.1 17151.4 20977.6 21272.9 22541.5 22778.2 22153.3 22374.4 22818.1 23289.8 23642.2 4269.6 5945.5 6117.9 6171.4 6184.2 3351.6 3468.8 3472.5 3474.3 3474.7 3471.3 3490.1 5824.2 6131.7 6135.5 5838.5 5902.0 5902.5 5969.2 6115.5 5310.6 5313.8 5317.6 5319.2 5322.0 26591.0 26944.8 27329.6 27604.0 27736.0 2184.2 2187.6 2191.4 2219.8 2220.9 16547.5 17672.7 17769.0 17983.5 18312.9 1945.6 2040.5 2134.2 2141.1 2143.3 124475.3 146920.0 147581.0 147779.3 148659.8 9829.5 11691.6 12120.3 12203.7 12393.9 16378.3 16404.0 16414.8 16431.7 16443.8 8689.5 8983.6 9010.5 9028.8 9221.1 8594.4 8613.9 8754.7 8795.9 8810.6 6685.5 7570.3 7679.5 7734.4 7851.6 2057.8 2199.4 2209.5 2238.5 2371.3 940.1 943.3 981.5 989.2 991.8 17922.8 20085.7 21379.1 21394.4 21506.8 948.1 971.8 1002.4 1006.3 1012.5 10425.5 11001.9 11020.3 11020.4 11074.8 559634.0 561015.0 562207.0 570677.0 574090.0 129345.4 132963.3 134624.0 135741.0 139706.3 1180.2 1187.5 1196.6 1197.7 1234.5 20204.6 20292.5 21733.5 21972.2 21988.5 54993.0 55549.6 56054.9 56193.7 57423.7 54694.0 76700.6 76747.6 77615.8 78394.6 7040.0 7928.2 7990.9 8482.0 8683.0 12284.3 12640.9 13098.6 13231.2 13734.0 11212.9 11776.0 11805.7 11868.1 11870.5 10629.5 11299.9 11375.9 11471.0 11752.1 9858.4 10781.5 11678.8 12109.8 12168.1 8622.0 8702.8 8795.0 8812.6 8880.8 11468.5 11688.3 11979.3 12010.8 12094.3 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7025.92 Median:3963.50 stddev:4489.87 (113.3%) stddev-sans-first:4481.99 16:52:21 INFO - PID 1639 | Values: 1318.9 1427.6 1446.7 1454.9 1455.0 11246.6 11778.4 11781.6 11786.7 11816.8 11231.2 11398.2 11969.1 11991.0 11996.2 2124.9 2506.5 2553.9 2554.6 2558.0 2462.4 2479.8 2514.3 2515.2 2515.4 2343.5 2518.6 2520.0 2524.1 2524.3 2483.2 2484.4 2504.4 2515.7 2518.3 2077.6 2468.0 2497.7 2500.1 2506.6 11441.2 11707.9 11722.2 11725.6 11734.4 6525.8 6773.7 6780.5 6780.9 6786.2 3913.7 4233.4 4284.4 4286.6 4312.4 1089.8 1243.1 1277.5 1288.6 1292.9 15177.9 15559.2 15560.8 16398.8 16548.3 5284.3 5407.5 5550.0 5551.1 5560.6 9240.4 11847.7 11856.2 11859.6 11893.7 5648.7 5826.1 6576.9 6586.4 6588.8 4505.5 5169.7 5258.5 6216.6 6219.3 4180.4 4361.7 4373.0 4403.7 4431.4 1223.4 1257.6 1272.2 1275.9 1277.4 780.9 792.8 795.2 796.0 799.9 5583.4 6537.2 6669.1 6931.9 6939.5 910.9 933.8 936.2 942.4 968.9 3876.6 4013.3 4171.3 4290.8 4384.4 14841.6 15279.3 15380.8 15401.8 15402.5 14491.4 15246.8 15254.5 15277.4 15295.5 8331.2 8600.3 8607.4 8611.1 8612.2 5430.6 5740.5 5941.7 6960.0 7124.1 12829.4 13352.7 13451.1 13704.2 13966.0 12029.5 13502.2 13679.2 13689.9 14107.6 8986.0 9286.9 9337.3 9452.0 9475.0 10739.0 10952.4 10956.9 10961.8 10966.7 8912.1 9035.9 9174.6 9182.3 9193.1 7346.8 7393.4 8738.5 8798.6 9021.6 8118.6 8132.0 8178.3 8242.9 8272.4 5390.7 5566.0 5660.5 5678.3 5801.7 5910.7 5927.8 6138.3 6200.8 6317.5 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5131.15 Median:5875.78 stddev:1613.54 (27.5%) stddev-sans-first:1577.86 16:52:21 INFO - PID 1639 | Values: 362.3 399.6 412.4 413.5 416.5 5040.7 5793.8 5966.3 6011.5 6076.6 5752.8 5796.0 5849.9 5863.2 5866.3 3853.7 4438.4 4546.6 4547.1 4576.5 4303.8 4554.9 4555.2 4572.3 4578.8 4031.5 4148.5 4253.4 4281.8 4574.0 3463.0 4261.0 4545.9 4576.7 4584.4 3539.1 4017.4 4062.9 4068.4 4071.7 5076.4 5812.2 5832.0 5833.5 5842.6 3633.6 5056.5 5069.5 5111.0 5121.4 6324.5 6354.5 6355.7 6367.7 6384.9 4123.4 4228.0 4230.5 4233.0 4235.5 5779.5 6356.2 6617.7 6636.3 6818.8 4090.6 4123.7 4248.6 4250.5 4268.9 3776.6 4261.7 4307.0 4328.2 4339.7 4471.4 4503.8 4596.4 4803.9 5111.6 6335.8 6337.3 6345.7 6354.3 6360.3 1384.7 1451.2 1476.4 1476.6 1485.6 787.6 963.7 964.0 969.7 986.8 5696.7 5990.3 6018.2 6024.9 6038.3 6423.2 6553.9 6578.9 6589.6 6592.5 5770.0 5885.2 5976.6 6022.6 6030.3 3141.2 3391.8 3441.9 3457.4 3463.2 6013.6 6053.5 6453.8 6707.1 6800.1 5622.5 6361.6 6628.6 6729.2 6766.4 5638.7 6234.5 6430.9 6754.1 6770.9 5900.2 6114.5 6568.5 6577.0 6617.7 5992.1 6023.5 6190.3 6471.4 6495.7 5674.9 6106.8 6137.3 6809.7 6816.7 4228.7 4244.4 4247.8 4268.0 4270.2 4997.6 6597.8 6612.0 6637.4 6701.2 6372.2 6404.2 6404.6 6410.8 6467.8 6054.8 6400.8 6447.2 6463.8 6473.6 5315.1 6315.7 6325.0 6337.7 6351.5 6265.5 6411.5 6429.5 6487.7 6489.0 5759.8 6297.9 6308.5 6313.5 6320.5 16:52:21 INFO - PID 1639 | 16:52:21 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21624.96 Median:18421.54 stddev:31027.89 (168.4%) stddev-sans-first:31075.18 16:52:21 INFO - PID 1639 | Values: 708.6 861.8 863.5 868.5 885.1 12644.4 17535.7 17887.2 18458.5 18546.0 14437.0 17287.3 17864.6 17919.3 17933.1 910.5 935.0 936.9 937.9 940.8 665.1 691.4 985.9 987.0 989.1 936.6 1021.4 1022.2 1026.3 1042.6 1012.5 1013.1 1018.4 1020.6 1045.7 746.3 748.7 749.8 754.1 774.1 16106.0 16389.0 16422.8 16727.4 16739.2 16480.8 16637.1 17009.7 17071.1 17096.7 13731.2 13871.4 13895.4 14022.2 14104.4 3505.4 3535.7 3537.8 3546.2 3546.5 125529.0 125883.1 126373.4 127089.0 127909.4 8870.4 12896.2 12980.1 13010.3 13157.7 19328.2 19674.2 22882.4 24388.0 24715.8 7600.8 7859.3 7864.9 7879.7 7879.9 3727.5 3781.9 3797.9 3819.7 3837.3 4123.2 4269.6 4271.2 4274.9 4275.7 885.3 887.2 923.7 925.1 926.2 645.2 645.3 656.6 663.6 677.3 10996.2 11866.0 12024.0 12076.6 12247.9 634.1 640.1 640.4 649.4 661.0 5405.3 5548.0 5593.9 5600.2 5628.0 107609.5 109729.9 110345.0 110670.5 112661.0 93151.0 94591.0 96157.5 96487.5 97632.5 71806.6 73033.3 76742.0 78436.0 79931.0 11368.9 11917.6 12268.0 12451.8 12453.4 33167.8 35547.8 39892.4 41159.0 41203.6 50651.5 50873.2 51087.0 51254.0 51474.0 15980.4 16002.6 16114.2 16475.1 16588.7 17540.4 17610.3 18296.4 18355.7 18384.5 13985.8 15773.5 16437.0 16915.4 17185.6 16347.6 16413.3 16845.5 17036.5 17166.6 15721.0 16244.4 16255.8 16590.7 16760.0 11784.4 11860.0 12130.9 12187.7 12314.4 12893.4 13206.5 13236.8 13253.7 13257.7 16:52:21 INFO - PID 1639 | -------- Summary: end -------- 16:52:21 INFO - PID 1639 | 16:52:22 INFO - TEST-INFO | 1639: exit 0 16:52:22 INFO - TEST-OK | dromaeo_css | took 1119716ms 16:52:22 INFO - TEST-START | kraken 16:52:22 INFO - operating with platform_type : mac_ 16:52:22 INFO - Initialising browser for kraken test... 16:52:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpPs6LoW/profile http://localhost:49236/getInfo.html) 16:52:24 INFO - PID 1650 | __metrics Screen width/height:1600/1200 16:52:24 INFO - PID 1650 | colorDepth:24 16:52:24 INFO - PID 1650 | Browser inner width/height: 1024/689 16:52:24 INFO - PID 1650 | __metrics 16:52:24 INFO - PID 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:52:24 INFO - PID 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:52:25 INFO - TEST-INFO | 1650: exit 0 16:52:25 INFO - Browser initialized. 16:52:25 INFO - Running cycle 1/1 for kraken test... 16:52:25 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpPs6LoW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:38 INFO - PID 1651 | RSS: Main: 241086464 16:52:38 INFO - PID 1651 | 16:52:40 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 16:52:41 INFO - PID 1651 | RSS: Main: 312623104 16:52:41 INFO - PID 1651 | 16:52:44 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 16:52:45 INFO - PID 1651 | RSS: Main: 295501824 16:52:45 INFO - PID 1651 | 16:52:48 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 16:52:48 INFO - PID 1651 | RSS: Main: 388063232 16:52:48 INFO - PID 1651 | 16:52:50 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 16:52:51 INFO - PID 1651 | RSS: Main: 290803712 16:52:51 INFO - PID 1651 | 16:52:53 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:54 INFO - PID 1651 | RSS: Main: 292921344 16:52:54 INFO - PID 1651 | 16:52:56 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:57 INFO - PID 1651 | RSS: Main: 356311040 16:52:57 INFO - PID 1651 | 16:53:00 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 16:53:01 INFO - PID 1651 | RSS: Main: 367788032 16:53:01 INFO - PID 1651 | 16:53:03 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 16:53:04 INFO - PID 1651 | RSS: Main: 369786880 16:53:04 INFO - PID 1651 | 16:53:05 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:53:06 INFO - PID 1651 | RSS: Main: 333758464 16:53:06 INFO - PID 1651 | 16:53:08 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:53:09 INFO - PID 1651 | RSS: Main: 334565376 16:53:09 INFO - PID 1651 | 16:53:11 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:53:11 INFO - PID 1651 | RSS: Main: 336531456 16:53:11 INFO - PID 1651 | 16:53:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:53:15 INFO - PID 1651 | RSS: Main: 356499456 16:53:15 INFO - PID 1651 | 16:53:18 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:53:19 INFO - PID 1651 | RSS: Main: 348585984 16:53:19 INFO - PID 1651 | 16:53:20 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 16:53:21 INFO - PID 1651 | RSS: Main: 392015872 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | __start_tp_report 16:53:21 INFO - PID 1651 | _x_x_mozilla_page_load 16:53:21 INFO - PID 1651 | _x_x_mozilla_page_load_details 16:53:21 INFO - PID 1651 | |i|pagename|runs| 16:53:21 INFO - PID 1651 | |0;ai-astar;117;161;148;108;109;110;108;110;110;107 16:53:21 INFO - PID 1651 | |1;audio-beat-detection;144;106;100;145;109;106;103;107;139;139 16:53:21 INFO - PID 1651 | |2;audio-dft;187;184;181;187;186;185;186;184;186;184 16:53:21 INFO - PID 1651 | |3;audio-fft;79;56;59;89;75;88;70;59;81;57 16:53:21 INFO - PID 1651 | |4;audio-oscillator;90;70;86;71;69;69;88;70;68;90 16:53:21 INFO - PID 1651 | |5;imaging-gaussian-blur;85;85;86;85;86;85;86;84;86;86 16:53:21 INFO - PID 1651 | |6;imaging-darkroom;92;94;93;93;94;103;107;99;93;93 16:53:21 INFO - PID 1651 | |7;imaging-desaturate;85;82;85;86;84;86;87;87;85;85 16:53:21 INFO - PID 1651 | |8;json-parse-financial;46;46;48;46;47;49;48;47;47;48 16:53:21 INFO - PID 1651 | |9;json-stringify-tinderbox;54;62;67;69;63;61;59;57;60;58 16:53:21 INFO - PID 1651 | |10;stanford-crypto-aes;84;83;84;81;84;86;81;81;83;82 16:53:21 INFO - PID 1651 | |11;stanford-crypto-ccm;137;135;134;137;148;143;136;137;175;153 16:53:21 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;174;184;184;187;189;170;183;183;184;231 16:53:21 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;66;68;66;67;69;68;68;67;67;67 16:53:21 INFO - PID 1651 | __end_tp_report 16:53:21 INFO - PID 1651 | __start_cc_report 16:53:21 INFO - PID 1651 | _x_x_mozilla_cycle_collect,2301 16:53:21 INFO - PID 1651 | __end_cc_report 16:53:21 INFO - PID 1651 | __startTimestamp1493682801113__endTimestamp 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | ------- Summary: start ------- 16:53:21 INFO - PID 1651 | Number of tests: 14 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:118.80 Median:110.00 stddev:19.26 (17.5%) stddev-sans-first:20.41 16:53:21 INFO - PID 1651 | Values: 117.0 161.0 148.0 108.0 109.0 110.0 108.0 110.0 110.0 107.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:124.00 stddev:19.13 (15.4%) stddev-sans-first:18.18 16:53:21 INFO - PID 1651 | Values: 144.0 106.0 100.0 145.0 109.0 106.0 103.0 107.0 139.0 139.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:1.83 (1.0%) stddev-sans-first:1.79 16:53:21 INFO - PID 1651 | Values: 187.0 184.0 181.0 187.0 186.0 185.0 186.0 184.0 186.0 184.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:71.30 Median:77.00 stddev:12.92 (16.8%) stddev-sans-first:13.40 16:53:21 INFO - PID 1651 | Values: 79.0 56.0 59.0 89.0 75.0 88.0 70.0 59.0 81.0 57.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.50 stddev:9.90 (12.6%) stddev-sans-first:9.34 16:53:21 INFO - PID 1651 | Values: 90.0 70.0 86.0 71.0 69.0 69.0 88.0 70.0 68.0 90.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 16:53:21 INFO - PID 1651 | Values: 85.0 85.0 86.0 85.0 86.0 85.0 86.0 84.0 86.0 86.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:93.00 stddev:5.15 (5.5%) stddev-sans-first:5.25 16:53:21 INFO - PID 1651 | Values: 92.0 94.0 93.0 93.0 94.0 103.0 107.0 99.0 93.0 93.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.48 (1.7%) stddev-sans-first:1.56 16:53:21 INFO - PID 1651 | Values: 85.0 82.0 85.0 86.0 84.0 86.0 87.0 87.0 85.0 85.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:47.20 Median:47.50 stddev:1.03 (2.2%) stddev-sans-first:1.00 16:53:21 INFO - PID 1651 | Values: 46.0 46.0 48.0 46.0 47.0 49.0 48.0 47.0 47.0 48.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.50 stddev:4.52 (7.4%) stddev-sans-first:4.02 16:53:21 INFO - PID 1651 | Values: 54.0 62.0 67.0 69.0 63.0 61.0 59.0 57.0 60.0 58.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.66 (2.0%) stddev-sans-first:1.72 16:53:21 INFO - PID 1651 | Values: 84.0 83.0 84.0 81.0 84.0 86.0 81.0 81.0 83.0 82.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:140.00 stddev:12.69 (9.1%) stddev-sans-first:13.24 16:53:21 INFO - PID 1651 | Values: 137.0 135.0 134.0 137.0 148.0 143.0 136.0 137.0 175.0 153.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:184.00 stddev:16.52 (9.0%) stddev-sans-first:16.85 16:53:21 INFO - PID 1651 | Values: 174.0 184.0 184.0 187.0 189.0 170.0 183.0 183.0 184.0 231.0 16:53:21 INFO - PID 1651 | 16:53:21 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 16:53:21 INFO - PID 1651 | Values: 66.0 68.0 66.0 67.0 69.0 68.0 68.0 67.0 67.0 67.0 16:53:21 INFO - PID 1651 | -------- Summary: end -------- 16:53:21 INFO - PID 1651 | 16:53:22 INFO - TEST-INFO | 1651: exit 0 16:53:22 INFO - TEST-OK | kraken | took 60194ms 16:53:22 INFO - SUITE-END | took 1179s 16:53:22 INFO - Completed test suite (00:19:39) 16:53:22 INFO - javascript benchmark 16:53:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7606.3380102757765, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3479.599846017709, 3487.825608719563, 3501.684848363647, 3513.4554144107665, 3547.988823185391, 5888.852778680535, 5985.371535988724, 6109.1447197392345, 6115.2050233469645, 6143.262808462985, 5857.0, 5898.410158984099, 5933.584649074566, 5944.959632064393, 5970.223870896788, 4328.935065974013, 4917.45907950127, 5192.013517431676, 5200.4019537753165, 5216.504432078947, 4674.485806561275, 5325.840224793243, 5328.333958255218, 5330.013947419739, 5330.253764472977, 5304.283921670583, 5309.256704061435, 5311.601629877755, 5320.707361095138, 5323.467653234665, 5301.628885977983, 5318.521333080042, 5321.73391330432, 5321.733913304358, 5332.3601167859915, 5160.664556803796, 5269.973650131763, 5286.286351342596, 5286.735663216862, 5316.494932981361, 6048.304444988838, 6080.270367555878, 6087.299960504554, 6114.388561143895, 6128.111423843562, 6399.456046236076, 6424.03639454081, 6425.100485931974, 6442.806715798487, 6453.612783232974, 5947.185585864547, 6310.148130002437, 6383.521235907326, 6386.776462823826, 6387.520935929824, 6077.726502307407, 6100.708853721966, 6117.602355846856, 6139.785107521216, 6144.354842741537, 6530.216374035146, 6533.281339052701, 6733.42765864907, 6743.089682892747, 6750.966245168743, 6394.264659564116, 6396.776112836028, 6397.840053998594, 6400.263969643457, 6405.839854003687, 6276.121343011982, 6406.199225096863, 6539.934600653933, 6571.2771595124495, 6571.474282057424, 5301.3373328333955, 6287.622742635456, 6368.490520758328, 6390.233172019294, 6390.329015453403, 6268.4671802897265, 6329.4303512683155, 6363.872722545523, 6391.648459334689, 6400.97584386496, 5080.212567052113, 5174.404943431478, 5190.740462976836, 5191.428942816287, 5231.581473482112, 4605.102005108972, 4628.722276663411, 4634.351190833286, 4663.463701674283, 4684.4378674559275, 6102.359252278536, 6111.51107911366, 6113.052476866093, 6119.326874043852, 6126.509879209652, 6391.6804159792755, 6392.872142557123, 6531.281559028503, 6617.404433600999, 6619.271880093186, 5273.920891186635, 6160.353162917919, 6188.4739797116845, 6240.968795155995, 6245.219347581552, 5723.055695810228, 5726.599138060295, 5729.427057294237, 5730.828075157752, 5798.565107616945, 5614.29821272341, 5839.737211825478, 6510.414062734377, 6751.898721519083, 6771.830704232433, 5446.482584154499, 6369.394907483782, 6594.802155935329, 6609.867802644017, 6635.2037755469655, 6749.831254218684, 6767.526273160832, 6773.424258938046, 6779.93220067793, 6780.389764920984, 6407.487401008001, 6411.903821442776, 6429.7428102875365, 6434.67826608677, 6444.871102577828, 6301.338359472189, 6333.20834895638, 6371.585846919936, 6371.808845734636, 6382.6170429774365, 5188.325517682828, 5494.80768173112, 6274.403931626488, 6319.778807741891, 6326.525510586633, 5444.0, 6246.937530624636, 6307.337729538516, 6342.334054924167, 6353.301136875032, 5295.576353891756, 6242.1261023455845, 6288.654124023223, 6296.181496405438, 6311.747530098744, 6247.562670613013, 6332.430081292706, 6337.714802833976, 6349.238091429058, 6373.521985850987, 6117.705611546597, 6146.446819786241, 6149.385061493815, 6154.78458253959, 6224.533160013108], "value": 5880.396161234839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.8087658961849, 805.1183953570838, 1103.0293341859162, 1121.96634100977, 1122.7137080044592, 31353.372932541337, 34368.0, 34495.82752086236, 34569.48145777809, 34843.477347839806, 36381.45427818585, 36735.08162295937, 36737.448938265945, 36739.0, 36749.44875826865, 5234.319538459995, 5356.866078348053, 8007.239312265326, 8159.796005099861, 8170.264676179143, 5338.652987555816, 7302.963485182567, 8055.234752698484, 8125.59372031399, 8132.064812546574, 8163.918360816375, 8203.26170644642, 8204.343652507814, 8206.548639824807, 8214.548199849007, 8128.59357032149, 8171.754847354559, 8179.791456306823, 8193.426460147792, 8201.507909525448, 5233.450487698813, 5352.57179425645, 5361.249425080492, 5363.168708850135, 5365.892682146336, 33485.49771753426, 33805.830970845236, 33896.32207355864, 33898.81354152593, 33921.49117763236, 3565.108722819295, 3580.5703315602036, 3582.910427239314, 3588.784672919607, 3591.6587924147166, 28371.57442638362, 28686.713132868612, 28709.71290287112, 28753.137405877857, 28769.856150719323, 3063.2495038715656, 3110.2535391506103, 3135.561021456998, 3146.7010633989735, 3147.8268695221755, 297489.0251097483, 306854.0, 307283.0, 307286.9271307303, 307459.46270268504, 37208.44187337192, 37509.62490375116, 42340.0, 45344.3198352025, 45629.54370456253, 45556.54443455589, 45572.54427455749, 45628.08743825105, 45730.08539829185, 45736.0, 13044.608661740163, 13123.934380328037, 13129.080964332405, 13130.080894337496, 13136.40886160125, 9954.855191652909, 10407.739806504747, 10919.836202456969, 10944.890551094388, 10967.50646220922, 9427.858582121273, 11465.770684586429, 11468.655940321803, 11581.363025033535, 11594.76810463786, 4432.0, 5143.916713730945, 5146.6911985281, 5190.0, 5196.194589838581, 819.3404309530765, 959.9808003840024, 965.2856885904521, 975.8926518083006, 1008.7427705935087, 22877.428064298194, 23334.64998025031, 23350.64974025391, 23402.297931062094, 23688.88155559211, 877.2236570635034, 1076.1605947360915, 1084.430673896195, 1107.9335239885472, 1127.7293449572207, 10331.8303156338, 11071.0, 11906.404679765978, 11944.22362546449, 12033.759324813454, 308691.0, 309826.0, 310236.0, 310761.0, 310923.0, 48080.5191948083, 48139.5186048135, 48145.0, 48198.0, 48337.0, 1466.6260103673494, 1516.0676184146892, 1519.51375559822, 1528.7630417285338, 1538.6461113943856, 18671.90664046671, 20141.791492510496, 21989.560208795414, 22975.65536516987, 23094.845257737383, 36123.63876361308, 36189.819050904574, 36193.81903090573, 36232.456513151796, 36344.45483317805, 288699.0, 289594.0, 289699.0, 290269.0, 290512.0, 27650.0, 27706.44587108287, 30829.845850770602, 31936.840315798272, 32012.67987320097, 39855.00362490845, 40457.59542404538, 40555.59444405518, 40565.1886962265, 40588.79705601453, 26493.584004774235, 27284.863575681993, 28748.281292967844, 29137.85431072831, 29630.85184574063, 28072.29819254535, 28217.012404565743, 28795.42409151847, 29144.854275729333, 29208.415831683673, 33575.0, 33704.1573960653, 33720.662793371754, 33764.32471350608, 33774.49338259977, 26705.866470667523, 27208.0, 29359.7064029357, 29465.410691786474, 29546.852265738533, 18249.0, 20191.394258172277, 21791.78208217961, 22823.771762282166, 22906.65640015368], "value": 16134.719685535252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.13668519202196, 429.6402135301938, 437.13665510616534, 438.8332433675203, 458.1455585333354, 17151.39970101045, 20977.58044839102, 21272.936353182355, 22541.54916901661, 22778.2027629033, 22153.335399937987, 22374.440638983993, 22818.08727650892, 23289.767102328973, 23642.172523961664, 4269.551697071809, 5945.4946329562035, 6117.938820611804, 6171.352008039158, 6184.165137706397, 3351.631320554737, 3468.826558672069, 3472.496488009237, 3474.339875423674, 3474.7393945454064, 3471.2710330830555, 3490.075130090528, 5824.213731146305, 6131.7240724167295, 6135.539834512407, 5838.532917366621, 5901.970490147564, 5902.468777809975, 5969.164316995624, 6115.510759139258, 5310.62825602208, 5313.787448502094, 5317.574594032468, 5319.175527793198, 5321.973390133025, 26591.0, 26944.787484563047, 27329.590056149173, 27604.0, 27736.029238976742, 2184.159098746978, 2187.55155193185, 2191.37545799448, 2219.7780221977832, 2220.877851718155, 16547.503574892773, 17672.734908976374, 17769.04540500544, 17983.460496185005, 18312.90843545787, 1945.5816999345209, 2040.5204776877422, 2134.157007981854, 2141.0579345088267, 2143.2605751015876, 124475.26574202788, 146920.0, 147581.0, 147779.26110369488, 148659.82370969592, 9829.508524573743, 11691.649250522498, 12120.333381664093, 12203.681300552866, 12393.938030309791, 16378.344866205456, 16404.0, 16414.83585164157, 16431.671366572602, 16443.83556164423, 8689.522076285739, 8983.640654373883, 9010.504422256708, 9028.819423611621, 9221.123993220768, 8594.44136131162, 8613.913860861436, 8754.737357879274, 8795.868061979076, 8810.647574097093, 6685.490117688252, 7570.318671319607, 7679.500832445873, 7734.419918506134, 7851.646675899598, 2057.79422057796, 2199.3951663292723, 2209.4807720185745, 2238.496338323864, 2371.3004663624274, 940.1209868772719, 943.2925306020485, 981.4847205217318, 989.2432289298692, 991.8165139449225, 17922.820771792114, 20085.698714519294, 21379.144834206767, 21394.35816925495, 21506.784932150476, 948.118250027481, 971.8396464583406, 1002.3534820041178, 1006.3458751811235, 1012.4583347908981, 10425.530851111718, 11001.889981100247, 11020.338779673086, 11020.393878336768, 11074.833877491845, 559634.0, 561015.0, 562207.0, 570677.0, 574090.0, 129345.35327323303, 132963.3351833254, 134624.0, 135741.0, 139706.30146849202, 1180.1856718863955, 1187.524990003988, 1196.5676619919047, 1197.74237051096, 1234.5370486067545, 20204.59590808205, 20292.492687682927, 21733.456663583536, 21972.230971915906, 21988.450288742908, 54993.0, 55549.61125971883, 56054.87890242091, 56193.71903140458, 57423.71288143533, 54694.0, 76700.61649691939, 76747.61626191833, 77615.83576246248, 78394.60802696178, 7039.964800175966, 7928.167542407964, 7990.920090799018, 8481.957590212256, 8682.956585217033, 12284.324362160167, 12640.936795315965, 13098.607041788762, 13231.206127632373, 13734.038617296694, 11212.887871121184, 11776.0, 11805.704857378634, 11868.10989175798, 11870.52517899309, 10629.521671524646, 11299.943500282447, 11375.943120284346, 11470.965616059977, 11752.059835212991, 9858.359206651545, 10781.460926953778, 11678.824817627572, 12109.818352724893, 12168.148229624196, 8622.0, 8702.825943480968, 8795.0, 8812.559372031501, 8880.822383552422, 11468.483918223534, 11688.298702077902, 11979.28124312544, 12010.75978480408, 12094.274343539415], "value": 10093.059494181382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.9406476708548, 1427.6288165077076, 1446.6907448758877, 1454.9272536373178, 1454.9709005819884, 11246.606368777095, 11778.411079446025, 11781.587644432446, 11786.705332366695, 11816.7636647267, 11231.157663175274, 11398.202125851194, 11969.102317326191, 11991.0, 11996.220245684024, 2124.915003399862, 2506.4736405354897, 2553.923382298534, 2554.552953233186, 2557.9872100639473, 2462.4336402627405, 2479.78921791647, 2514.3462699698025, 2515.195137555983, 2515.421453065787, 2343.4650304050874, 2518.609615509599, 2519.962200566993, 2524.0534799450206, 2524.3436706456364, 2483.205374280231, 2484.3789052736815, 2504.4490212153296, 2515.710693270279, 2518.3452302401415, 2077.5948690005457, 2468.0127948820436, 2497.725250222474, 2500.1374525788574, 2506.5738824399896, 11441.199116061878, 11707.94146029273, 11722.238054526428, 11725.648230553097, 11734.354610496419, 6525.804225873231, 6773.695183716744, 6780.457563394966, 6780.864382712368, 6786.185657721105, 3913.7064720146104, 4233.407322974786, 4284.400183974246, 4286.614204721559, 4312.417823593806, 1089.7657003744155, 1243.1422318600137, 1277.4506962006333, 1288.632739669199, 1292.8965682745359, 15177.924110379488, 15559.222038898122, 15560.766588501181, 16398.75401868961, 16548.255328510248, 5284.339457567804, 5407.486288802557, 5550.0, 5551.056320425538, 5560.638558493685, 9240.445573265626, 11847.703807404883, 11856.170068095324, 11859.58491452795, 11893.702657433634, 5648.661080335193, 5826.067829147316, 6576.86846263072, 6586.37429444202, 6588.835279117964, 4505.504394516601, 5169.689818610896, 5258.474152584711, 6216.564840461215, 6219.346968568326, 4180.352045432963, 4361.738295702268, 4372.978135109304, 4403.669724770591, 4431.357453169272, 1223.4494477485168, 1257.6289994451658, 1272.166730791333, 1275.8660340664283, 1277.3740866975115, 780.9414293927978, 792.7978365516872, 795.2087672765635, 796.0, 799.8880156778056, 5583.441655834466, 6537.215534135934, 6669.133012708414, 6931.930680693229, 6939.514234003672, 910.8523260691576, 933.8085692433035, 936.2369668719972, 942.3933627027759, 968.9176420004237, 3876.5541962674088, 4013.297672907288, 4171.3325867860995, 4290.806913688892, 4384.386185933972, 14841.628959276104, 15279.312430940412, 15380.769288460682, 15401.768973465407, 15402.537923862077, 14491.420343186366, 15246.771298430533, 15254.542363729106, 15277.38890444392, 15295.464658736892, 8331.208535189147, 8600.268977137013, 8607.397482176188, 8611.052784193733, 8612.224899759052, 5430.565554755689, 5740.512056475246, 5941.67320797343, 6960.035255727722, 7124.145102587722, 12829.358532073546, 13352.732945341233, 13451.125676830974, 13704.246266455042, 13966.0, 12029.518819247482, 13502.189868607915, 13679.179249244678, 13689.86310136886, 14107.647308817363, 8986.0, 9286.907130928605, 9337.299702522474, 9452.0, 9474.95262523683, 10739.0, 10952.397618131079, 10956.945215273872, 10961.849005854589, 10966.670999870017, 8912.064233255414, 9035.909640903506, 9174.587143578688, 9182.265418766616, 9193.126652967958, 7346.77959661211, 7393.371563417169, 8738.475691458532, 8798.560071996502, 9021.639134434548, 8118.634661440367, 8132.024157101186, 8178.304844088319, 8242.876356854771, 8272.37957153204, 5390.730463476889, 5566.025945459447, 5660.462256085665, 5678.296511046752, 5801.738921748616, 5910.70446477683, 5927.8221653350465, 6138.263408391022, 6200.7519699211525, 6317.4630156437215], "value": 5313.481643203747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.3170323939375, 399.59640762829537, 412.4123124547519, 413.45424040266823, 416.496039791852, 5040.672356296838, 5793.82618521444, 5966.313873904492, 6011.549133814965, 6076.605020673659, 5752.827415177541, 5795.971020144904, 5849.864799348228, 5863.179154918304, 5866.325372582154, 3853.7109716771283, 4438.42300500936, 4546.590307137222, 4547.113312903985, 4576.4737055238575, 4303.849365272216, 4554.931676024862, 4555.20283950309, 4572.291294849304, 4578.793954272049, 4031.455753473273, 4148.543660197376, 4253.404523366731, 4281.785910704468, 4574.0, 3462.9653703462895, 4261.041265715205, 4545.931811022804, 4576.679632425731, 4584.358189853423, 3539.0975301298004, 4017.3973903914352, 4062.857799976987, 4068.3694027425795, 4071.676705070834, 5076.416212135615, 5812.244408226946, 5832.0, 5833.504152147073, 5842.620229685057, 3633.5639723233116, 5056.544910957995, 5069.493050694901, 5110.95225478776, 5121.385433747974, 6324.462420694246, 6354.459870910978, 6355.741653092439, 6367.675798333621, 6384.872302553969, 4123.443335149776, 4227.957720422787, 4230.534641189467, 4232.957670423287, 4235.53409124996, 5779.450952159496, 6356.215843582318, 6617.735290588419, 6636.303188165221, 6818.795436136874, 4090.550039495653, 4123.690723195772, 4248.617624413818, 4250.489941207075, 4268.935965960513, 3776.584575696671, 4261.722988005769, 4307.0, 4328.242557552416, 4339.652827773771, 4471.374007638933, 4503.797329120198, 4596.37948876904, 4803.903921921542, 5111.642185047011, 6335.778247761306, 6337.334579869047, 6345.714442850082, 6354.3010268870385, 6360.332165122595, 1384.7161331926932, 1451.1945870042227, 1476.372541669786, 1476.5644134980207, 1485.569184936378, 787.6140691061453, 963.7301555564453, 963.9951800241095, 969.7236287658125, 986.7665418227216, 5696.715164241771, 5990.341062483123, 6018.247719035121, 6024.939750602525, 6038.33578306386, 6423.197100362455, 6553.934460655332, 6578.901316480256, 6589.604623722592, 6592.472602191813, 5770.019096753562, 5885.234919460443, 5976.641401515923, 6022.560862850552, 6030.33666296707, 3141.2146963259183, 3391.762576619613, 3441.9483707744403, 3457.429524128541, 3463.2207753255316, 6013.579049466495, 6053.51571874249, 6453.838309104406, 6707.094542236736, 6800.115984922028, 5622.457851553495, 6361.5546911716665, 6628.602283862983, 6729.207378937784, 6766.424853887376, 5638.718064096696, 6234.470070044097, 6430.871382572323, 6754.121964144728, 6770.93229067703, 5900.173975643327, 6114.5414093942245, 6568.47452203813, 6577.013447982841, 6617.735290588515, 5992.131140984446, 6023.48800351975, 6190.3190649029475, 6471.385218404244, 6495.74017039332, 5674.943250567441, 6106.755729770759, 6137.263528376623, 6809.65951702403, 6816.659167041727, 4228.70399072062, 4244.363345498076, 4247.808848601759, 4268.01835577825, 4270.231358355526, 4997.575206107522, 6597.835054123685, 6612.0, 6637.369449902251, 6701.1623547056615, 6372.235331760218, 6404.231492220963, 6404.615723056631, 6410.820321090851, 6467.805965821033, 6054.848628784315, 6400.839979000562, 6447.194100737408, 6463.806085817433, 6473.611583305017, 5315.126784902627, 6315.747370105328, 6324.968375158095, 6337.65142917144, 6351.491880649629, 6265.530085243716, 6411.455026322815, 6429.4856411486035, 6487.675616219264, 6488.967555162194, 5759.827205183851, 6297.937020629918, 6308.52686048539, 6313.46335561464, 6320.462760665211], "value": 4626.321511022651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5748550869482, 861.7587075618829, 863.4603372891943, 868.4572142410993, 885.1104639836965, 12644.431000604973, 17535.736963945536, 17887.195076221567, 18458.538536536576, 18546.0, 14437.0, 17287.30850765968, 17864.55338616532, 17919.283228670836, 17933.10334483274, 910.5037754423855, 935.0, 936.8735220745215, 937.9062093790635, 940.7789169545185, 665.1120753793691, 691.4468425259797, 985.9112679858812, 986.9555869985832, 989.0999190736432, 936.6347124621403, 1021.4484178543578, 1022.1567207054173, 1026.3123707116213, 1042.5777560088177, 1012.5443550402275, 1013.1135256650431, 1018.4245901065874, 1020.6427750287414, 1045.6862941117672, 746.2686567164155, 748.7304570354668, 749.8237914090184, 754.1327473405572, 774.0633833062002, 16106.033637981758, 16389.0, 16422.75365869513, 16727.414540491023, 16739.16304184798, 16480.752788708178, 16637.084960327178, 17009.659806803793, 17071.146442677815, 17096.658066838594, 13731.24478153701, 13871.4451421943, 13895.444182232699, 14022.158670479805, 14104.365303561364, 3505.4040813061843, 3535.734819888519, 3537.7523573349877, 3546.184377593168, 3546.5034895114704, 125529.0, 125883.11175332377, 126373.36813315966, 127089.03030999782, 127909.36045319807, 8870.379073464925, 12896.161749486253, 12980.091393602357, 13010.349482525837, 13157.736845263042, 19328.226870925286, 19674.21303147858, 22882.42793930165, 24388.0, 24715.752842471346, 7600.771976840593, 7859.253370929752, 7864.882026769603, 7879.724209652634, 7879.881801772978, 3727.4781530585738, 3781.905452363713, 3797.9430308544843, 3819.694424446038, 3837.2901013312626, 4123.2165888481695, 4269.551697071763, 4271.209826182167, 4274.893127671771, 4275.743455392686, 885.2630600756157, 887.1882227761525, 923.6720964057797, 925.0656836595087, 926.2266007883493, 645.1612903225788, 645.3224114679567, 656.5502630697891, 663.5952069237761, 677.3328271652418, 10996.23026388161, 11866.0, 12024.0, 12076.637700868989, 12247.877521224673, 634.1312402009277, 640.0942666127471, 640.3596403596404, 649.389573800626, 660.9537332386783, 5405.324334458192, 5548.0, 5593.916091258634, 5600.187972744011, 5628.04323265046, 107609.46195268973, 109729.90270097356, 110345.0, 110670.46647667585, 112661.0, 93151.0, 94591.0, 96157.51921240489, 96487.51756241314, 97632.51183744035, 71806.64096679483, 73033.26966730371, 76742.0, 78435.99999999886, 79931.0, 11368.94315528417, 11917.642470725892, 12268.0, 12451.750964980469, 12453.439595218419, 33167.83416082904, 35547.82226088853, 39892.401613975235, 41159.0, 41203.58796412117, 50651.493485064675, 50873.23690144725, 51087.0, 51254.0, 51474.0, 15980.440684575984, 16002.599935001717, 16114.194290285204, 16475.093869836794, 16588.66822663516, 17540.386086486913, 17610.295588176843, 18296.359627412978, 18355.724664130317, 18384.540386490444, 13985.790213146607, 15773.526794196192, 16437.0, 16915.407960721317, 17185.570360741083, 16347.59131021734, 16413.261403236644, 16845.494635160965, 17036.48890533286, 17166.570835729206, 15721.0, 16244.350225990827, 16255.756163657317, 16590.66818663644, 16760.0, 11784.351860647746, 11860.0, 12130.878691212974, 12187.720289369843, 12314.445849936596, 12893.419796109385, 13206.471741130246, 13236.801447978482, 13253.66865828362, 13257.734845303234], "value": 8226.560005090472, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 161.0, 148.0, 108.0, 109.0, 110.0, 108.0, 110.0, 110.0, 107.0], "value": 118.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 100.0, 145.0, 109.0, 106.0, 103.0, 107.0, 139.0, 139.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 181.0, 187.0, 186.0, 185.0, 186.0, 184.0, 186.0, 184.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 56.0, 59.0, 89.0, 75.0, 88.0, 70.0, 59.0, 81.0, 57.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 86.0, 71.0, 69.0, 69.0, 88.0, 70.0, 68.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 86.0, 84.0, 86.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 93.0, 94.0, 103.0, 107.0, 99.0, 93.0, 93.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 86.0, 84.0, 86.0, 87.0, 87.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 48.0, 46.0, 47.0, 49.0, 48.0, 47.0, 47.0, 48.0], "value": 47.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 67.0, 69.0, 63.0, 61.0, 59.0, 57.0, 60.0, 58.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 81.0, 84.0, 86.0, 81.0, 81.0, 83.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 134.0, 137.0, 148.0, 143.0, 136.0, 137.0, 175.0, 153.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 184.0, 184.0, 187.0, 189.0, 170.0, 183.0, 183.0, 184.0, 231.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 67.0, 69.0, 68.0, 68.0, 67.0, 67.0, 67.0], "value": 67.3, "unit": "score"}]}]} 16:53:22 INFO - Return code: 0 16:53:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:53:22 ERROR - # TBPL SUCCESS # 16:53:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:53:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:53:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:53:22 INFO - 2017-05-01 16:53:22.459 screenresolution[1656:10159] starting screenresolution argv=screenresolution get 16:53:22 INFO - 2017-05-01 16:53:22.462 screenresolution[1656:10159] Display 0: 1600x1200x32@60 16:53:22 INFO - 2017-05-01 16:53:22.468 screenresolution[1657:10162] starting screenresolution argv=screenresolution list 16:53:22 INFO - Available Modes on Display 0 16:53:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:53:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:53:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:53:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:53:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:53:22 INFO - Intel Iris: 16:53:22 INFO - Chipset Model: Intel Iris 16:53:22 INFO - Type: GPU 16:53:22 INFO - Bus: Built-In 16:53:22 INFO - VRAM (Dynamic, Max): 1536 MB 16:53:22 INFO - Vendor: Intel (0x8086) 16:53:22 INFO - Device ID: 0x0a2e 16:53:22 INFO - Revision ID: 0x0009 16:53:22 INFO - Displays: 16:53:22 INFO - Display: 16:53:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:53:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:53:22 INFO - Display Serial Number: 1600x1200 60 16:53:22 INFO - Main Display: Yes 16:53:22 INFO - Mirror: Off 16:53:22 INFO - Online: Yes 16:53:22 INFO - Rotation: Supported 16:53:22 INFO - Return code: 0 16:53:22 INFO - Running post-action listener: _resource_record_post_action 16:53:22 INFO - [mozharness: 2017-05-01 23:53:22.719280Z] Finished run-tests step (success) 16:53:22 INFO - Running post-run listener: _resource_record_post_run 16:53:22 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 39089664; Write bytes: 512553984; Read time: 251; Write time: 1583 16:53:22 INFO - TinderboxPrint: CPU usage
53.3% 16:53:22 INFO - TinderboxPrint: I/O read bytes / time
39,089,664 / 251 16:53:22 INFO - TinderboxPrint: I/O write bytes / time
512,553,984 / 1,583 16:53:22 INFO - TinderboxPrint: CPU idle
2,241.4 (46.7%) 16:53:22 INFO - TinderboxPrint: CPU system
955.8 (19.9%) 16:53:22 INFO - TinderboxPrint: CPU user
1,604.5 (33.4%) 16:53:22 INFO - TinderboxPrint: Swap in / out
247,021,568 / 0 16:53:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195131904; Write bytes: 195151872; Read time: 15341; Write time: 406 16:53:22 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 38049280; Write bytes: 300510208; Read time: 236; Write time: 1124 16:53:23 INFO - Running post-run listener: _upload_blobber_files 16:53:23 INFO - Blob upload gear active. 16:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:53:23 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 16:53:23 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:53:23 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:53:23 INFO - (blobuploader) - INFO - Open directory for files ... 16:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:24 INFO - (blobuploader) - INFO - Done attempting. 16:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:25 INFO - (blobuploader) - INFO - Done attempting. 16:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:26 INFO - (blobuploader) - INFO - Done attempting. 16:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:28 INFO - (blobuploader) - INFO - Done attempting. 16:53:28 INFO - (blobuploader) - INFO - Iteration through files over. 16:53:28 INFO - Return code: 0 16:53:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:53:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:53:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/fb06b5f8c4cedba00ff951460f75e02adf9cfc95130751f69be423b3b586bf9c43d65b69cb3a07d9bbc7ab5f9f73e817808b6301915e90adebeb82910b5d07ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5c5238783cc2cbc3c3844829d7c55eea9a2f4c4d9f7bbb413d29fae2c86307b4590e93284c3e03f6e6b47ae4d0259ae462a19544197a4b62c64962db62387be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5fdabae535f15dd3c740dc368027dfbf6ff61caf7c297e922af708757324530b2bd996683a438b47683828b0055009d593b62d55405818c552543050da7995f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/85c369809a6cb43f8547f071a098ecf626019cf37dd67096a60056c321f3803152e14a9611e86f47e254f1f90086575a053187deb77b4b1a1ce3dbb78b99e2cf"} 16:53:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:53:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:53:28 INFO - Contents: 16:53:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/fb06b5f8c4cedba00ff951460f75e02adf9cfc95130751f69be423b3b586bf9c43d65b69cb3a07d9bbc7ab5f9f73e817808b6301915e90adebeb82910b5d07ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5c5238783cc2cbc3c3844829d7c55eea9a2f4c4d9f7bbb413d29fae2c86307b4590e93284c3e03f6e6b47ae4d0259ae462a19544197a4b62c64962db62387be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5fdabae535f15dd3c740dc368027dfbf6ff61caf7c297e922af708757324530b2bd996683a438b47683828b0055009d593b62d55405818c552543050da7995f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/85c369809a6cb43f8547f071a098ecf626019cf37dd67096a60056c321f3803152e14a9611e86f47e254f1f90086575a053187deb77b4b1a1ce3dbb78b99e2cf"} 16:53:28 INFO - Running post-run listener: copy_logs_to_upload_dir 16:53:28 INFO - Copying logs to upload dir... 16:53:28 INFO - mkdir: /builds/slave/test/build/upload/logs 16:53:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.148731 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-05-01 16:53:28.432281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-05-01 16:53:28.436433) ========= 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.iKmKDh0JfH/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.xy6h25QrPB/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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/Pine/sha512/fb06b5f8c4cedba00ff951460f75e02adf9cfc95130751f69be423b3b586bf9c43d65b69cb3a07d9bbc7ab5f9f73e817808b6301915e90adebeb82910b5d07ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5c5238783cc2cbc3c3844829d7c55eea9a2f4c4d9f7bbb413d29fae2c86307b4590e93284c3e03f6e6b47ae4d0259ae462a19544197a4b62c64962db62387be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5fdabae535f15dd3c740dc368027dfbf6ff61caf7c297e922af708757324530b2bd996683a438b47683828b0055009d593b62d55405818c552543050da7995f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/85c369809a6cb43f8547f071a098ecf626019cf37dd67096a60056c321f3803152e14a9611e86f47e254f1f90086575a053187deb77b4b1a1ce3dbb78b99e2cf"} build_url:https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/CMUWwzgnQOOymBOYUletgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/fb06b5f8c4cedba00ff951460f75e02adf9cfc95130751f69be423b3b586bf9c43d65b69cb3a07d9bbc7ab5f9f73e817808b6301915e90adebeb82910b5d07ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5c5238783cc2cbc3c3844829d7c55eea9a2f4c4d9f7bbb413d29fae2c86307b4590e93284c3e03f6e6b47ae4d0259ae462a19544197a4b62c64962db62387be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5fdabae535f15dd3c740dc368027dfbf6ff61caf7c297e922af708757324530b2bd996683a438b47683828b0055009d593b62d55405818c552543050da7995f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/85c369809a6cb43f8547f071a098ecf626019cf37dd67096a60056c321f3803152e14a9611e86f47e254f1f90086575a053187deb77b4b1a1ce3dbb78b99e2cf"}' ========= master_lag: 1.71 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-05-01 16:53:30.154272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 16:53:30.154602) ========= 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.iKmKDh0JfH/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.xy6h25QrPB/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.005410 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 16:53:30.193962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 16:53:30.194272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 16:53:30.194769) ========= ========= Total master_lag: 1.73 =========