builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1493069098.55 results: success (0) buildid: 20170424081926 builduid: 2e64723bad2248bc812a9e6908a27ddb revision: 0bee350a1c5dc4aaece2bd3d2947c45e88d4a045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.551646) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.552148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.552470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.580286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.580719) ========= 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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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-04-24 14:24:58-- 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% 23.9M=0s 2017-04-24 14:24:58 (23.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124651 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.731020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.731402) ========= 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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.031106 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:24:58.786495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 14:24:58.787067) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 0bee350a1c5dc4aaece2bd3d2947c45e88d4a045 --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 0bee350a1c5dc4aaece2bd3d2947c45e88d4a045 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pe2z4TpO21/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.jw9lHzaGTC/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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-04-24 14:24:58,897 truncating revision to first 12 chars 2017-04-24 14:24:58,897 Setting DEBUG logging. 2017-04-24 14:24:58,897 attempt 1/10 2017-04-24 14:24:58,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/0bee350a1c5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 14:25:00,834 unpacking tar archive at: pine-0bee350a1c5d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.214922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 14:25:01.026970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 14:25:01.027292) ========= script_repo_revision: 0bee350a1c5dc4aaece2bd3d2947c45e88d4a045 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 14:25:01.027690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 14:25:01.027956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 14:25:01.048439) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-24 14:25:01.048813) ========= /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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:25:01 INFO - MultiFileLogger online at 20170424 14:25:01 in /builds/slave/test 14:25:01 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 14:25:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:25:01 INFO - {'append_to_log': False, 14:25:01 INFO - 'base_work_dir': '/builds/slave/test', 14:25:01 INFO - 'blob_upload_branch': 'Pine', 14:25:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:25:01 INFO - 'branch': 'Pine', 14:25:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:25:01 INFO - 'config_files': ('talos/mac_config.py',), 14:25:01 INFO - 'default_actions': ('clobber', 14:25:01 INFO - 'read-buildbot-config', 14:25:01 INFO - 'download-and-extract', 14:25:01 INFO - 'populate-webroot', 14:25:01 INFO - 'create-virtualenv', 14:25:01 INFO - 'install', 14:25:01 INFO - 'run-tests'), 14:25:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:25:01 INFO - 'download_minidump_stackwalk': True, 14:25:01 INFO - 'download_symbols': 'ondemand', 14:25:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:25:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:25:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:25:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:25:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:25:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:25:01 INFO - 'gecko_profile': False, 14:25:01 INFO - 'gecko_profile_interval': 0, 14:25:01 INFO - 'installer_path': 'installer.exe', 14:25:01 INFO - 'log_level': 'info', 14:25:01 INFO - 'log_name': 'talos', 14:25:01 INFO - 'log_to_console': True, 14:25:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:25:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:25:01 INFO - 'opt_config_files': (), 14:25:01 INFO - 'pip_index': False, 14:25:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:25:01 INFO - 'cmd': ('bash', 14:25:01 INFO - '-c', 14:25:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:25:01 INFO - 'enabled': True, 14:25:01 INFO - 'halt_on_failure': False, 14:25:01 INFO - 'name': 'check_screen_resolution'},), 14:25:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:25:01 INFO - 'cmd': ('bash', 14:25:01 INFO - '-c', 14:25:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:25:01 INFO - 'enabled': True, 14:25:01 INFO - 'halt_on_failure': False, 14:25:01 INFO - 'name': 'check_screen_resolution'},), 14:25:01 INFO - 'run_cmd_checks_enabled': True, 14:25:01 INFO - 'suite': 'dromaeojs', 14:25:01 INFO - 'system_bits': '32', 14:25:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:25:01 INFO - 'title': 't-yosemite-r7-0263', 14:25:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:25:01 INFO - 'use_talos_json': True, 14:25:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:25:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:25:01 INFO - 'work_dir': 'build'} 14:25:01 INFO - [mozharness: 2017-04-24 21:25:01.264081Z] Running clobber step. 14:25:01 INFO - Running pre-action listener: _resource_record_pre_action 14:25:01 INFO - Running main action method: clobber 14:25:01 INFO - rmtree: /builds/slave/test/build 14:25:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - [mozharness: 2017-04-24 21:25:03.677063Z] Finished clobber step (success) 14:25:03 INFO - [mozharness: 2017-04-24 21:25:03.677198Z] Running read-buildbot-config step. 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running main action method: read_buildbot_config 14:25:03 INFO - Using buildbot properties: 14:25:03 INFO - { 14:25:03 INFO - "project": "", 14:25:03 INFO - "product": "firefox", 14:25:03 INFO - "script_repo_revision": "default", 14:25:03 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 14:25:03 INFO - "repository": "", 14:25:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 14:25:03 INFO - "buildid": "20170424081926", 14:25:03 INFO - "pgo_build": "False", 14:25:03 INFO - "basedir": "/builds/slave/test", 14:25:03 INFO - "buildnumber": 7, 14:25:03 INFO - "slavename": "t-yosemite-r7-0263", 14:25:03 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:25:03 INFO - "platform": "yosemite_r7", 14:25:03 INFO - "scheduler": "tests-pine-macosx64-talos", 14:25:03 INFO - "branch": "pine", 14:25:03 INFO - "repo_path": "projects/pine", 14:25:03 INFO - "revision": "0bee350a1c5dc4aaece2bd3d2947c45e88d4a045", 14:25:03 INFO - "stage_platform": "macosx64", 14:25:03 INFO - "builduid": "2e64723bad2248bc812a9e6908a27ddb", 14:25:03 INFO - "slavebuilddir": "test" 14:25:03 INFO - } 14:25:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - [mozharness: 2017-04-24 21:25:03.680551Z] Finished read-buildbot-config step (success) 14:25:03 INFO - [mozharness: 2017-04-24 21:25:03.680668Z] Running download-and-extract step. 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running main action method: download_and_extract 14:25:03 INFO - mkdir: /builds/slave/test/build/tests 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - trying https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:25:03 INFO - Downloading https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/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 14:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/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 14:25:04 INFO - Downloaded 1325 bytes. 14:25:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:25:04 INFO - Using the following test package requirements: 14:25:04 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:25:04 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:25:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:25:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:25:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'jsshell-mac.zip'], 14:25:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:25:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:25:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:25:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:25:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:25:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:25:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:25:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:25:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:25:04 INFO - Fetch https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:25:05 INFO - Content-Length response header: 52524681 14:25:05 INFO - Bytes received: 52524681 14:25:22 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 14:25:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:25:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:25:22 INFO - Fetch https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:25:24 INFO - Content-Length response header: 52524681 14:25:24 INFO - Bytes received: 52524681 14:25:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:25:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:25:40 INFO - Fetch https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:25:41 INFO - Content-Length response header: 14408822 14:25:41 INFO - Bytes received: 14408822 14:25: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')]} 14:25:41 INFO - trying https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:25:41 INFO - Downloading https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/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 14:25:43 INFO - Downloaded 71175253 bytes. 14:25:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:25:43 INFO - mkdir: /builds/slave/test/properties 14:25:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:25:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:25:43 INFO - Contents: 14:25:43 INFO - build_url:https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:25:44 INFO - Running post-action listener: _resource_record_post_action 14:25:44 INFO - Running post-action listener: set_extra_try_arguments 14:25:44 INFO - [mozharness: 2017-04-24 21:25:44.295357Z] Finished download-and-extract step (success) 14:25:44 INFO - [mozharness: 2017-04-24 21:25:44.295512Z] Running populate-webroot step. 14:25:44 INFO - Running pre-action listener: _resource_record_pre_action 14:25:44 INFO - Running main action method: populate_webroot 14:25:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:25:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:25:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:25:44 INFO - '--tppagecycles', 14:25:44 INFO - '7'], 14:25:44 INFO - 'tests': ['tsvgm']}}, 14:25:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:25:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:25:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:25:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:25:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:25:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['damp', 'tps']}, 14:25:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'tests': ['damp', 'tps']}, 14:25:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['dromaeo_dom']}, 14:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:25:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:25:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['a11yr', 14:25:44 INFO - 'ts_paint', 14:25:44 INFO - 'tpaint', 14:25:44 INFO - 'sessionrestore', 14:25:44 INFO - 'sessionrestore_no_auto_restore', 14:25:44 INFO - 'tabpaint']}, 14:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:25:44 INFO - 'ts_paint', 14:25:44 INFO - 'tpaint', 14:25:44 INFO - 'sessionrestore', 14:25:44 INFO - 'sessionrestore_no_auto_restore', 14:25:44 INFO - 'tabpaint']}, 14:25:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:25:44 INFO - 'ts_paint', 14:25:44 INFO - 'tpaint', 14:25:44 INFO - 'sessionrestore', 14:25:44 INFO - 'sessionrestore_no_auto_restore', 14:25:44 INFO - 'tabpaint']}, 14:25:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:25:44 INFO - 'ts_paint', 14:25:44 INFO - 'tpaint', 14:25:44 INFO - 'sessionrestore', 14:25:44 INFO - 'sessionrestore_no_auto_restore', 14:25:44 INFO - 'tabpaint']}, 14:25:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['a11yr', 14:25:44 INFO - 'ts_paint', 14:25:44 INFO - 'tpaint', 14:25:44 INFO - 'sessionrestore', 14:25:44 INFO - 'sessionrestore_no_auto_restore', 14:25:44 INFO - 'tabpaint']}, 14:25:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['a11yr', 14:25:44 INFO - 'ts_paint', 14:25:44 INFO - 'tpaint', 14:25:44 INFO - 'sessionrestore', 14:25:44 INFO - 'sessionrestore_no_auto_restore', 14:25:44 INFO - 'tabpaint']}, 14:25:44 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:25:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:25:44 INFO - 'bloom_basic_ref']}, 14:25:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['tsvgx', 14:25:44 INFO - 'tsvgr_opacity', 14:25:44 INFO - 'tart', 14:25:44 INFO - 'tscrollx', 14:25:44 INFO - 'cart', 14:25:44 INFO - 'tsvg_static']}, 14:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:25:44 INFO - 'tsvgr_opacity', 14:25:44 INFO - 'tart', 14:25:44 INFO - 'tscrollx', 14:25:44 INFO - 'cart', 14:25:44 INFO - 'tsvg_static']}, 14:25:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'talos_options': ['--disable-e10s'], 14:25:44 INFO - 'tests': ['tp5o']}, 14:25:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:25:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'talos_options': ['--disable-e10s', 14:25:44 INFO - '--xperf_path', 14:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:25:44 INFO - 'tests': ['tp5n']}, 14:25:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:25:44 INFO - 'talos_options': ['--xperf_path', 14:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:25:44 INFO - 'tests': ['tp5n']}}, 14:25:44 INFO - 'talos.zip': {'path': '', 14:25:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:25:44 INFO - Running post-action listener: _resource_record_post_action 14:25:44 INFO - [mozharness: 2017-04-24 21:25:44.314725Z] Finished populate-webroot step (success) 14:25:44 INFO - [mozharness: 2017-04-24 21:25:44.314852Z] Running create-virtualenv step. 14:25:44 INFO - Running pre-action listener: _resource_record_pre_action 14:25:44 INFO - Running main action method: create_virtualenv 14:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:25:44 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 14:25:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:25:44 INFO - Using real prefix '/tools/python27' 14:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 14:25:48 INFO - Installing pip.................done. 14:25:48 INFO - Return code: 0 14:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:25:48 INFO - Reading from file tmpfile_stdout 14:25:48 INFO - Output received: 14:25:48 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) 14:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:48 INFO - 'HOME': '/Users/cltbld', 14:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:48 INFO - 'LOGNAME': 'cltbld', 14:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:48 INFO - 'MOZ_NO_REMOTE': '1', 14:25:48 INFO - 'NO_EM_RESTART': '1', 14:25:48 INFO - 'PAGER': '/bin/cat', 14:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:48 INFO - 'PWD': '/builds/slave/test', 14:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:48 INFO - 'SHELL': '/bin/bash', 14:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:25:48 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:48 INFO - 'USER': 'cltbld', 14:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:48 INFO - 'XPC_FLAGS': '0x0', 14:25:48 INFO - 'XPC_SERVICE_NAME': '0', 14:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:48 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 14:25:48 INFO - Cleaning up... 14:25:48 INFO - Return code: 0 14:25:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:48 INFO - 'HOME': '/Users/cltbld', 14:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:48 INFO - 'LOGNAME': 'cltbld', 14:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:48 INFO - 'MOZ_NO_REMOTE': '1', 14:25:48 INFO - 'NO_EM_RESTART': '1', 14:25:48 INFO - 'PAGER': '/bin/cat', 14:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:48 INFO - 'PWD': '/builds/slave/test', 14:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:48 INFO - 'SHELL': '/bin/bash', 14:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:25:48 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:48 INFO - 'USER': 'cltbld', 14:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:48 INFO - 'XPC_FLAGS': '0x0', 14:25:48 INFO - 'XPC_SERVICE_NAME': '0', 14:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:48 INFO - Downloading/unpacking psutil>=3.1.1 14:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:52 INFO - Installing collected packages: psutil 14:25:52 INFO - Running setup.py install for psutil 14:25:52 INFO - building 'psutil._psutil_osx' extension 14:25:52 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 14:25:52 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 14:25:53 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 14:25:53 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 14:25:53 INFO - building 'psutil._psutil_posix' extension 14:25:53 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 14:25:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:25:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:25:53 INFO - ^ 14:25:53 INFO - 1 warning generated. 14:25:53 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 14:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:53 INFO - Successfully installed psutil 14:25:53 INFO - Cleaning up... 14:25:53 INFO - Return code: 0 14:25:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:25: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')]} 14:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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')]} 14:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:25: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 mozsystemmonitor==0.3 14:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:53 INFO - 'HOME': '/Users/cltbld', 14:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:53 INFO - 'LOGNAME': 'cltbld', 14:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:53 INFO - 'MOZ_NO_REMOTE': '1', 14:25:53 INFO - 'NO_EM_RESTART': '1', 14:25:53 INFO - 'PAGER': '/bin/cat', 14:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:53 INFO - 'PWD': '/builds/slave/test', 14:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:53 INFO - 'SHELL': '/bin/bash', 14:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:25:53 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:53 INFO - 'USER': 'cltbld', 14:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:53 INFO - 'XPC_FLAGS': '0x0', 14:25:53 INFO - 'XPC_SERVICE_NAME': '0', 14:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:25:56 INFO - Installing collected packages: mozsystemmonitor 14:25:56 INFO - Running setup.py install for mozsystemmonitor 14:25:56 INFO - Successfully installed mozsystemmonitor 14:25:56 INFO - Cleaning up... 14:25:56 INFO - Return code: 0 14:25:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:57 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')]} 14:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:57 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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:25:57 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 14:25:57 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 14:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:57 INFO - 'HOME': '/Users/cltbld', 14:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:57 INFO - 'LOGNAME': 'cltbld', 14:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:57 INFO - 'MOZ_NO_REMOTE': '1', 14:25:57 INFO - 'NO_EM_RESTART': '1', 14:25:57 INFO - 'PAGER': '/bin/cat', 14:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:57 INFO - 'PWD': '/builds/slave/test', 14:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:57 INFO - 'SHELL': '/bin/bash', 14:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:25:57 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:57 INFO - 'USER': 'cltbld', 14:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:57 INFO - 'XPC_FLAGS': '0x0', 14:25:57 INFO - 'XPC_SERVICE_NAME': '0', 14:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:57 INFO - Downloading/unpacking jsonschema==2.5.1 14:25:57 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 14:25:57 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 14:25:57 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 14:25:57 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 14:25:57 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 14:25:57 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 14:26:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:26:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:26:01 INFO - warning: no files found matching '*.txt' 14:26:01 INFO - no previously-included directories found matching 'build' 14:26:01 INFO - no previously-included directories found matching 'dist' 14:26:01 INFO - no previously-included directories found matching '.git*' 14:26:01 INFO - Installing collected packages: jsonschema, functools32 14:26:01 INFO - Running setup.py install for functools32 14:26:01 INFO - warning: no files found matching '*.txt' 14:26:01 INFO - no previously-included directories found matching 'build' 14:26:01 INFO - no previously-included directories found matching 'dist' 14:26:01 INFO - no previously-included directories found matching '.git*' 14:26:01 INFO - Successfully installed jsonschema functools32 14:26:01 INFO - Cleaning up... 14:26:01 INFO - Return code: 0 14:26:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:01 INFO - 'HOME': '/Users/cltbld', 14:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:01 INFO - 'LOGNAME': 'cltbld', 14:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:01 INFO - 'MOZ_NO_REMOTE': '1', 14:26:01 INFO - 'NO_EM_RESTART': '1', 14:26:01 INFO - 'PAGER': '/bin/cat', 14:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:01 INFO - 'PWD': '/builds/slave/test', 14:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:01 INFO - 'SHELL': '/bin/bash', 14:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:01 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:01 INFO - 'USER': 'cltbld', 14:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:01 INFO - 'XPC_FLAGS': '0x0', 14:26:01 INFO - 'XPC_SERVICE_NAME': '0', 14:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:26:01 INFO - Cleaning up... 14:26:01 INFO - Return code: 0 14:26:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:01 INFO - 'HOME': '/Users/cltbld', 14:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:01 INFO - 'LOGNAME': 'cltbld', 14:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:01 INFO - 'MOZ_NO_REMOTE': '1', 14:26:01 INFO - 'NO_EM_RESTART': '1', 14:26:01 INFO - 'PAGER': '/bin/cat', 14:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:01 INFO - 'PWD': '/builds/slave/test', 14:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:01 INFO - 'SHELL': '/bin/bash', 14:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:01 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:01 INFO - 'USER': 'cltbld', 14:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:01 INFO - 'XPC_FLAGS': '0x0', 14:26:01 INFO - 'XPC_SERVICE_NAME': '0', 14:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:26: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 14:26: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 14:26: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 14:26: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 14:26: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 14:26: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 14:26:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:26:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:26:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:26: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 14:26: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 14:26: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 14:26: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 14:26: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 14:26: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 14:26:05 INFO - Downloading docopt-0.6.1.tar.gz 14:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:26:06 INFO - Installing collected packages: blobuploader, requests, docopt 14:26:06 INFO - Running setup.py install for blobuploader 14:26:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:26:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:26:06 INFO - Running setup.py install for requests 14:26:06 INFO - Running setup.py install for docopt 14:26:06 INFO - Successfully installed blobuploader requests docopt 14:26:06 INFO - Cleaning up... 14:26:06 INFO - Return code: 0 14:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:06 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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:26:06 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 14:26:06 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 14:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:06 INFO - 'HOME': '/Users/cltbld', 14:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:06 INFO - 'LOGNAME': 'cltbld', 14:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:06 INFO - 'MOZ_NO_REMOTE': '1', 14:26:06 INFO - 'NO_EM_RESTART': '1', 14:26:06 INFO - 'PAGER': '/bin/cat', 14:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:06 INFO - 'PWD': '/builds/slave/test', 14:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:06 INFO - 'SHELL': '/bin/bash', 14:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:06 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:06 INFO - 'USER': 'cltbld', 14:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:06 INFO - 'XPC_FLAGS': '0x0', 14:26:06 INFO - 'XPC_SERVICE_NAME': '0', 14:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Lj8GSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-XhrvUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-wyc4f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Fj1Spp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-B5dZjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-CzFq3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-14mxM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-88RlZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:26:07 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-9kRwvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-fFgTQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-T5WmOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-aH1X1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-v4U1wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-lgr2_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-hWiewf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-srbLHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:26:08 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-BWfVHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:26:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:26:08 INFO - Running setup.py install for manifestparser 14:26:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:26:09 INFO - Running setup.py install for mozcrash 14:26:09 INFO - Running setup.py install for mozdebug 14:26:09 INFO - Running setup.py install for mozdevice 14:26:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:26:09 INFO - Running setup.py install for mozfile 14:26:09 INFO - Running setup.py install for mozhttpd 14:26:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:26:09 INFO - Running setup.py install for mozinfo 14:26:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:26:09 INFO - Running setup.py install for mozInstall 14:26:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Running setup.py install for mozleak 14:26:10 INFO - Running setup.py install for mozlog 14:26:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Running setup.py install for moznetwork 14:26:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Running setup.py install for mozprocess 14:26:10 INFO - Running setup.py install for mozprofile 14:26:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:26:10 INFO - Running setup.py install for mozrunner 14:26:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:26:11 INFO - Running setup.py install for mozscreenshot 14:26:11 INFO - Running setup.py install for moztest 14:26:11 INFO - Running setup.py install for mozversion 14:26:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:26:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:26:11 INFO - Cleaning up... 14:26:11 INFO - Return code: 0 14:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:11 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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:26:11 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 14:26:11 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 14:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:11 INFO - 'HOME': '/Users/cltbld', 14:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:11 INFO - 'LOGNAME': 'cltbld', 14:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:11 INFO - 'MOZ_NO_REMOTE': '1', 14:26:11 INFO - 'NO_EM_RESTART': '1', 14:26:11 INFO - 'PAGER': '/bin/cat', 14:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:11 INFO - 'PWD': '/builds/slave/test', 14:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:11 INFO - 'SHELL': '/bin/bash', 14:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:11 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:11 INFO - 'USER': 'cltbld', 14:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:11 INFO - 'XPC_FLAGS': '0x0', 14:26:11 INFO - 'XPC_SERVICE_NAME': '0', 14:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:26:11 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-nTpDQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:26:11 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)) 14:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:26:11 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-vrmEQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:26:11 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)) 14:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-SwiZ0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-IuzEa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-IxveUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-N_MyFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pbcAwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-uERB3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-1rO3_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-EOELcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-7pRLSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:26:12 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)) 14:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:26:12 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-_O9Euo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:26:13 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)) 14:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:26:13 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ta8Z5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:26:13 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)) 14:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:26:13 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NLVseP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:26:13 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)) 14:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:13 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-EgLsft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:13 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)) 14:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:26:13 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-5xIMiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:26:13 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)) 14:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:26:13 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-TjQQED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:26:13 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)) 14:26:13 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)) 14:26:13 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)) 14:26:13 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)) 14:26:13 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)) 14:26:13 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)) 14:26:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:26:13 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 14:26:13 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 14:26:13 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 14:26:13 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 14:26:13 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 14:26:13 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 14:26:16 INFO - Downloading blessings-1.6.tar.gz 14:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:26:16 INFO - Installing collected packages: blessings 14:26:16 INFO - Running setup.py install for blessings 14:26:16 INFO - Successfully installed blessings 14:26:16 INFO - Cleaning up... 14:26:16 INFO - Return code: 0 14:26:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:26:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:26:16 INFO - Reading from file tmpfile_stdout 14:26:16 INFO - Current package versions: 14:26:16 INFO - blessings == 1.6 14:26:16 INFO - blobuploader == 1.2.4 14:26:16 INFO - docopt == 0.6.1 14:26:16 INFO - functools32 == 3.2.3-2 14:26:16 INFO - jsonschema == 2.5.1 14:26:16 INFO - manifestparser == 1.1 14:26:16 INFO - mozInstall == 1.12 14:26:16 INFO - mozcrash == 1.0 14:26:16 INFO - mozdebug == 0.1 14:26:16 INFO - mozdevice == 0.50 14:26:16 INFO - mozfile == 1.2 14:26:16 INFO - mozhttpd == 0.7 14:26:16 INFO - mozinfo == 0.9 14:26:16 INFO - mozleak == 0.1 14:26:16 INFO - mozlog == 3.4 14:26:16 INFO - moznetwork == 0.27 14:26:16 INFO - mozprocess == 0.25 14:26:16 INFO - mozprofile == 0.28 14:26:16 INFO - mozrunner == 6.13 14:26:16 INFO - mozscreenshot == 0.1 14:26:16 INFO - mozsystemmonitor == 0.3 14:26:16 INFO - moztest == 0.8 14:26:16 INFO - mozversion == 1.4 14:26:16 INFO - psutil == 3.1.1 14:26:16 INFO - requests == 1.2.3 14:26:16 INFO - wsgiref == 0.1.2 14:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:16 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 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:26:16 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 14:26:16 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 14:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:16 INFO - 'HOME': '/Users/cltbld', 14:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:16 INFO - 'LOGNAME': 'cltbld', 14:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:16 INFO - 'MOZ_NO_REMOTE': '1', 14:26:16 INFO - 'NO_EM_RESTART': '1', 14:26:16 INFO - 'PAGER': '/bin/cat', 14:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:16 INFO - 'PWD': '/builds/slave/test', 14:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:16 INFO - 'SHELL': '/bin/bash', 14:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:16 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:16 INFO - 'USER': 'cltbld', 14:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:16 INFO - 'XPC_FLAGS': '0x0', 14:26:16 INFO - 'XPC_SERVICE_NAME': '0', 14:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 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)) 14:26:17 INFO - Cleaning up... 14:26:17 INFO - Return code: 0 14:26:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97c245c290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, '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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 14:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:26:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:17 INFO - 'HOME': '/Users/cltbld', 14:26:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:17 INFO - 'LOGNAME': 'cltbld', 14:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:17 INFO - 'MOZ_NO_REMOTE': '1', 14:26:17 INFO - 'NO_EM_RESTART': '1', 14:26:17 INFO - 'PAGER': '/bin/cat', 14:26:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:17 INFO - 'PWD': '/builds/slave/test', 14:26:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:17 INFO - 'SHELL': '/bin/bash', 14:26:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:17 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:17 INFO - 'USER': 'cltbld', 14:26:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:17 INFO - 'XPC_FLAGS': '0x0', 14:26:17 INFO - 'XPC_SERVICE_NAME': '0', 14:26:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:26:17 INFO - Cleaning up... 14:26:17 INFO - Return code: 0 14:26:17 INFO - Running post-action listener: _resource_record_post_action 14:26:17 INFO - Running post-action listener: _start_resource_monitoring 14:26:17 INFO - Starting resource monitoring. 14:26:17 INFO - [mozharness: 2017-04-24 21:26:17.331175Z] Finished create-virtualenv step (success) 14:26:17 INFO - [mozharness: 2017-04-24 21:26:17.332210Z] Running install step. 14:26:17 INFO - Running pre-action listener: _resource_record_pre_action 14:26:17 INFO - Running main action method: install 14:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:26:17 INFO - Reading from file tmpfile_stdout 14:26:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:26:17 INFO - Reading from file tmpfile_stdout 14:26:17 INFO - Output received: 14:26:17 INFO - Usage: mozinstall [options] installer 14:26:17 INFO - Options: 14:26:17 INFO - -h, --help show this help message and exit 14:26:17 INFO - -d DEST, --destination=DEST 14:26:17 INFO - Directory to install application into. [default: 14:26:17 INFO - "/builds/slave/test"] 14:26:17 INFO - --app=APP Application being installed. [default: firefox] 14:26:17 INFO - mkdir: /builds/slave/test/build/application 14:26:17 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'] 14:26:17 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 14:26:38 INFO - Reading from file tmpfile_stdout 14:26:38 INFO - Output received: 14:26:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:26:38 INFO - Running post-action listener: _resource_record_post_action 14:26:38 INFO - [mozharness: 2017-04-24 21:26:38.095052Z] Finished install step (success) 14:26:38 INFO - [mozharness: 2017-04-24 21:26:38.095195Z] Running run-tests step. 14:26:38 INFO - Running pre-action listener: _resource_record_pre_action 14:26:38 INFO - Running main action method: run_tests 14:26:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:26:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:26:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:26:38 INFO - 2017-04-24 14:26:38.110 screenresolution[1627:7611] starting screenresolution argv=screenresolution get 14:26:38 INFO - 2017-04-24 14:26:38.112 screenresolution[1627:7611] Display 0: 1600x1200x32@60 14:26:38 INFO - 2017-04-24 14:26:38.118 screenresolution[1628:7613] starting screenresolution argv=screenresolution list 14:26:38 INFO - Available Modes on Display 0 14:26:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:26:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:26:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:26:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:26:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:26:38 INFO - Intel Iris: 14:26:38 INFO - Chipset Model: Intel Iris 14:26:38 INFO - Type: GPU 14:26:38 INFO - Bus: Built-In 14:26:38 INFO - VRAM (Dynamic, Max): 1536 MB 14:26:38 INFO - Vendor: Intel (0x8086) 14:26:38 INFO - Device ID: 0x0a2e 14:26:38 INFO - Revision ID: 0x0009 14:26:38 INFO - Displays: 14:26:38 INFO - Display: 14:26:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:26:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:26:38 INFO - Display Serial Number: 1600x1200 60 14:26:38 INFO - Main Display: Yes 14:26:38 INFO - Mirror: Off 14:26:38 INFO - Online: Yes 14:26:38 INFO - Rotation: Supported 14:26:38 INFO - Return code: 0 14:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:26:38 INFO - Python 2.7.3 14:26:38 INFO - Return code: 0 14:26:38 INFO - grabbing minidump binary from tooltool 14:26:38 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')]} 14:26:38 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 0x10bb4fd30>, '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 0x10ba75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:26:38 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 14:26:38 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 14:26:38 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 14:26:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:26:38 INFO - Return code: 0 14:26:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:26:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:26:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:26:38 INFO - ENV: RUST_BACKTRACE is now 1 14:26:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:26:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:26:38 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/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 14:26:38 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/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 14:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pe2z4TpO21/Render', 14:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:38 INFO - 'HOME': '/Users/cltbld', 14:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:38 INFO - 'LOGNAME': 'cltbld', 14:26:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:26:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:38 INFO - 'MOZ_NO_REMOTE': '1', 14:26:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:26:38 INFO - 'NO_EM_RESTART': '1', 14:26:38 INFO - 'PAGER': '/bin/cat', 14:26:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:38 INFO - 'PWD': '/builds/slave/test', 14:26:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:38 INFO - 'RUST_BACKTRACE': '1', 14:26:38 INFO - 'SHELL': '/bin/bash', 14:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jw9lHzaGTC/Listeners', 14:26:38 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 14:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:38 INFO - 'USER': 'cltbld', 14:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:38 INFO - 'XPC_FLAGS': '0x0', 14:26:38 INFO - 'XPC_SERVICE_NAME': '0', 14:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:38 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/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 14:26:38 INFO - mozversion application_buildid: 20170424081926 14:26:38 INFO - mozversion application_changeset: 0bee350a1c5dc4aaece2bd3d2947c45e88d4a045 14:26:38 INFO - mozversion application_display_name: Nightly 14:26:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:26:38 INFO - mozversion application_name: Firefox 14:26:38 INFO - mozversion application_remotingname: firefox 14:26:38 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 14:26:38 INFO - mozversion application_vendor: Mozilla 14:26:38 INFO - mozversion application_version: 55.0a1 14:26:38 INFO - mozversion platform_buildid: 20170424081926 14:26:38 INFO - mozversion platform_changeset: 0bee350a1c5dc4aaece2bd3d2947c45e88d4a045 14:26:38 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 14:26:38 INFO - mozversion platform_version: 55.0a1 14:26:38 INFO - using testdate: 1493069198 14:26:38 INFO - actual date: 1493069198 14:26:38 INFO - starting webserver on 'localhost:49242' 14:26:38 INFO - SUITE-START | Running 2 tests 14:26:38 INFO - TEST-START | dromaeo_css 14:26:38 INFO - operating with platform_type : mac_ 14:26:38 INFO - Initialising browser for dromaeo_css test... 14:26:38 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp_umxQ5/profile http://localhost:49242/getInfo.html) 14:26:41 INFO - PID 1638 | __metrics Screen width/height:1600/1200 14:26:41 INFO - PID 1638 | colorDepth:24 14:26:41 INFO - PID 1638 | Browser inner width/height: 1024/689 14:26:41 INFO - PID 1638 | __metrics 14:26:41 INFO - PID 1638 | 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" 14:26:41 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:26:42 INFO - TEST-INFO | 1638: exit 0 14:26:42 INFO - Browser initialized. 14:26:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:26:42 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp_umxQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:54 INFO - PID 1639 | RSS: Main: 243978240 14:26:54 INFO - PID 1639 | 14:29:59 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:30:01 INFO - PID 1639 | RSS: Main: 415883264 14:30:01 INFO - PID 1639 | 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:31:43 INFO - PID 1639 | 14:31:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:31:43 INFO - PID 1639 | Full stack: 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:31:43 INFO - PID 1639 | 14:31:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:31:43 INFO - PID 1639 | Full stack: 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:31:43 INFO - PID 1639 | 14:31:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:31:43 INFO - PID 1639 | Full stack: 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | ************************* 14:31:43 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 14:31:43 INFO - PID 1639 | 14:31:43 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:31:43 INFO - PID 1639 | Full stack: 14:31:43 INFO - PID 1639 | ************************* 14:33:03 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:33:04 INFO - PID 1639 | RSS: Main: 368992256 14:33:04 INFO - PID 1639 | 14:36:06 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:36:07 INFO - PID 1639 | RSS: Main: 341692416 14:36:07 INFO - PID 1639 | 14:39:09 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:39:10 INFO - PID 1639 | RSS: Main: 332734464 14:39:10 INFO - PID 1639 | 14:42:13 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:42:14 INFO - PID 1639 | RSS: Main: 339116032 14:42:14 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:45:16 INFO - PID 1639 | RSS: Main: 376614912 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | __start_tp_report 14:45:16 INFO - PID 1639 | _x_x_mozilla_page_load 14:45:16 INFO - PID 1639 | _x_x_mozilla_page_load_details 14:45:16 INFO - PID 1639 | |i|pagename|runs| 14:45:16 INFO - PID 1639 | |0;dojo.html;3440.8107554084513;3463.653634636535;3473.5484387029683;3478.6347433519486;3519.1729943463283;6077.361877002912;6097.4817140543055;6100.237470316205;6125.387461253872;6154.969225153879;6100.308687927425;6112.47308512808;6116.449519543251;6124.112003759452;6138.202033735619;4857.854264372057;5049.293098966147;5215.40022897366;5273.551748101416;5368.382635996852;5148.613853960949;5320.441353657869;5342.038433082043;5378.704171270579;5422.864428389283;5233.502817232356;5266.683998960037;5282.841514754564;5325.440828712968;5373.194020896858;5259.658122222081;5307.071262529042;5307.442718514539;5309.814156504543;5345.786168553292;5251.448597897204;5261.789528418897;5291.603129765283;5294.391145018334;5314.97342513285;5863.442972917566;5959.374265702126;5983.611065280743;6060.636361818261;6066.939330606681;6350.523710721668;6356.745730170787;6364.904526432108;6370.840728981766;6375.394337537927;6461;6477.514186435989;6487.22153341602;6488.578242414228;6492.156019717407;5999.370066143079;6052.485538729169;6071.362506936708;6136.417040381157;6138.754449822001;6369.458596019297;6435.549511534147;6536.967315163489;6670.166229221348;6680.365365290289;5316.441773613792;6267.5299352548745;6273.780417685359;6292.622442653455;6351.396617321347;6375.362463753588;6481.578697384749;6493.383128602775;6503.8699226015215;6530.967345163243;6237.064440333987;6325.019621958604;6377;6394.680265986775;6413.935860641427;6266.749330026748;6328.873422531524;6370.649614271259;6401.135846660642;6428.871422571616;5147.356580427447;5155.6391052626705;5156.96860627876;5177.792888284502;5183.403908550489;4620.19146649335;4620.8151673933335;4637.466691330473;4640.187967105743;4673.602743766818;5970.880582388328;6037.6679282639;6079.574429789872;6144.754209831557;6210.254769427697;6465.2564955030775;6473.190851143607;6517.967410162919;6531.281559028503;6534.673266336759;6140.508759299335;6163.476104531075;6172.290186628506;6174.289956655042;6175.104609831549;5499.257600223998;5638.661680299195;5645.2096706461125;5688.089905615082;5706.629069110494;6644.136262285969;6736.157980252468;6737.461003119836;6742.93257067423;6751.291114432914;6398.712057957497;6415.8396040097505;6416.358364163546;6423.518236132215;6427.83930401725;6353.205849268841;6583.868322633425;6609.735610575523;6639.302873198438;6654.434373078149;6189.690515474298;6336;6337.271213810471;6353.332900045613;6384.361563843579;6269.247690277196;6496.610203387811;6524.151860258136;6525.477961763143;6532.248791389051;6104.004449388181;6181.072839074175;6242.812715618538;6319.96840015797;6330;6274.713683694923;6296.874062518816;6297.905531416941;6305.464035557029;6307.180066591313;5738.48353648157;6191.752329906753;6214.8135555933395;6215.129881816459;6221.973374393356;5332.253484512094;5886.852828679317;6184;6252.749890004531;6288.371162883675;5126.589872810092;5203.401608814884;6200.0699895016105;6200.627962322275;6209.59637623553 14:45:16 INFO - PID 1639 | |1;ext.html;647.5596594315865;714.9249328820474;797.1510341486317;1007.3099926550309;1112.410422476088;26644.467110657773;27249.59125613115;27286.31784205396;27300.04449844256;27310.863445682768;37484.81257593708;37594.62405375946;37601.435978460344;37617.62382376175;37684.81157594215;8332.750017499484;8468.618912148937;8486.19381158792;8491.448055876348;8511.021232558242;5958.940410595882;8395.328373730086;8550.273226775731;8563.272121869648;8574.871376929319;6150;8367.958160209191;8581;8588.269997050227;8588.699395521158;8548.87176692347;8597.355198360148;8600.526971016623;8607.483550986899;8609;5914.763409463616;6041.969790151065;8290.502569845828;8388.07731149573;8391.580420978926;35681.10797230064;35842.46236306457;35876.82061589675;35927.46108808344;35945.820270898475;3506.9824650876835;3528.259065596228;3543.7696549724187;3546.308469848381;3549.4853246279145;29886;29903.850480747675;29917.25206869824;29928.850355748298;29988.70011299881;2974.5835583018393;2995.2961054152256;3002.384511175204;3007.7593792496546;3021.561873528326;230709;289044;290759;292033.17717994;293812;48382.758086209345;48387;48406.757966209945;48555.757221213666;48625.51374486281;50660.493395065576;50665.74667126641;50684;50768.98462030739;50799.49200508022;13645.181289122684;13722.725545489235;13733.725325493435;13739.931300343434;13753.106048107042;11163.609273675382;11174.832377514344;11179.44102794857;11183.44082795857;11217.439128043565;10165.542550585242;10515.26393152472;10573.471326433648;12081.57714479989;12293.56972505958;4689.906201875943;5215.947840521622;5260.395054568697;5263.526282634504;5286.814961476407;1015.3501758874327;1017.5268500147467;1020.6682828080754;1051.71603667011;1052.4316868890867;21499.355019349445;23164.65253021206;24318.148864789648;24357.51284974326;24374.51250975006;962.6630679262342;995.2684776689127;1065.6376831877199;1123.4158237716342;1133.9546418143348;12280.447379867928;12343.321117338453;12358.44387002587;12373.195742276903;12393.752124957631;300262;302576;302817;303127;303307;52133.7393313031;52160;52217;52221.7388913053;52453.688657783096;1493.3802471974227;1527.5035613425903;1537.2851623994895;1544.5984044148602;1546.7061258360875;23692.104631629085;23800.523989520458;23803.761962380155;23830.52338953246;23886.52226955486;37083;37096;37109.81445092757;37141;37158.699445519276;279897;280006;280324;280414;280632;32706.509402358508;33229.83385083156;33382.499262510595;33437;33581.66418335883;35987.64012359843;36452;36597.45103823498;43216.135677286904;43335.783321084455;24453;26380.285281456643;29648.851755741947;29918.85040574783;30213.77483312054;29061.7093829059;29589.112326630235;29693.257668558457;29980.400391992473;30124.84937575298;35079.47380789239;35165.296694065466;35424.645753542136;35666;35694.82152589221;28940.565891512066;29452.705472945854;30158.396832063674;30432.695673043872;30583.388332233677;21054.368368948955;21386.077493291625;23070.398642917862;23373.24700647424;23546.52906941886 14:45:16 INFO - PID 1639 | |2;jquery.html;406.28088283737765;429.7965696051056;435.9803808828601;442.2592158135124;457.81916143123465;16911;18981.525461863443;20863.47841303968;21083.367498975054;21569.24507642233;21845;22322.77677223227;22754.31737047891;23060.8846955765;23222.419439514022;6016.247969003885;6275.152854364648;6278.497720182398;6280.838044961674;6281.057841323793;5977.491913187384;6102.786402475915;6259.968700156493;6262.436380725734;6276.843078923041;5982.371850955652;6236.189295391593;6240.906386404207;6244.12582238487;6248.062790581426;6066.787662431816;6247.375262473739;6252.781152659635;6258.092576576417;6258.1551490548645;4969.378827646544;5280.81517146898;5534.114541673353;5599.188117722907;5635.971820140914;27487.725122748718;27726.445471090465;28171.718282817114;28324.85837570799;28479;2178.9891050544807;2270.591293567157;2271.046160612547;2273.2498275569023;2277.430642339415;13436.596902092953;14380.424783008668;17494.425501704907;17767;18613.34853280142;2160.5786871560053;2191.123550579765;2214.5128071824174;2216.5899308627954;2222.0334154642783;163439;166236;168852.15573922175;171010;171715;12149.331786751813;12364.1963272387;12405;12571;12672.303023333621;16600.086995215137;16605.252763625667;16610.833891661172;16617.41839035628;16621.6675666486;8465.576721163918;8785.472871627595;8791.472511649321;8905.154010369004;8943.329250306253;8335.624896879655;8350.874736878952;8352.624131914079;8522.147785221428;8570.185832345916;6398.808035758934;6420;6454.741810327629;7624.923750762532;7778.961105194551;2132.584146091497;2133.1680644548637;2134.8825814580346;2136.5620047890147;2260.0733699183256;784.8351846112266;917.504467717616;944.3625552751865;979.7011911367101;999.6101520407047;20552.691709624367;20557.588848222953;21065.578688426147;21116.366509004754;21483.570328593654;963.5182408795603;967.192394350711;1004.0762498501397;1007.9344842585208;1013.4476710192963;10303;10589.417582033062;10643.201759868041;10693.83959240612;10738.838917416246;546008;555398;561116;561565;561878;100166;124486.37756811158;126149.73850261564;128802;129281.35359323332;1143.6226045405162;1150.4822829726825;1190.4345435918042;1192.3025030357337;1195.318668359027;17837.73243401376;17887.463376098738;17892.28430862803;17942.461726148238;18132.456026319232;40933;55001;55701;55917.44082559285;56026;75926.62036689781;76636;77726;78219.43561128859;78748;7261;8453.66185352579;8693.174148455886;8723.607437665447;8736.213740763362;13761.036727428984;13767.655808604864;13907.652308692364;14093.365798538885;14101.29493525299;10728.946355268174;11364.659060228207;11531.30812151271;11827.17209795306;11866.288022718665;10652.946735266274;10924.672259832218;10931.672049838518;11217.270877392943;11293.887061129284;11858.288502689866;11906.523739050688;11945.283283003047;12117.818232726693;12216.633500994983;8504;8604.870926936226;8660.913390866011;8712.825743485222;8746.69386571467;10454.372737635766;10685.679429617125;10917.890821091687;11753.764924701629;12098.516059357527 14:45:16 INFO - PID 1639 | |3;mootools.html;1167.1888037813724;1398.2589227709313;1431.8210223722035;1459.1536908593012;1467.6844478437138;9769.853452198222;10208.74478138046;11566.768664626703;11644.95195432411;11797.820217978198;11409;11458.942705286461;11501.827472587896;11510.539578416874;11524.942375288132;2466.5313590417854;2510.3598582361474;2512.836665616729;2516.200916344813;2517.697876254843;2107.905144268512;2190.967135492961;2458.4714286428416;2523.6088406296963;2541.5679334513084;2127.500037491196;2468.1114798672465;2489.7385774493687;2492.5887228607257;2495.463475352799;2462.963055554168;2496.213692686798;2502.2618327593314;2504.536660717773;2509;2239.104358256694;2269.103704036896;2444.523317953;2466.3587467258644;2476.455179860428;11508.654740357802;11623;11642.359670218219;11700.414979251003;11704.590339338083;6483.351664833526;6755.425788807957;6763.526553141282;6769.627670478122;6773.254941956381;3843.846246150151;4017.3973903914352;4191.517975432834;4353.151135528573;4374.628156606692;1243.2043492165021;1248.1387842388722;1269.3153979333736;1285.6593002854252;1295.8963282937343;16739.832601674072;16819;16830.242639081273;16840.915795421068;16878.74681879773;5764.682942438206;5919.1713160157615;5957.434043765836;6014.9699251504335;6053.939460605426;13872.167669939836;13883.514077007256;13890.09714368583;13915.860841391457;13916.791248131287;6691.1636045494315;6795.592264464148;6829.248782633907;6838.14523184602;6842.965785171043;5224.92162617561;6149.938500615026;6178.351273116348;6206.875862482725;6223.875522489525;3561.857525698943;4118.320477121241;4626.421697287839;4694.929576056362;4703.435587729495;1429.485385261326;1435.9425622975173;1454.3673502026652;1459.613202501338;1474.0492382413283;677.8305423644089;714.3642158478958;811.9715809946623;820.7004443378124;826.1779529368197;6127.846803829851;6222.439980401786;6311.715972781144;6346.952752795737;6699.0621313015245;889.6263569300909;912.4616476279027;921.0881227584644;938.7043081429327;945.8486642137225;3784.299904517673;3839.7696138231795;4325.76208308546;4382.868513944587;4449.844255451108;14603.19682417456;15287.38850445992;15297.623213910801;15317;15371;14494.420223191166;14997.925010374878;15238.542843714706;15248.3900643973;15270.923645381701;8348.081711011784;8590.527520986405;8591.957040214758;8718.956405217934;8738.825223495494;5890.410958904075;6509.283978762238;6564.671766411565;6760.1549806274215;6792.490563207878;12619.81070283928;13319.800202997156;13851.79222311646;13943.930280348533;13960.232187229394;13850.445982160601;13930.95517836146;13981.790273145707;14023.929880350941;14326.57020289393;9430.387024843638;9712.980137085504;9727.270454715783;9728.659496917857;9739.366941148803;9638.277129215478;9642.517874106406;9949.005099490283;10756.193285503463;10844.728881778019;8769.342299327449;9188.173064423967;9222.216111630587;9349.859752103588;9409.059094090537;8702.651893924172;8911;8995.730128096167;9103.453792772454;9127.680531181377;8113.5131892086665;8284.50292982423;8294.129116442928;8308.086110527958;8311.459755115899;5291.3121294231505;5948.917878742405;5952.107183922273;6162.383761623802;6207.286162091417;5976.760929562943;6040.1543783871175;6054.455099041107;6146.108814221823;6205.720742566505 14:45:16 INFO - PID 1639 | |4;prototype.html;389.90642245860994;396.4667522182663;405.525535123905;405.55996743533274;408.44859439756334;5790.913136302959;5807.680577568232;5849.795257166;5862.912056319158;5871.559633027524;5529.557635389169;5652.406497317784;5726.713664316789;5776.884462310752;5781.4507621775965;3640.3265395901713;4073.6188963160653;4079.83680652775;4457.885528617846;4471.977640111795;4454;4456.509783923766;4456.754878481682;4477.343382948314;4492.236319825637;3293.78590391625;3927.6857851371965;4260.488741351042;4423.579759922803;4426.29179331307;4012.839486420569;4208.537060923327;4231.788410579489;4234.431722285185;4244.745315281093;3512.4204506256438;3724.087598538348;3727.850885964558;3730.477733117366;3735.2529494101286;4620.884477888046;5100;5509.504144626962;5610.382857885629;5610.438956104398;4353.869383918487;5029.823956161516;5050.823221187277;5060.645754797166;5083.237514372837;6064.575479716422;6085.178500902366;6099.5425343099005;6103;6152.846178845564;4004.9599504004877;4173.7495750254775;4194.6853985951175;4203.7057405981595;4216.536181020086;5539.972300138514;5891.293044834647;6234.625922444668;6269.373062693694;6380.29816720165;3660.3045421369857;3965.9490235087146;4134.813933372945;4155.459790227251;4225.408442818008;3638.490611314418;4349.608535231781;4354.978225108917;4365.926185062133;4372.628326592212;4473.843415480443;4754.835065408997;4899.265110233494;5078.390593128848;5092.694438333638;5289.788408463618;5794.391588883191;6178.783742568989;6186.10301506279;6210.254769427697;1204.975900482003;1464.7363474574465;1499.5351441053308;1499.7600383938518;1502.774583812415;930.1775614370449;948.2177203806887;987.8320685483485;988.1600639456404;1002.1982414068716;4743.620510359163;5191.402988656278;5484.2047903053835;5513.696746678971;5865.560082993792;6330.525210609223;6357.554971152067;6363.809085727436;6378.756142552251;6387.425131738166;5541.390447050821;5763.394843541368;5802.912956305659;5874.295084589791;5900.321463031721;3288.704016638514;3301.7853839500353;3331.666833316649;3335.31626016666;3356.311956049004;4728.71627702339;5240.947590524046;6081.422264884829;6479.1901012373455;6507.219133703986;5430.067763407795;6492.967535162294;6494;6498.415142637185;6523.804285871432;6494.642794646245;6508.630379936666;6533.575317604341;6535.771248006392;6544.284122089375;5993.460588547052;6312.242530896322;6328.588641738273;6390.329015453496;6409.166808314889;5075.857931965278;5189.584833213409;6161.291451482957;6234.75060997555;6241.531885108726;5591.287787450288;6144.692765361803;6215.34738852414;6279.434850863444;6351.5073957619;3758.2295629396453;4102.487189101363;4239.618434340924;4282.700210985326;4299.398084268268;6087.969560152171;6282.811515654537;6336.683165841781;6370.235571731237;6382.489400848014;5098.592112630907;5513.751881165437;5757.683327417032;6124.785632502841;6181.938180618316;5113.667611605234;5122.206058061007;6132;6148.969255153875;6207.596506227081;4862.927056094232;5752.453516915886;5894.322152952293;5942.732577033958;5979.342272349951;5026.798928042837;6096.298925623432;6098.847528811815;6110.205673262625;6112.235970503687;5055.87360315995;5139.871503212449;5470.753816078366;5563.332400112013;5955.898158840629 14:45:16 INFO - PID 1639 | |5;yui.html;691.8789211887924;715.4205093873961;849.9150084991497;850.5619605902957;871.7471933139392;13239.338033098342;18040.278388864444;18366.173522191482;18603;18618.348357807445;16546.92908810685;16844.494665160033;16952.49142525723;16953.237104330303;16964.66070678589;628.789355565886;645.9922520867439;647.1748520636191;891.2201823404521;897.7217062710581;683.8769021576114;922.6678395777549;949.9192568631674;951.3911096897956;959.9904000959971;1000.4447531619948;1003.2525768302588;1005.0803514783964;1005.1807776662033;1019.0930072235716;998.610541888664;998.7752755629998;998.9250806189492;1000.1099021870541;1012.9240306976969;741.5958302724974;743.6170372258238;745.6868115391494;746.6565379925241;752.7440670172113;15883.444079457278;16016.75974860378;16151.515454536382;16537.090460024694;16934.83065169357;16555.420560280454;16608;16794.916025419916;17035.97784132956;17085.48743537696;11776.646700598996;13867.930660346734;14102.224377659224;14222.217778022205;14264.286785660675;3426.588809342895;3448.2413868948793;3448.8620455181763;3449.1721986723255;3457.481377793326;110266.89733102647;120800.58398832062;125086;127373;128813.42373152578;11954.222975506564;11984.940075299743;12024.939875300568;12130.332831694164;12275.693107672201;20450.897745511178;20548.38354849357;20579.07394167266;21015.369538913856;21026.684599731016;7209.711611535585;7249.238829922782;7260.927390726025;7263.745768898063;7267.055282813306;3788.905277368033;3841.500604921398;3855.556610989716;3895.8831235062994;3908.785016824102;4221.261279276176;4307.22469955411;4313.956860431355;4321.308590625485;4321.308590625485;850.706506255341;861.8060936289285;862.159394590282;904.5658084119659;931.7391130483476;622.6730966242759;637.7608396851181;638.2755572425331;650.8633187030682;667.7162206062501;9592.944776074626;10907.718812215384;11103.111751059896;11930.701732456759;12033.398330083635;631.0282165465223;633.1800318587349;637.636547168119;644.5037321262602;672.5359501943643;4376.978115109404;5142.948570514322;5174.456682048331;5313.415524292324;5540.889182216414;110164.4491777552;111324.33013504803;112493.43753281182;113709;114494;83138.58430707808;83720;98679.50660246653;99827;101148.49425752825;77344.45311093859;77579.61210193913;77762;79230;79287.4142517158;11771.823422648496;12260.203086799329;12271.631851044483;12317.384130793604;12372.81440778407;29370.11889643314;39974;40093.59906400899;40248.59129930555;41012.79493602513;40569.59430405658;50544.49455505545;52787.73606131945;53167;53257.6685582848;12870.806937895752;13028.47886084546;15445.382184712485;15661.060336379855;15990.120543370227;15206.391744330103;17029.403970861455;17463.912680436515;17555.210015549077;18080.276788928295;13809.51666691661;16051.759223611421;16148.515544533682;16541.421050263183;16959.23683434273;16180.595485112966;16267.430639927547;16427.753583696493;16672.749908751623;16711.415100471426;15824.841751582797;16054.759178612563;16170.353185872904;16255.105969171336;16497.422590209284;11069.5572177112;11348.148888833206;11391.829122563002;11538.192326537397;11546;12728.490860365851;12757.808632870328;12771.808422873479;12819.615411537668;12821.487140514275 14:45:16 INFO - PID 1639 | __end_tp_report 14:45:16 INFO - PID 1639 | __start_cc_report 14:45:16 INFO - PID 1639 | _x_x_mozilla_cycle_collect,2055 14:45:16 INFO - PID 1639 | __end_cc_report 14:45:16 INFO - PID 1639 | __startTimestamp1493070316958__endTimestamp 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | ------- Summary: start ------- 14:45:16 INFO - PID 1639 | Number of tests: 6 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:5936.96 Median:6184.00 stddev:683.26 (11.0%) stddev-sans-first:656.70 14:45:16 INFO - PID 1639 | Values: 3440.8 3463.7 3473.5 3478.6 3519.2 6077.4 6097.5 6100.2 6125.4 6155.0 6100.3 6112.5 6116.4 6124.1 6138.2 4857.9 5049.3 5215.4 5273.6 5368.4 5148.6 5320.4 5342.0 5378.7 5422.9 5233.5 5266.7 5282.8 5325.4 5373.2 5259.7 5307.1 5307.4 5309.8 5345.8 5251.4 5261.8 5291.6 5294.4 5315.0 5863.4 5959.4 5983.6 6060.6 6066.9 6350.5 6356.7 6364.9 6370.8 6375.4 6461.0 6477.5 6487.2 6488.6 6492.2 5999.4 6052.5 6071.4 6136.4 6138.8 6369.5 6435.5 6537.0 6670.2 6680.4 5316.4 6267.5 6273.8 6292.6 6351.4 6375.4 6481.6 6493.4 6503.9 6531.0 6237.1 6325.0 6377.0 6394.7 6413.9 6266.7 6328.9 6370.6 6401.1 6428.9 5147.4 5155.6 5157.0 5177.8 5183.4 4620.2 4620.8 4637.5 4640.2 4673.6 5970.9 6037.7 6079.6 6144.8 6210.3 6465.3 6473.2 6518.0 6531.3 6534.7 6140.5 6163.5 6172.3 6174.3 6175.1 5499.3 5638.7 5645.2 5688.1 5706.6 6644.1 6736.2 6737.5 6742.9 6751.3 6398.7 6415.8 6416.4 6423.5 6427.8 6353.2 6583.9 6609.7 6639.3 6654.4 6189.7 6336.0 6337.3 6353.3 6384.4 6269.2 6496.6 6524.2 6525.5 6532.2 6104.0 6181.1 6242.8 6320.0 6330.0 6274.7 6296.9 6297.9 6305.5 6307.2 5738.5 6191.8 6214.8 6215.1 6222.0 5332.3 5886.9 6184.0 6252.7 6288.4 5126.6 5203.4 6200.1 6200.6 6209.6 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43095.01 Median:302972.00 stddev:75518.16 (24.9%) stddev-sans-first:75662.76 14:45:16 INFO - PID 1639 | Values: 647.6 714.9 797.2 1007.3 1112.4 26644.5 27249.6 27286.3 27300.0 27310.9 37484.8 37594.6 37601.4 37617.6 37684.8 8332.8 8468.6 8486.2 8491.4 8511.0 5958.9 8395.3 8550.3 8563.3 8574.9 6150.0 8368.0 8581.0 8588.3 8588.7 8548.9 8597.4 8600.5 8607.5 8609.0 5914.8 6042.0 8290.5 8388.1 8391.6 35681.1 35842.5 35876.8 35927.5 35945.8 3507.0 3528.3 3543.8 3546.3 3549.5 29886.0 29903.9 29917.3 29928.9 29988.7 2974.6 2995.3 3002.4 3007.8 3021.6 230709.0 289044.0 290759.0 292033.2 293812.0 48382.8 48387.0 48406.8 48555.8 48625.5 50660.5 50665.7 50684.0 50769.0 50799.5 13645.2 13722.7 13733.7 13739.9 13753.1 11163.6 11174.8 11179.4 11183.4 11217.4 10165.5 10515.3 10573.5 12081.6 12293.6 4689.9 5215.9 5260.4 5263.5 5286.8 1015.4 1017.5 1020.7 1051.7 1052.4 21499.4 23164.7 24318.1 24357.5 24374.5 962.7 995.3 1065.6 1123.4 1134.0 12280.4 12343.3 12358.4 12373.2 12393.8 300262.0 302576.0 302817.0 303127.0 303307.0 52133.7 52160.0 52217.0 52221.7 52453.7 1493.4 1527.5 1537.3 1544.6 1546.7 23692.1 23800.5 23803.8 23830.5 23886.5 37083.0 37096.0 37109.8 37141.0 37158.7 279897.0 280006.0 280324.0 280414.0 280632.0 32706.5 33229.8 33382.5 33437.0 33581.7 35987.6 36452.0 36597.5 43216.1 43335.8 24453.0 26380.3 29648.9 29918.9 30213.8 29061.7 29589.1 29693.3 29980.4 30124.8 35079.5 35165.3 35424.6 35666.0 35694.8 28940.6 29452.7 30158.4 30432.7 30583.4 21054.4 21386.1 23070.4 23373.2 23546.5 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:35664.30 Median:2265.33 stddev:94739.19 (4182.1%) stddev-sans-first:94967.97 14:45:16 INFO - PID 1639 | Values: 406.3 429.8 436.0 442.3 457.8 16911.0 18981.5 20863.5 21083.4 21569.2 21845.0 22322.8 22754.3 23060.9 23222.4 6016.2 6275.2 6278.5 6280.8 6281.1 5977.5 6102.8 6260.0 6262.4 6276.8 5982.4 6236.2 6240.9 6244.1 6248.1 6066.8 6247.4 6252.8 6258.1 6258.2 4969.4 5280.8 5534.1 5599.2 5636.0 27487.7 27726.4 28171.7 28324.9 28479.0 2179.0 2270.6 2271.0 2273.2 2277.4 13436.6 14380.4 17494.4 17767.0 18613.3 2160.6 2191.1 2214.5 2216.6 2222.0 163439.0 166236.0 168852.2 171010.0 171715.0 12149.3 12364.2 12405.0 12571.0 12672.3 16600.1 16605.3 16610.8 16617.4 16621.7 8465.6 8785.5 8791.5 8905.2 8943.3 8335.6 8350.9 8352.6 8522.1 8570.2 6398.8 6420.0 6454.7 7624.9 7779.0 2132.6 2133.2 2134.9 2136.6 2260.1 784.8 917.5 944.4 979.7 999.6 20552.7 20557.6 21065.6 21116.4 21483.6 963.5 967.2 1004.1 1007.9 1013.4 10303.0 10589.4 10643.2 10693.8 10738.8 546008.0 555398.0 561116.0 561565.0 561878.0 100166.0 124486.4 126149.7 128802.0 129281.4 1143.6 1150.5 1190.4 1192.3 1195.3 17837.7 17887.5 17892.3 17942.5 18132.5 40933.0 55001.0 55701.0 55917.4 56026.0 75926.6 76636.0 77726.0 78219.4 78748.0 7261.0 8453.7 8693.2 8723.6 8736.2 13761.0 13767.7 13907.7 14093.4 14101.3 10728.9 11364.7 11531.3 11827.2 11866.3 10652.9 10924.7 10931.7 11217.3 11293.9 11858.3 11906.5 11945.3 12117.8 12216.6 8504.0 8604.9 8660.9 8712.8 8746.7 10454.4 10685.7 10917.9 11753.8 12098.5 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7176.82 Median:4067.86 stddev:4607.52 (113.3%) stddev-sans-first:4598.32 14:45:16 INFO - PID 1639 | Values: 1167.2 1398.3 1431.8 1459.2 1467.7 9769.9 10208.7 11566.8 11645.0 11797.8 11409.0 11458.9 11501.8 11510.5 11524.9 2466.5 2510.4 2512.8 2516.2 2517.7 2107.9 2191.0 2458.5 2523.6 2541.6 2127.5 2468.1 2489.7 2492.6 2495.5 2463.0 2496.2 2502.3 2504.5 2509.0 2239.1 2269.1 2444.5 2466.4 2476.5 11508.7 11623.0 11642.4 11700.4 11704.6 6483.4 6755.4 6763.5 6769.6 6773.3 3843.8 4017.4 4191.5 4353.2 4374.6 1243.2 1248.1 1269.3 1285.7 1295.9 16739.8 16819.0 16830.2 16840.9 16878.7 5764.7 5919.2 5957.4 6015.0 6053.9 13872.2 13883.5 13890.1 13915.9 13916.8 6691.2 6795.6 6829.2 6838.1 6843.0 5224.9 6149.9 6178.4 6206.9 6223.9 3561.9 4118.3 4626.4 4694.9 4703.4 1429.5 1435.9 1454.4 1459.6 1474.0 677.8 714.4 812.0 820.7 826.2 6127.8 6222.4 6311.7 6347.0 6699.1 889.6 912.5 921.1 938.7 945.8 3784.3 3839.8 4325.8 4382.9 4449.8 14603.2 15287.4 15297.6 15317.0 15371.0 14494.4 14997.9 15238.5 15248.4 15270.9 8348.1 8590.5 8592.0 8719.0 8738.8 5890.4 6509.3 6564.7 6760.2 6792.5 12619.8 13319.8 13851.8 13943.9 13960.2 13850.4 13931.0 13981.8 14023.9 14326.6 9430.4 9713.0 9727.3 9728.7 9739.4 9638.3 9642.5 9949.0 10756.2 10844.7 8769.3 9188.2 9222.2 9349.9 9409.1 8702.7 8911.0 8995.7 9103.5 9127.7 8113.5 8284.5 8294.1 8308.1 8311.5 5291.3 5948.9 5952.1 6162.4 6207.3 5976.8 6040.2 6054.5 6146.1 6205.7 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:4916.64 Median:5511.60 stddev:1518.12 (27.5%) stddev-sans-first:1483.87 14:45:16 INFO - PID 1639 | Values: 389.9 396.5 405.5 405.6 408.4 5790.9 5807.7 5849.8 5862.9 5871.6 5529.6 5652.4 5726.7 5776.9 5781.5 3640.3 4073.6 4079.8 4457.9 4472.0 4454.0 4456.5 4456.8 4477.3 4492.2 3293.8 3927.7 4260.5 4423.6 4426.3 4012.8 4208.5 4231.8 4234.4 4244.7 3512.4 3724.1 3727.9 3730.5 3735.3 4620.9 5100.0 5509.5 5610.4 5610.4 4353.9 5029.8 5050.8 5060.6 5083.2 6064.6 6085.2 6099.5 6103.0 6152.8 4005.0 4173.7 4194.7 4203.7 4216.5 5540.0 5891.3 6234.6 6269.4 6380.3 3660.3 3965.9 4134.8 4155.5 4225.4 3638.5 4349.6 4355.0 4365.9 4372.6 4473.8 4754.8 4899.3 5078.4 5092.7 5289.8 5794.4 6178.8 6186.1 6210.3 1205.0 1464.7 1499.5 1499.8 1502.8 930.2 948.2 987.8 988.2 1002.2 4743.6 5191.4 5484.2 5513.7 5865.6 6330.5 6357.6 6363.8 6378.8 6387.4 5541.4 5763.4 5802.9 5874.3 5900.3 3288.7 3301.8 3331.7 3335.3 3356.3 4728.7 5240.9 6081.4 6479.2 6507.2 5430.1 6493.0 6494.0 6498.4 6523.8 6494.6 6508.6 6533.6 6535.8 6544.3 5993.5 6312.2 6328.6 6390.3 6409.2 5075.9 5189.6 6161.3 6234.8 6241.5 5591.3 6144.7 6215.3 6279.4 6351.5 3758.2 4102.5 4239.6 4282.7 4299.4 6088.0 6282.8 6336.7 6370.2 6382.5 5098.6 5513.8 5757.7 6124.8 6181.9 5113.7 5122.2 6132.0 6149.0 6207.6 4862.9 5752.5 5894.3 5942.7 5979.3 5026.8 6096.3 6098.8 6110.2 6112.2 5055.9 5139.9 5470.8 5563.3 5955.9 14:45:16 INFO - PID 1639 | 14:45:16 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21317.03 Median:18610.67 stddev:30870.46 (165.9%) stddev-sans-first:30918.22 14:45:16 INFO - PID 1639 | Values: 691.9 715.4 849.9 850.6 871.7 13239.3 18040.3 18366.2 18603.0 18618.3 16546.9 16844.5 16952.5 16953.2 16964.7 628.8 646.0 647.2 891.2 897.7 683.9 922.7 949.9 951.4 960.0 1000.4 1003.3 1005.1 1005.2 1019.1 998.6 998.8 998.9 1000.1 1012.9 741.6 743.6 745.7 746.7 752.7 15883.4 16016.8 16151.5 16537.1 16934.8 16555.4 16608.0 16794.9 17036.0 17085.5 11776.6 13867.9 14102.2 14222.2 14264.3 3426.6 3448.2 3448.9 3449.2 3457.5 110266.9 120800.6 125086.0 127373.0 128813.4 11954.2 11984.9 12024.9 12130.3 12275.7 20450.9 20548.4 20579.1 21015.4 21026.7 7209.7 7249.2 7260.9 7263.7 7267.1 3788.9 3841.5 3855.6 3895.9 3908.8 4221.3 4307.2 4314.0 4321.3 4321.3 850.7 861.8 862.2 904.6 931.7 622.7 637.8 638.3 650.9 667.7 9592.9 10907.7 11103.1 11930.7 12033.4 631.0 633.2 637.6 644.5 672.5 4377.0 5142.9 5174.5 5313.4 5540.9 110164.4 111324.3 112493.4 113709.0 114494.0 83138.6 83720.0 98679.5 99827.0 101148.5 77344.5 77579.6 77762.0 79230.0 79287.4 11771.8 12260.2 12271.6 12317.4 12372.8 29370.1 39974.0 40093.6 40248.6 41012.8 40569.6 50544.5 52787.7 53167.0 53257.7 12870.8 13028.5 15445.4 15661.1 15990.1 15206.4 17029.4 17463.9 17555.2 18080.3 13809.5 16051.8 16148.5 16541.4 16959.2 16180.6 16267.4 16427.8 16672.7 16711.4 15824.8 16054.8 16170.4 16255.1 16497.4 11069.6 11348.1 11391.8 11538.2 11546.0 12728.5 12757.8 12771.8 12819.6 12821.5 14:45:16 INFO - PID 1639 | -------- Summary: end -------- 14:45:16 INFO - PID 1639 | 14:45:17 INFO - TEST-INFO | 1639: exit 0 14:45:17 INFO - TEST-OK | dromaeo_css | took 1118936ms 14:45:17 INFO - TEST-START | kraken 14:45:17 INFO - operating with platform_type : mac_ 14:45:17 INFO - Initialising browser for kraken test... 14:45:17 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpgGUmx7/profile http://localhost:49242/getInfo.html) 14:45:20 INFO - PID 1650 | __metrics Screen width/height:1600/1200 14:45:20 INFO - PID 1650 | colorDepth:24 14:45:20 INFO - PID 1650 | Browser inner width/height: 1024/689 14:45:20 INFO - PID 1650 | __metrics 14:45:20 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" 14:45:20 INFO - PID 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:45:21 INFO - TEST-INFO | 1650: exit 0 14:45:21 INFO - Browser initialized. 14:45:21 INFO - Running cycle 1/1 for kraken test... 14:45:21 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpgGUmx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:45:33 INFO - PID 1651 | RSS: Main: 235401216 14:45:33 INFO - PID 1651 | 14:45:36 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 14:45:37 INFO - PID 1651 | RSS: Main: 312586240 14:45:37 INFO - PID 1651 | 14:45:39 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 14:45:40 INFO - PID 1651 | RSS: Main: 296804352 14:45:40 INFO - PID 1651 | 14:45:43 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 14:45:44 INFO - PID 1651 | RSS: Main: 387620864 14:45:44 INFO - PID 1651 | 14:45:46 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 14:45:47 INFO - PID 1651 | RSS: Main: 290967552 14:45:47 INFO - PID 1651 | 14:45:49 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:45:49 INFO - PID 1651 | RSS: Main: 293449728 14:45:49 INFO - PID 1651 | 14:45:52 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 14:45:53 INFO - PID 1651 | RSS: Main: 356311040 14:45:53 INFO - PID 1651 | 14:45:56 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 14:45:57 INFO - PID 1651 | RSS: Main: 375152640 14:45:57 INFO - PID 1651 | 14:45:59 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 14:46:00 INFO - PID 1651 | RSS: Main: 385691648 14:46:00 INFO - PID 1651 | 14:46:02 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:46:02 INFO - PID 1651 | RSS: Main: 315240448 14:46:02 INFO - PID 1651 | 14:46:04 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:46:05 INFO - PID 1651 | RSS: Main: 335163392 14:46:05 INFO - PID 1651 | 14:46:07 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:46:07 INFO - PID 1651 | RSS: Main: 318574592 14:46:07 INFO - PID 1651 | 14:46:10 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:46:11 INFO - PID 1651 | RSS: Main: 331169792 14:46:11 INFO - PID 1651 | 14:46:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:46:15 INFO - PID 1651 | RSS: Main: 347041792 14:46:15 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 14:46:17 INFO - PID 1651 | RSS: Main: 390426624 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | __start_tp_report 14:46:17 INFO - PID 1651 | _x_x_mozilla_page_load 14:46:17 INFO - PID 1651 | _x_x_mozilla_page_load_details 14:46:17 INFO - PID 1651 | |i|pagename|runs| 14:46:17 INFO - PID 1651 | |0;ai-astar;110;111;111;112;111;112;110;111;111;111 14:46:17 INFO - PID 1651 | |1;audio-beat-detection;140;118;132;129;127;137;113;108;132;104 14:46:17 INFO - PID 1651 | |2;audio-dft;184;183;185;185;182;196;256;182;192;254 14:46:17 INFO - PID 1651 | |3;audio-fft;81;61;64;96;86;61;61;59;81;58 14:46:17 INFO - PID 1651 | |4;audio-oscillator;92;70;86;70;68;67;90;74;90;117 14:46:17 INFO - PID 1651 | |5;imaging-gaussian-blur;88;87;88;86;88;86;87;86;87;87 14:46:17 INFO - PID 1651 | |6;imaging-darkroom;95;100;94;94;106;104;94;94;105;148 14:46:17 INFO - PID 1651 | |7;imaging-desaturate;83;83;83;82;84;84;82;83;83;83 14:46:17 INFO - PID 1651 | |8;json-parse-financial;51;50;47;47;66;76;75;75;56;51 14:46:17 INFO - PID 1651 | |9;json-stringify-tinderbox;54;61;52;59;66;61;57;55;56;56 14:46:17 INFO - PID 1651 | |10;stanford-crypto-aes;81;81;83;81;83;83;82;80;82;81 14:46:17 INFO - PID 1651 | |11;stanford-crypto-ccm;136;129;143;137;137;137;137;136;223;152 14:46:17 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;182;191;190;192;193;189;191;189;191;183 14:46:17 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;69;69;67;68;69;67;69;68;69;70 14:46:17 INFO - PID 1651 | __end_tp_report 14:46:17 INFO - PID 1651 | __start_cc_report 14:46:17 INFO - PID 1651 | _x_x_mozilla_cycle_collect,2167 14:46:17 INFO - PID 1651 | __end_cc_report 14:46:17 INFO - PID 1651 | __startTimestamp1493070377302__endTimestamp 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | ------- Summary: start ------- 14:46:17 INFO - PID 1651 | Number of tests: 14 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 14:46:17 INFO - PID 1651 | Values: 110.0 111.0 111.0 112.0 111.0 112.0 110.0 111.0 111.0 111.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:130.50 stddev:12.47 (9.6%) stddev-sans-first:11.81 14:46:17 INFO - PID 1651 | Values: 140.0 118.0 132.0 129.0 127.0 137.0 113.0 108.0 132.0 104.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:199.90 Median:188.50 stddev:29.39 (15.6%) stddev-sans-first:30.61 14:46:17 INFO - PID 1651 | Values: 184.0 183.0 185.0 185.0 182.0 196.0 256.0 182.0 192.0 254.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:70.80 Median:72.50 stddev:13.79 (19.0%) stddev-sans-first:14.12 14:46:17 INFO - PID 1651 | Values: 81.0 61.0 64.0 96.0 86.0 61.0 61.0 59.0 81.0 58.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:80.00 stddev:15.78 (19.7%) stddev-sans-first:16.35 14:46:17 INFO - PID 1651 | Values: 92.0 70.0 86.0 70.0 68.0 67.0 90.0 74.0 90.0 117.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 14:46:17 INFO - PID 1651 | Values: 88.0 87.0 88.0 86.0 88.0 86.0 87.0 86.0 87.0 87.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:94.00 stddev:16.45 (17.5%) stddev-sans-first:17.16 14:46:17 INFO - PID 1651 | Values: 95.0 100.0 94.0 94.0 106.0 104.0 94.0 94.0 105.0 148.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:83.00 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 14:46:17 INFO - PID 1651 | Values: 83.0 83.0 83.0 82.0 84.0 84.0 82.0 83.0 83.0 83.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:61.00 stddev:12.27 (20.1%) stddev-sans-first:12.63 14:46:17 INFO - PID 1651 | Values: 51.0 50.0 47.0 47.0 66.0 76.0 75.0 75.0 56.0 51.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:4.11 (7.1%) stddev-sans-first:4.14 14:46:17 INFO - PID 1651 | Values: 54.0 61.0 52.0 59.0 66.0 61.0 57.0 55.0 56.0 56.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 14:46:17 INFO - PID 1651 | Values: 81.0 81.0 83.0 81.0 83.0 83.0 82.0 80.0 82.0 81.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:137.00 stddev:27.45 (20.0%) stddev-sans-first:28.84 14:46:17 INFO - PID 1651 | Values: 136.0 129.0 143.0 137.0 137.0 137.0 137.0 136.0 223.0 152.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.10 Median:191.00 stddev:3.70 (1.9%) stddev-sans-first:2.89 14:46:17 INFO - PID 1651 | Values: 182.0 191.0 190.0 192.0 193.0 189.0 191.0 189.0 191.0 183.0 14:46:17 INFO - PID 1651 | 14:46:17 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 14:46:17 INFO - PID 1651 | Values: 69.0 69.0 67.0 68.0 69.0 67.0 69.0 68.0 69.0 70.0 14:46:17 INFO - PID 1651 | -------- Summary: end -------- 14:46:17 INFO - PID 1651 | 14:46:18 INFO - TEST-INFO | 1651: exit 0 14:46:18 INFO - TEST-OK | kraken | took 60745ms 14:46:18 INFO - SUITE-END | took 1179s 14:46:18 INFO - Completed test suite (00:19:39) 14:46:18 INFO - javascript benchmark 14:46:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7616.349741693044, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3440.8107554084513, 3463.653634636535, 3473.5484387029683, 3478.6347433519486, 3519.1729943463283, 6077.361877002912, 6097.4817140543055, 6100.237470316205, 6125.387461253872, 6154.969225153879, 6100.308687927425, 6112.47308512808, 6116.449519543251, 6124.112003759452, 6138.202033735619, 4857.854264372057, 5049.293098966147, 5215.40022897366, 5273.551748101416, 5368.382635996852, 5148.613853960949, 5320.441353657869, 5342.038433082043, 5378.704171270579, 5422.864428389283, 5233.502817232356, 5266.683998960037, 5282.841514754564, 5325.440828712968, 5373.194020896858, 5259.658122222081, 5307.071262529042, 5307.442718514539, 5309.814156504543, 5345.786168553292, 5251.448597897204, 5261.789528418897, 5291.603129765283, 5294.391145018334, 5314.97342513285, 5863.442972917566, 5959.374265702126, 5983.611065280743, 6060.636361818261, 6066.939330606681, 6350.523710721668, 6356.745730170787, 6364.904526432108, 6370.840728981766, 6375.394337537927, 6461.0, 6477.514186435989, 6487.22153341602, 6488.578242414228, 6492.156019717407, 5999.370066143079, 6052.485538729169, 6071.362506936708, 6136.417040381157, 6138.754449822001, 6369.458596019297, 6435.549511534147, 6536.967315163489, 6670.166229221348, 6680.365365290289, 5316.441773613792, 6267.5299352548745, 6273.780417685359, 6292.622442653455, 6351.396617321347, 6375.362463753588, 6481.578697384749, 6493.383128602775, 6503.8699226015215, 6530.967345163243, 6237.064440333987, 6325.019621958604, 6377.0, 6394.680265986775, 6413.935860641427, 6266.749330026748, 6328.873422531524, 6370.649614271259, 6401.135846660642, 6428.871422571616, 5147.356580427447, 5155.6391052626705, 5156.96860627876, 5177.792888284502, 5183.403908550489, 4620.19146649335, 4620.8151673933335, 4637.466691330473, 4640.187967105743, 4673.602743766818, 5970.880582388328, 6037.6679282639, 6079.574429789872, 6144.754209831557, 6210.254769427697, 6465.2564955030775, 6473.190851143607, 6517.967410162919, 6531.281559028503, 6534.673266336759, 6140.508759299335, 6163.476104531075, 6172.290186628506, 6174.289956655042, 6175.104609831549, 5499.257600223998, 5638.661680299195, 5645.2096706461125, 5688.089905615082, 5706.629069110494, 6644.136262285969, 6736.157980252468, 6737.461003119836, 6742.93257067423, 6751.291114432914, 6398.712057957497, 6415.8396040097505, 6416.358364163546, 6423.518236132215, 6427.83930401725, 6353.205849268841, 6583.868322633425, 6609.735610575523, 6639.302873198438, 6654.434373078149, 6189.690515474298, 6336.0, 6337.271213810471, 6353.332900045613, 6384.361563843579, 6269.247690277196, 6496.610203387811, 6524.151860258136, 6525.477961763143, 6532.248791389051, 6104.004449388181, 6181.072839074175, 6242.812715618538, 6319.96840015797, 6330.0, 6274.713683694923, 6296.874062518816, 6297.905531416941, 6305.464035557029, 6307.180066591313, 5738.48353648157, 6191.752329906753, 6214.8135555933395, 6215.129881816459, 6221.973374393356, 5332.253484512094, 5886.852828679317, 6184.0, 6252.749890004531, 6288.371162883675, 5126.589872810092, 5203.401608814884, 6200.0699895016105, 6200.627962322275, 6209.59637623553], "value": 5892.761143580806, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.5596594315865, 714.9249328820474, 797.1510341486317, 1007.3099926550309, 1112.410422476088, 26644.467110657773, 27249.59125613115, 27286.31784205396, 27300.04449844256, 27310.863445682768, 37484.81257593708, 37594.62405375946, 37601.435978460344, 37617.62382376175, 37684.81157594215, 8332.750017499484, 8468.618912148937, 8486.19381158792, 8491.448055876348, 8511.021232558242, 5958.940410595882, 8395.328373730086, 8550.273226775731, 8563.272121869648, 8574.871376929319, 6150.0, 8367.958160209191, 8581.0, 8588.269997050227, 8588.699395521158, 8548.87176692347, 8597.355198360148, 8600.526971016623, 8607.483550986899, 8609.0, 5914.763409463616, 6041.969790151065, 8290.502569845828, 8388.07731149573, 8391.580420978926, 35681.10797230064, 35842.46236306457, 35876.82061589675, 35927.46108808344, 35945.820270898475, 3506.9824650876835, 3528.259065596228, 3543.7696549724187, 3546.308469848381, 3549.4853246279145, 29886.0, 29903.850480747675, 29917.25206869824, 29928.850355748298, 29988.70011299881, 2974.5835583018393, 2995.2961054152256, 3002.384511175204, 3007.7593792496546, 3021.561873528326, 230709.0, 289044.0, 290759.0, 292033.17717994, 293812.0, 48382.758086209345, 48387.0, 48406.757966209945, 48555.757221213666, 48625.51374486281, 50660.493395065576, 50665.74667126641, 50684.0, 50768.98462030739, 50799.49200508022, 13645.181289122684, 13722.725545489235, 13733.725325493435, 13739.931300343434, 13753.106048107042, 11163.609273675382, 11174.832377514344, 11179.44102794857, 11183.44082795857, 11217.439128043565, 10165.542550585242, 10515.26393152472, 10573.471326433648, 12081.57714479989, 12293.56972505958, 4689.906201875943, 5215.947840521622, 5260.395054568697, 5263.526282634504, 5286.814961476407, 1015.3501758874327, 1017.5268500147467, 1020.6682828080754, 1051.71603667011, 1052.4316868890867, 21499.355019349445, 23164.65253021206, 24318.148864789648, 24357.51284974326, 24374.51250975006, 962.6630679262342, 995.2684776689127, 1065.6376831877199, 1123.4158237716342, 1133.9546418143348, 12280.447379867928, 12343.321117338453, 12358.44387002587, 12373.195742276903, 12393.752124957631, 300262.0, 302576.0, 302817.0, 303127.0, 303307.0, 52133.7393313031, 52160.0, 52217.0, 52221.7388913053, 52453.688657783096, 1493.3802471974227, 1527.5035613425903, 1537.2851623994895, 1544.5984044148602, 1546.7061258360875, 23692.104631629085, 23800.523989520458, 23803.761962380155, 23830.52338953246, 23886.52226955486, 37083.0, 37096.0, 37109.81445092757, 37141.0, 37158.699445519276, 279897.0, 280006.0, 280324.0, 280414.0, 280632.0, 32706.509402358508, 33229.83385083156, 33382.499262510595, 33437.0, 33581.66418335883, 35987.64012359843, 36452.0, 36597.45103823498, 43216.135677286904, 43335.783321084455, 24453.0, 26380.285281456643, 29648.851755741947, 29918.85040574783, 30213.77483312054, 29061.7093829059, 29589.112326630235, 29693.257668558457, 29980.400391992473, 30124.84937575298, 35079.47380789239, 35165.296694065466, 35424.645753542136, 35666.0, 35694.82152589221, 28940.565891512066, 29452.705472945854, 30158.396832063674, 30432.695673043872, 30583.388332233677, 21054.368368948955, 21386.077493291625, 23070.398642917862, 23373.24700647424, 23546.52906941886], "value": 16692.391380567304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.28088283737765, 429.7965696051056, 435.9803808828601, 442.2592158135124, 457.81916143123465, 16911.0, 18981.525461863443, 20863.47841303968, 21083.367498975054, 21569.24507642233, 21845.0, 22322.77677223227, 22754.31737047891, 23060.8846955765, 23222.419439514022, 6016.247969003885, 6275.152854364648, 6278.497720182398, 6280.838044961674, 6281.057841323793, 5977.491913187384, 6102.786402475915, 6259.968700156493, 6262.436380725734, 6276.843078923041, 5982.371850955652, 6236.189295391593, 6240.906386404207, 6244.12582238487, 6248.062790581426, 6066.787662431816, 6247.375262473739, 6252.781152659635, 6258.092576576417, 6258.1551490548645, 4969.378827646544, 5280.81517146898, 5534.114541673353, 5599.188117722907, 5635.971820140914, 27487.725122748718, 27726.445471090465, 28171.718282817114, 28324.85837570799, 28479.0, 2178.9891050544807, 2270.591293567157, 2271.046160612547, 2273.2498275569023, 2277.430642339415, 13436.596902092953, 14380.424783008668, 17494.425501704907, 17767.0, 18613.34853280142, 2160.5786871560053, 2191.123550579765, 2214.5128071824174, 2216.5899308627954, 2222.0334154642783, 163439.0, 166236.0, 168852.15573922175, 171010.0, 171715.0, 12149.331786751813, 12364.1963272387, 12405.0, 12571.0, 12672.303023333621, 16600.086995215137, 16605.252763625667, 16610.833891661172, 16617.41839035628, 16621.6675666486, 8465.576721163918, 8785.472871627595, 8791.472511649321, 8905.154010369004, 8943.329250306253, 8335.624896879655, 8350.874736878952, 8352.624131914079, 8522.147785221428, 8570.185832345916, 6398.808035758934, 6420.0, 6454.741810327629, 7624.923750762532, 7778.961105194551, 2132.584146091497, 2133.1680644548637, 2134.8825814580346, 2136.5620047890147, 2260.0733699183256, 784.8351846112266, 917.504467717616, 944.3625552751865, 979.7011911367101, 999.6101520407047, 20552.691709624367, 20557.588848222953, 21065.578688426147, 21116.366509004754, 21483.570328593654, 963.5182408795603, 967.192394350711, 1004.0762498501397, 1007.9344842585208, 1013.4476710192963, 10303.0, 10589.417582033062, 10643.201759868041, 10693.83959240612, 10738.838917416246, 546008.0, 555398.0, 561116.0, 561565.0, 561878.0, 100166.0, 124486.37756811158, 126149.73850261564, 128802.0, 129281.35359323332, 1143.6226045405162, 1150.4822829726825, 1190.4345435918042, 1192.3025030357337, 1195.318668359027, 17837.73243401376, 17887.463376098738, 17892.28430862803, 17942.461726148238, 18132.456026319232, 40933.0, 55001.0, 55701.0, 55917.44082559285, 56026.0, 75926.62036689781, 76636.0, 77726.0, 78219.43561128859, 78748.0, 7261.0, 8453.66185352579, 8693.174148455886, 8723.607437665447, 8736.213740763362, 13761.036727428984, 13767.655808604864, 13907.652308692364, 14093.365798538885, 14101.29493525299, 10728.946355268174, 11364.659060228207, 11531.30812151271, 11827.17209795306, 11866.288022718665, 10652.946735266274, 10924.672259832218, 10931.672049838518, 11217.270877392943, 11293.887061129284, 11858.288502689866, 11906.523739050688, 11945.283283003047, 12117.818232726693, 12216.633500994983, 8504.0, 8604.870926936226, 8660.913390866011, 8712.825743485222, 8746.69386571467, 10454.372737635766, 10685.679429617125, 10917.890821091687, 11753.764924701629, 12098.516059357527], "value": 10289.296443640624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1167.1888037813724, 1398.2589227709313, 1431.8210223722035, 1459.1536908593012, 1467.6844478437138, 9769.853452198222, 10208.74478138046, 11566.768664626703, 11644.95195432411, 11797.820217978198, 11409.0, 11458.942705286461, 11501.827472587896, 11510.539578416874, 11524.942375288132, 2466.5313590417854, 2510.3598582361474, 2512.836665616729, 2516.200916344813, 2517.697876254843, 2107.905144268512, 2190.967135492961, 2458.4714286428416, 2523.6088406296963, 2541.5679334513084, 2127.500037491196, 2468.1114798672465, 2489.7385774493687, 2492.5887228607257, 2495.463475352799, 2462.963055554168, 2496.213692686798, 2502.2618327593314, 2504.536660717773, 2509.0, 2239.104358256694, 2269.103704036896, 2444.523317953, 2466.3587467258644, 2476.455179860428, 11508.654740357802, 11623.0, 11642.359670218219, 11700.414979251003, 11704.590339338083, 6483.351664833526, 6755.425788807957, 6763.526553141282, 6769.627670478122, 6773.254941956381, 3843.846246150151, 4017.3973903914352, 4191.517975432834, 4353.151135528573, 4374.628156606692, 1243.2043492165021, 1248.1387842388722, 1269.3153979333736, 1285.6593002854252, 1295.8963282937343, 16739.832601674072, 16819.0, 16830.242639081273, 16840.915795421068, 16878.74681879773, 5764.682942438206, 5919.1713160157615, 5957.434043765836, 6014.9699251504335, 6053.939460605426, 13872.167669939836, 13883.514077007256, 13890.09714368583, 13915.860841391457, 13916.791248131287, 6691.1636045494315, 6795.592264464148, 6829.248782633907, 6838.14523184602, 6842.965785171043, 5224.92162617561, 6149.938500615026, 6178.351273116348, 6206.875862482725, 6223.875522489525, 3561.857525698943, 4118.320477121241, 4626.421697287839, 4694.929576056362, 4703.435587729495, 1429.485385261326, 1435.9425622975173, 1454.3673502026652, 1459.613202501338, 1474.0492382413283, 677.8305423644089, 714.3642158478958, 811.9715809946623, 820.7004443378124, 826.1779529368197, 6127.846803829851, 6222.439980401786, 6311.715972781144, 6346.952752795737, 6699.0621313015245, 889.6263569300909, 912.4616476279027, 921.0881227584644, 938.7043081429327, 945.8486642137225, 3784.299904517673, 3839.7696138231795, 4325.76208308546, 4382.868513944587, 4449.844255451108, 14603.19682417456, 15287.38850445992, 15297.623213910801, 15317.0, 15371.0, 14494.420223191166, 14997.925010374878, 15238.542843714706, 15248.3900643973, 15270.923645381701, 8348.081711011784, 8590.527520986405, 8591.957040214758, 8718.956405217934, 8738.825223495494, 5890.410958904075, 6509.283978762238, 6564.671766411565, 6760.1549806274215, 6792.490563207878, 12619.81070283928, 13319.800202997156, 13851.79222311646, 13943.930280348533, 13960.232187229394, 13850.445982160601, 13930.95517836146, 13981.790273145707, 14023.929880350941, 14326.57020289393, 9430.387024843638, 9712.980137085504, 9727.270454715783, 9728.659496917857, 9739.366941148803, 9638.277129215478, 9642.517874106406, 9949.005099490283, 10756.193285503463, 10844.728881778019, 8769.342299327449, 9188.173064423967, 9222.216111630587, 9349.859752103588, 9409.059094090537, 8702.651893924172, 8911.0, 8995.730128096167, 9103.453792772454, 9127.680531181377, 8113.5131892086665, 8284.50292982423, 8294.129116442928, 8308.086110527958, 8311.459755115899, 5291.3121294231505, 5948.917878742405, 5952.107183922273, 6162.383761623802, 6207.286162091417, 5976.760929562943, 6040.1543783871175, 6054.455099041107, 6146.108814221823, 6205.720742566505], "value": 5404.00572434785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.90642245860994, 396.4667522182663, 405.525535123905, 405.55996743533274, 408.44859439756334, 5790.913136302959, 5807.680577568232, 5849.795257166, 5862.912056319158, 5871.559633027524, 5529.557635389169, 5652.406497317784, 5726.713664316789, 5776.884462310752, 5781.4507621775965, 3640.3265395901713, 4073.6188963160653, 4079.83680652775, 4457.885528617846, 4471.977640111795, 4454.0, 4456.509783923766, 4456.754878481682, 4477.343382948314, 4492.236319825637, 3293.78590391625, 3927.6857851371965, 4260.488741351042, 4423.579759922803, 4426.29179331307, 4012.839486420569, 4208.537060923327, 4231.788410579489, 4234.431722285185, 4244.745315281093, 3512.4204506256438, 3724.087598538348, 3727.850885964558, 3730.477733117366, 3735.2529494101286, 4620.884477888046, 5100.0, 5509.504144626962, 5610.382857885629, 5610.438956104398, 4353.869383918487, 5029.823956161516, 5050.823221187277, 5060.645754797166, 5083.237514372837, 6064.575479716422, 6085.178500902366, 6099.5425343099005, 6103.0, 6152.846178845564, 4004.9599504004877, 4173.7495750254775, 4194.6853985951175, 4203.7057405981595, 4216.536181020086, 5539.972300138514, 5891.293044834647, 6234.625922444668, 6269.373062693694, 6380.29816720165, 3660.3045421369857, 3965.9490235087146, 4134.813933372945, 4155.459790227251, 4225.408442818008, 3638.490611314418, 4349.608535231781, 4354.978225108917, 4365.926185062133, 4372.628326592212, 4473.843415480443, 4754.835065408997, 4899.265110233494, 5078.390593128848, 5092.694438333638, 5289.788408463618, 5794.391588883191, 6178.783742568989, 6186.10301506279, 6210.254769427697, 1204.975900482003, 1464.7363474574465, 1499.5351441053308, 1499.7600383938518, 1502.774583812415, 930.1775614370449, 948.2177203806887, 987.8320685483485, 988.1600639456404, 1002.1982414068716, 4743.620510359163, 5191.402988656278, 5484.2047903053835, 5513.696746678971, 5865.560082993792, 6330.525210609223, 6357.554971152067, 6363.809085727436, 6378.756142552251, 6387.425131738166, 5541.390447050821, 5763.394843541368, 5802.912956305659, 5874.295084589791, 5900.321463031721, 3288.704016638514, 3301.7853839500353, 3331.666833316649, 3335.31626016666, 3356.311956049004, 4728.71627702339, 5240.947590524046, 6081.422264884829, 6479.1901012373455, 6507.219133703986, 5430.067763407795, 6492.967535162294, 6494.0, 6498.415142637185, 6523.804285871432, 6494.642794646245, 6508.630379936666, 6533.575317604341, 6535.771248006392, 6544.284122089375, 5993.460588547052, 6312.242530896322, 6328.588641738273, 6390.329015453496, 6409.166808314889, 5075.857931965278, 5189.584833213409, 6161.291451482957, 6234.75060997555, 6241.531885108726, 5591.287787450288, 6144.692765361803, 6215.34738852414, 6279.434850863444, 6351.5073957619, 3758.2295629396453, 4102.487189101363, 4239.618434340924, 4282.700210985326, 4299.398084268268, 6087.969560152171, 6282.811515654537, 6336.683165841781, 6370.235571731237, 6382.489400848014, 5098.592112630907, 5513.751881165437, 5757.683327417032, 6124.785632502841, 6181.938180618316, 5113.667611605234, 5122.206058061007, 6132.0, 6148.969255153875, 6207.596506227081, 4862.927056094232, 5752.453516915886, 5894.322152952293, 5942.732577033958, 5979.342272349951, 5026.798928042837, 6096.298925623432, 6098.847528811815, 6110.205673262625, 6112.235970503687, 5055.87360315995, 5139.871503212449, 5470.753816078366, 5563.332400112013, 5955.898158840629], "value": 4455.57711216585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.8789211887924, 715.4205093873961, 849.9150084991497, 850.5619605902957, 871.7471933139392, 13239.338033098342, 18040.278388864444, 18366.173522191482, 18603.0, 18618.348357807445, 16546.92908810685, 16844.494665160033, 16952.49142525723, 16953.237104330303, 16964.66070678589, 628.789355565886, 645.9922520867439, 647.1748520636191, 891.2201823404521, 897.7217062710581, 683.8769021576114, 922.6678395777549, 949.9192568631674, 951.3911096897956, 959.9904000959971, 1000.4447531619948, 1003.2525768302588, 1005.0803514783964, 1005.1807776662033, 1019.0930072235716, 998.610541888664, 998.7752755629998, 998.9250806189492, 1000.1099021870541, 1012.9240306976969, 741.5958302724974, 743.6170372258238, 745.6868115391494, 746.6565379925241, 752.7440670172113, 15883.444079457278, 16016.75974860378, 16151.515454536382, 16537.090460024694, 16934.83065169357, 16555.420560280454, 16608.0, 16794.916025419916, 17035.97784132956, 17085.48743537696, 11776.646700598996, 13867.930660346734, 14102.224377659224, 14222.217778022205, 14264.286785660675, 3426.588809342895, 3448.2413868948793, 3448.8620455181763, 3449.1721986723255, 3457.481377793326, 110266.89733102647, 120800.58398832062, 125086.0, 127373.0, 128813.42373152578, 11954.222975506564, 11984.940075299743, 12024.939875300568, 12130.332831694164, 12275.693107672201, 20450.897745511178, 20548.38354849357, 20579.07394167266, 21015.369538913856, 21026.684599731016, 7209.711611535585, 7249.238829922782, 7260.927390726025, 7263.745768898063, 7267.055282813306, 3788.905277368033, 3841.500604921398, 3855.556610989716, 3895.8831235062994, 3908.785016824102, 4221.261279276176, 4307.22469955411, 4313.956860431355, 4321.308590625485, 4321.308590625485, 850.706506255341, 861.8060936289285, 862.159394590282, 904.5658084119659, 931.7391130483476, 622.6730966242759, 637.7608396851181, 638.2755572425331, 650.8633187030682, 667.7162206062501, 9592.944776074626, 10907.718812215384, 11103.111751059896, 11930.701732456759, 12033.398330083635, 631.0282165465223, 633.1800318587349, 637.636547168119, 644.5037321262602, 672.5359501943643, 4376.978115109404, 5142.948570514322, 5174.456682048331, 5313.415524292324, 5540.889182216414, 110164.4491777552, 111324.33013504803, 112493.43753281182, 113709.0, 114494.0, 83138.58430707808, 83720.0, 98679.50660246653, 99827.0, 101148.49425752825, 77344.45311093859, 77579.61210193913, 77762.0, 79230.0, 79287.4142517158, 11771.823422648496, 12260.203086799329, 12271.631851044483, 12317.384130793604, 12372.81440778407, 29370.11889643314, 39974.0, 40093.59906400899, 40248.59129930555, 41012.79493602513, 40569.59430405658, 50544.49455505545, 52787.73606131945, 53167.0, 53257.6685582848, 12870.806937895752, 13028.47886084546, 15445.382184712485, 15661.060336379855, 15990.120543370227, 15206.391744330103, 17029.403970861455, 17463.912680436515, 17555.210015549077, 18080.276788928295, 13809.51666691661, 16051.759223611421, 16148.515544533682, 16541.421050263183, 16959.23683434273, 16180.595485112966, 16267.430639927547, 16427.753583696493, 16672.749908751623, 16711.415100471426, 15824.841751582797, 16054.759178612563, 16170.353185872904, 16255.105969171336, 16497.422590209284, 11069.5572177112, 11348.148888833206, 11391.829122563002, 11538.192326537397, 11546.0, 12728.490860365851, 12757.808632870328, 12771.808422873479, 12819.615411537668, 12821.487140514275], "value": 8009.521682480573, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 112.0, 111.0, 112.0, 110.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 132.0, 129.0, 127.0, 137.0, 113.0, 108.0, 132.0, 104.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 185.0, 185.0, 182.0, 196.0, 256.0, 182.0, 192.0, 254.0], "value": 199.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 64.0, 96.0, 86.0, 61.0, 61.0, 59.0, 81.0, 58.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 70.0, 68.0, 67.0, 90.0, 74.0, 90.0, 117.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 86.0, 88.0, 86.0, 87.0, 86.0, 87.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 94.0, 94.0, 106.0, 104.0, 94.0, 94.0, 105.0, 148.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 84.0, 84.0, 82.0, 83.0, 83.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 47.0, 47.0, 66.0, 76.0, 75.0, 75.0, 56.0, 51.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 52.0, 59.0, 66.0, 61.0, 57.0, 55.0, 56.0, 56.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 81.0, 83.0, 83.0, 82.0, 80.0, 82.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 143.0, 137.0, 137.0, 137.0, 137.0, 136.0, 223.0, 152.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 191.0, 190.0, 192.0, 193.0, 189.0, 191.0, 189.0, 191.0, 183.0], "value": 189.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 68.0, 69.0, 67.0, 69.0, 68.0, 69.0, 70.0], "value": 68.5, "unit": "score"}]}]} 14:46:18 INFO - Return code: 0 14:46:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:46:18 ERROR - # TBPL SUCCESS # 14:46:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:46:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:46:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:46:18 INFO - 2017-04-24 14:46:18.631 screenresolution[1655:9921] starting screenresolution argv=screenresolution get 14:46:18 INFO - 2017-04-24 14:46:18.633 screenresolution[1655:9921] Display 0: 1600x1200x32@60 14:46:18 INFO - 2017-04-24 14:46:18.640 screenresolution[1656:9924] starting screenresolution argv=screenresolution list 14:46:18 INFO - Available Modes on Display 0 14:46:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:46:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:46:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:46:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:46:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:46:18 INFO - Intel Iris: 14:46:18 INFO - Chipset Model: Intel Iris 14:46:18 INFO - Type: GPU 14:46:18 INFO - Bus: Built-In 14:46:18 INFO - VRAM (Dynamic, Max): 1536 MB 14:46:18 INFO - Vendor: Intel (0x8086) 14:46:18 INFO - Device ID: 0x0a2e 14:46:18 INFO - Revision ID: 0x0009 14:46:18 INFO - Displays: 14:46:18 INFO - Display: 14:46:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:46:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:46:18 INFO - Display Serial Number: 1600x1200 60 14:46:18 INFO - Main Display: Yes 14:46:18 INFO - Mirror: Off 14:46:18 INFO - Online: Yes 14:46:18 INFO - Rotation: Supported 14:46:18 INFO - Return code: 0 14:46:18 INFO - Running post-action listener: _resource_record_post_action 14:46:18 INFO - [mozharness: 2017-04-24 21:46:18.886708Z] Finished run-tests step (success) 14:46:18 INFO - Running post-run listener: _resource_record_post_run 14:46:18 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 37229568; Write bytes: 508231168; Read time: 248; Write time: 1575 14:46:18 INFO - TinderboxPrint: CPU usage
53.1% 14:46:18 INFO - TinderboxPrint: I/O read bytes / time
37,229,568 / 248 14:46:18 INFO - TinderboxPrint: I/O write bytes / time
508,231,168 / 1,575 14:46:18 INFO - TinderboxPrint: CPU idle
2,252.7 (46.9%) 14:46:18 INFO - TinderboxPrint: CPU system
951.9 (19.8%) 14:46:18 INFO - TinderboxPrint: CPU user
1,601.0 (33.3%) 14:46:18 INFO - TinderboxPrint: Swap in / out
245,026,816 / 0 14:46:18 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 199483904; Write bytes: 193717760; Read time: 16199; Write time: 432 14:46:18 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 36193280; Write bytes: 297691136; Read time: 233; Write time: 1093 14:46:19 INFO - Running post-run listener: _upload_blobber_files 14:46:19 INFO - Blob upload gear active. 14:46:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:46:19 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 14:46:19 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'] 14:46:19 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 14:46:19 INFO - (blobuploader) - INFO - Open directory for files ... 14:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:20 INFO - (blobuploader) - INFO - Done attempting. 14:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:21 INFO - (blobuploader) - INFO - Done attempting. 14:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:22 INFO - (blobuploader) - INFO - Done attempting. 14:46:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:46:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:24 INFO - (blobuploader) - INFO - Done attempting. 14:46:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:46:24 INFO - Return code: 0 14:46:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:46:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:46:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7e77b67283e47a4f6770eb26cc0adca10eda18140a018757d6cc8daafddca010df28a7ac752df304480cccd5c696cd59b43e87a2cf8b79e0833c50d8daff47ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7eb5e3f446741be3d31cdd0d9936ff133d75e59c4a5be454d498ad8642a2c8c97e496919727a41fd5fb771927b97a0082d7b7ef514a2ffc0017de1ce0408e2e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/46d3df748f447d48aa85752ca29002eedd8e2c773fb70f34d0100d75aa2e7c61c1c0151d1c2fe72b9a22c9ebab14b4ce15322280082b90d9e45e252c730c647a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/66b789ae0df3804fe797af7b821af40095273d1265d8ad4235b845da2d56af7bc2ce4bdb1495a4ef69d12dadfa1d5947463db32c8d9ddae10116aedc28065156"} 14:46:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:46:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:46:24 INFO - Contents: 14:46:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7e77b67283e47a4f6770eb26cc0adca10eda18140a018757d6cc8daafddca010df28a7ac752df304480cccd5c696cd59b43e87a2cf8b79e0833c50d8daff47ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7eb5e3f446741be3d31cdd0d9936ff133d75e59c4a5be454d498ad8642a2c8c97e496919727a41fd5fb771927b97a0082d7b7ef514a2ffc0017de1ce0408e2e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/46d3df748f447d48aa85752ca29002eedd8e2c773fb70f34d0100d75aa2e7c61c1c0151d1c2fe72b9a22c9ebab14b4ce15322280082b90d9e45e252c730c647a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/66b789ae0df3804fe797af7b821af40095273d1265d8ad4235b845da2d56af7bc2ce4bdb1495a4ef69d12dadfa1d5947463db32c8d9ddae10116aedc28065156"} 14:46:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:46:24 INFO - Copying logs to upload dir... 14:46:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:46:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.178369 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-24 14:46:24.452935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 14:46:24.456854) ========= 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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/7e77b67283e47a4f6770eb26cc0adca10eda18140a018757d6cc8daafddca010df28a7ac752df304480cccd5c696cd59b43e87a2cf8b79e0833c50d8daff47ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7eb5e3f446741be3d31cdd0d9936ff133d75e59c4a5be454d498ad8642a2c8c97e496919727a41fd5fb771927b97a0082d7b7ef514a2ffc0017de1ce0408e2e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/46d3df748f447d48aa85752ca29002eedd8e2c773fb70f34d0100d75aa2e7c61c1c0151d1c2fe72b9a22c9ebab14b4ce15322280082b90d9e45e252c730c647a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/66b789ae0df3804fe797af7b821af40095273d1265d8ad4235b845da2d56af7bc2ce4bdb1495a4ef69d12dadfa1d5947463db32c8d9ddae10116aedc28065156"} build_url:https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/E5FG0YYUSHqsPXo0gAcHAQ/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/7e77b67283e47a4f6770eb26cc0adca10eda18140a018757d6cc8daafddca010df28a7ac752df304480cccd5c696cd59b43e87a2cf8b79e0833c50d8daff47ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7eb5e3f446741be3d31cdd0d9936ff133d75e59c4a5be454d498ad8642a2c8c97e496919727a41fd5fb771927b97a0082d7b7ef514a2ffc0017de1ce0408e2e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/46d3df748f447d48aa85752ca29002eedd8e2c773fb70f34d0100d75aa2e7c61c1c0151d1c2fe72b9a22c9ebab14b4ce15322280082b90d9e45e252c730c647a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/66b789ae0df3804fe797af7b821af40095273d1265d8ad4235b845da2d56af7bc2ce4bdb1495a4ef69d12dadfa1d5947463db32c8d9ddae10116aedc28065156"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 14:46:24.492503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:46:24.492804) ========= 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.Pe2z4TpO21/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.jw9lHzaGTC/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:46:24.541037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 14:46:24.541319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 14:46:24.541641) ========= ========= Total master_lag: 0.37 =========