builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0335 starttime: 1489436978.22 results: success (0) buildid: 20170313123037 builduid: df50f13b687440199be8df0d4a7cbc70 revision: a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.223909) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.224327) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.224608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.249264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.249621) ========= 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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-13 13:29:38-- 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% 57.2M=0s 2017-03-13 13:29:38 (57.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.373479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.373798) ========= 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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.024122 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.422206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:38.422561) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mC0Oz7fdVE/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.r6olZRWkE3/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-13 13:29:38,511 truncating revision to first 12 chars 2017-03-13 13:29:38,511 Setting DEBUG logging. 2017-03-13 13:29:38,511 attempt 1/10 2017-03-13 13:29:38,511 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a70aec4e81ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 13:29:38,981 unpacking tar archive at: mozilla-beta-a70aec4e81ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735086 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:39.183332) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:39.183661) ========= script_repo_revision: a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:39.184089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:39.184614) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 13:29:39.207286) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-13 13:29:39.207743) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mC0Oz7fdVE/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.r6olZRWkE3/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:29:39 INFO - MultiFileLogger online at 20170313 13:29:39 in /builds/slave/test 13:29:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:29:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:29:39 INFO - {'append_to_log': False, 13:29:39 INFO - 'base_work_dir': '/builds/slave/test', 13:29:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:29:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:29:39 INFO - 'branch': 'Mozilla-Beta', 13:29:39 INFO - 'buildbot_json_path': 'buildprops.json', 13:29:39 INFO - 'config_files': ('talos/mac_config.py',), 13:29:39 INFO - 'default_actions': ('clobber', 13:29:39 INFO - 'read-buildbot-config', 13:29:39 INFO - 'download-and-extract', 13:29:39 INFO - 'populate-webroot', 13:29:39 INFO - 'create-virtualenv', 13:29:39 INFO - 'install', 13:29:39 INFO - 'run-tests'), 13:29:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:29:39 INFO - 'download_minidump_stackwalk': True, 13:29:39 INFO - 'download_symbols': 'ondemand', 13:29:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:29:39 INFO - 'tooltool.py': '/tools/tooltool.py', 13:29:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:29:39 INFO - '/tools/misc-python/virtualenv.py')}, 13:29:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:29:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:29:39 INFO - 'installer_path': 'installer.exe', 13:29:39 INFO - 'log_level': 'info', 13:29:39 INFO - 'log_name': 'talos', 13:29:39 INFO - 'log_to_console': True, 13:29:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:29:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:29:39 INFO - 'opt_config_files': (), 13:29:39 INFO - 'pip_index': False, 13:29:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:29:39 INFO - 'cmd': ('bash', 13:29:39 INFO - '-c', 13:29:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:29:39 INFO - 'enabled': True, 13:29:39 INFO - 'halt_on_failure': False, 13:29:39 INFO - 'name': 'check_screen_resolution'},), 13:29:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:29:39 INFO - 'cmd': ('bash', 13:29:39 INFO - '-c', 13:29:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:29:39 INFO - 'enabled': True, 13:29:39 INFO - 'halt_on_failure': False, 13:29:39 INFO - 'name': 'check_screen_resolution'},), 13:29:39 INFO - 'run_cmd_checks_enabled': True, 13:29:39 INFO - 'sps_profile': False, 13:29:39 INFO - 'sps_profile_interval': 0, 13:29:39 INFO - 'suite': 'dromaeojs', 13:29:39 INFO - 'system_bits': '32', 13:29:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:29:39 INFO - 'title': 't-yosemite-r7-0335', 13:29:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:29:39 INFO - 'use_talos_json': True, 13:29:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:29:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:29:39 INFO - 'work_dir': 'build'} 13:29:39 INFO - [mozharness: 2017-03-13 20:29:39.415721Z] Running clobber step. 13:29:39 INFO - Running pre-action listener: _resource_record_pre_action 13:29:39 INFO - Running main action method: clobber 13:29:39 INFO - rmtree: /builds/slave/test/build 13:29:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:29:41 INFO - Running post-action listener: _resource_record_post_action 13:29:41 INFO - [mozharness: 2017-03-13 20:29:41.715722Z] Finished clobber step (success) 13:29:41 INFO - [mozharness: 2017-03-13 20:29:41.715889Z] Running read-buildbot-config step. 13:29:41 INFO - Running pre-action listener: _resource_record_pre_action 13:29:41 INFO - Running main action method: read_buildbot_config 13:29:41 INFO - Using buildbot properties: 13:29:41 INFO - { 13:29:41 INFO - "project": "", 13:29:41 INFO - "product": "firefox", 13:29:41 INFO - "script_repo_revision": "production", 13:29:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:29:41 INFO - "repository": "", 13:29:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:29:41 INFO - "buildid": "20170313123037", 13:29:41 INFO - "pgo_build": "False", 13:29:41 INFO - "basedir": "/builds/slave/test", 13:29:41 INFO - "buildnumber": 3, 13:29:41 INFO - "slavename": "t-yosemite-r7-0335", 13:29:41 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:29:41 INFO - "platform": "yosemite_r7", 13:29:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:29:41 INFO - "branch": "mozilla-beta", 13:29:41 INFO - "repo_path": "releases/mozilla-beta", 13:29:41 INFO - "revision": "a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1", 13:29:41 INFO - "stage_platform": "macosx64", 13:29:41 INFO - "builduid": "df50f13b687440199be8df0d4a7cbc70", 13:29:41 INFO - "slavebuilddir": "test" 13:29:41 INFO - } 13:29:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 13:29:41 INFO - Running post-action listener: _resource_record_post_action 13:29:41 INFO - [mozharness: 2017-03-13 20:29:41.719381Z] Finished read-buildbot-config step (success) 13:29:41 INFO - [mozharness: 2017-03-13 20:29:41.719529Z] Running download-and-extract step. 13:29:41 INFO - Running pre-action listener: _resource_record_pre_action 13:29:41 INFO - Running main action method: download_and_extract 13:29:41 INFO - mkdir: /builds/slave/test/build/tests 13:29: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')]} 13:29:41 INFO - trying https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 13:29:41 INFO - Downloading https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 13:29:42 INFO - Downloaded 1165 bytes. 13:29:42 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 13:29:42 INFO - Using the following test package requirements: 13:29:42 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:29:42 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 13:29:42 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 13:29:42 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:29:42 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 13:29:42 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 13:29:42 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 13:29:42 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 13:29:42 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 13:29:42 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 13:29:42 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 13:29:42 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 13:29:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:29:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:29:42 INFO - Fetch https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:29:43 INFO - Expected file size: 16104308 13:29:43 INFO - Obtained file size: 16104308 13:29:50 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 13:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 13:29:50 INFO - Fetch https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 13:29:51 INFO - Expected file size: 16104308 13:29:51 INFO - Obtained file size: 16104308 13:29:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 13:29:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 13:29:57 INFO - Fetch https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 13:29:58 INFO - Expected file size: 14403650 13:29:58 INFO - Obtained file size: 14403650 13:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:29:58 INFO - trying https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:29:58 INFO - Downloading https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 13:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 13:30:01 INFO - Downloaded 58691216 bytes. 13:30:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:30:01 INFO - mkdir: /builds/slave/test/properties 13:30:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:30:01 INFO - Writing to file /builds/slave/test/properties/build_url 13:30:01 INFO - Contents: 13:30:01 INFO - build_url:https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 13:30:01 INFO - Running post-action listener: _resource_record_post_action 13:30:01 INFO - Running post-action listener: set_extra_try_arguments 13:30:01 INFO - [mozharness: 2017-03-13 20:30:01.823701Z] Finished download-and-extract step (success) 13:30:01 INFO - [mozharness: 2017-03-13 20:30:01.823829Z] Running populate-webroot step. 13:30:01 INFO - Running pre-action listener: _resource_record_pre_action 13:30:01 INFO - Running main action method: populate_webroot 13:30:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:30:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:30:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:30:01 INFO - '--tppagecycles', 13:30:01 INFO - '7'], 13:30:01 INFO - 'tests': ['tsvgm']}}, 13:30:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:30:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:30:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:30:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:30:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['damp', 'tps']}, 13:30:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'tests': ['damp', 'tps']}, 13:30:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['dromaeo_dom']}, 13:30:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:30:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['basic_compositor_video']}, 13:30:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:30:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['a11yr', 13:30:01 INFO - 'ts_paint', 13:30:01 INFO - 'tpaint', 13:30:01 INFO - 'sessionrestore', 13:30:01 INFO - 'sessionrestore_no_auto_restore', 13:30:01 INFO - 'tabpaint']}, 13:30:01 INFO - 'other-e10s': {'tests': ['a11yr', 13:30:01 INFO - 'ts_paint', 13:30:01 INFO - 'tpaint', 13:30:01 INFO - 'sessionrestore', 13:30:01 INFO - 'sessionrestore_no_auto_restore', 13:30:01 INFO - 'tabpaint']}, 13:30:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:30:01 INFO - 'ts_paint', 13:30:01 INFO - 'tpaint', 13:30:01 INFO - 'sessionrestore', 13:30:01 INFO - 'sessionrestore_no_auto_restore', 13:30:01 INFO - 'tabpaint']}, 13:30:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:30:01 INFO - 'ts_paint', 13:30:01 INFO - 'tpaint', 13:30:01 INFO - 'sessionrestore', 13:30:01 INFO - 'sessionrestore_no_auto_restore', 13:30:01 INFO - 'tabpaint']}, 13:30:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['a11yr', 13:30:01 INFO - 'ts_paint', 13:30:01 INFO - 'tpaint', 13:30:01 INFO - 'sessionrestore', 13:30:01 INFO - 'sessionrestore_no_auto_restore', 13:30:01 INFO - 'tabpaint']}, 13:30:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['a11yr', 13:30:01 INFO - 'ts_paint', 13:30:01 INFO - 'tpaint', 13:30:01 INFO - 'sessionrestore', 13:30:01 INFO - 'sessionrestore_no_auto_restore', 13:30:01 INFO - 'tabpaint']}, 13:30:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['tsvgx', 13:30:01 INFO - 'tsvgr_opacity', 13:30:01 INFO - 'tart', 13:30:01 INFO - 'tscrollx', 13:30:01 INFO - 'cart', 13:30:01 INFO - 'tsvg_static']}, 13:30:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:30:01 INFO - 'tsvgr_opacity', 13:30:01 INFO - 'tart', 13:30:01 INFO - 'tscrollx', 13:30:01 INFO - 'cart', 13:30:01 INFO - 'tsvg_static']}, 13:30:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'talos_options': ['--disable-e10s'], 13:30:01 INFO - 'tests': ['tp5o']}, 13:30:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:30:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'talos_options': ['--disable-e10s', 13:30:01 INFO - '--xperf_path', 13:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:01 INFO - 'tests': ['tp5n']}, 13:30:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:30:01 INFO - 'talos_options': ['--xperf_path', 13:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:01 INFO - 'tests': ['tp5n']}}, 13:30:01 INFO - 'talos.zip': {'path': '', 13:30:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:30:01 INFO - Running post-action listener: _resource_record_post_action 13:30:01 INFO - [mozharness: 2017-03-13 20:30:01.841852Z] Finished populate-webroot step (success) 13:30:01 INFO - [mozharness: 2017-03-13 20:30:01.841963Z] Running create-virtualenv step. 13:30:01 INFO - Running pre-action listener: _resource_record_pre_action 13:30:01 INFO - Running main action method: create_virtualenv 13:30:01 INFO - Creating virtualenv /builds/slave/test/build/venv 13:30:01 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 13:30:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:30:01 INFO - Using real prefix '/tools/python27' 13:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:30:02 INFO - Installing distribute.............................................................................................................................................................................................done. 13:30:05 INFO - Installing pip.................done. 13:30:05 INFO - Return code: 0 13:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:30:05 INFO - Reading from file tmpfile_stdout 13:30:05 INFO - Output received: 13:30:05 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) 13:30:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:30:05 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')]} 13:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:05 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')]} 13:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:05 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:05 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 13:30:05 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 13:30:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:05 INFO - 'HOME': '/Users/cltbld', 13:30:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:05 INFO - 'LOGNAME': 'cltbld', 13:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:05 INFO - 'MOZ_NO_REMOTE': '1', 13:30:05 INFO - 'NO_EM_RESTART': '1', 13:30:05 INFO - 'PAGER': '/bin/cat', 13:30:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:05 INFO - 'PWD': '/builds/slave/test', 13:30:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:05 INFO - 'SHELL': '/bin/bash', 13:30:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:05 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:05 INFO - 'USER': 'cltbld', 13:30:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:05 INFO - 'XPC_FLAGS': '0x0', 13:30:05 INFO - 'XPC_SERVICE_NAME': '0', 13:30:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:06 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 13:30:06 INFO - Cleaning up... 13:30:06 INFO - Return code: 0 13:30:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:30:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:06 INFO - 'HOME': '/Users/cltbld', 13:30:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:06 INFO - 'LOGNAME': 'cltbld', 13:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:06 INFO - 'MOZ_NO_REMOTE': '1', 13:30:06 INFO - 'NO_EM_RESTART': '1', 13:30:06 INFO - 'PAGER': '/bin/cat', 13:30:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:06 INFO - 'PWD': '/builds/slave/test', 13:30:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:06 INFO - 'SHELL': '/bin/bash', 13:30:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:06 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:06 INFO - 'USER': 'cltbld', 13:30:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:06 INFO - 'XPC_FLAGS': '0x0', 13:30:06 INFO - 'XPC_SERVICE_NAME': '0', 13:30:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:06 INFO - Downloading/unpacking psutil>=3.1.1 13:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:10 INFO - Installing collected packages: psutil 13:30:10 INFO - Running setup.py install for psutil 13:30:10 INFO - building 'psutil._psutil_osx' extension 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 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 13:30:10 INFO - building 'psutil._psutil_posix' extension 13:30:10 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 13:30:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:30:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:30:10 INFO - ^ 13:30:10 INFO - 1 warning generated. 13:30:10 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 13:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:10 INFO - Successfully installed psutil 13:30:10 INFO - Cleaning up... 13:30:11 INFO - Return code: 0 13:30:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:11 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:11 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 13:30:11 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 13:30:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:11 INFO - 'HOME': '/Users/cltbld', 13:30:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:11 INFO - 'LOGNAME': 'cltbld', 13:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:11 INFO - 'MOZ_NO_REMOTE': '1', 13:30:11 INFO - 'NO_EM_RESTART': '1', 13:30:11 INFO - 'PAGER': '/bin/cat', 13:30:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:11 INFO - 'PWD': '/builds/slave/test', 13:30:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:11 INFO - 'SHELL': '/bin/bash', 13:30:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:11 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:11 INFO - 'USER': 'cltbld', 13:30:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:11 INFO - 'XPC_FLAGS': '0x0', 13:30:11 INFO - 'XPC_SERVICE_NAME': '0', 13:30:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:30:13 INFO - Installing collected packages: mozsystemmonitor 13:30:13 INFO - Running setup.py install for mozsystemmonitor 13:30:14 INFO - Successfully installed mozsystemmonitor 13:30:14 INFO - Cleaning up... 13:30:14 INFO - Return code: 0 13:30:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:30:14 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')]} 13:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:14 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')]} 13:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:14 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:14 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 13:30:14 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 13:30:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:14 INFO - 'HOME': '/Users/cltbld', 13:30:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:14 INFO - 'LOGNAME': 'cltbld', 13:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:14 INFO - 'MOZ_NO_REMOTE': '1', 13:30:14 INFO - 'NO_EM_RESTART': '1', 13:30:14 INFO - 'PAGER': '/bin/cat', 13:30:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:14 INFO - 'PWD': '/builds/slave/test', 13:30:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:14 INFO - 'SHELL': '/bin/bash', 13:30:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:14 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:14 INFO - 'USER': 'cltbld', 13:30:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:14 INFO - 'XPC_FLAGS': '0x0', 13:30:14 INFO - 'XPC_SERVICE_NAME': '0', 13:30:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:14 INFO - Downloading/unpacking jsonschema==2.5.1 13:30:14 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 13:30:14 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 13:30:14 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 13:30:14 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 13:30:14 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 13:30:14 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 13:30:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:30:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:17 INFO - Downloading functools32-3.2.3-2.tar.gz 13:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:30:17 INFO - warning: no files found matching '*.txt' 13:30:17 INFO - no previously-included directories found matching 'build' 13:30:17 INFO - no previously-included directories found matching 'dist' 13:30:17 INFO - no previously-included directories found matching '.git*' 13:30:17 INFO - Installing collected packages: jsonschema, functools32 13:30:17 INFO - Running setup.py install for functools32 13:30:17 INFO - warning: no files found matching '*.txt' 13:30:17 INFO - no previously-included directories found matching 'build' 13:30:17 INFO - no previously-included directories found matching 'dist' 13:30:17 INFO - no previously-included directories found matching '.git*' 13:30:17 INFO - Successfully installed jsonschema functools32 13:30:17 INFO - Cleaning up... 13:30:17 INFO - Return code: 0 13:30:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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', '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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:30: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 functools32==3.2.3-2 13:30:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:17 INFO - 'HOME': '/Users/cltbld', 13:30:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:17 INFO - 'LOGNAME': 'cltbld', 13:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:17 INFO - 'MOZ_NO_REMOTE': '1', 13:30:17 INFO - 'NO_EM_RESTART': '1', 13:30:17 INFO - 'PAGER': '/bin/cat', 13:30:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:17 INFO - 'PWD': '/builds/slave/test', 13:30:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:17 INFO - 'SHELL': '/bin/bash', 13:30:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:17 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:17 INFO - 'USER': 'cltbld', 13:30:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:17 INFO - 'XPC_FLAGS': '0x0', 13:30:17 INFO - 'XPC_SERVICE_NAME': '0', 13:30:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:30:18 INFO - Cleaning up... 13:30:18 INFO - Return code: 0 13:30:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:18 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:18 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 13:30:18 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 13:30:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:18 INFO - 'HOME': '/Users/cltbld', 13:30:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:18 INFO - 'LOGNAME': 'cltbld', 13:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:18 INFO - 'MOZ_NO_REMOTE': '1', 13:30:18 INFO - 'NO_EM_RESTART': '1', 13:30:18 INFO - 'PAGER': '/bin/cat', 13:30:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:18 INFO - 'PWD': '/builds/slave/test', 13:30:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:18 INFO - 'SHELL': '/bin/bash', 13:30:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:18 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:18 INFO - 'USER': 'cltbld', 13:30:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:18 INFO - 'XPC_FLAGS': '0x0', 13:30:18 INFO - 'XPC_SERVICE_NAME': '0', 13:30:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:18 INFO - Downloading/unpacking blobuploader==1.2.4 13:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:30:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:30:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 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 13:30:21 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 13:30:22 INFO - Downloading docopt-0.6.1.tar.gz 13:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:30:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:30:22 INFO - Running setup.py install for blobuploader 13:30:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:30:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:30:22 INFO - Running setup.py install for requests 13:30:23 INFO - Running setup.py install for docopt 13:30:23 INFO - Successfully installed blobuploader requests docopt 13:30:23 INFO - Cleaning up... 13:30:23 INFO - Return code: 0 13:30:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:23 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')]} 13:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:23 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')]} 13:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:23 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:23 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 13:30:23 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 13:30:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:23 INFO - 'HOME': '/Users/cltbld', 13:30:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:23 INFO - 'LOGNAME': 'cltbld', 13:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:23 INFO - 'MOZ_NO_REMOTE': '1', 13:30:23 INFO - 'NO_EM_RESTART': '1', 13:30:23 INFO - 'PAGER': '/bin/cat', 13:30:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:23 INFO - 'PWD': '/builds/slave/test', 13:30:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:23 INFO - 'SHELL': '/bin/bash', 13:30:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:23 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:23 INFO - 'USER': 'cltbld', 13:30:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:23 INFO - 'XPC_FLAGS': '0x0', 13:30:23 INFO - 'XPC_SERVICE_NAME': '0', 13:30:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-iPNmOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-9MmiQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-6j5dgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:23 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-gICDIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-ZDq8FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-VnPdR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-TuuyUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-deFujB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-URetyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-OpOmlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-GU23Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-U6yGL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:24 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-TVWqED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:25 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-cgXKCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:25 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-kWvggE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:25 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-oC1AKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:25 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-iy7W75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:30:25 INFO - Running setup.py install for manifestparser 13:30:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:30:25 INFO - Running setup.py install for mozcrash 13:30:25 INFO - Running setup.py install for mozdebug 13:30:25 INFO - Running setup.py install for mozdevice 13:30:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Running setup.py install for mozfile 13:30:26 INFO - Running setup.py install for mozhttpd 13:30:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Running setup.py install for mozinfo 13:30:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Running setup.py install for mozInstall 13:30:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Running setup.py install for mozleak 13:30:26 INFO - Running setup.py install for mozlog 13:30:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:30:26 INFO - Running setup.py install for moznetwork 13:30:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:30:27 INFO - Running setup.py install for mozprocess 13:30:27 INFO - Running setup.py install for mozprofile 13:30:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:30:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:30:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:30:27 INFO - Running setup.py install for mozrunner 13:30:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:30:27 INFO - Running setup.py install for mozscreenshot 13:30:27 INFO - Running setup.py install for moztest 13:30:27 INFO - Running setup.py install for mozversion 13:30:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:30:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:30:28 INFO - Cleaning up... 13:30:28 INFO - Return code: 0 13:30:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:28 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')]} 13:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:28 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')]} 13:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:28 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:28 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 13:30:28 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 13:30:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:28 INFO - 'HOME': '/Users/cltbld', 13:30:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:28 INFO - 'LOGNAME': 'cltbld', 13:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:28 INFO - 'MOZ_NO_REMOTE': '1', 13:30:28 INFO - 'NO_EM_RESTART': '1', 13:30:28 INFO - 'PAGER': '/bin/cat', 13:30:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:28 INFO - 'PWD': '/builds/slave/test', 13:30:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:28 INFO - 'SHELL': '/bin/bash', 13:30:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:28 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:28 INFO - 'USER': 'cltbld', 13:30:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:28 INFO - 'XPC_FLAGS': '0x0', 13:30:28 INFO - 'XPC_SERVICE_NAME': '0', 13:30:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:28 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-p2VcyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:28 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)) 13:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:28 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Z0DIzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:28 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)) 13:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:28 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-BQ3mgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:28 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)) 13:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:28 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-aX_in3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:28 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-IpsiGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:28 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)) 13:30:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:28 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-WeMLU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-GYzKR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-29DRvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-gC58jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-mrW6k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Jij4k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-aly7hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-J5de_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-VCOhpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-u4pE8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:29 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)) 13:30:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:29 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-USUExD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:30 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)) 13:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:30 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-KfuwPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:30 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)) 13:30:30 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)) 13:30:30 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)) 13:30:30 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)) 13:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:30:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:32 INFO - Downloading blessings-1.6.tar.gz 13:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:30:32 INFO - Installing collected packages: blessings 13:30:32 INFO - Running setup.py install for blessings 13:30:33 INFO - Successfully installed blessings 13:30:33 INFO - Cleaning up... 13:30:33 INFO - Return code: 0 13:30:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:30:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:33 INFO - Reading from file tmpfile_stdout 13:30:33 INFO - Current package versions: 13:30:33 INFO - blessings == 1.6 13:30:33 INFO - blobuploader == 1.2.4 13:30:33 INFO - docopt == 0.6.1 13:30:33 INFO - functools32 == 3.2.3-2 13:30:33 INFO - jsonschema == 2.5.1 13:30:33 INFO - manifestparser == 1.1 13:30:33 INFO - mozInstall == 1.12 13:30:33 INFO - mozcrash == 1.0 13:30:33 INFO - mozdebug == 0.1 13:30:33 INFO - mozdevice == 0.49 13:30:33 INFO - mozfile == 1.2 13:30:33 INFO - mozhttpd == 0.7 13:30:33 INFO - mozinfo == 0.9 13:30:33 INFO - mozleak == 0.1 13:30:33 INFO - mozlog == 3.4 13:30:33 INFO - moznetwork == 0.27 13:30:33 INFO - mozprocess == 0.24 13:30:33 INFO - mozprofile == 0.28 13:30:33 INFO - mozrunner == 6.13 13:30:33 INFO - mozscreenshot == 0.1 13:30:33 INFO - mozsystemmonitor == 0.3 13:30:33 INFO - moztest == 0.8 13:30:33 INFO - mozversion == 1.4 13:30:33 INFO - psutil == 3.1.1 13:30:33 INFO - requests == 1.2.3 13:30:33 INFO - wsgiref == 0.1.2 13:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:33 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')]} 13:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:33 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')]} 13:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:33 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:33 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 13:30:33 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 13:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:33 INFO - 'HOME': '/Users/cltbld', 13:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:33 INFO - 'LOGNAME': 'cltbld', 13:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:33 INFO - 'MOZ_NO_REMOTE': '1', 13:30:33 INFO - 'NO_EM_RESTART': '1', 13:30:33 INFO - 'PAGER': '/bin/cat', 13:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:33 INFO - 'PWD': '/builds/slave/test', 13:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:33 INFO - 'SHELL': '/bin/bash', 13:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:33 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:33 INFO - 'USER': 'cltbld', 13:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:33 INFO - 'XPC_FLAGS': '0x0', 13:30:33 INFO - 'XPC_SERVICE_NAME': '0', 13:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 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)) 13:30:33 INFO - Cleaning up... 13:30:33 INFO - Return code: 0 13:30:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:30:33 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')]} 13:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:33 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')]} 13:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:33 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 0x10f56cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f56f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8635de3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, '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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 13:30:33 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 13:30:33 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 13:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:33 INFO - 'HOME': '/Users/cltbld', 13:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:33 INFO - 'LOGNAME': 'cltbld', 13:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:33 INFO - 'MOZ_NO_REMOTE': '1', 13:30:33 INFO - 'NO_EM_RESTART': '1', 13:30:33 INFO - 'PAGER': '/bin/cat', 13:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:33 INFO - 'PWD': '/builds/slave/test', 13:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:33 INFO - 'SHELL': '/bin/bash', 13:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:33 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:33 INFO - 'USER': 'cltbld', 13:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:33 INFO - 'XPC_FLAGS': '0x0', 13:30:33 INFO - 'XPC_SERVICE_NAME': '0', 13:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:30:34 INFO - Cleaning up... 13:30:34 INFO - Return code: 0 13:30:34 INFO - Running post-action listener: _resource_record_post_action 13:30:34 INFO - Running post-action listener: _start_resource_monitoring 13:30:34 INFO - Starting resource monitoring. 13:30:34 INFO - [mozharness: 2017-03-13 20:30:34.051201Z] Finished create-virtualenv step (success) 13:30:34 INFO - [mozharness: 2017-03-13 20:30:34.052191Z] Running install step. 13:30:34 INFO - Running pre-action listener: _resource_record_pre_action 13:30:34 INFO - Running main action method: install 13:30:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:34 INFO - Reading from file tmpfile_stdout 13:30:34 INFO - Detecting whether we're running mozinstall >=1.0... 13:30:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:30:34 INFO - Reading from file tmpfile_stdout 13:30:34 INFO - Output received: 13:30:34 INFO - Usage: mozinstall [options] installer 13:30:34 INFO - Options: 13:30:34 INFO - -h, --help show this help message and exit 13:30:34 INFO - -d DEST, --destination=DEST 13:30:34 INFO - Directory to install application into. [default: 13:30:34 INFO - "/builds/slave/test"] 13:30:34 INFO - --app=APP Application being installed. [default: firefox] 13:30:34 INFO - mkdir: /builds/slave/test/build/application 13:30:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:30:49 INFO - Reading from file tmpfile_stdout 13:30:49 INFO - Output received: 13:30:49 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:30:49 INFO - Running post-action listener: _resource_record_post_action 13:30:49 INFO - [mozharness: 2017-03-13 20:30:49.136848Z] Finished install step (success) 13:30:49 INFO - [mozharness: 2017-03-13 20:30:49.137050Z] Running run-tests step. 13:30:49 INFO - Running pre-action listener: _resource_record_pre_action 13:30:49 INFO - Running main action method: run_tests 13:30:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:30:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:30:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:30:49 INFO - 2017-03-13 13:30:49.151 screenresolution[2237:68112] starting screenresolution argv=screenresolution get 13:30:49 INFO - 2017-03-13 13:30:49.154 screenresolution[2237:68112] Display 0: 1600x1200x32@60 13:30:49 INFO - 2017-03-13 13:30:49.160 screenresolution[2238:68114] starting screenresolution argv=screenresolution list 13:30:49 INFO - Available Modes on Display 0 13:30:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:30:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:30:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:30:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:30:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:30:49 INFO - Intel Iris: 13:30:49 INFO - Chipset Model: Intel Iris 13:30:49 INFO - Type: GPU 13:30:49 INFO - Bus: Built-In 13:30:49 INFO - VRAM (Dynamic, Max): 1536 MB 13:30:49 INFO - Vendor: Intel (0x8086) 13:30:49 INFO - Device ID: 0x0a2e 13:30:49 INFO - Revision ID: 0x0009 13:30:49 INFO - Displays: 13:30:49 INFO - Display: 13:30:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:30:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:30:49 INFO - Display Serial Number: 1600x1200 60 13:30:49 INFO - Main Display: Yes 13:30:49 INFO - Mirror: Off 13:30:49 INFO - Online: Yes 13:30:49 INFO - Rotation: Supported 13:30:49 INFO - Return code: 0 13:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:30:49 INFO - Python 2.7.3 13:30:49 INFO - Return code: 0 13:30:49 INFO - grabbing minidump binary from tooltool 13:30:49 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')]} 13:30:49 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 0x10f34ad30>, '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 0x10f271db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f33fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:30:49 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 13:30:49 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 13:30:49 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 13:30:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:30:49 INFO - Return code: 0 13:30:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:30:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:30:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:30:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:30:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--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 13:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0335 --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 13:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mC0Oz7fdVE/Render', 13:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:30:49 INFO - 'HOME': '/Users/cltbld', 13:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:30:49 INFO - 'LOGNAME': 'cltbld', 13:30:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:30:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:49 INFO - 'MOZ_NO_REMOTE': '1', 13:30:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:30:49 INFO - 'NO_EM_RESTART': '1', 13:30:49 INFO - 'PAGER': '/bin/cat', 13:30:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:49 INFO - 'PWD': '/builds/slave/test', 13:30:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:30:49 INFO - 'SHELL': '/bin/bash', 13:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r6olZRWkE3/Listeners', 13:30:49 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 13:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:30:49 INFO - 'USER': 'cltbld', 13:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:49 INFO - 'XPC_FLAGS': '0x0', 13:30:49 INFO - 'XPC_SERVICE_NAME': '0', 13:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:30:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--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 13:30:49 INFO - mozversion application_buildid: 20170313123037 13:30:49 INFO - mozversion application_changeset: a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1 13:30:49 INFO - mozversion application_display_name: Firefox 13:30:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:30:49 INFO - mozversion application_name: Firefox 13:30:49 INFO - mozversion application_remotingname: firefox 13:30:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:30:49 INFO - mozversion application_vendor: Mozilla 13:30:49 INFO - mozversion application_version: 53.0 13:30:49 INFO - mozversion platform_buildid: 20170313123037 13:30:49 INFO - mozversion platform_changeset: a70aec4e81ce3ca5fd1a5303b6aa1251fc9bb1a1 13:30:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:30:49 INFO - mozversion platform_version: 53.0 13:30:49 INFO - using testdate: 1489437049 13:30:49 INFO - actual date: 1489437049 13:30:49 INFO - starting webserver on 'localhost:51487' 13:30:49 INFO - SUITE-START | Running 2 tests 13:30:49 INFO - TEST-START | dromaeo_css 13:30:49 INFO - operating with platform_type : mac_ 13:30:49 INFO - Initialising browser for dromaeo_css test... 13:30:49 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmp4InY5p/profile http://localhost:51487/getInfo.html) 13:30:52 INFO - PROCESS | 2248 | __metrics Screen width/height:1600/1200 13:30:52 INFO - PROCESS | 2248 | colorDepth:24 13:30:52 INFO - PROCESS | 2248 | Browser inner width/height: 1024/689 13:30:52 INFO - PROCESS | 2248 | __metrics 13:30:52 INFO - PROCESS | 2248 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:30:52 INFO - PROCESS | 2248 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:52 INFO - TEST-INFO | 2248: exit 0 13:30:52 INFO - Browser initialized. 13:30:52 INFO - Running cycle 1/1 for dromaeo_css test... 13:30:52 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmp4InY5p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:04 INFO - PROCESS | 2251 | RSS: Main: 166711296 13:31:04 INFO - PROCESS | 2251 | 13:34:07 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:51487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51487/tests/dromaeo/cssquery-ext.html) 13:34:09 INFO - PROCESS | 2251 | RSS: Main: 323960832 13:34:09 INFO - PROCESS | 2251 | 13:37:12 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:51487/tests/dromaeo/cssquery-ext.html (next: http://localhost:51487/tests/dromaeo/cssquery-jquery.html) 13:37:13 INFO - PROCESS | 2251 | RSS: Main: 311296000 13:37:13 INFO - PROCESS | 2251 | 13:40:15 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:51487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51487/tests/dromaeo/cssquery-mootools.html) 13:40:15 INFO - PROCESS | 2251 | RSS: Main: 286588928 13:40:15 INFO - PROCESS | 2251 | 13:43:18 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:51487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51487/tests/dromaeo/cssquery-prototype.html) 13:43:18 INFO - PROCESS | 2251 | RSS: Main: 284692480 13:43:18 INFO - PROCESS | 2251 | 13:46:22 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:51487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51487/tests/dromaeo/cssquery-yui.html) 13:46:22 INFO - PROCESS | 2251 | RSS: Main: 275333120 13:46:22 INFO - PROCESS | 2251 | 13:49:25 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:51487/tests/dromaeo/cssquery-yui.html (next: http://localhost:51487/tests/dromaeo/cssquery-dojo.html) 13:49:26 INFO - PROCESS | 2251 | RSS: Main: 493137920 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | __start_tp_report 13:49:26 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 13:49:26 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 13:49:26 INFO - PROCESS | 2251 | |i|pagename|runs| 13:49:26 INFO - PROCESS | 2251 | |0;dojo.html;3405.540252065971;3416.64125266847;3424.8801291954787;3456.7407444441674;3500.9474857877135;5786;5799.101139323401;5810.73851676674;5811.157382179592;5836.970815145924;5775.740091695873;5831.358550559435;5832.6792026438525;5835.124731290309;5848.1520179574045;5101.515356041179;5233.241180028894;5267.789288428458;5317.175837745156;5344.465553444663;5126.589872810185;5136.512031357015;5159.458256883011;5329.946700532983;5341.332333458317;5255.842324730245;5265.526102650761;5269.525742683158;5275;5276.472352764712;5233.842984710464;5264.263003179558;5265.473452654742;5270.631055826094;5271.024860400838;5142.151544995071;5228.79084836606;5228.816991405282;5229.372475302988;5255.605829562798;5814.244148260699;5820.5634577406445;5820.7962721304975;5834.2998840139035;5844.912326315109;6218.844528886769;6227.688615569204;6256.96871515644;6277.686115694197;6288.371162883721;6297.685115744194;6305.495560355206;6313.779017734403;6331.620102793847;6355.3009168991375;5891.764329426818;5897.469227769521;5908.734106965154;5912.674802885839;5927.3776253493625;6216.067589861466;6248.009871039694;6267.9373206268265;6281.685915704196;6316.431521163117;6222.81331560054;6305.716242769086;6316.747330106836;6317.020861766434;6330.651814150174;6297.590656607306;6308.116863639094;6310.211223597051;6317.115603815378;6320.747170113144;6169.444749972435;6355.809325720235;6359.745610175633;6364.554481186365;6365.045243213555;6198.194234749544;6226.813195604139;6236.407541283571;6266.965950618188;6373.52198585108;5014.548690617862;5018.372703412074;5020.322256495327;5025.3718285214345;5032.3206367139965;4514.887127821765;4515.412996310524;4533.206688829442;4541.613962813198;4553.567411095941;5545.1682247663175;5635.380108188096;5650.576206784508;5989.790357337472;5989.9101513477335;6269.059641053787;6295.842603934847;6314;6317.873642527124;6324.43080122782;6048.153258543807;6068.059450785136;6088.330283668793;6091.360407157274;6099.2985806632805;5373.758180881791;5417.322834645669;5434.347878254634;5541.501264886179;5589.972050139723;6382.106505089291;6430.517711171681;6472.320406357265;6551.246606640298;6556.770513032021;6257.2491301044165;6265.467435267871;6291.245050593775;6303.086052522451;6322.2729386119345;6233.376662333731;6445.1943507061615;6483.319251478527;6512.413882750575;6562.507811914221;6073.058675905242;6250.281217660027;6252.906206406817;6293.874122517615;6375.713092910923;5273.947260527346;6293.905591416041;6320.336364681826;6346.428821406095;6347.873042539216;6056.121862330026;6256.186695729526;6266.557775431762;6298;6298.149749783721;6111.113888486056;6125.723854043132;6154.01535754295;6159.29168145669;6296.716647750771;6143.416375444325;6161.72272247741;6161.815145545641;6165.32181460048;6177.62934223948;6246.5002799775;6274.152989346379;6279.591826531444;6282.717277722422;6292.653904035322;5886.087656413263;5915.911261330997;5943.613665111754;5999.4900433463645;6075.422834830684 13:49:26 INFO - PROCESS | 2251 | |1;ext.html;470.18657722140694;519.1641457253824;523.4294618865438;536.922146288788;562.555581090938;30144;41863.162736745246;43779.90550236245;43834.12331753371;45072;45525.31712024314;45885.54114458855;45975.31037034447;46013.84965375859;46091.53908460915;9021.097890210993;9613.99053099425;9806.656767013155;9811.362261452983;9816.067473590034;8995.550222488882;11739.354335511543;12007.399630018508;12056.93971530141;12215.144939854214;11890.10824188185;11909.523619055228;11966.401679916013;11976.28142311464;11979.520819167266;12000.819987700148;12047.518099276105;12058.276503409823;12066.457009434509;12103.818442723366;10454;10921.12630989519;11845.703857403547;11949.342786146759;11953;42197.57802421967;42744.7176584703;42962.78518607387;43052.784736076435;43191;4038.5557588665224;4110.609492098246;4132.297509423405;4139.503259608836;4146.730462519927;30612.846935765403;31669;32785.50821737676;33257.334853303044;33383.16542086443;3269.950950735717;3465.462853257749;3470.774399664014;3532.364174448598;3544.787312761217;499760;501192;501254;502700.48649756884;503926;64311.678441607495;64581.03128453077;64828;64859;64881.67559162174;65480;65583;65601.01598476026;65665.34334656688;65716;17343.392981245597;17562.736558951627;17580.208890599955;17594.560135996446;17634;12417.44121514534;12635.557755478514;13384.799228011587;13450.327483625975;13483.52807651747;14975.951683382276;16359.018458892504;16576.75134872978;16746.4138755143;16997;5989.371116032841;6105.84735381619;6990.9300906990275;7078.893816592756;7127.4298056155385;888.1873086126251;889.8620713789373;903.8418276801533;942.9952850235705;944.5371767833713;29690.851545742564;30109;30554.69445305563;30848.383032339676;31221;905.8867641544807;1127.1715289262386;1132.592266783957;1155.422288855572;1177.6879127031343;15716.21418929049;16223.918880405523;16227.83772162287;16330.265138068578;16616;583295;583468;587769;589728;760014;51279.743601281756;51748.965020700125;62475;63686;63702;1462.1738717624507;1489.7095066462152;1493.8954273200773;1516.4010215964852;1519.5365413548752;29128.854355728086;31170.68829311678;32265.838670806497;32350;32477.51283730793;53268.4673153279;53765.38703838891;53827;53839.730801345744;53940.46059539511;540040;558178;560253;560327;702339;25272;26312.736872631795;26551.33621659474;26826;27017.324566885985;48320.5167948316;48698;48787.26819097645;49325.2601210975;49433;39353.60646393499;39533.604663952996;39786.20427591374;39972.80013599913;41025;35437;39308.80345598254;39362.606373935894;40006.59993400145;40895.77312680624;37995.43006854955;38541.22917541577;38549.4217586742;38564.80717596394;38882;32434.35131297408;34375.82812085924;34481.31037379288;34546.96359109231;34662.653373465946;19999;24810.245494111008;25096.37259068538;25233.747662523874;25636.871815640803 13:49:26 INFO - PROCESS | 2251 | |2;jquery.html;334.15380025359883;401.9638232559071;407.4072224912752;415.88563145135083;436.8929612245;17545.473635790913;21940.341789746293;22386.664200037012;22396;22741.772582274174;23359.532809343804;23455;23881.5223695526;24080.157194498195;24207.63688544669;5940.405959404057;6146.385361463863;6283.528735344845;6284.842878928018;6296;5892.116182572606;6113.510919126482;6179.536534759888;6193.597416167957;6206.410391012869;5315.910238401138;5801.82594522165;6010.939890601082;6159.630422174661;6168.969155154218;5904.645721256738;6099.359567245442;6165.013597824349;6171.352008039181;6175.382461753834;5318.6542874713405;5343.412224655285;5402.189671549259;5416.891662166774;5423.810166644149;28285.434291314265;28295.434091318264;28396.71603283982;28420.715792842013;28671.56992645112;2832.306085009165;2874.626298581171;2898.145047211057;2900.10096869971;2904.4771941050603;16287.51137465878;16426.93224940375;16526.83473165277;16590.75113873293;17190.914045429694;1833.4133077415233;1879.0792511669183;1894.0813705352894;1923.807619238079;1927.0364817591205;128178;134307.32846335805;136000;140455;140721.99999999898;11345.376004319842;11859.822102668468;11898.16712830111;11905.166638335233;11909.285442873455;15637.843621563867;15648.982816116915;15661.530154095395;15693.921530392276;15695.529134125994;8962.372633915693;9153.130452606993;9155.771105722277;9272.443653380818;9281.350305478687;9060.003399626035;9114.954425227832;9128.452292862317;9308.581113849894;9319.30105242096;7561.508501947355;7679.656060189444;7714.729984450517;7721.922780772233;7729.458937874408;1946.5912158446886;1979.6931475621302;1979.9901000494906;1981.8810871347766;1983.652860749363;1051.731808388856;1061.1669839176209;1067.8771941226703;1079.2930630437077;1128.7573171768108;23002.884985574965;23690.407739806644;23696.93363798633;23852.045918163425;23866.806659667294;983.3509883476871;1025.3079171559168;1079.63292480557;1142.7543078238218;1147.2772153543215;9731.756706082404;12130.636080917586;12936.725688041293;12976.480940762263;13251.403686834115;810006;814611;830501;834336;845510;108749.29449158798;149026;152833.12250948735;171390;176488;1049.4333060147435;1061.3790932304535;1077.0575746222055;1086.4241951765578;1089.090609341209;16404.67190656156;19396;19730.60538789245;19897.403077907686;21397.144114235256;44794;49477.25784113169;58738;64687.70624587388;66153.67692646217;73094.90357644745;91342.08657913601;91952;92715.53642231745;93944;6487.610743355413;8748;8809.911900880908;8828.117188281121;9316.534173291444;9813.656522021694;13856.792148117987;13956.930215348859;14251;14676.119432834064;11178.832317515082;11218.495167717636;11372.31766094037;11822.527098915947;12143.39283035827;9364.625414983324;11547.595834146101;11708.648740537797;12031.939840301093;12058.095642826647;11359.204855660024;11722.41387930583;11813.291202527877;12290.508379664714;12438.626841194779;8719.302455803647;8805.471671699463;8833.205011548991;9006.279497640304;9229.769255768391;8859.202671759573;11208.495617697386;11755.353455560027;12140.75718485643;12201.20692155007 13:49:26 INFO - PROCESS | 2251 | |3;mootools.html;1483.095311859766;1484.9331780069895;1501.6921531086125;1513.6215946013504;1517.6509402837348;8293.253607175353;8656.350773691975;8664.263537599296;8673.219410253068;8678.956605216965;7655.846883062335;7858.332041776456;8291.046529649077;8492.363072769536;8493.617787199575;2419;2463.7659422354845;2466.962995555059;2469.6542484052247;2477.2196758021164;2444.0590372706456;2462.396712805365;2466.3217615155886;2470.3330100872754;2477.8141639377027;2390.6653068570413;2401.6637670726113;2403.351095204294;2418.7823095921362;2427.8179136564827;1877.8357418400542;2133.95732085359;2292.6473380705297;2371.3834403055157;2384.6423036544484;2054.4555692741437;2422.624493203556;2446.6330050492393;2447.3025187821563;2447.706275246982;8471.06818249992;8629.266512346458;8644.82710345796;8646.697365592237;8655.264302534291;5129.384473863161;5302.840914772563;5306.681599104028;5312.9734351328;5313.893722125575;3019.8641061152302;3433.725301975861;3570.235406164139;3675.5773086095173;3712.294664013829;1251.1304643272929;1278.2458349573797;1298.2340419152652;1314.6516173214106;1775.9250231317956;9311.487868167249;10815.459227038695;10996;11071.833922491169;11078.501467433985;3868.3617203161725;4337.50118736343;4573.405457290531;4635.582797548237;4639.37368455261;8806.603702833389;8807.427517211361;8813.074627164184;8819.206271435472;8825.985011723735;5222.268882356473;5226.346706661668;5230.163173892159;5233.476652334813;5235.476452354734;4392.802323895432;4629.444466664022;4859.562639362474;4863.805447782049;4937.679050861682;3701.2967536168044;3746.7939263340777;3787.905302367463;3811;3822.6750726188584;1178.1693905796392;1190.8094704847183;1195.653260554447;1202.8255902894207;1205.698575356161;911.6125646600168;923.1091996223677;926.3543330198924;929.2148134826061;976.5215044628081;5393.298871146804;5530.889382212334;5801.82594522165;5820.912686309709;5837.3287071986415;861.5907443964066;958.4057884111895;959.1990687775785;987.3187500624546;1038.2213339995003;3447.5690538682666;3595.209054008114;3839.2897313997;3937.448757173998;4038.5759495253164;10053;10258.384496930208;10262.384256944608;10276.588936442608;10290.176785857113;9959.800803984024;10158.187345012382;10232.897671023195;10248.923862994427;10280.023397777199;7582.886256706154;7802.531848089019;7985.840283194304;8087.716929907425;8107.2703456688005;5664.0937450007805;5677.1768093627015;5709.9714501427225;5896.970515147397;5947.583669143119;9319.673811416838;9336.53317334117;9507.809843803223;9539.189168920719;9541.141297283279;9062.954685226796;9577.521123943914;9711.805763884542;9740;9758.75603109928;6845.931540684529;7046.048783414379;7186.1376634804155;7314.268573142643;7497.812554686177;7857.646405911862;8167.428280020579;8170.060443049126;8177.9591102044105;8181.100078991187;6208.782692605737;7136.179339376038;7296.562206267641;7306.926930730838;7327.670254838438;7208.747693830691;7215.170255420694;7224.819379515554;7230.89153662706;7345.228750981284;6452.096706461193;6464.095026696173;6533.379328963741;6537.411632953057;6543.509236807164;4912.70523768575;4962.379702537183;4965.4289756678445;4974.104661161025;4997.600191984705;4569.177548041384;4599.494055653809;4627.62978961689;4711.599514041208;4718.268668356411 13:49:26 INFO - PROCESS | 2251 | |4;prototype.html;368.2359104857421;371.8865745947485;378.8749712594845;388.7492567294097;390.377348129733;5012.869530449553;5115.667481613693;5212.843614691556;5260.447652996438;5309.362876454821;5002.373753779268;5062.341895553582;5144.639875208728;5171.233390136278;5184.377874655037;3258.8533515991776;3581.4985901973746;3956.4065390191413;4123.587641235882;4144.534002268645;3509.298140371936;4119.464469618945;4152.356384760352;4171.414862352317;4176.561461046592;3140.026591756551;3179.2210908327493;3898.571157172723;3949.2299001694682;3962.1679447316096;3292.160499072745;3346.3641908037516;3957.8416863325433;3969.5435024972207;3970.920581588381;3045.8781648734025;3475.8703421387895;3482.37317282889;3492.6856582907662;3501.4768575669664;4988.7006779592975;5053.5237733510685;5101.4133374662015;5104.719240441774;5195.64913122587;3473.0796338970194;3817.2556351511466;4547.818087276505;4557.498675145731;4566.200914839923;5509.559235261169;5516.007118718629;5516.227728118027;5521.696306703129;5561.555075593943;3681.7606855554304;3818.9618103818884;3841.9039524012123;3842;3854.3062248795204;4750.382450281476;5768.7692492300675;5773.094878690023;5775.844831033768;5815.185873977646;3290.9341813164083;3856.749311294757;3866.2267546490816;3879.728419010642;3892.260470510594;3516.5604299462566;3927.3323534999117;3939.6060393960374;3961.5246170459727;3981.6416522513114;3795.4876091727815;4324.589164029412;4534.841280555231;4557.361969324297;4557.772111394417;4731.858044258678;5525.640833345819;5547.44525547442;5555.972220138873;5618.185363122325;1086.896744809242;1147.7302833834042;1153.5558809858264;1190.458341454636;1235.4872727817856;852.1989330029752;870.656090844113;874.6851133591902;877.4428238068745;888.3692578269502;4409.36064270679;4565.452145742465;4906.484819094015;4968.180250258739;5098.847034588968;4652.953470465252;5031.949680503221;5227.581793456515;5377.800208875713;5391.705990562236;4461.531539188339;4932.457429682732;5256.710880901511;5310.7610157543;5362.785488580413;2593;2687.3550347916357;2819.4502072096157;2830.589564513134;2843.5924217512465;4857.441394239708;5363.666804939864;5636.577256705681;5652.208690783294;5655;4680.742559159279;4739.805272334009;5493.395726470085;5523.917141242885;5603.35561410443;5352.91970620441;5451.972740136274;5581.720913954286;5667.829965101054;5670.234518340137;4548.4541854977615;4953.925691114564;5046.47012063728;5383.757730902197;5391.029614669397;4560.4983451820935;4663.487016428258;4755.500672429345;5060.392752869532;5165.845024649267;4460.843870464518;4782.904341913073;4853.126437241331;5593.888122237451;5648.745806438802;3628.5282913221113;3659.451082337564;3848.653621173996;3957.327254366822;3983.701222408273;4913.612304004708;5724.713764311685;5734.455226753452;5734.562810805308;5747.712614369349;4307.8492252771;4975.353204083446;5625.493705566519;5642.094321424388;5662.602438536845;5166.6125040621355;5252.921206181833;5401;5578.748956297058;5642.774289028393;5218.504242096995;5283.603729720209;5396.271503346998;5440.510354067995;5580.35825880029;5474.726263686879;5527.972360138335;5543.52880005204;5557.610967232255;5572.801847602623;4777.402824646919;5125.897482050413;5425.538829199404;5446.373667028342;5456.026465576191 13:49:26 INFO - PROCESS | 2251 | |5;yui.html;754.777340684498;757.5757575757573;775.980600484988;793.821390187208;898.6091050393079;15156.77264841027;15462.922685386557;15505.922470387632;15667.999999999985;15708.214589270534;14311;14446.494372696958;14451.927740361283;14459;16209.594760131002;917.4907926101027;934.0472717827812;937.8030613571158;939.0562484702898;940.1162906867522;902.4359775140537;930.6044930904372;934.8457504511747;935.0696057422874;936.976575585609;984.675057231112;986.8075725233582;987.6197663899414;988.4909271725068;988.86650302209;981.9459929703863;982.882054153499;982.9803403931917;985.9260555458297;986.5067466266867;735.2720806401677;735.9337659610608;735.9852802943911;737.5206116024573;737.8302990312204;16147.273372698257;16153.757693634605;16162.515124546282;16182.595435114099;16234.10712410817;14312.713745725132;14437.566872993826;14459.927700361535;14593.48922787708;14629.487967921179;11874.52501899923;11889.346085965268;11980.64058078259;12104.576339828063;12286.686015778445;3655.652712992288;3741.38267185914;3815.065308999285;3852.114013776847;3857.61423857612;87853.99999999936;110896.89103108946;115523.42238288838;115600;116351;11014;11054.668359949215;11129.610463633733;11597.884021159849;11659.475323610457;21845.563088738138;22893.88553057224;23212.955417006277;23481.647775283385;23735.88132059363;7210.242924492853;7354.742584009534;7496.7001319947685;7681.846363072707;7695.461317707819;4389.363542286351;4458.398116254329;4499.235130027903;4570.3829982951875;4663.673542851968;3661.688756455731;3706.592274849764;3757.6242375762204;3773.9433908491396;3819.694424446038;678.1015154919751;686.7321744519642;696.0429409561852;700.3976580141075;702.8594281143792;598.4344794169468;693.7918624412656;719.2627556754264;723.7466886589651;751.9172890981988;9929.851052234222;10480.633177838892;10676.199285053652;10917;10992.505337259843;713.1299814226635;726.4091639309894;727.9281777531309;737.1706829816457;737.9188289288174;4684.218867625444;5111.386633603991;5182.559482444034;5192.5586325162785;5217.677968472137;87646.68529972056;89738;100750.99249007563;107489;114158;55191.89616207653;69796.6510167446;87667.68498472527;92222;96875.51562242143;49988.99999999927;69058.65470672715;72906;80525;86260.27479450376;10841.186910981865;10882.510287037261;11139;11409.543618255177;11417.029552488131;46698.76650616725;46889.53110468852;47086;47892;49033;63393.732125358154;63758;69013.30986690069;71071.64464177853;71656.64171679108;13405.658264699217;13523.391447384694;13666.666666666666;13668.179909205479;13777.931110344383;14738.926305368404;14812;15071.794256459238;15633.452829150925;16303;13584.592462226148;13768.724625507233;14348.856511434751;14505;14833.30609172024;13317.733645326845;13959.441622334993;14029.929850350683;14169.563306564747;14418.279086045866;13314.733705326033;13671.83789377914;14047.55994638344;14484.493042743454;14641.560753177422;10740.785184296426;10941.343519388862;11259.943700281447;11440.313581185155;11540.596079137189;8216.876746848922;10134.594616215269;10598.523066461874;11214.607488737855;12049.156559041134 13:49:26 INFO - PROCESS | 2251 | __end_tp_report 13:49:26 INFO - PROCESS | 2251 | __start_cc_report 13:49:26 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,1322 13:49:26 INFO - PROCESS | 2251 | __end_cc_report 13:49:26 INFO - PROCESS | 2251 | __startTimestamp1489438166071__endTimestamp 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | ------- Summary: start ------- 13:49:26 INFO - PROCESS | 2251 | Number of tests: 6 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | [#0] dojo.html Cycles:165 Average:5836.85 Median:6099.30 stddev:649.98 (10.7%) stddev-sans-first:623.37 13:49:26 INFO - PROCESS | 2251 | Values: 3405.5 3416.6 3424.9 3456.7 3500.9 5786.0 5799.1 5810.7 5811.2 5837.0 5775.7 5831.4 5832.7 5835.1 5848.2 5101.5 5233.2 5267.8 5317.2 5344.5 5126.6 5136.5 5159.5 5329.9 5341.3 5255.8 5265.5 5269.5 5275.0 5276.5 5233.8 5264.3 5265.5 5270.6 5271.0 5142.2 5228.8 5228.8 5229.4 5255.6 5814.2 5820.6 5820.8 5834.3 5844.9 6218.8 6227.7 6257.0 6277.7 6288.4 6297.7 6305.5 6313.8 6331.6 6355.3 5891.8 5897.5 5908.7 5912.7 5927.4 6216.1 6248.0 6267.9 6281.7 6316.4 6222.8 6305.7 6316.7 6317.0 6330.7 6297.6 6308.1 6310.2 6317.1 6320.7 6169.4 6355.8 6359.7 6364.6 6365.0 6198.2 6226.8 6236.4 6267.0 6373.5 5014.5 5018.4 5020.3 5025.4 5032.3 4514.9 4515.4 4533.2 4541.6 4553.6 5545.2 5635.4 5650.6 5989.8 5989.9 6269.1 6295.8 6314.0 6317.9 6324.4 6048.2 6068.1 6088.3 6091.4 6099.3 5373.8 5417.3 5434.3 5541.5 5590.0 6382.1 6430.5 6472.3 6551.2 6556.8 6257.2 6265.5 6291.2 6303.1 6322.3 6233.4 6445.2 6483.3 6512.4 6562.5 6073.1 6250.3 6252.9 6293.9 6375.7 5273.9 6293.9 6320.3 6346.4 6347.9 6056.1 6256.2 6266.6 6298.0 6298.1 6111.1 6125.7 6154.0 6159.3 6296.7 6143.4 6161.7 6161.8 6165.3 6177.6 6246.5 6274.2 6279.6 6282.7 6292.7 5886.1 5915.9 5943.6 5999.5 6075.4 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | [#1] ext.html Cycles:180 Average:71175.24 Median:39331.20 stddev:153106.20 (389.3%) stddev-sans-first:153443.67 13:49:26 INFO - PROCESS | 2251 | Values: 470.2 519.2 523.4 536.9 562.6 30144.0 41863.2 43779.9 43834.1 45072.0 45525.3 45885.5 45975.3 46013.8 46091.5 9021.1 9614.0 9806.7 9811.4 9816.1 8995.6 11739.4 12007.4 12056.9 12215.1 11890.1 11909.5 11966.4 11976.3 11979.5 12000.8 12047.5 12058.3 12066.5 12103.8 10454.0 10921.1 11845.7 11949.3 11953.0 42197.6 42744.7 42962.8 43052.8 43191.0 4038.6 4110.6 4132.3 4139.5 4146.7 30612.8 31669.0 32785.5 33257.3 33383.2 3270.0 3465.5 3470.8 3532.4 3544.8 499760.0 501192.0 501254.0 502700.5 503926.0 64311.7 64581.0 64828.0 64859.0 64881.7 65480.0 65583.0 65601.0 65665.3 65716.0 17343.4 17562.7 17580.2 17594.6 17634.0 12417.4 12635.6 13384.8 13450.3 13483.5 14976.0 16359.0 16576.8 16746.4 16997.0 5989.4 6105.8 6990.9 7078.9 7127.4 888.2 889.9 903.8 943.0 944.5 29690.9 30109.0 30554.7 30848.4 31221.0 905.9 1127.2 1132.6 1155.4 1177.7 15716.2 16223.9 16227.8 16330.3 16616.0 583295.0 583468.0 587769.0 589728.0 760014.0 51279.7 51749.0 62475.0 63686.0 63702.0 1462.2 1489.7 1493.9 1516.4 1519.5 29128.9 31170.7 32265.8 32350.0 32477.5 53268.5 53765.4 53827.0 53839.7 53940.5 540040.0 558178.0 560253.0 560327.0 702339.0 25272.0 26312.7 26551.3 26826.0 27017.3 48320.5 48698.0 48787.3 49325.3 49433.0 39353.6 39533.6 39786.2 39972.8 41025.0 35437.0 39308.8 39362.6 40006.6 40895.8 37995.4 38541.2 38549.4 38564.8 38882.0 32434.4 34375.8 34481.3 34547.0 34662.7 19999.0 24810.2 25096.4 25233.7 25636.9 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | [#2] jquery.html Cycles:180 Average:43768.52 Median:23859.43 stddev:137137.69 (574.8%) stddev-sans-first:137483.61 13:49:26 INFO - PROCESS | 2251 | Values: 334.2 402.0 407.4 415.9 436.9 17545.5 21940.3 22386.7 22396.0 22741.8 23359.5 23455.0 23881.5 24080.2 24207.6 5940.4 6146.4 6283.5 6284.8 6296.0 5892.1 6113.5 6179.5 6193.6 6206.4 5315.9 5801.8 6010.9 6159.6 6169.0 5904.6 6099.4 6165.0 6171.4 6175.4 5318.7 5343.4 5402.2 5416.9 5423.8 28285.4 28295.4 28396.7 28420.7 28671.6 2832.3 2874.6 2898.1 2900.1 2904.5 16287.5 16426.9 16526.8 16590.8 17190.9 1833.4 1879.1 1894.1 1923.8 1927.0 128178.0 134307.3 136000.0 140455.0 140722.0 11345.4 11859.8 11898.2 11905.2 11909.3 15637.8 15649.0 15661.5 15693.9 15695.5 8962.4 9153.1 9155.8 9272.4 9281.4 9060.0 9115.0 9128.5 9308.6 9319.3 7561.5 7679.7 7714.7 7721.9 7729.5 1946.6 1979.7 1980.0 1981.9 1983.7 1051.7 1061.2 1067.9 1079.3 1128.8 23002.9 23690.4 23696.9 23852.0 23866.8 983.4 1025.3 1079.6 1142.8 1147.3 9731.8 12130.6 12936.7 12976.5 13251.4 810006.0 814611.0 830501.0 834336.0 845510.0 108749.3 149026.0 152833.1 171390.0 176488.0 1049.4 1061.4 1077.1 1086.4 1089.1 16404.7 19396.0 19730.6 19897.4 21397.1 44794.0 49477.3 58738.0 64687.7 66153.7 73094.9 91342.1 91952.0 92715.5 93944.0 6487.6 8748.0 8809.9 8828.1 9316.5 9813.7 13856.8 13956.9 14251.0 14676.1 11178.8 11218.5 11372.3 11822.5 12143.4 9364.6 11547.6 11708.6 12031.9 12058.1 11359.2 11722.4 11813.3 12290.5 12438.6 8719.3 8805.5 8833.2 9006.3 9229.8 8859.2 11208.5 11755.4 12140.8 12201.2 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | [#3] mootools.html Cycles:180 Average:5496.78 Median:5224.31 stddev:2981.45 (57.1%) stddev-sans-first:2974.55 13:49:26 INFO - PROCESS | 2251 | Values: 1483.1 1484.9 1501.7 1513.6 1517.7 8293.3 8656.4 8664.3 8673.2 8679.0 7655.8 7858.3 8291.0 8492.4 8493.6 2419.0 2463.8 2467.0 2469.7 2477.2 2444.1 2462.4 2466.3 2470.3 2477.8 2390.7 2401.7 2403.4 2418.8 2427.8 1877.8 2134.0 2292.6 2371.4 2384.6 2054.5 2422.6 2446.6 2447.3 2447.7 8471.1 8629.3 8644.8 8646.7 8655.3 5129.4 5302.8 5306.7 5313.0 5313.9 3019.9 3433.7 3570.2 3675.6 3712.3 1251.1 1278.2 1298.2 1314.7 1775.9 9311.5 10815.5 10996.0 11071.8 11078.5 3868.4 4337.5 4573.4 4635.6 4639.4 8806.6 8807.4 8813.1 8819.2 8826.0 5222.3 5226.3 5230.2 5233.5 5235.5 4392.8 4629.4 4859.6 4863.8 4937.7 3701.3 3746.8 3787.9 3811.0 3822.7 1178.2 1190.8 1195.7 1202.8 1205.7 911.6 923.1 926.4 929.2 976.5 5393.3 5530.9 5801.8 5820.9 5837.3 861.6 958.4 959.2 987.3 1038.2 3447.6 3595.2 3839.3 3937.4 4038.6 10053.0 10258.4 10262.4 10276.6 10290.2 9959.8 10158.2 10232.9 10248.9 10280.0 7582.9 7802.5 7985.8 8087.7 8107.3 5664.1 5677.2 5710.0 5897.0 5947.6 9319.7 9336.5 9507.8 9539.2 9541.1 9063.0 9577.5 9711.8 9740.0 9758.8 6845.9 7046.0 7186.1 7314.3 7497.8 7857.6 8167.4 8170.1 8178.0 8181.1 6208.8 7136.2 7296.6 7306.9 7327.7 7208.7 7215.2 7224.8 7230.9 7345.2 6452.1 6464.1 6533.4 6537.4 6543.5 4912.7 4962.4 4965.4 4974.1 4997.6 4569.2 4599.5 4627.6 4711.6 4718.3 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | [#4] prototype.html Cycles:180 Average:4387.60 Median:4943.19 stddev:1346.96 (27.2%) stddev-sans-first:1316.52 13:49:26 INFO - PROCESS | 2251 | Values: 368.2 371.9 378.9 388.7 390.4 5012.9 5115.7 5212.8 5260.4 5309.4 5002.4 5062.3 5144.6 5171.2 5184.4 3258.9 3581.5 3956.4 4123.6 4144.5 3509.3 4119.5 4152.4 4171.4 4176.6 3140.0 3179.2 3898.6 3949.2 3962.2 3292.2 3346.4 3957.8 3969.5 3970.9 3045.9 3475.9 3482.4 3492.7 3501.5 4988.7 5053.5 5101.4 5104.7 5195.6 3473.1 3817.3 4547.8 4557.5 4566.2 5509.6 5516.0 5516.2 5521.7 5561.6 3681.8 3819.0 3841.9 3842.0 3854.3 4750.4 5768.8 5773.1 5775.8 5815.2 3290.9 3856.7 3866.2 3879.7 3892.3 3516.6 3927.3 3939.6 3961.5 3981.6 3795.5 4324.6 4534.8 4557.4 4557.8 4731.9 5525.6 5547.4 5556.0 5618.2 1086.9 1147.7 1153.6 1190.5 1235.5 852.2 870.7 874.7 877.4 888.4 4409.4 4565.5 4906.5 4968.2 5098.8 4653.0 5031.9 5227.6 5377.8 5391.7 4461.5 4932.5 5256.7 5310.8 5362.8 2593.0 2687.4 2819.5 2830.6 2843.6 4857.4 5363.7 5636.6 5652.2 5655.0 4680.7 4739.8 5493.4 5523.9 5603.4 5352.9 5452.0 5581.7 5667.8 5670.2 4548.5 4953.9 5046.5 5383.8 5391.0 4560.5 4663.5 4755.5 5060.4 5165.8 4460.8 4782.9 4853.1 5593.9 5648.7 3628.5 3659.5 3848.7 3957.3 3983.7 4913.6 5724.7 5734.5 5734.6 5747.7 4307.8 4975.4 5625.5 5642.1 5662.6 5166.6 5252.9 5401.0 5578.7 5642.8 5218.5 5283.6 5396.3 5440.5 5580.4 5474.7 5528.0 5543.5 5557.6 5572.8 4777.4 5125.9 5425.5 5446.4 5456.0 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - PROCESS | 2251 | [#5] yui.html Cycles:180 Average:20291.33 Median:3794.50 stddev:28729.25 (757.1%) stddev-sans-first:28772.39 13:49:26 INFO - PROCESS | 2251 | Values: 754.8 757.6 776.0 793.8 898.6 15156.8 15462.9 15505.9 15668.0 15708.2 14311.0 14446.5 14451.9 14459.0 16209.6 917.5 934.0 937.8 939.1 940.1 902.4 930.6 934.8 935.1 937.0 984.7 986.8 987.6 988.5 988.9 981.9 982.9 983.0 985.9 986.5 735.3 735.9 736.0 737.5 737.8 16147.3 16153.8 16162.5 16182.6 16234.1 14312.7 14437.6 14459.9 14593.5 14629.5 11874.5 11889.3 11980.6 12104.6 12286.7 3655.7 3741.4 3815.1 3852.1 3857.6 87854.0 110896.9 115523.4 115600.0 116351.0 11014.0 11054.7 11129.6 11597.9 11659.5 21845.6 22893.9 23213.0 23481.6 23735.9 7210.2 7354.7 7496.7 7681.8 7695.5 4389.4 4458.4 4499.2 4570.4 4663.7 3661.7 3706.6 3757.6 3773.9 3819.7 678.1 686.7 696.0 700.4 702.9 598.4 693.8 719.3 723.7 751.9 9929.9 10480.6 10676.2 10917.0 10992.5 713.1 726.4 727.9 737.2 737.9 4684.2 5111.4 5182.6 5192.6 5217.7 87646.7 89738.0 100751.0 107489.0 114158.0 55191.9 69796.7 87667.7 92222.0 96875.5 49989.0 69058.7 72906.0 80525.0 86260.3 10841.2 10882.5 11139.0 11409.5 11417.0 46698.8 46889.5 47086.0 47892.0 49033.0 63393.7 63758.0 69013.3 71071.6 71656.6 13405.7 13523.4 13666.7 13668.2 13777.9 14738.9 14812.0 15071.8 15633.5 16303.0 13584.6 13768.7 14348.9 14505.0 14833.3 13317.7 13959.4 14029.9 14169.6 14418.3 13314.7 13671.8 14047.6 14484.5 14641.6 10740.8 10941.3 11259.9 11440.3 11540.6 8216.9 10134.6 10598.5 11214.6 12049.2 13:49:26 INFO - PROCESS | 2251 | -------- Summary: end -------- 13:49:26 INFO - PROCESS | 2251 | 13:49:26 INFO - TEST-INFO | 2251: exit 0 13:49:26 INFO - TEST-OK | dromaeo_css | took 1117000ms 13:49:26 INFO - TEST-START | kraken 13:49:26 INFO - operating with platform_type : mac_ 13:49:26 INFO - Initialising browser for kraken test... 13:49:26 INFO - TEST-INFO | started process 2254 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpw65VDl/profile http://localhost:51487/getInfo.html) 13:49:28 INFO - PROCESS | 2254 | __metrics Screen width/height:1600/1200 13:49:28 INFO - PROCESS | 2254 | colorDepth:24 13:49:28 INFO - PROCESS | 2254 | Browser inner width/height: 1024/689 13:49:28 INFO - PROCESS | 2254 | __metrics 13:49:28 INFO - PROCESS | 2254 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:49:28 INFO - PROCESS | 2254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:49:29 INFO - TEST-INFO | 2254: exit 0 13:49:29 INFO - Browser initialized. 13:49:29 INFO - Running cycle 1/1 for kraken test... 13:49:29 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpw65VDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:41 INFO - PROCESS | 2256 | RSS: Main: 162926592 13:49:41 INFO - PROCESS | 2256 | 13:49:44 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51487/tests/kraken/driver.html?testName=audio-beat-detection) 13:49:45 INFO - PROCESS | 2256 | RSS: Main: 213016576 13:49:45 INFO - PROCESS | 2256 | 13:49:47 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51487/tests/kraken/driver.html?testName=audio-dft) 13:49:48 INFO - PROCESS | 2256 | RSS: Main: 226742272 13:49:48 INFO - PROCESS | 2256 | 13:49:51 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51487/tests/kraken/driver.html?testName=audio-fft) 13:49:52 INFO - PROCESS | 2256 | RSS: Main: 323223552 13:49:52 INFO - PROCESS | 2256 | 13:49:54 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51487/tests/kraken/driver.html?testName=audio-oscillator) 13:49:54 INFO - PROCESS | 2256 | RSS: Main: 227782656 13:49:54 INFO - PROCESS | 2256 | 13:49:56 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:49:57 INFO - PROCESS | 2256 | RSS: Main: 228859904 13:49:57 INFO - PROCESS | 2256 | 13:50:00 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51487/tests/kraken/driver.html?testName=imaging-darkroom) 13:50:00 INFO - PROCESS | 2256 | RSS: Main: 269623296 13:50:00 INFO - PROCESS | 2256 | 13:50:03 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51487/tests/kraken/driver.html?testName=imaging-desaturate) 13:50:04 INFO - PROCESS | 2256 | RSS: Main: 269496320 13:50:04 INFO - PROCESS | 2256 | 13:50:07 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51487/tests/kraken/driver.html?testName=json-parse-financial) 13:50:07 INFO - PROCESS | 2256 | RSS: Main: 267620352 13:50:07 INFO - PROCESS | 2256 | 13:50:09 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:50:10 INFO - PROCESS | 2256 | RSS: Main: 243515392 13:50:10 INFO - PROCESS | 2256 | 13:50:11 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:50:12 INFO - PROCESS | 2256 | RSS: Main: 244273152 13:50:12 INFO - PROCESS | 2256 | 13:50:14 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:50:15 INFO - PROCESS | 2256 | RSS: Main: 254214144 13:50:15 INFO - PROCESS | 2256 | 13:50:18 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:50:19 INFO - PROCESS | 2256 | RSS: Main: 270483456 13:50:19 INFO - PROCESS | 2256 | 13:50:21 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:50:22 INFO - PROCESS | 2256 | RSS: Main: 264765440 13:50:22 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | Cycle 1(1): loaded http://localhost:51487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51487/tests/kraken/driver.html?testName=ai-astar) 13:50:24 INFO - PROCESS | 2256 | RSS: Main: 309334016 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | __start_tp_report 13:50:24 INFO - PROCESS | 2256 | _x_x_mozilla_page_load 13:50:24 INFO - PROCESS | 2256 | _x_x_mozilla_page_load_details 13:50:24 INFO - PROCESS | 2256 | |i|pagename|runs| 13:50:24 INFO - PROCESS | 2256 | |0;ai-astar;104;160;113;113;115;113;114;114;114;114 13:50:24 INFO - PROCESS | 2256 | |1;audio-beat-detection;147;109;114;173;141;137;110;109;130;109 13:50:24 INFO - PROCESS | 2256 | |2;audio-dft;183;182;183;184;183;185;183;183;184;183 13:50:24 INFO - PROCESS | 2256 | |3;audio-fft;84;59;58;92;60;58;58;58;74;58 13:50:24 INFO - PROCESS | 2256 | |4;audio-oscillator;88;71;86;71;68;69;81;69;69;85 13:50:24 INFO - PROCESS | 2256 | |5;imaging-gaussian-blur;87;84;87;85;87;83;88;84;87;83 13:50:24 INFO - PROCESS | 2256 | |6;imaging-darkroom;132;95;95;96;95;95;95;112;161;94 13:50:24 INFO - PROCESS | 2256 | |7;imaging-desaturate;87;85;85;83;87;84;84;85;86;85 13:50:24 INFO - PROCESS | 2256 | |8;json-parse-financial;54;51;52;52;56;57;55;62;54;53 13:50:24 INFO - PROCESS | 2256 | |9;json-stringify-tinderbox;64;75;68;70;76;68;74;74;70;70 13:50:24 INFO - PROCESS | 2256 | |10;stanford-crypto-aes;84;84;83;84;79;83;86;78;70;79 13:50:24 INFO - PROCESS | 2256 | |11;stanford-crypto-ccm;158;170;138;142;133;129;133;152;161;127 13:50:24 INFO - PROCESS | 2256 | |12;stanford-crypto-pbkdf2;160;166;162;166;163;162;166;162;162;162 13:50:24 INFO - PROCESS | 2256 | |13;stanford-crypto-sha256-iterative;63;65;65;64;64;63;64;65;63;62 13:50:24 INFO - PROCESS | 2256 | __end_tp_report 13:50:24 INFO - PROCESS | 2256 | __start_cc_report 13:50:24 INFO - PROCESS | 2256 | _x_x_mozilla_cycle_collect,2111 13:50:24 INFO - PROCESS | 2256 | __end_cc_report 13:50:24 INFO - PROCESS | 2256 | __startTimestamp1489438224498__endTimestamp 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | ------- Summary: start ------- 13:50:24 INFO - PROCESS | 2256 | Number of tests: 14 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#0] ai-astar Cycles:10 Average:117.40 Median:114.00 stddev:15.29 (13.4%) stddev-sans-first:15.43 13:50:24 INFO - PROCESS | 2256 | Values: 104.0 160.0 113.0 113.0 115.0 113.0 114.0 114.0 114.0 114.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:133.50 stddev:21.71 (16.3%) stddev-sans-first:21.90 13:50:24 INFO - PROCESS | 2256 | Values: 147.0 109.0 114.0 173.0 141.0 137.0 110.0 109.0 130.0 109.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.00 stddev:0.82 (0.4%) stddev-sans-first:0.87 13:50:24 INFO - PROCESS | 2256 | Values: 183.0 182.0 183.0 184.0 183.0 185.0 183.0 183.0 184.0 183.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#3] audio-fft Cycles:10 Average:65.90 Median:59.50 stddev:12.78 (21.5%) stddev-sans-first:11.75 13:50:24 INFO - PROCESS | 2256 | Values: 84.0 59.0 58.0 92.0 60.0 58.0 58.0 58.0 74.0 58.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:8.23 (10.8%) stddev-sans-first:7.43 13:50:24 INFO - PROCESS | 2256 | Values: 88.0 71.0 86.0 71.0 68.0 69.0 81.0 69.0 69.0 85.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:87.00 stddev:1.90 (2.2%) stddev-sans-first:1.94 13:50:24 INFO - PROCESS | 2256 | Values: 87.0 84.0 87.0 85.0 87.0 83.0 88.0 84.0 87.0 83.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#6] imaging-darkroom Cycles:10 Average:107.00 Median:95.00 stddev:22.55 (23.7%) stddev-sans-first:22.03 13:50:24 INFO - PROCESS | 2256 | Values: 132.0 95.0 95.0 96.0 95.0 95.0 95.0 112.0 161.0 94.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.17 13:50:24 INFO - PROCESS | 2256 | Values: 87.0 85.0 85.0 83.0 87.0 84.0 84.0 85.0 86.0 85.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:3.20 (5.9%) stddev-sans-first:3.39 13:50:24 INFO - PROCESS | 2256 | Values: 54.0 51.0 52.0 52.0 56.0 57.0 55.0 62.0 54.0 53.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:72.00 stddev:3.78 (5.3%) stddev-sans-first:3.08 13:50:24 INFO - PROCESS | 2256 | Values: 64.0 75.0 68.0 70.0 76.0 68.0 74.0 74.0 70.0 70.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:83.50 stddev:4.69 (5.6%) stddev-sans-first:4.85 13:50:24 INFO - PROCESS | 2256 | Values: 84.0 84.0 83.0 84.0 79.0 83.0 86.0 78.0 70.0 79.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:147.00 stddev:14.98 (10.2%) stddev-sans-first:15.05 13:50:24 INFO - PROCESS | 2256 | Values: 158.0 170.0 138.0 142.0 133.0 129.0 133.0 152.0 161.0 127.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:162.50 stddev:2.13 (1.3%) stddev-sans-first:1.94 13:50:24 INFO - PROCESS | 2256 | Values: 160.0 166.0 162.0 166.0 163.0 162.0 166.0 162.0 162.0 162.0 13:50:24 INFO - PROCESS | 2256 | 13:50:24 INFO - PROCESS | 2256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 13:50:24 INFO - PROCESS | 2256 | Values: 63.0 65.0 65.0 64.0 64.0 63.0 64.0 65.0 63.0 62.0 13:50:24 INFO - PROCESS | 2256 | -------- Summary: end -------- 13:50:24 INFO - PROCESS | 2256 | 13:50:25 INFO - TEST-INFO | 2256: exit 0 13:50:25 INFO - TEST-OK | kraken | took 58627ms 13:50:25 INFO - SUITE-END | took 1175s 13:50:25 INFO - Completed test suite (00:19:35) 13:50:25 INFO - javascript benchmark 13:50:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.540252065971, 3416.64125266847, 3424.8801291954787, 3456.7407444441674, 3500.9474857877135, 5786.0, 5799.101139323401, 5810.73851676674, 5811.157382179592, 5836.970815145924, 5775.740091695873, 5831.358550559435, 5832.6792026438525, 5835.124731290309, 5848.1520179574045, 5101.515356041179, 5233.241180028894, 5267.789288428458, 5317.175837745156, 5344.465553444663, 5126.589872810185, 5136.512031357015, 5159.458256883011, 5329.946700532983, 5341.332333458317, 5255.842324730245, 5265.526102650761, 5269.525742683158, 5275.0, 5276.472352764712, 5233.842984710464, 5264.263003179558, 5265.473452654742, 5270.631055826094, 5271.024860400838, 5142.151544995071, 5228.79084836606, 5228.816991405282, 5229.372475302988, 5255.605829562798, 5814.244148260699, 5820.5634577406445, 5820.7962721304975, 5834.2998840139035, 5844.912326315109, 6218.844528886769, 6227.688615569204, 6256.96871515644, 6277.686115694197, 6288.371162883721, 6297.685115744194, 6305.495560355206, 6313.779017734403, 6331.620102793847, 6355.3009168991375, 5891.764329426818, 5897.469227769521, 5908.734106965154, 5912.674802885839, 5927.3776253493625, 6216.067589861466, 6248.009871039694, 6267.9373206268265, 6281.685915704196, 6316.431521163117, 6222.81331560054, 6305.716242769086, 6316.747330106836, 6317.020861766434, 6330.651814150174, 6297.590656607306, 6308.116863639094, 6310.211223597051, 6317.115603815378, 6320.747170113144, 6169.444749972435, 6355.809325720235, 6359.745610175633, 6364.554481186365, 6365.045243213555, 6198.194234749544, 6226.813195604139, 6236.407541283571, 6266.965950618188, 6373.52198585108, 5014.548690617862, 5018.372703412074, 5020.322256495327, 5025.3718285214345, 5032.3206367139965, 4514.887127821765, 4515.412996310524, 4533.206688829442, 4541.613962813198, 4553.567411095941, 5545.1682247663175, 5635.380108188096, 5650.576206784508, 5989.790357337472, 5989.9101513477335, 6269.059641053787, 6295.842603934847, 6314.0, 6317.873642527124, 6324.43080122782, 6048.153258543807, 6068.059450785136, 6088.330283668793, 6091.360407157274, 6099.2985806632805, 5373.758180881791, 5417.322834645669, 5434.347878254634, 5541.501264886179, 5589.972050139723, 6382.106505089291, 6430.517711171681, 6472.320406357265, 6551.246606640298, 6556.770513032021, 6257.2491301044165, 6265.467435267871, 6291.245050593775, 6303.086052522451, 6322.2729386119345, 6233.376662333731, 6445.1943507061615, 6483.319251478527, 6512.413882750575, 6562.507811914221, 6073.058675905242, 6250.281217660027, 6252.906206406817, 6293.874122517615, 6375.713092910923, 5273.947260527346, 6293.905591416041, 6320.336364681826, 6346.428821406095, 6347.873042539216, 6056.121862330026, 6256.186695729526, 6266.557775431762, 6298.0, 6298.149749783721, 6111.113888486056, 6125.723854043132, 6154.01535754295, 6159.29168145669, 6296.716647750771, 6143.416375444325, 6161.72272247741, 6161.815145545641, 6165.32181460048, 6177.62934223948, 6246.5002799775, 6274.152989346379, 6279.591826531444, 6282.717277722422, 6292.653904035322, 5886.087656413263, 5915.911261330997, 5943.613665111754, 5999.4900433463645, 6075.422834830684], "value": 5795.000236078827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.18657722140694, 519.1641457253824, 523.4294618865438, 536.922146288788, 562.555581090938, 30144.0, 41863.162736745246, 43779.90550236245, 43834.12331753371, 45072.0, 45525.31712024314, 45885.54114458855, 45975.31037034447, 46013.84965375859, 46091.53908460915, 9021.097890210993, 9613.99053099425, 9806.656767013155, 9811.362261452983, 9816.067473590034, 8995.550222488882, 11739.354335511543, 12007.399630018508, 12056.93971530141, 12215.144939854214, 11890.10824188185, 11909.523619055228, 11966.401679916013, 11976.28142311464, 11979.520819167266, 12000.819987700148, 12047.518099276105, 12058.276503409823, 12066.457009434509, 12103.818442723366, 10454.0, 10921.12630989519, 11845.703857403547, 11949.342786146759, 11953.0, 42197.57802421967, 42744.7176584703, 42962.78518607387, 43052.784736076435, 43191.0, 4038.5557588665224, 4110.609492098246, 4132.297509423405, 4139.503259608836, 4146.730462519927, 30612.846935765403, 31669.0, 32785.50821737676, 33257.334853303044, 33383.16542086443, 3269.950950735717, 3465.462853257749, 3470.774399664014, 3532.364174448598, 3544.787312761217, 499760.0, 501192.0, 501254.0, 502700.48649756884, 503926.0, 64311.678441607495, 64581.03128453077, 64828.0, 64859.0, 64881.67559162174, 65480.0, 65583.0, 65601.01598476026, 65665.34334656688, 65716.0, 17343.392981245597, 17562.736558951627, 17580.208890599955, 17594.560135996446, 17634.0, 12417.44121514534, 12635.557755478514, 13384.799228011587, 13450.327483625975, 13483.52807651747, 14975.951683382276, 16359.018458892504, 16576.75134872978, 16746.4138755143, 16997.0, 5989.371116032841, 6105.84735381619, 6990.9300906990275, 7078.893816592756, 7127.4298056155385, 888.1873086126251, 889.8620713789373, 903.8418276801533, 942.9952850235705, 944.5371767833713, 29690.851545742564, 30109.0, 30554.69445305563, 30848.383032339676, 31221.0, 905.8867641544807, 1127.1715289262386, 1132.592266783957, 1155.422288855572, 1177.6879127031343, 15716.21418929049, 16223.918880405523, 16227.83772162287, 16330.265138068578, 16616.0, 583295.0, 583468.0, 587769.0, 589728.0, 760014.0, 51279.743601281756, 51748.965020700125, 62475.0, 63686.0, 63702.0, 1462.1738717624507, 1489.7095066462152, 1493.8954273200773, 1516.4010215964852, 1519.5365413548752, 29128.854355728086, 31170.68829311678, 32265.838670806497, 32350.0, 32477.51283730793, 53268.4673153279, 53765.38703838891, 53827.0, 53839.730801345744, 53940.46059539511, 540040.0, 558178.0, 560253.0, 560327.0, 702339.0, 25272.0, 26312.736872631795, 26551.33621659474, 26826.0, 27017.324566885985, 48320.5167948316, 48698.0, 48787.26819097645, 49325.2601210975, 49433.0, 39353.60646393499, 39533.604663952996, 39786.20427591374, 39972.80013599913, 41025.0, 35437.0, 39308.80345598254, 39362.606373935894, 40006.59993400145, 40895.77312680624, 37995.43006854955, 38541.22917541577, 38549.4217586742, 38564.80717596394, 38882.0, 32434.35131297408, 34375.82812085924, 34481.31037379288, 34546.96359109231, 34662.653373465946, 19999.0, 24810.245494111008, 25096.37259068538, 25233.747662523874, 25636.871815640803], "value": 20868.079581220114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.15380025359883, 401.9638232559071, 407.4072224912752, 415.88563145135083, 436.8929612245, 17545.473635790913, 21940.341789746293, 22386.664200037012, 22396.0, 22741.772582274174, 23359.532809343804, 23455.0, 23881.5223695526, 24080.157194498195, 24207.63688544669, 5940.405959404057, 6146.385361463863, 6283.528735344845, 6284.842878928018, 6296.0, 5892.116182572606, 6113.510919126482, 6179.536534759888, 6193.597416167957, 6206.410391012869, 5315.910238401138, 5801.82594522165, 6010.939890601082, 6159.630422174661, 6168.969155154218, 5904.645721256738, 6099.359567245442, 6165.013597824349, 6171.352008039181, 6175.382461753834, 5318.6542874713405, 5343.412224655285, 5402.189671549259, 5416.891662166774, 5423.810166644149, 28285.434291314265, 28295.434091318264, 28396.71603283982, 28420.715792842013, 28671.56992645112, 2832.306085009165, 2874.626298581171, 2898.145047211057, 2900.10096869971, 2904.4771941050603, 16287.51137465878, 16426.93224940375, 16526.83473165277, 16590.75113873293, 17190.914045429694, 1833.4133077415233, 1879.0792511669183, 1894.0813705352894, 1923.807619238079, 1927.0364817591205, 128178.0, 134307.32846335805, 136000.0, 140455.0, 140721.99999999898, 11345.376004319842, 11859.822102668468, 11898.16712830111, 11905.166638335233, 11909.285442873455, 15637.843621563867, 15648.982816116915, 15661.530154095395, 15693.921530392276, 15695.529134125994, 8962.372633915693, 9153.130452606993, 9155.771105722277, 9272.443653380818, 9281.350305478687, 9060.003399626035, 9114.954425227832, 9128.452292862317, 9308.581113849894, 9319.30105242096, 7561.508501947355, 7679.656060189444, 7714.729984450517, 7721.922780772233, 7729.458937874408, 1946.5912158446886, 1979.6931475621302, 1979.9901000494906, 1981.8810871347766, 1983.652860749363, 1051.731808388856, 1061.1669839176209, 1067.8771941226703, 1079.2930630437077, 1128.7573171768108, 23002.884985574965, 23690.407739806644, 23696.93363798633, 23852.045918163425, 23866.806659667294, 983.3509883476871, 1025.3079171559168, 1079.63292480557, 1142.7543078238218, 1147.2772153543215, 9731.756706082404, 12130.636080917586, 12936.725688041293, 12976.480940762263, 13251.403686834115, 810006.0, 814611.0, 830501.0, 834336.0, 845510.0, 108749.29449158798, 149026.0, 152833.12250948735, 171390.0, 176488.0, 1049.4333060147435, 1061.3790932304535, 1077.0575746222055, 1086.4241951765578, 1089.090609341209, 16404.67190656156, 19396.0, 19730.60538789245, 19897.403077907686, 21397.144114235256, 44794.0, 49477.25784113169, 58738.0, 64687.70624587388, 66153.67692646217, 73094.90357644745, 91342.08657913601, 91952.0, 92715.53642231745, 93944.0, 6487.610743355413, 8748.0, 8809.911900880908, 8828.117188281121, 9316.534173291444, 9813.656522021694, 13856.792148117987, 13956.930215348859, 14251.0, 14676.119432834064, 11178.832317515082, 11218.495167717636, 11372.31766094037, 11822.527098915947, 12143.39283035827, 9364.625414983324, 11547.595834146101, 11708.648740537797, 12031.939840301093, 12058.095642826647, 11359.204855660024, 11722.41387930583, 11813.291202527877, 12290.508379664714, 12438.626841194779, 8719.302455803647, 8805.471671699463, 8833.205011548991, 9006.279497640304, 9229.769255768391, 8859.202671759573, 11208.495617697386, 11755.353455560027, 12140.75718485643, 12201.20692155007], "value": 10645.573998992892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.095311859766, 1484.9331780069895, 1501.6921531086125, 1513.6215946013504, 1517.6509402837348, 8293.253607175353, 8656.350773691975, 8664.263537599296, 8673.219410253068, 8678.956605216965, 7655.846883062335, 7858.332041776456, 8291.046529649077, 8492.363072769536, 8493.617787199575, 2419.0, 2463.7659422354845, 2466.962995555059, 2469.6542484052247, 2477.2196758021164, 2444.0590372706456, 2462.396712805365, 2466.3217615155886, 2470.3330100872754, 2477.8141639377027, 2390.6653068570413, 2401.6637670726113, 2403.351095204294, 2418.7823095921362, 2427.8179136564827, 1877.8357418400542, 2133.95732085359, 2292.6473380705297, 2371.3834403055157, 2384.6423036544484, 2054.4555692741437, 2422.624493203556, 2446.6330050492393, 2447.3025187821563, 2447.706275246982, 8471.06818249992, 8629.266512346458, 8644.82710345796, 8646.697365592237, 8655.264302534291, 5129.384473863161, 5302.840914772563, 5306.681599104028, 5312.9734351328, 5313.893722125575, 3019.8641061152302, 3433.725301975861, 3570.235406164139, 3675.5773086095173, 3712.294664013829, 1251.1304643272929, 1278.2458349573797, 1298.2340419152652, 1314.6516173214106, 1775.9250231317956, 9311.487868167249, 10815.459227038695, 10996.0, 11071.833922491169, 11078.501467433985, 3868.3617203161725, 4337.50118736343, 4573.405457290531, 4635.582797548237, 4639.37368455261, 8806.603702833389, 8807.427517211361, 8813.074627164184, 8819.206271435472, 8825.985011723735, 5222.268882356473, 5226.346706661668, 5230.163173892159, 5233.476652334813, 5235.476452354734, 4392.802323895432, 4629.444466664022, 4859.562639362474, 4863.805447782049, 4937.679050861682, 3701.2967536168044, 3746.7939263340777, 3787.905302367463, 3811.0, 3822.6750726188584, 1178.1693905796392, 1190.8094704847183, 1195.653260554447, 1202.8255902894207, 1205.698575356161, 911.6125646600168, 923.1091996223677, 926.3543330198924, 929.2148134826061, 976.5215044628081, 5393.298871146804, 5530.889382212334, 5801.82594522165, 5820.912686309709, 5837.3287071986415, 861.5907443964066, 958.4057884111895, 959.1990687775785, 987.3187500624546, 1038.2213339995003, 3447.5690538682666, 3595.209054008114, 3839.2897313997, 3937.448757173998, 4038.5759495253164, 10053.0, 10258.384496930208, 10262.384256944608, 10276.588936442608, 10290.176785857113, 9959.800803984024, 10158.187345012382, 10232.897671023195, 10248.923862994427, 10280.023397777199, 7582.886256706154, 7802.531848089019, 7985.840283194304, 8087.716929907425, 8107.2703456688005, 5664.0937450007805, 5677.1768093627015, 5709.9714501427225, 5896.970515147397, 5947.583669143119, 9319.673811416838, 9336.53317334117, 9507.809843803223, 9539.189168920719, 9541.141297283279, 9062.954685226796, 9577.521123943914, 9711.805763884542, 9740.0, 9758.75603109928, 6845.931540684529, 7046.048783414379, 7186.1376634804155, 7314.268573142643, 7497.812554686177, 7857.646405911862, 8167.428280020579, 8170.060443049126, 8177.9591102044105, 8181.100078991187, 6208.782692605737, 7136.179339376038, 7296.562206267641, 7306.926930730838, 7327.670254838438, 7208.747693830691, 7215.170255420694, 7224.819379515554, 7230.89153662706, 7345.228750981284, 6452.096706461193, 6464.095026696173, 6533.379328963741, 6537.411632953057, 6543.509236807164, 4912.70523768575, 4962.379702537183, 4965.4289756678445, 4974.104661161025, 4997.600191984705, 4569.177548041384, 4599.494055653809, 4627.62978961689, 4711.599514041208, 4718.268668356411], "value": 4489.103304835608, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.2359104857421, 371.8865745947485, 378.8749712594845, 388.7492567294097, 390.377348129733, 5012.869530449553, 5115.667481613693, 5212.843614691556, 5260.447652996438, 5309.362876454821, 5002.373753779268, 5062.341895553582, 5144.639875208728, 5171.233390136278, 5184.377874655037, 3258.8533515991776, 3581.4985901973746, 3956.4065390191413, 4123.587641235882, 4144.534002268645, 3509.298140371936, 4119.464469618945, 4152.356384760352, 4171.414862352317, 4176.561461046592, 3140.026591756551, 3179.2210908327493, 3898.571157172723, 3949.2299001694682, 3962.1679447316096, 3292.160499072745, 3346.3641908037516, 3957.8416863325433, 3969.5435024972207, 3970.920581588381, 3045.8781648734025, 3475.8703421387895, 3482.37317282889, 3492.6856582907662, 3501.4768575669664, 4988.7006779592975, 5053.5237733510685, 5101.4133374662015, 5104.719240441774, 5195.64913122587, 3473.0796338970194, 3817.2556351511466, 4547.818087276505, 4557.498675145731, 4566.200914839923, 5509.559235261169, 5516.007118718629, 5516.227728118027, 5521.696306703129, 5561.555075593943, 3681.7606855554304, 3818.9618103818884, 3841.9039524012123, 3842.0, 3854.3062248795204, 4750.382450281476, 5768.7692492300675, 5773.094878690023, 5775.844831033768, 5815.185873977646, 3290.9341813164083, 3856.749311294757, 3866.2267546490816, 3879.728419010642, 3892.260470510594, 3516.5604299462566, 3927.3323534999117, 3939.6060393960374, 3961.5246170459727, 3981.6416522513114, 3795.4876091727815, 4324.589164029412, 4534.841280555231, 4557.361969324297, 4557.772111394417, 4731.858044258678, 5525.640833345819, 5547.44525547442, 5555.972220138873, 5618.185363122325, 1086.896744809242, 1147.7302833834042, 1153.5558809858264, 1190.458341454636, 1235.4872727817856, 852.1989330029752, 870.656090844113, 874.6851133591902, 877.4428238068745, 888.3692578269502, 4409.36064270679, 4565.452145742465, 4906.484819094015, 4968.180250258739, 5098.847034588968, 4652.953470465252, 5031.949680503221, 5227.581793456515, 5377.800208875713, 5391.705990562236, 4461.531539188339, 4932.457429682732, 5256.710880901511, 5310.7610157543, 5362.785488580413, 2593.0, 2687.3550347916357, 2819.4502072096157, 2830.589564513134, 2843.5924217512465, 4857.441394239708, 5363.666804939864, 5636.577256705681, 5652.208690783294, 5655.0, 4680.742559159279, 4739.805272334009, 5493.395726470085, 5523.917141242885, 5603.35561410443, 5352.91970620441, 5451.972740136274, 5581.720913954286, 5667.829965101054, 5670.234518340137, 4548.4541854977615, 4953.925691114564, 5046.47012063728, 5383.757730902197, 5391.029614669397, 4560.4983451820935, 4663.487016428258, 4755.500672429345, 5060.392752869532, 5165.845024649267, 4460.843870464518, 4782.904341913073, 4853.126437241331, 5593.888122237451, 5648.745806438802, 3628.5282913221113, 3659.451082337564, 3848.653621173996, 3957.327254366822, 3983.701222408273, 4913.612304004708, 5724.713764311685, 5734.455226753452, 5734.562810805308, 5747.712614369349, 4307.8492252771, 4975.353204083446, 5625.493705566519, 5642.094321424388, 5662.602438536845, 5166.6125040621355, 5252.921206181833, 5401.0, 5578.748956297058, 5642.774289028393, 5218.504242096995, 5283.603729720209, 5396.271503346998, 5440.510354067995, 5580.35825880029, 5474.726263686879, 5527.972360138335, 5543.52880005204, 5557.610967232255, 5572.801847602623, 4777.402824646919, 5125.897482050413, 5425.538829199404, 5446.373667028342, 5456.026465576191], "value": 3977.862031511296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.777340684498, 757.5757575757573, 775.980600484988, 793.821390187208, 898.6091050393079, 15156.77264841027, 15462.922685386557, 15505.922470387632, 15667.999999999985, 15708.214589270534, 14311.0, 14446.494372696958, 14451.927740361283, 14459.0, 16209.594760131002, 917.4907926101027, 934.0472717827812, 937.8030613571158, 939.0562484702898, 940.1162906867522, 902.4359775140537, 930.6044930904372, 934.8457504511747, 935.0696057422874, 936.976575585609, 984.675057231112, 986.8075725233582, 987.6197663899414, 988.4909271725068, 988.86650302209, 981.9459929703863, 982.882054153499, 982.9803403931917, 985.9260555458297, 986.5067466266867, 735.2720806401677, 735.9337659610608, 735.9852802943911, 737.5206116024573, 737.8302990312204, 16147.273372698257, 16153.757693634605, 16162.515124546282, 16182.595435114099, 16234.10712410817, 14312.713745725132, 14437.566872993826, 14459.927700361535, 14593.48922787708, 14629.487967921179, 11874.52501899923, 11889.346085965268, 11980.64058078259, 12104.576339828063, 12286.686015778445, 3655.652712992288, 3741.38267185914, 3815.065308999285, 3852.114013776847, 3857.61423857612, 87853.99999999936, 110896.89103108946, 115523.42238288838, 115600.0, 116351.0, 11014.0, 11054.668359949215, 11129.610463633733, 11597.884021159849, 11659.475323610457, 21845.563088738138, 22893.88553057224, 23212.955417006277, 23481.647775283385, 23735.88132059363, 7210.242924492853, 7354.742584009534, 7496.7001319947685, 7681.846363072707, 7695.461317707819, 4389.363542286351, 4458.398116254329, 4499.235130027903, 4570.3829982951875, 4663.673542851968, 3661.688756455731, 3706.592274849764, 3757.6242375762204, 3773.9433908491396, 3819.694424446038, 678.1015154919751, 686.7321744519642, 696.0429409561852, 700.3976580141075, 702.8594281143792, 598.4344794169468, 693.7918624412656, 719.2627556754264, 723.7466886589651, 751.9172890981988, 9929.851052234222, 10480.633177838892, 10676.199285053652, 10917.0, 10992.505337259843, 713.1299814226635, 726.4091639309894, 727.9281777531309, 737.1706829816457, 737.9188289288174, 4684.218867625444, 5111.386633603991, 5182.559482444034, 5192.5586325162785, 5217.677968472137, 87646.68529972056, 89738.0, 100750.99249007563, 107489.0, 114158.0, 55191.89616207653, 69796.6510167446, 87667.68498472527, 92222.0, 96875.51562242143, 49988.99999999927, 69058.65470672715, 72906.0, 80525.0, 86260.27479450376, 10841.186910981865, 10882.510287037261, 11139.0, 11409.543618255177, 11417.029552488131, 46698.76650616725, 46889.53110468852, 47086.0, 47892.0, 49033.0, 63393.732125358154, 63758.0, 69013.30986690069, 71071.64464177853, 71656.64171679108, 13405.658264699217, 13523.391447384694, 13666.666666666666, 13668.179909205479, 13777.931110344383, 14738.926305368404, 14812.0, 15071.794256459238, 15633.452829150925, 16303.0, 13584.592462226148, 13768.724625507233, 14348.856511434751, 14505.0, 14833.30609172024, 13317.733645326845, 13959.441622334993, 14029.929850350683, 14169.563306564747, 14418.279086045866, 13314.733705326033, 13671.83789377914, 14047.55994638344, 14484.493042743454, 14641.560753177422, 10740.785184296426, 10941.343519388862, 11259.943700281447, 11440.313581185155, 11540.596079137189, 8216.876746848922, 10134.594616215269, 10598.523066461874, 11214.607488737855, 12049.156559041134], "value": 7775.053417720573, "unit": "score"}], "name": "dromaeo_css", "value": 7505.47430829458, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 160.0, 113.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 114.0, 173.0, 141.0, 137.0, 110.0, 109.0, 130.0, 109.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 184.0, 183.0, 185.0, 183.0, 183.0, 184.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 92.0, 60.0, 58.0, 58.0, 58.0, 74.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 86.0, 71.0, 68.0, 69.0, 81.0, 69.0, 69.0, 85.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 87.0, 83.0, 88.0, 84.0, 87.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 112.0, 161.0, 94.0], "value": 107.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 83.0, 87.0, 84.0, 84.0, 85.0, 86.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 52.0, 56.0, 57.0, 55.0, 62.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 68.0, 70.0, 76.0, 68.0, 74.0, 74.0, 70.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 79.0, 83.0, 86.0, 78.0, 70.0, 79.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 170.0, 138.0, 142.0, 133.0, 129.0, 133.0, 152.0, 161.0, 127.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 166.0, 162.0, 166.0, 163.0, 162.0, 166.0, 162.0, 162.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 64.0, 64.0, 63.0, 64.0, 65.0, 63.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1425.5, "alertThreshold": 2.0}]} 13:50:25 INFO - Return code: 0 13:50:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:50:25 INFO - # TBPL SUCCESS # 13:50:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:25 INFO - 2017-03-13 13:50:25.799 screenresolution[2260:70161] starting screenresolution argv=screenresolution get 13:50:25 INFO - 2017-03-13 13:50:25.802 screenresolution[2260:70161] Display 0: 1600x1200x32@60 13:50:25 INFO - 2017-03-13 13:50:25.808 screenresolution[2261:70164] starting screenresolution argv=screenresolution list 13:50:25 INFO - Available Modes on Display 0 13:50:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:26 INFO - Intel Iris: 13:50:26 INFO - Chipset Model: Intel Iris 13:50:26 INFO - Type: GPU 13:50:26 INFO - Bus: Built-In 13:50:26 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:26 INFO - Vendor: Intel (0x8086) 13:50:26 INFO - Device ID: 0x0a2e 13:50:26 INFO - Revision ID: 0x0009 13:50:26 INFO - Displays: 13:50:26 INFO - Display: 13:50:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:26 INFO - Display Serial Number: 1600x1200 60 13:50:26 INFO - Main Display: Yes 13:50:26 INFO - Mirror: Off 13:50:26 INFO - Online: Yes 13:50:26 INFO - Rotation: Supported 13:50:26 INFO - Return code: 0 13:50:26 INFO - Running post-action listener: _resource_record_post_action 13:50:26 INFO - [mozharness: 2017-03-13 20:50:26.045551Z] Finished run-tests step (success) 13:50:26 INFO - Running post-run listener: _resource_record_post_run 13:50:26 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 106496; Write bytes: 423194624; Read time: 2; Write time: 1401 13:50:26 INFO - TinderboxPrint: CPU usage
53.7% 13:50:26 INFO - TinderboxPrint: I/O read bytes / time
106,496 / 2 13:50:26 INFO - TinderboxPrint: I/O write bytes / time
423,194,624 / 1,401 13:50:26 INFO - TinderboxPrint: CPU idle
2,206.4 (46.3%) 13:50:26 INFO - TinderboxPrint: CPU system
956.5 (20.1%) 13:50:26 INFO - TinderboxPrint: CPU user
1,602.9 (33.6%) 13:50:26 INFO - TinderboxPrint: Swap in / out
121,401,344 / 0 13:50:26 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122724864; Write bytes: 126568448; Read time: 11193; Write time: 304 13:50:26 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 4096; Write bytes: 295249920; Read time: 0; Write time: 1088 13:50:26 INFO - Running post-run listener: _upload_blobber_files 13:50:26 INFO - Blob upload gear active. 13:50:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:50:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:50:26 INFO - (blobuploader) - INFO - Open directory for files ... 13:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:27 INFO - (blobuploader) - INFO - Done attempting. 13:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:50:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:50:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:28 INFO - (blobuploader) - INFO - Done attempting. 13:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:29 INFO - (blobuploader) - INFO - Done attempting. 13:50:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:50:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:31 INFO - (blobuploader) - INFO - Done attempting. 13:50:31 INFO - (blobuploader) - INFO - Iteration through files over. 13:50:31 INFO - Return code: 0 13:50:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:50:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:50:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175161c03f682bf8556d88dbe4b946f9192d7b383f6e16b3c1cc7bbcbe56b00b08b8af287373a188602c86e7c3215c7997225e13b31f12f3b6d85e28a7d55dd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7bd5301dad5ae4587ae81b1dd0efe540f4e2b0bbace01c78941f41e74342e508af2bbadd54f970bb1dad9a3ae5ec5ef8467fce59ddead314bcabce466c77ffb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e76c19bb360700add9335f180b626dd6a29e277db646bc4fac751f2a1f57cecba2e36282c29e9b2bf83e31d9c74a8a3b0ebb272915e012f02e5824b44242551a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61ceed79026d8dc6a06fa1a790cc7d81572984231dfaf42987f1c7ca0b5cb3ef7f4b7a5aa6bcfa25e1b1e9c00c68299ddce070f423628f2f076a563dc4dd5775"} 13:50:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:50:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:50:31 INFO - Contents: 13:50:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175161c03f682bf8556d88dbe4b946f9192d7b383f6e16b3c1cc7bbcbe56b00b08b8af287373a188602c86e7c3215c7997225e13b31f12f3b6d85e28a7d55dd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7bd5301dad5ae4587ae81b1dd0efe540f4e2b0bbace01c78941f41e74342e508af2bbadd54f970bb1dad9a3ae5ec5ef8467fce59ddead314bcabce466c77ffb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e76c19bb360700add9335f180b626dd6a29e277db646bc4fac751f2a1f57cecba2e36282c29e9b2bf83e31d9c74a8a3b0ebb272915e012f02e5824b44242551a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61ceed79026d8dc6a06fa1a790cc7d81572984231dfaf42987f1c7ca0b5cb3ef7f4b7a5aa6bcfa25e1b1e9c00c68299ddce070f423628f2f076a563dc4dd5775"} 13:50:31 INFO - Running post-run listener: copy_logs_to_upload_dir 13:50:31 INFO - Copying logs to upload dir... 13:50:31 INFO - mkdir: /builds/slave/test/build/upload/logs 13:50:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.444989 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-13 13:50:31.741631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 13:50:31.744894) ========= 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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175161c03f682bf8556d88dbe4b946f9192d7b383f6e16b3c1cc7bbcbe56b00b08b8af287373a188602c86e7c3215c7997225e13b31f12f3b6d85e28a7d55dd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7bd5301dad5ae4587ae81b1dd0efe540f4e2b0bbace01c78941f41e74342e508af2bbadd54f970bb1dad9a3ae5ec5ef8467fce59ddead314bcabce466c77ffb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e76c19bb360700add9335f180b626dd6a29e277db646bc4fac751f2a1f57cecba2e36282c29e9b2bf83e31d9c74a8a3b0ebb272915e012f02e5824b44242551a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61ceed79026d8dc6a06fa1a790cc7d81572984231dfaf42987f1c7ca0b5cb3ef7f4b7a5aa6bcfa25e1b1e9c00c68299ddce070f423628f2f076a563dc4dd5775"} build_url:https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010727 build_url: 'https://queue.taskcluster.net/v1/task/P5n54WqBRkyS1QTT7iSV0g/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/175161c03f682bf8556d88dbe4b946f9192d7b383f6e16b3c1cc7bbcbe56b00b08b8af287373a188602c86e7c3215c7997225e13b31f12f3b6d85e28a7d55dd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7bd5301dad5ae4587ae81b1dd0efe540f4e2b0bbace01c78941f41e74342e508af2bbadd54f970bb1dad9a3ae5ec5ef8467fce59ddead314bcabce466c77ffb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e76c19bb360700add9335f180b626dd6a29e277db646bc4fac751f2a1f57cecba2e36282c29e9b2bf83e31d9c74a8a3b0ebb272915e012f02e5824b44242551a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/61ceed79026d8dc6a06fa1a790cc7d81572984231dfaf42987f1c7ca0b5cb3ef7f4b7a5aa6bcfa25e1b1e9c00c68299ddce070f423628f2f076a563dc4dd5775"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 13:50:31.780052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:50:31.780410) ========= 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.mC0Oz7fdVE/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.r6olZRWkE3/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.005517 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 13:50:31.829234) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 13:50:31.829571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 13:50:31.829909) ========= ========= Total master_lag: 0.23 =========