builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1492730281.08 results: success (0) buildid: 20170420144628 builduid: 52045ffb1f4f4f0c9d0943d0e6e88a39 revision: 5e3dc7e1288af835220871fefdb18d520efb06d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.075770) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.076249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.076553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.105570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.106156) ========= 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.8hnF05bYbM/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.EVP6iZjnDk/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-20 16:18:01-- 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% 176M=0s 2017-04-20 16:18:01 (176 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083385 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.214626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.215006) ========= 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.8hnF05bYbM/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.EVP6iZjnDk/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.027128 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:01.264223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-20 16:18:01.264611) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e3dc7e1288af835220871fefdb18d520efb06d4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5e3dc7e1288af835220871fefdb18d520efb06d4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8hnF05bYbM/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.EVP6iZjnDk/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-20 16:18:01,569 truncating revision to first 12 chars 2017-04-20 16:18:01,570 Setting DEBUG logging. 2017-04-20 16:18:01,570 attempt 1/10 2017-04-20 16:18:01,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e3dc7e1288a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 16:18:03,276 unpacking tar archive at: mozilla-central-5e3dc7e1288a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.977108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-20 16:18:03.265266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:03.265925) ========= script_repo_revision: 5e3dc7e1288af835220871fefdb18d520efb06d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:03.266790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:03.267250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 16:18:03.288088) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-20 16:18:03.288505) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8hnF05bYbM/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.EVP6iZjnDk/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:18:03 INFO - MultiFileLogger online at 20170420 16:18:03 in /builds/slave/test 16:18:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:18:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:03 INFO - {'append_to_log': False, 16:18:03 INFO - 'base_work_dir': '/builds/slave/test', 16:18:03 INFO - 'blob_upload_branch': 'Firefox', 16:18:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:03 INFO - 'branch': 'Firefox', 16:18:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:03 INFO - 'config_files': ('talos/mac_config.py',), 16:18:03 INFO - 'default_actions': ('clobber', 16:18:03 INFO - 'read-buildbot-config', 16:18:03 INFO - 'download-and-extract', 16:18:03 INFO - 'populate-webroot', 16:18:03 INFO - 'create-virtualenv', 16:18:03 INFO - 'install', 16:18:03 INFO - 'run-tests'), 16:18:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:03 INFO - 'download_minidump_stackwalk': True, 16:18:03 INFO - 'download_symbols': 'ondemand', 16:18:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:03 INFO - 'gecko_profile': False, 16:18:03 INFO - 'gecko_profile_interval': 0, 16:18:03 INFO - 'installer_path': 'installer.exe', 16:18:03 INFO - 'log_level': 'info', 16:18:03 INFO - 'log_name': 'talos', 16:18:03 INFO - 'log_to_console': True, 16:18:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:18:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:18:03 INFO - 'opt_config_files': (), 16:18:03 INFO - 'pip_index': False, 16:18:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:03 INFO - 'cmd': ('bash', 16:18:03 INFO - '-c', 16:18:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:03 INFO - 'enabled': True, 16:18:03 INFO - 'halt_on_failure': False, 16:18:03 INFO - 'name': 'check_screen_resolution'},), 16:18:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:03 INFO - 'cmd': ('bash', 16:18:03 INFO - '-c', 16:18:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:03 INFO - 'enabled': True, 16:18:03 INFO - 'halt_on_failure': False, 16:18:03 INFO - 'name': 'check_screen_resolution'},), 16:18:03 INFO - 'run_cmd_checks_enabled': True, 16:18:03 INFO - 'suite': 'dromaeojs', 16:18:03 INFO - 'system_bits': '32', 16:18:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:03 INFO - 'title': 't-yosemite-r7-0225', 16:18:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:03 INFO - 'use_talos_json': True, 16:18:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:03 INFO - 'work_dir': 'build'} 16:18:03 INFO - [mozharness: 2017-04-20 23:18:03.701184Z] Running clobber step. 16:18:03 INFO - Running pre-action listener: _resource_record_pre_action 16:18:03 INFO - Running main action method: clobber 16:18:03 INFO - rmtree: /builds/slave/test/build 16:18:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:06 INFO - Running post-action listener: _resource_record_post_action 16:18:06 INFO - [mozharness: 2017-04-20 23:18:06.020106Z] Finished clobber step (success) 16:18:06 INFO - [mozharness: 2017-04-20 23:18:06.020233Z] Running read-buildbot-config step. 16:18:06 INFO - Running pre-action listener: _resource_record_pre_action 16:18:06 INFO - Running main action method: read_buildbot_config 16:18:06 INFO - Using buildbot properties: 16:18:06 INFO - { 16:18:06 INFO - "project": "", 16:18:06 INFO - "product": "firefox", 16:18:06 INFO - "script_repo_revision": "production", 16:18:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:18:06 INFO - "repository": "", 16:18:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:18:06 INFO - "buildid": "20170420144628", 16:18:06 INFO - "pgo_build": "False", 16:18:06 INFO - "basedir": "/builds/slave/test", 16:18:06 INFO - "buildnumber": 82, 16:18:06 INFO - "slavename": "t-yosemite-r7-0225", 16:18:06 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:18:06 INFO - "platform": "yosemite_r7", 16:18:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:18:06 INFO - "branch": "mozilla-central", 16:18:06 INFO - "repo_path": "mozilla-central", 16:18:06 INFO - "revision": "5e3dc7e1288af835220871fefdb18d520efb06d4", 16:18:06 INFO - "stage_platform": "macosx64", 16:18:06 INFO - "builduid": "52045ffb1f4f4f0c9d0943d0e6e88a39", 16:18:06 INFO - "slavebuilddir": "test" 16:18:06 INFO - } 16:18:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:18:06 INFO - Running post-action listener: _resource_record_post_action 16:18:06 INFO - [mozharness: 2017-04-20 23:18:06.023371Z] Finished read-buildbot-config step (success) 16:18:06 INFO - [mozharness: 2017-04-20 23:18:06.023498Z] Running download-and-extract step. 16:18:06 INFO - Running pre-action listener: _resource_record_pre_action 16:18:06 INFO - Running main action method: download_and_extract 16:18:06 INFO - mkdir: /builds/slave/test/build/tests 16:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:06 INFO - trying https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:18:06 INFO - Downloading https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:18:07 INFO - Downloaded 1325 bytes. 16:18:07 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:18:07 INFO - Using the following test package requirements: 16:18:07 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:18:07 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:18:07 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:18:07 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:18:07 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'jsshell-mac.zip'], 16:18:07 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:18:07 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:18:07 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:18:07 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:18:07 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:18:07 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:07 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:18:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:18:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:18:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:18:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:18:08 INFO - Expected file size: 52521907 16:18:08 INFO - Obtained file size: 52521907 16:18:25 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:18:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:18:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:18:25 INFO - Fetch https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:18:26 INFO - Expected file size: 52521907 16:18:26 INFO - Obtained file size: 52521907 16:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:18:43 INFO - Expected file size: 14408811 16:18:43 INFO - Obtained file size: 14408811 16:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:44 INFO - trying https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:18:46 INFO - Downloaded 70969641 bytes. 16:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:18:46 INFO - mkdir: /builds/slave/test/properties 16:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:46 INFO - Contents: 16:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:18:46 INFO - Running post-action listener: _resource_record_post_action 16:18:46 INFO - Running post-action listener: set_extra_try_arguments 16:18:46 INFO - [mozharness: 2017-04-20 23:18:46.779988Z] Finished download-and-extract step (success) 16:18:46 INFO - [mozharness: 2017-04-20 23:18:46.780107Z] Running populate-webroot step. 16:18:46 INFO - Running pre-action listener: _resource_record_pre_action 16:18:46 INFO - Running main action method: populate_webroot 16:18:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:46 INFO - '--tppagecycles', 16:18:46 INFO - '7'], 16:18:46 INFO - 'tests': ['tsvgm']}}, 16:18:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['damp', 'tps']}, 16:18:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'tests': ['damp', 'tps']}, 16:18:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['dromaeo_dom']}, 16:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:18:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:18:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['a11yr', 16:18:46 INFO - 'ts_paint', 16:18:46 INFO - 'tpaint', 16:18:46 INFO - 'sessionrestore', 16:18:46 INFO - 'sessionrestore_no_auto_restore', 16:18:46 INFO - 'tabpaint']}, 16:18:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:46 INFO - 'ts_paint', 16:18:46 INFO - 'tpaint', 16:18:46 INFO - 'sessionrestore', 16:18:46 INFO - 'sessionrestore_no_auto_restore', 16:18:46 INFO - 'tabpaint']}, 16:18:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:46 INFO - 'ts_paint', 16:18:46 INFO - 'tpaint', 16:18:46 INFO - 'sessionrestore', 16:18:46 INFO - 'sessionrestore_no_auto_restore', 16:18:46 INFO - 'tabpaint']}, 16:18:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:46 INFO - 'ts_paint', 16:18:46 INFO - 'tpaint', 16:18:46 INFO - 'sessionrestore', 16:18:46 INFO - 'sessionrestore_no_auto_restore', 16:18:46 INFO - 'tabpaint']}, 16:18:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['a11yr', 16:18:46 INFO - 'ts_paint', 16:18:46 INFO - 'tpaint', 16:18:46 INFO - 'sessionrestore', 16:18:46 INFO - 'sessionrestore_no_auto_restore', 16:18:46 INFO - 'tabpaint']}, 16:18:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['a11yr', 16:18:46 INFO - 'ts_paint', 16:18:46 INFO - 'tpaint', 16:18:46 INFO - 'sessionrestore', 16:18:46 INFO - 'sessionrestore_no_auto_restore', 16:18:46 INFO - 'tabpaint']}, 16:18:46 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:18:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:18:46 INFO - 'bloom_basic_ref']}, 16:18:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['tsvgx', 16:18:46 INFO - 'tsvgr_opacity', 16:18:46 INFO - 'tart', 16:18:46 INFO - 'tscrollx', 16:18:46 INFO - 'cart', 16:18:46 INFO - 'tsvg_static']}, 16:18:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:46 INFO - 'tsvgr_opacity', 16:18:46 INFO - 'tart', 16:18:46 INFO - 'tscrollx', 16:18:46 INFO - 'cart', 16:18:46 INFO - 'tsvg_static']}, 16:18:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'talos_options': ['--disable-e10s'], 16:18:46 INFO - 'tests': ['tp5o']}, 16:18:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:18:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'talos_options': ['--disable-e10s', 16:18:46 INFO - '--xperf_path', 16:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:46 INFO - 'tests': ['tp5n']}, 16:18:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:18:46 INFO - 'talos_options': ['--xperf_path', 16:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:46 INFO - 'tests': ['tp5n']}}, 16:18:46 INFO - 'talos.zip': {'path': '', 16:18:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:46 INFO - Running post-action listener: _resource_record_post_action 16:18:46 INFO - [mozharness: 2017-04-20 23:18:46.799032Z] Finished populate-webroot step (success) 16:18:46 INFO - [mozharness: 2017-04-20 23:18:46.799159Z] Running create-virtualenv step. 16:18:46 INFO - Running pre-action listener: _resource_record_pre_action 16:18:46 INFO - Running main action method: create_virtualenv 16:18:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:18:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:46 INFO - Using real prefix '/tools/python27' 16:18:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:50 INFO - Installing pip.................done. 16:18:50 INFO - Return code: 0 16:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:18:50 INFO - Reading from file tmpfile_stdout 16:18:50 INFO - Output received: 16:18:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:50 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:50 INFO - 'HOME': '/Users/cltbld', 16:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:50 INFO - 'LOGNAME': 'cltbld', 16:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:50 INFO - 'MOZ_NO_REMOTE': '1', 16:18:50 INFO - 'NO_EM_RESTART': '1', 16:18:50 INFO - 'PAGER': '/bin/cat', 16:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:50 INFO - 'PWD': '/builds/slave/test', 16:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:50 INFO - 'SHELL': '/bin/bash', 16:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:18:50 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:50 INFO - 'USER': 'cltbld', 16:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:50 INFO - 'XPC_FLAGS': '0x0', 16:18:50 INFO - 'XPC_SERVICE_NAME': '0', 16:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:18:51 INFO - Cleaning up... 16:18:51 INFO - Return code: 0 16:18:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:51 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:18:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:18:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:51 INFO - 'HOME': '/Users/cltbld', 16:18:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:51 INFO - 'LOGNAME': 'cltbld', 16:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:51 INFO - 'MOZ_NO_REMOTE': '1', 16:18:51 INFO - 'NO_EM_RESTART': '1', 16:18:51 INFO - 'PAGER': '/bin/cat', 16:18:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:51 INFO - 'PWD': '/builds/slave/test', 16:18:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:51 INFO - 'SHELL': '/bin/bash', 16:18:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:18:51 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:18:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:51 INFO - 'USER': 'cltbld', 16:18:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:51 INFO - 'XPC_FLAGS': '0x0', 16:18:51 INFO - 'XPC_SERVICE_NAME': '0', 16:18:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:51 INFO - Downloading/unpacking psutil>=3.1.1 16:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:18:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:54 INFO - Installing collected packages: psutil 16:18:54 INFO - Running setup.py install for psutil 16:18:54 INFO - building 'psutil._psutil_osx' extension 16:18:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:18:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:18:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:18:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:18:55 INFO - building 'psutil._psutil_posix' extension 16:18:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:18:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:18:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:18:55 INFO - ^ 16:18:55 INFO - 1 warning generated. 16:18:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:18:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:55 INFO - Successfully installed psutil 16:18:55 INFO - Cleaning up... 16:18:55 INFO - Return code: 0 16:18:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:55 INFO - 'HOME': '/Users/cltbld', 16:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:55 INFO - 'LOGNAME': 'cltbld', 16:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:55 INFO - 'MOZ_NO_REMOTE': '1', 16:18:55 INFO - 'NO_EM_RESTART': '1', 16:18:55 INFO - 'PAGER': '/bin/cat', 16:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:55 INFO - 'PWD': '/builds/slave/test', 16:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:55 INFO - 'SHELL': '/bin/bash', 16:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:18:55 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:55 INFO - 'USER': 'cltbld', 16:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:55 INFO - 'XPC_FLAGS': '0x0', 16:18:55 INFO - 'XPC_SERVICE_NAME': '0', 16:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:18:58 INFO - Installing collected packages: mozsystemmonitor 16:18:58 INFO - Running setup.py install for mozsystemmonitor 16:18:59 INFO - Successfully installed mozsystemmonitor 16:18:59 INFO - Cleaning up... 16:18:59 INFO - Return code: 0 16:18:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:59 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:18:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:18:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:59 INFO - 'HOME': '/Users/cltbld', 16:18:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:59 INFO - 'LOGNAME': 'cltbld', 16:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:59 INFO - 'MOZ_NO_REMOTE': '1', 16:18:59 INFO - 'NO_EM_RESTART': '1', 16:18:59 INFO - 'PAGER': '/bin/cat', 16:18:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:59 INFO - 'PWD': '/builds/slave/test', 16:18:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:59 INFO - 'SHELL': '/bin/bash', 16:18:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:18:59 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:18:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:59 INFO - 'USER': 'cltbld', 16:18:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:59 INFO - 'XPC_FLAGS': '0x0', 16:18:59 INFO - 'XPC_SERVICE_NAME': '0', 16:18:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:00 INFO - Downloading/unpacking jsonschema==2.5.1 16:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:03 INFO - warning: no files found matching '*.txt' 16:19:03 INFO - no previously-included directories found matching 'build' 16:19:03 INFO - no previously-included directories found matching 'dist' 16:19:03 INFO - no previously-included directories found matching '.git*' 16:19:03 INFO - Installing collected packages: jsonschema, functools32 16:19:03 INFO - Running setup.py install for functools32 16:19:03 INFO - warning: no files found matching '*.txt' 16:19:03 INFO - no previously-included directories found matching 'build' 16:19:03 INFO - no previously-included directories found matching 'dist' 16:19:03 INFO - no previously-included directories found matching '.git*' 16:19:03 INFO - Successfully installed jsonschema functools32 16:19:03 INFO - Cleaning up... 16:19:03 INFO - Return code: 0 16:19:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:03 INFO - 'HOME': '/Users/cltbld', 16:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:03 INFO - 'LOGNAME': 'cltbld', 16:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:03 INFO - 'MOZ_NO_REMOTE': '1', 16:19:03 INFO - 'NO_EM_RESTART': '1', 16:19:03 INFO - 'PAGER': '/bin/cat', 16:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:03 INFO - 'PWD': '/builds/slave/test', 16:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:03 INFO - 'SHELL': '/bin/bash', 16:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:03 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:03 INFO - 'USER': 'cltbld', 16:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:03 INFO - 'XPC_FLAGS': '0x0', 16:19:03 INFO - 'XPC_SERVICE_NAME': '0', 16:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:19:04 INFO - Cleaning up... 16:19:04 INFO - Return code: 0 16:19:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:04 INFO - 'HOME': '/Users/cltbld', 16:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:04 INFO - 'LOGNAME': 'cltbld', 16:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:04 INFO - 'MOZ_NO_REMOTE': '1', 16:19:04 INFO - 'NO_EM_RESTART': '1', 16:19:04 INFO - 'PAGER': '/bin/cat', 16:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:04 INFO - 'PWD': '/builds/slave/test', 16:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:04 INFO - 'SHELL': '/bin/bash', 16:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:04 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:04 INFO - 'USER': 'cltbld', 16:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:04 INFO - 'XPC_FLAGS': '0x0', 16:19:04 INFO - 'XPC_SERVICE_NAME': '0', 16:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:04 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:08 INFO - Downloading docopt-0.6.1.tar.gz 16:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:08 INFO - Running setup.py install for blobuploader 16:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:08 INFO - Running setup.py install for requests 16:19:09 INFO - Running setup.py install for docopt 16:19:09 INFO - Successfully installed blobuploader requests docopt 16:19:09 INFO - Cleaning up... 16:19:09 INFO - Return code: 0 16:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:09 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:09 INFO - 'HOME': '/Users/cltbld', 16:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:09 INFO - 'LOGNAME': 'cltbld', 16:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:09 INFO - 'MOZ_NO_REMOTE': '1', 16:19:09 INFO - 'NO_EM_RESTART': '1', 16:19:09 INFO - 'PAGER': '/bin/cat', 16:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:09 INFO - 'PWD': '/builds/slave/test', 16:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:09 INFO - 'SHELL': '/bin/bash', 16:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:09 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:09 INFO - 'USER': 'cltbld', 16:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:09 INFO - 'XPC_FLAGS': '0x0', 16:19:09 INFO - 'XPC_SERVICE_NAME': '0', 16:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:09 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-D3jwhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:09 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-p1a1yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:09 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-b1iHMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:09 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-aJ_Aqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:09 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-uFrAWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-tUSfQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6Y4z93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-YNIEHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-t9duoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-jDy2PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-oexktc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-39eZ0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-H_rS87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6EfM3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:10 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-u6UggZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:11 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-8tGbOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:11 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-v6DksM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:11 INFO - Running setup.py install for manifestparser 16:19:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:11 INFO - Running setup.py install for mozcrash 16:19:11 INFO - Running setup.py install for mozdebug 16:19:11 INFO - Running setup.py install for mozdevice 16:19:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:11 INFO - Running setup.py install for mozfile 16:19:12 INFO - Running setup.py install for mozhttpd 16:19:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozinfo 16:19:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozInstall 16:19:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozleak 16:19:12 INFO - Running setup.py install for mozlog 16:19:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for moznetwork 16:19:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:12 INFO - Running setup.py install for mozprocess 16:19:13 INFO - Running setup.py install for mozprofile 16:19:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozrunner 16:19:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Running setup.py install for mozscreenshot 16:19:13 INFO - Running setup.py install for moztest 16:19:13 INFO - Running setup.py install for mozversion 16:19:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:13 INFO - Cleaning up... 16:19:13 INFO - Return code: 0 16:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:13 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:13 INFO - 'HOME': '/Users/cltbld', 16:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:13 INFO - 'LOGNAME': 'cltbld', 16:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:13 INFO - 'MOZ_NO_REMOTE': '1', 16:19:13 INFO - 'NO_EM_RESTART': '1', 16:19:13 INFO - 'PAGER': '/bin/cat', 16:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:13 INFO - 'PWD': '/builds/slave/test', 16:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:13 INFO - 'SHELL': '/bin/bash', 16:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:13 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:13 INFO - 'USER': 'cltbld', 16:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:13 INFO - 'XPC_FLAGS': '0x0', 16:19:13 INFO - 'XPC_SERVICE_NAME': '0', 16:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-WdMUgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-WAQ_Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-HNmVIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-pusmbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-9M3nqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-O3rD9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-X6tWL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-bjv0hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:14 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-CqeO3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-MPOdIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-lx1HVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-8aGE1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-NnbjRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-OEEXWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Coo8_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-mJv28i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:15 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-TCIFr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:18 INFO - Downloading blessings-1.6.tar.gz 16:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:18 INFO - Installing collected packages: blessings 16:19:18 INFO - Running setup.py install for blessings 16:19:18 INFO - Successfully installed blessings 16:19:18 INFO - Cleaning up... 16:19:18 INFO - Return code: 0 16:19:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:19 INFO - Reading from file tmpfile_stdout 16:19:19 INFO - Current package versions: 16:19:19 INFO - blessings == 1.6 16:19:19 INFO - blobuploader == 1.2.4 16:19:19 INFO - docopt == 0.6.1 16:19:19 INFO - functools32 == 3.2.3-2 16:19:19 INFO - jsonschema == 2.5.1 16:19:19 INFO - manifestparser == 1.1 16:19:19 INFO - mozInstall == 1.12 16:19:19 INFO - mozcrash == 1.0 16:19:19 INFO - mozdebug == 0.1 16:19:19 INFO - mozdevice == 0.50 16:19:19 INFO - mozfile == 1.2 16:19:19 INFO - mozhttpd == 0.7 16:19:19 INFO - mozinfo == 0.9 16:19:19 INFO - mozleak == 0.1 16:19:19 INFO - mozlog == 3.4 16:19:19 INFO - moznetwork == 0.27 16:19:19 INFO - mozprocess == 0.25 16:19:19 INFO - mozprofile == 0.28 16:19:19 INFO - mozrunner == 6.13 16:19:19 INFO - mozscreenshot == 0.1 16:19:19 INFO - mozsystemmonitor == 0.3 16:19:19 INFO - moztest == 0.8 16:19:19 INFO - mozversion == 1.4 16:19:19 INFO - psutil == 3.1.1 16:19:19 INFO - requests == 1.2.3 16:19:19 INFO - wsgiref == 0.1.2 16:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:19 INFO - 'HOME': '/Users/cltbld', 16:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PAGER': '/bin/cat', 16:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:19 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - 'XPC_FLAGS': '0x0', 16:19:19 INFO - 'XPC_SERVICE_NAME': '0', 16:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:19:19 INFO - Cleaning up... 16:19:19 INFO - Return code: 0 16:19:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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 0x10475ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10475d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f887ad656b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, '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.8hnF05bYbM/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.EVP6iZjnDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:19 INFO - 'HOME': '/Users/cltbld', 16:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PAGER': '/bin/cat', 16:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:19 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - 'XPC_FLAGS': '0x0', 16:19:19 INFO - 'XPC_SERVICE_NAME': '0', 16:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:19:19 INFO - Cleaning up... 16:19:19 INFO - Return code: 0 16:19:19 INFO - Running post-action listener: _resource_record_post_action 16:19:19 INFO - Running post-action listener: _start_resource_monitoring 16:19:19 INFO - Starting resource monitoring. 16:19:19 INFO - [mozharness: 2017-04-20 23:19:19.704003Z] Finished create-virtualenv step (success) 16:19:19 INFO - [mozharness: 2017-04-20 23:19:19.704936Z] Running install step. 16:19:19 INFO - Running pre-action listener: _resource_record_pre_action 16:19:19 INFO - Running main action method: install 16:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:19 INFO - Reading from file tmpfile_stdout 16:19:19 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:20 INFO - Reading from file tmpfile_stdout 16:19:20 INFO - Output received: 16:19:20 INFO - Usage: mozinstall [options] installer 16:19:20 INFO - Options: 16:19:20 INFO - -h, --help show this help message and exit 16:19:20 INFO - -d DEST, --destination=DEST 16:19:20 INFO - Directory to install application into. [default: 16:19:20 INFO - "/builds/slave/test"] 16:19:20 INFO - --app=APP Application being installed. [default: firefox] 16:19:20 INFO - mkdir: /builds/slave/test/build/application 16:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:19:39 INFO - Reading from file tmpfile_stdout 16:19:39 INFO - Output received: 16:19:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:19:39 INFO - Running post-action listener: _resource_record_post_action 16:19:39 INFO - [mozharness: 2017-04-20 23:19:39.933791Z] Finished install step (success) 16:19:39 INFO - [mozharness: 2017-04-20 23:19:39.933925Z] Running run-tests step. 16:19:39 INFO - Running pre-action listener: _resource_record_pre_action 16:19:39 INFO - Running main action method: run_tests 16:19:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:39 INFO - 2017-04-20 16:19:39.948 screenresolution[1621:7303] starting screenresolution argv=screenresolution get 16:19:39 INFO - 2017-04-20 16:19:39.951 screenresolution[1621:7303] Display 0: 1600x1200x32@60 16:19:39 INFO - 2017-04-20 16:19:39.956 screenresolution[1622:7306] starting screenresolution argv=screenresolution list 16:19:39 INFO - Available Modes on Display 0 16:19:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:40 INFO - Intel Iris: 16:19:40 INFO - Chipset Model: Intel Iris 16:19:40 INFO - Type: GPU 16:19:40 INFO - Bus: Built-In 16:19:40 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:40 INFO - Vendor: Intel (0x8086) 16:19:40 INFO - Device ID: 0x0a2e 16:19:40 INFO - Revision ID: 0x0009 16:19:40 INFO - Displays: 16:19:40 INFO - Display: 16:19:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:40 INFO - Display Serial Number: 1600x1200 60 16:19:40 INFO - Main Display: Yes 16:19:40 INFO - Mirror: Off 16:19:40 INFO - Online: Yes 16:19:40 INFO - Rotation: Supported 16:19:40 INFO - Return code: 0 16:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:40 INFO - Python 2.7.3 16:19:40 INFO - Return code: 0 16:19:40 INFO - grabbing minidump binary from tooltool 16:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:40 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 0x104538d30>, '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 0x10445edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:19:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:19:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:19:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:40 INFO - Return code: 0 16:19:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:19:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:40 INFO - ENV: RUST_BACKTRACE is now 1 16:19:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:19:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8hnF05bYbM/Render', 16:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:40 INFO - 'HOME': '/Users/cltbld', 16:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:40 INFO - 'LOGNAME': 'cltbld', 16:19:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:40 INFO - 'MOZ_NO_REMOTE': '1', 16:19:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:40 INFO - 'NO_EM_RESTART': '1', 16:19:40 INFO - 'PAGER': '/bin/cat', 16:19:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:40 INFO - 'PWD': '/builds/slave/test', 16:19:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:40 INFO - 'RUST_BACKTRACE': '1', 16:19:40 INFO - 'SHELL': '/bin/bash', 16:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EVP6iZjnDk/Listeners', 16:19:40 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 16:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:40 INFO - 'USER': 'cltbld', 16:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:40 INFO - 'XPC_FLAGS': '0x0', 16:19:40 INFO - 'XPC_SERVICE_NAME': '0', 16:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:19:40 INFO - mozversion application_buildid: 20170420144628 16:19:40 INFO - mozversion application_changeset: 5e3dc7e1288af835220871fefdb18d520efb06d4 16:19:40 INFO - mozversion application_display_name: Nightly 16:19:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:40 INFO - mozversion application_name: Firefox 16:19:40 INFO - mozversion application_remotingname: firefox 16:19:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:19:40 INFO - mozversion application_vendor: Mozilla 16:19:40 INFO - mozversion application_version: 55.0a1 16:19:40 INFO - mozversion platform_buildid: 20170420144628 16:19:40 INFO - mozversion platform_changeset: 5e3dc7e1288af835220871fefdb18d520efb06d4 16:19:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:19:40 INFO - mozversion platform_version: 55.0a1 16:19:40 INFO - using testdate: 1492730380 16:19:40 INFO - actual date: 1492730380 16:19:40 INFO - starting webserver on 'localhost:49241' 16:19:40 INFO - SUITE-START | Running 2 tests 16:19:40 INFO - TEST-START | dromaeo_css 16:19:40 INFO - operating with platform_type : mac_ 16:19:40 INFO - Initialising browser for dromaeo_css test... 16:19:40 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpWlBbD2/profile http://localhost:49241/getInfo.html) 16:19:43 INFO - PID 1632 | __metrics Screen width/height:1600/1200 16:19:43 INFO - PID 1632 | colorDepth:24 16:19:43 INFO - PID 1632 | Browser inner width/height: 1024/689 16:19:43 INFO - PID 1632 | __metrics 16:19:43 INFO - PID 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:19:43 INFO - PID 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:44 INFO - TEST-INFO | 1632: exit 0 16:19:44 INFO - Browser initialized. 16:19:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:19:44 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpWlBbD2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:56 INFO - PID 1634 | RSS: Main: 241377280 16:19:56 INFO - PID 1634 | 16:23:00 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:23:02 INFO - PID 1634 | RSS: Main: 448200704 16:23:02 INFO - PID 1634 | 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 16:24:46 INFO - PID 1634 | 16:24:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:24:46 INFO - PID 1634 | Full stack: 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 16:24:46 INFO - PID 1634 | 16:24:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:24:46 INFO - PID 1634 | Full stack: 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 16:24:46 INFO - PID 1634 | 16:24:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:24:46 INFO - PID 1634 | Full stack: 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | ************************* 16:24:46 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 16:24:46 INFO - PID 1634 | 16:24:46 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:24:46 INFO - PID 1634 | Full stack: 16:24:46 INFO - PID 1634 | ************************* 16:26:05 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:26:06 INFO - PID 1634 | RSS: Main: 371269632 16:26:06 INFO - PID 1634 | 16:29:08 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:29:08 INFO - PID 1634 | RSS: Main: 330969088 16:29:08 INFO - PID 1634 | 16:32:11 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:32:11 INFO - PID 1634 | RSS: Main: 339238912 16:32:11 INFO - PID 1634 | 16:35:15 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:35:15 INFO - PID 1634 | RSS: Main: 337768448 16:35:15 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:38:18 INFO - PID 1634 | RSS: Main: 377131008 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | __start_tp_report 16:38:18 INFO - PID 1634 | _x_x_mozilla_page_load 16:38:18 INFO - PID 1634 | _x_x_mozilla_page_load_details 16:38:18 INFO - PID 1634 | |i|pagename|runs| 16:38:18 INFO - PID 1634 | |0;dojo.html;3447.7758945668547;3466.947995780063;3472.0972547137753;3484.0418884806677;3512.3326567952085;6047.516198704104;6071.483923866476;6072.908906366402;6098.401972603836;6101.35935726749;4853.272009198622;6041.093835924603;6072.574919755608;6087.939120608793;6095.847603809907;4781.880452988686;5095.923561146586;5285.445028272034;5314.282571852808;5323.733813309338;5169.56058735008;5336.866578335534;5344.412114667383;5373.596980226479;5391.649542779726;5237.711925844096;5250.238715386247;5294.6029047821185;5337.733113344318;5360.249565060894;5233.345831771028;5263.973680131613;5265.157574788054;5301.681899086028;5346.705931173784;5241.947580524184;5256.342957130359;5275.920861187085;5294.49702278283;5311.282976798121;5813.563982701315;5848.853778655525;5904.439078287556;6047.274327080779;6047.697615119227;6319.8736025279695;6335.936640633627;6336.144620476222;6355.87288254237;6357.904631430486;6434.4852411807415;6439;6439.93560064398;6452.193475815523;6454.451371633417;5053.722045287471;5997.790077347272;6087.9391206087375;6099.298580663191;6137.877242455171;5229.843104706865;5496.422875598085;6569.474442044625;6584.913489274312;6598.670066496656;6293.937060629427;6307.905381419282;6325.810225693236;6327.145835312174;6329.778457753957;6366.363363663597;6456.483481321483;6473.935260647428;6480.384363485461;6482.837929051717;5612.494875461147;6296.874062518724;6303.873922521524;6320.841978950563;6330.905036424458;6344.746210151542;6349.46029587481;6360.14138091361;6371.904421433682;6394.936050639434;5190.714510701872;5209.348831396075;5217.165253559412;5223.138182199895;5243.9213411798855;4585.908281834411;4596.287575425815;4657.836975705834;4680.789364478606;4730.52694730531;6070.271567411939;6075.665838378844;6080.087986802015;6089.817305480843;6097.420745029215;6288.5283603728985;6421.101045853584;6457.418832305021;6492.480601551864;6500.219973603198;6160.630362178284;6216.720247588869;6222.439980401786;6223.37766223374;6229.626222426669;5688.260526131577;5692.345380281321;5698.430156984268;5701.258836351248;5733.77064917407;5401.2168235606405;6399.104125422445;6483.967580162069;6487.708053137526;6494.123293355431;6328.525360598066;6329.873402531832;6419.967900160656;6437.420632143129;6506.219253689587;6703.463722902254;6709.36261055199;6710.496712746466;6711.664416779239;6725.630090345078;6326.145970294136;6336.3030066693545;6337.7148028337915;6344.873102537831;6362.681865906594;5300.840974770763;6302.117703521419;6363.745450181941;6370.140031095928;6380.87238255223;6226.315105338319;6237.126802247598;6242.282137554058;6252.906206406817;6268.185135932482;6206.224221972254;6308.653024083719;6323.430891219812;6338.524610654312;6339.4928405726505;5205;6237.625742455467;6250.749970001149;6274.309825919237;6292.182016337847;6268.305804060658;6285.811425657238;6300.873982520416;6302.243730752339;6306.085617585332;6085.69571521431;6131.407250743203;6145.600535965148;6189.133521306931;6242.812715618538 16:38:18 INFO - PID 1634 | |1;ext.html;790.3242727468015;803.465695312617;1117.033765792589;1135.420935322985;1138.0042462845015;36286.27427451449;36675.083122921904;36988;37026.70406535772;37030;38623.80688096555;38805.80597097018;38932.41601375974;39018.41472377917;39046;5927.288725352963;6070.210872586557;8427.831443371144;8566.614502347378;8573.01410337813;8308.127646597111;8478.236958673719;8515.574221288942;8521.318294536453;8523.232909038185;8533.573321333939;8588.484690918534;8590.055093939662;8593;8594.87107693385;8495.532745699014;8557.957210213972;8558.015828179745;8560.914390856075;8563.186497282748;8400.243978041945;8451.619677114544;8457.53483558404;8462.61918213682;8463.111373305775;36183;36466.63533364685;36474.088147796254;36487.27025459476;36521;3574.3208790330013;3585.6235095315137;3596.748227624041;3599.2981368633127;3603.1352475405715;30179.547306790417;30238.84880575583;30259.94090206854;30294.242643933856;30331.696683033108;3144.8427578620976;3167.7465802735724;3190.361927614463;3201.183698156978;3201.3117179806222;220828;286032;286546.5672671644;286796.56601717067;287735;38948.2210355797;38986.6101338983;39056.02359941024;48058;48249.5175048245;38073.80963095222;39798.80100599537;48037.279440808416;48039.75980120077;48057.75971120192;13168.802467962989;13230.272335021666;13232.338383080807;13273.800892986614;13292.800607990888;10755.56977720898;10760.838587421194;10774.353538787698;10779.083777878968;10813.891861081289;12049.337286449154;12054.517819287306;12079;12102.515899363927;12183.147179697513;5121.897562048738;5125.513076257749;5132.230165475208;5134.306868572769;5137.614678899097;1008.1732978957331;1009.2682804966487;1011.8229309870743;1044.7440377107657;1057.1278695076592;21246.362609121752;22935.426614334774;24246.78694080781;24388.87805560961;24443.75556244415;1097.8243481042996;1098.9285696429706;1137.9829302560468;1138.6413279816832;1162.7441962768178;11586.88413115875;11787.587434439753;12378.257304561756;12383.318917459446;12396.75206495865;311898;312191;312458;312467;313421;50518.74740626274;50636.240456393185;50700.239496406844;50737.73155671138;50776.492235077916;1349.3927732520406;1473.8820894328428;1521.269790500588;1537.5233677559993;1537.7001484710374;21851.235206767687;23725.64411533794;23755.881220593787;23839.642405363586;23971.880140599187;36468;36586.45120323144;36607.26785464329;36632.45051324285;36736;293915;294223;294368;295087.5245623758;295590;28490.287742805765;28586.14241572756;32812.19532925712;32881.83559082285;33005;41218.58781412148;42013;42095.1580968385;42200.36699449449;42205;27673.446531068865;27976;28910;29364.11907642774;29792.255193620334;25628.743712562635;28746.281342966595;28902.566461502673;29566;30070.69929300679;35801.46297805587;35811.74658886927;35884.923452296476;35931.46102808408;36099.917002489965;28659.426811464073;29249.85375073111;29387.85306073456;30153;30225;20775.792242077387;21461.712297262213;21938.45153871166;23473.943672534435;23828.761712382653 16:38:18 INFO - PID 1634 | |2;jquery.html;387.9165979314447;426.62830624621284;434.86953913825846;441.81664609187186;451.9683622146449;17563.034033128188;21550.56898862022;22955.885220573873;23074.307770766904;23401.414964625892;22422.32733018012;22764.317070487912;23616.76383236167;23721.881390593066;24089.277321680333;5080.872978175556;5694.032014557535;5905.320888097859;6150.784722534723;6380.3300653431415;6223.346548612399;6364.172657554512;6364.268109167436;6367.4906007519285;6369.968150159266;6071.78748743794;6208.689565521729;6221.875562488747;6270.686465676721;6300.653464059475;6092.238470191226;6162.22972128484;6198.101275315076;6245.781397651083;6253.374662533733;5511.807086751945;5592.384837667853;5593.440655934414;5596.076647353182;5597.63615365;26823.597646035327;27813.582796258073;27833.16500504988;27840.860795696095;28166.577501337495;2217.323716266538;2271.0234599122373;2272.863628182314;2276.84062115652;2278.7493375728654;13543.932280338633;17654.91172544142;18155.27378904842;18529;18743.250269989185;2146.6565349544153;2193.243331050785;2228.721409823772;2230.241717815934;2234.2850287907877;145226.27386862997;145797;146536;147046;148839.2558037203;11093.611723589636;11705.122115841175;11984.280943143265;12505.687357816127;12592.370381480889;14222.669786452634;14596.927015364856;15052.021618594756;15096.773548396783;15102.697946041018;8710.21608055278;8784.121587841164;8823.470591764515;8848.336374771918;8970.506622135845;8345.582720863933;8353.498790072616;8515.787105322417;8523.829523409497;8559.443636163629;7593.734219302298;7689.461737678421;7748.883766743504;7813.921860781433;7821.843563128706;2152.4824998376107;2168.837337199685;2180.3835397523035;2184.421128400975;2212.889355532217;903.9300002993073;982.2338575910801;985.5614251657944;1027.8561001459802;1041.4480325427535;21112.683309750366;22016.77983220179;22034.44913877134;22084.779152208273;22105.77894221037;1007.8236308645958;1012.4128005756644;1029.6447725534829;1047.2145890582065;1048.7587854793287;10965;11226.691667782768;11256.986871181633;11261.43692815356;11268.15488838324;543888;551942;557589;559992;563393;132588;133795;136172;137894.31052844672;140460.59539404477;1171.1275100050348;1177.4877928101132;1201.0331682995097;1201.6274954763876;1204.7831390349645;17345.653086938444;18191.636167276843;18416.447506574823;18734.063296834833;18836.811631883505;55895;58085;58384.70807645935;59247.703761480916;59289.703551481965;63559.0466142999;81289;82190;82594;82626.58686706529;8606.719219406987;8663.826723465621;8820.735377938672;9166.954165229132;9223.44659320443;14292.285385730464;14369.928150359181;14444.638884027983;14504.995776457105;14903.552893413214;9976.900230997888;11902.880971190178;11984.880151198377;12251.142420030512;12386.442610082388;11422.600208992646;11565.959063683973;11640.708982275512;11824.940875295568;11908.52365905354;10479.95200479946;11956.58151964677;12112.878871211175;12510.249385036926;12626.810597841224;7347.8163045924275;8785.165409286108;8912.242459391024;8915;9053.818923621358;10450.634227801991;10714.357138571711;10793.244472886823;10894;10962.397068161328 16:38:18 INFO - PID 1634 | |3;mootools.html;1367.1045465220282;1429.5925661186564;1443.797868298438;1455.1341951538836;1458.7082583483307;11514.769704605913;12057.854503822124;12062.698432539191;12081.456334464949;12089.395530223486;11503.42482875857;11964.521419143246;11999;12004.45979930903;12030.759384812298;2540.3776074861685;2581.8838152283097;2587.676540432446;2590.5337039332912;2591.0931174089105;2121.427214652043;2422.0675040109595;2518.6347979542957;2569.550328692481;2573.7812285955715;2177;2202.922897698581;2464.2114523352534;2550.910718124866;2552.310876063462;2470.7776300133073;2490.452100537879;2503.0738626708053;2505.3235626380956;2506.448581312108;2515.00657240389;2524.0913271222344;2527.3049911274547;2528.026709716754;2529.152733834168;11844.28934263947;11942.462589183508;11978.401079945968;11984.262281969153;11995.16033877629;6509.316521765241;6755.594664320108;6759.15510561175;6766.25571187169;6767.42476889465;3886.7756656653064;4112.650424713903;4236.851710190129;4262.680298977589;4270.060586670958;1078.9352638841694;1268.3594784633792;1269.428757059327;1308.5420102963888;1314.5333406640696;16640.417585384454;16800.49598512059;16810.66378672432;16813;16824.411145609967;5391.541718953855;5469.535089517356;5593.300837395325;5697.088465845445;5721.628094173865;12507.874921250854;12525.812112818316;12531;12569.994400447942;12593.181443206162;6590.340965903371;6590.538662293689;6591;6592.011198320194;6599.505037122139;5982.282126144891;5990.73041713124;6018.909716354258;6114.633122012693;6243.219597550306;4266.573342665771;4380.255356589388;4383.956160438419;4444.6666500012625;4449.110177964355;1102.2174256278133;1276.049343239274;1299.2983788753968;1311.4557458654742;1320.0627554436458;659.8350412396901;676.2730065179853;761.9370977486376;773.4160708665034;785.1716439156744;5960.582759206901;6140.508759299245;6772.762953296709;6934.47991400647;7097.574145551283;580.1761498671896;584.1325631437312;586.7447660267712;598.064029793372;704.0706267726654;3379.5606571145595;3880.631340022693;4165.146145040259;4275.700700950903;4476.619487343547;14260.643483912985;15035.097894126387;15205.391784328724;15361.308741106677;15377.769333460006;14832.406703731946;15253.542393728207;15339;15461.690766184613;15480.225988700746;8531;8613.569321534023;8644.351673624504;8755.0807165248;8788.824223515494;6320.652364120017;6632.270450250372;6752.662366881538;6807.004917836136;6809.69356378974;13474.19154850712;13632;13800;14011.859881401055;14044.087134336236;13867.375968081662;14132.15207087578;14136;14201.147931123753;14413.639659008608;8878.334124940784;8886.555672216235;8999.280057595246;9009.27925765924;9013.909860901307;10893.618723344962;10918.78162436731;11025.393603351893;11040.668779936615;11054.170937179904;7088.751893683696;9205.76985575366;9255.86116208244;9322.813543728951;9360.48517331526;9124.908750912406;9184.908150918405;9218.585163667516;9237.12247336502;9312.8336365636;7730.458867879194;7908.802279942817;7966.92033079685;7973.561454120079;7981.122076571689;5521.199426083276;5630.155476678531;5667.943320566742;5672.716364181857;5793.797217097382;6049.969750151397;6142.341567776586;6163.96918015407;6169.074638804215;6262.561620686691 16:38:18 INFO - PID 1634 | |4;prototype.html;393.0782315470222;398.68503881933253;402.7053024526148;407.10843253275345;409.9979500102499;5868.178455016296;5894.705264736762;5933.406659334064;5950.49420799232;5972.148633923476;4622.745748983804;4713.670043096985;5486.969821166164;5680.034394152994;5738.43794183624;4444.355568442574;4445.355423463596;4463.620592249663;4469.687121901468;4492.079123779634;3655.9709361304467;4456.509783923766;4460.910781784362;4461.955380446203;4476.843310484133;3836.865709700161;3861.362875125615;4222.366645003243;4255.425517555122;4377.540358262384;4404.4054052702795;4405.713628614129;4409.074094440171;4409.801558929824;4434.179676759793;3915.8237879295502;3922.7450215735885;3925.2934471795065;3928.5285765708013;3934.272159650474;4379.474463064453;5633.662030257479;5686.260786097822;5717.714114294268;5741.569382296345;4608.976955115237;5336.91994620081;5345.305110335631;5346.866328341823;5350.197470379435;6203.534734894901;6217.285012223607;6218.378162183745;6237.688115594247;6253.812385628438;3553.6446355364515;3681.631836816324;3864.8840534784003;4032.8790136295665;4241.724287921275;6247.656378899159;6415;6421.325760795143;6504.284528701839;6604.174478190226;4199.454070970754;4267.743935363888;4278.422412974209;4280.058387154821;4291.721038132574;4162.500499939966;4328.480582330078;4368.825246990148;4370;4370.628496577827;4951.579115775127;4955.752212389366;5049.444561098277;5053.7220452875445;5061.8734531637;6183.690815459209;6187.566870319034;6190.226221722285;6196.721147548371;6207.317195108534;1409.6828213652052;1458.6936743283818;1466.8730341005585;1484.094702231638;1487.137460273039;911.4030310146865;968.7261251454315;970.6408628807245;988.8763904511936;993.8956409577034;5942.970285148633;5954.404559544011;5983.790567330123;6000.099985002197;6011;6401.167848179707;6403.711832967528;6410.083412047507;6458.192725909262;6458.61248325102;4932.926006109911;5852.752650811707;5927.1405646181065;5946.870094682083;5949.25634295713;2921.5617657351568;2934.3837794063484;3090.2188030772486;3319.369319829225;3358.8503357850996;6095.329513753483;6240.875182496416;6624.205095388585;6625.734970601122;6650.442013522742;5746.770129194869;6009.5961615353335;6393.392627700361;6564.934350656432;6593.044008618724;5783.595148339576;5790.565707571949;5955.642661440327;6630.602163870087;6636.568623039487;5201.349831271091;5814.592978491465;6380.117865229676;6380.457661098859;6403.103565500741;6027.246594175728;6305.779297724741;6315.336889626523;6322.462590679844;6332.778352757631;6258.405451482102;6478.805635830932;6481.287058423664;6642.236142843635;6722.529422940543;3795.0132965428634;4074.7351422157467;4666.78999445019;4717.693349932243;4745.0509898019845;4969.0807200668;5438.592105592017;5758.452946970031;5765.5675824314185;6191.535634827316;6264.686765661608;6269.153664255267;6269.341719119427;6269.3417191196095;6301.149344838388;5465.6447330923365;5908.231929849092;6282.937170628235;6294.527910406646;6301.527385446018;4887.828925987574;5493.148561972901;6093.969530152321;6127.111568822585;6171.444569988723;5054.21659642756;5863.853403664772;6280;6294.402031806971;6309.469698861656;4743.715377077387;4996.7534089205465;6052.576319657582;6105.419985101408;6110.511159107172 16:38:18 INFO - PID 1634 | |5;yui.html;710.651780627492;860.1613426908765;860.3719284922007;860.6084231674585;880.6389380354054;12295.63113106606;12782.872171278274;12910.160839545422;15433.228338583081;15491.302891369887;14632.12207267562;16270.83729162708;17543.73684394735;17850.464486065437;18077.728834067468;972.4602845420789;986.0287616697548;987.9407235565853;988.6045581767279;993.6373223773306;654.947604191666;670.8926571748522;938.5494962418044;959.7120863740885;971.8833739951216;1027.8047171037517;1028.1928685981507;1028.4806172882684;1029.3000759483548;1037.9273450858443;1022.396785896321;1023.0741179232806;1023.8617786598788;1024.51335615582;1030.3302853145478;756.451572609859;759.8784194528904;762.1349768013289;763.6372722956606;765.586583245047;16002.519924402286;16258.75611865823;16415.179241037902;16425.83574164255;16738.83261167385;16632.168391580373;16689.91655041717;16842.663146736995;17076.2315695794;17133.657326853518;13781.724365512633;13797.724045519133;13902.930485347508;14006.719865602732;14077.225752583603;3463.5843698756057;3486.4944583035317;3487.319972605343;3490.912727181815;3492.860285588599;124714;125896;125934;126677.36661316727;127844;12010.579629713093;12202.633920982385;13089.214647121204;13265.204087754766;13443.395047222899;25313.62029569558;25353.366165846;25902.352441188745;26329.341766455993;26349.47301053968;6613.801585952429;7494.21310762373;7623.085229772463;7779.7666070017995;7884.053913530413;3787.8484860605818;3848.615138486185;3856.3444214483607;3865.3042452358845;3868.0716628009077;4263.5096963849555;4289.871303860889;4332.6317263033;4362.280223763107;4433.091216300651;936.5832204668857;959.6305422412421;960.7934294126796;964.320154291223;964.5611246882652;631.8294060603612;659.4823063894916;664.3190729502298;675.2302375292171;697.9616121113286;9669;11159.549258596331;11276.210665253353;11564;11650.41747912601;662.6852245183595;662.7382184037278;669.926308106108;683.1938312790954;695.9860802783916;5349.625526213128;5547.916781248285;5569.164625306236;5617.634853734494;5633.464820842096;102543.4872825631;103621;105732.94267057232;107665;108266;94025.5298723502;94679.52660236655;97954;98476.52285215727;98847.50576247073;59447.77145590202;69826.30173698299;76179.61910190525;80800;80834;9457.716268511957;12576.685582860136;12680.873191267969;12703.110782245154;12709.428075736429;38426.23147536978;39341.40987885127;39655.80172099121;40392.99017524585;42429;67597;68721;69333.65333173302;69444;69687.6515617439;16210.918945405198;16892;16924.407645732834;16968.575785604964;16998.660026799644;18072.186751595946;18111.547211319823;18124.184411701768;18672.15975281143;18694.439166825017;16751.832481675516;17151.656966860843;17356.91321543384;17391;17724.822751772834;16869.578260543094;17082.572935676708;17143.485695429157;17342.30630774755;17457;13767.173969561858;16722;16943.32226710918;16974.830251697324;17168.74246886273;11473.4263286837;11527.596534121265;11888.108391870472;12009.339486327986;12022.27866328023;12262;12595.370231488205;12616;12628.242305461701;12889.033322501038 16:38:18 INFO - PID 1634 | __end_tp_report 16:38:18 INFO - PID 1634 | __start_cc_report 16:38:18 INFO - PID 1634 | _x_x_mozilla_cycle_collect,2198 16:38:18 INFO - PID 1634 | __end_cc_report 16:38:18 INFO - PID 1634 | __startTimestamp1492731498429__endTimestamp 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | ------- Summary: start ------- 16:38:18 INFO - PID 1634 | Number of tests: 6 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | [#0] dojo.html Cycles:165 Average:5906.66 Median:6216.72 stddev:676.33 (10.9%) stddev-sans-first:650.32 16:38:18 INFO - PID 1634 | Values: 3447.8 3466.9 3472.1 3484.0 3512.3 6047.5 6071.5 6072.9 6098.4 6101.4 4853.3 6041.1 6072.6 6087.9 6095.8 4781.9 5095.9 5285.4 5314.3 5323.7 5169.6 5336.9 5344.4 5373.6 5391.6 5237.7 5250.2 5294.6 5337.7 5360.2 5233.3 5264.0 5265.2 5301.7 5346.7 5241.9 5256.3 5275.9 5294.5 5311.3 5813.6 5848.9 5904.4 6047.3 6047.7 6319.9 6335.9 6336.1 6355.9 6357.9 6434.5 6439.0 6439.9 6452.2 6454.5 5053.7 5997.8 6087.9 6099.3 6137.9 5229.8 5496.4 6569.5 6584.9 6598.7 6293.9 6307.9 6325.8 6327.1 6329.8 6366.4 6456.5 6473.9 6480.4 6482.8 5612.5 6296.9 6303.9 6320.8 6330.9 6344.7 6349.5 6360.1 6371.9 6394.9 5190.7 5209.3 5217.2 5223.1 5243.9 4585.9 4596.3 4657.8 4680.8 4730.5 6070.3 6075.7 6080.1 6089.8 6097.4 6288.5 6421.1 6457.4 6492.5 6500.2 6160.6 6216.7 6222.4 6223.4 6229.6 5688.3 5692.3 5698.4 5701.3 5733.8 5401.2 6399.1 6484.0 6487.7 6494.1 6328.5 6329.9 6420.0 6437.4 6506.2 6703.5 6709.4 6710.5 6711.7 6725.6 6326.1 6336.3 6337.7 6344.9 6362.7 5300.8 6302.1 6363.7 6370.1 6380.9 6226.3 6237.1 6242.3 6252.9 6268.2 6206.2 6308.7 6323.4 6338.5 6339.5 5205.0 6237.6 6250.7 6274.3 6292.2 6268.3 6285.8 6300.9 6302.2 6306.1 6085.7 6131.4 6145.6 6189.1 6242.8 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | [#1] ext.html Cycles:180 Average:43577.28 Median:3156.29 stddev:77246.77 (2447.4%) stddev-sans-first:77396.67 16:38:18 INFO - PID 1634 | Values: 790.3 803.5 1117.0 1135.4 1138.0 36286.3 36675.1 36988.0 37026.7 37030.0 38623.8 38805.8 38932.4 39018.4 39046.0 5927.3 6070.2 8427.8 8566.6 8573.0 8308.1 8478.2 8515.6 8521.3 8523.2 8533.6 8588.5 8590.1 8593.0 8594.9 8495.5 8558.0 8558.0 8560.9 8563.2 8400.2 8451.6 8457.5 8462.6 8463.1 36183.0 36466.6 36474.1 36487.3 36521.0 3574.3 3585.6 3596.7 3599.3 3603.1 30179.5 30238.8 30259.9 30294.2 30331.7 3144.8 3167.7 3190.4 3201.2 3201.3 220828.0 286032.0 286546.6 286796.6 287735.0 38948.2 38986.6 39056.0 48058.0 48249.5 38073.8 39798.8 48037.3 48039.8 48057.8 13168.8 13230.3 13232.3 13273.8 13292.8 10755.6 10760.8 10774.4 10779.1 10813.9 12049.3 12054.5 12079.0 12102.5 12183.1 5121.9 5125.5 5132.2 5134.3 5137.6 1008.2 1009.3 1011.8 1044.7 1057.1 21246.4 22935.4 24246.8 24388.9 24443.8 1097.8 1098.9 1138.0 1138.6 1162.7 11586.9 11787.6 12378.3 12383.3 12396.8 311898.0 312191.0 312458.0 312467.0 313421.0 50518.7 50636.2 50700.2 50737.7 50776.5 1349.4 1473.9 1521.3 1537.5 1537.7 21851.2 23725.6 23755.9 23839.6 23971.9 36468.0 36586.5 36607.3 36632.5 36736.0 293915.0 294223.0 294368.0 295087.5 295590.0 28490.3 28586.1 32812.2 32881.8 33005.0 41218.6 42013.0 42095.2 42200.4 42205.0 27673.4 27976.0 28910.0 29364.1 29792.3 25628.7 28746.3 28902.6 29566.0 30070.7 35801.5 35811.7 35884.9 35931.5 36099.9 28659.4 29249.9 29387.9 30153.0 30225.0 20775.8 21461.7 21938.5 23473.9 23828.8 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | [#2] jquery.html Cycles:180 Average:35739.58 Median:2271.94 stddev:94078.85 (4140.9%) stddev-sans-first:94305.32 16:38:18 INFO - PID 1634 | Values: 387.9 426.6 434.9 441.8 452.0 17563.0 21550.6 22955.9 23074.3 23401.4 22422.3 22764.3 23616.8 23721.9 24089.3 5080.9 5694.0 5905.3 6150.8 6380.3 6223.3 6364.2 6364.3 6367.5 6370.0 6071.8 6208.7 6221.9 6270.7 6300.7 6092.2 6162.2 6198.1 6245.8 6253.4 5511.8 5592.4 5593.4 5596.1 5597.6 26823.6 27813.6 27833.2 27840.9 28166.6 2217.3 2271.0 2272.9 2276.8 2278.7 13543.9 17654.9 18155.3 18529.0 18743.3 2146.7 2193.2 2228.7 2230.2 2234.3 145226.3 145797.0 146536.0 147046.0 148839.3 11093.6 11705.1 11984.3 12505.7 12592.4 14222.7 14596.9 15052.0 15096.8 15102.7 8710.2 8784.1 8823.5 8848.3 8970.5 8345.6 8353.5 8515.8 8523.8 8559.4 7593.7 7689.5 7748.9 7813.9 7821.8 2152.5 2168.8 2180.4 2184.4 2212.9 903.9 982.2 985.6 1027.9 1041.4 21112.7 22016.8 22034.4 22084.8 22105.8 1007.8 1012.4 1029.6 1047.2 1048.8 10965.0 11226.7 11257.0 11261.4 11268.2 543888.0 551942.0 557589.0 559992.0 563393.0 132588.0 133795.0 136172.0 137894.3 140460.6 1171.1 1177.5 1201.0 1201.6 1204.8 17345.7 18191.6 18416.4 18734.1 18836.8 55895.0 58085.0 58384.7 59247.7 59289.7 63559.0 81289.0 82190.0 82594.0 82626.6 8606.7 8663.8 8820.7 9167.0 9223.4 14292.3 14369.9 14444.6 14505.0 14903.6 9976.9 11902.9 11984.9 12251.1 12386.4 11422.6 11566.0 11640.7 11824.9 11908.5 10480.0 11956.6 12112.9 12510.2 12626.8 7347.8 8785.2 8912.2 8915.0 9053.8 10450.6 10714.4 10793.2 10894.0 10962.4 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | [#3] mootools.html Cycles:180 Average:7174.38 Median:3630.10 stddev:4640.70 (127.8%) stddev-sans-first:4633.20 16:38:18 INFO - PID 1634 | Values: 1367.1 1429.6 1443.8 1455.1 1458.7 11514.8 12057.9 12062.7 12081.5 12089.4 11503.4 11964.5 11999.0 12004.5 12030.8 2540.4 2581.9 2587.7 2590.5 2591.1 2121.4 2422.1 2518.6 2569.6 2573.8 2177.0 2202.9 2464.2 2550.9 2552.3 2470.8 2490.5 2503.1 2505.3 2506.4 2515.0 2524.1 2527.3 2528.0 2529.2 11844.3 11942.5 11978.4 11984.3 11995.2 6509.3 6755.6 6759.2 6766.3 6767.4 3886.8 4112.7 4236.9 4262.7 4270.1 1078.9 1268.4 1269.4 1308.5 1314.5 16640.4 16800.5 16810.7 16813.0 16824.4 5391.5 5469.5 5593.3 5697.1 5721.6 12507.9 12525.8 12531.0 12570.0 12593.2 6590.3 6590.5 6591.0 6592.0 6599.5 5982.3 5990.7 6018.9 6114.6 6243.2 4266.6 4380.3 4384.0 4444.7 4449.1 1102.2 1276.0 1299.3 1311.5 1320.1 659.8 676.3 761.9 773.4 785.2 5960.6 6140.5 6772.8 6934.5 7097.6 580.2 584.1 586.7 598.1 704.1 3379.6 3880.6 4165.1 4275.7 4476.6 14260.6 15035.1 15205.4 15361.3 15377.8 14832.4 15253.5 15339.0 15461.7 15480.2 8531.0 8613.6 8644.4 8755.1 8788.8 6320.7 6632.3 6752.7 6807.0 6809.7 13474.2 13632.0 13800.0 14011.9 14044.1 13867.4 14132.2 14136.0 14201.1 14413.6 8878.3 8886.6 8999.3 9009.3 9013.9 10893.6 10918.8 11025.4 11040.7 11054.2 7088.8 9205.8 9255.9 9322.8 9360.5 9124.9 9184.9 9218.6 9237.1 9312.8 7730.5 7908.8 7966.9 7973.6 7981.1 5521.2 5630.2 5667.9 5672.7 5793.8 6050.0 6142.3 6164.0 6169.1 6262.6 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | [#4] prototype.html Cycles:180 Average:5021.57 Median:5752.61 stddev:1555.51 (27.0%) stddev-sans-first:1520.58 16:38:18 INFO - PID 1634 | Values: 393.1 398.7 402.7 407.1 410.0 5868.2 5894.7 5933.4 5950.5 5972.1 4622.7 4713.7 5487.0 5680.0 5738.4 4444.4 4445.4 4463.6 4469.7 4492.1 3656.0 4456.5 4460.9 4462.0 4476.8 3836.9 3861.4 4222.4 4255.4 4377.5 4404.4 4405.7 4409.1 4409.8 4434.2 3915.8 3922.7 3925.3 3928.5 3934.3 4379.5 5633.7 5686.3 5717.7 5741.6 4609.0 5336.9 5345.3 5346.9 5350.2 6203.5 6217.3 6218.4 6237.7 6253.8 3553.6 3681.6 3864.9 4032.9 4241.7 6247.7 6415.0 6421.3 6504.3 6604.2 4199.5 4267.7 4278.4 4280.1 4291.7 4162.5 4328.5 4368.8 4370.0 4370.6 4951.6 4955.8 5049.4 5053.7 5061.9 6183.7 6187.6 6190.2 6196.7 6207.3 1409.7 1458.7 1466.9 1484.1 1487.1 911.4 968.7 970.6 988.9 993.9 5943.0 5954.4 5983.8 6000.1 6011.0 6401.2 6403.7 6410.1 6458.2 6458.6 4932.9 5852.8 5927.1 5946.9 5949.3 2921.6 2934.4 3090.2 3319.4 3358.9 6095.3 6240.9 6624.2 6625.7 6650.4 5746.8 6009.6 6393.4 6564.9 6593.0 5783.6 5790.6 5955.6 6630.6 6636.6 5201.3 5814.6 6380.1 6380.5 6403.1 6027.2 6305.8 6315.3 6322.5 6332.8 6258.4 6478.8 6481.3 6642.2 6722.5 3795.0 4074.7 4666.8 4717.7 4745.1 4969.1 5438.6 5758.5 5765.6 6191.5 6264.7 6269.2 6269.3 6269.3 6301.1 5465.6 5908.2 6282.9 6294.5 6301.5 4887.8 5493.1 6094.0 6127.1 6171.4 5054.2 5863.9 6280.0 6294.4 6309.5 4743.7 4996.8 6052.6 6105.4 6110.5 16:38:18 INFO - PID 1634 | 16:38:18 INFO - PID 1634 | [#5] yui.html Cycles:180 Average:22036.16 Median:18398.17 stddev:31281.96 (170.0%) stddev-sans-first:31328.73 16:38:18 INFO - PID 1634 | Values: 710.7 860.2 860.4 860.6 880.6 12295.6 12782.9 12910.2 15433.2 15491.3 14632.1 16270.8 17543.7 17850.5 18077.7 972.5 986.0 987.9 988.6 993.6 654.9 670.9 938.5 959.7 971.9 1027.8 1028.2 1028.5 1029.3 1037.9 1022.4 1023.1 1023.9 1024.5 1030.3 756.5 759.9 762.1 763.6 765.6 16002.5 16258.8 16415.2 16425.8 16738.8 16632.2 16689.9 16842.7 17076.2 17133.7 13781.7 13797.7 13902.9 14006.7 14077.2 3463.6 3486.5 3487.3 3490.9 3492.9 124714.0 125896.0 125934.0 126677.4 127844.0 12010.6 12202.6 13089.2 13265.2 13443.4 25313.6 25353.4 25902.4 26329.3 26349.5 6613.8 7494.2 7623.1 7779.8 7884.1 3787.8 3848.6 3856.3 3865.3 3868.1 4263.5 4289.9 4332.6 4362.3 4433.1 936.6 959.6 960.8 964.3 964.6 631.8 659.5 664.3 675.2 698.0 9669.0 11159.5 11276.2 11564.0 11650.4 662.7 662.7 669.9 683.2 696.0 5349.6 5547.9 5569.2 5617.6 5633.5 102543.5 103621.0 105732.9 107665.0 108266.0 94025.5 94679.5 97954.0 98476.5 98847.5 59447.8 69826.3 76179.6 80800.0 80834.0 9457.7 12576.7 12680.9 12703.1 12709.4 38426.2 39341.4 39655.8 40393.0 42429.0 67597.0 68721.0 69333.7 69444.0 69687.7 16210.9 16892.0 16924.4 16968.6 16998.7 18072.2 18111.5 18124.2 18672.2 18694.4 16751.8 17151.7 17356.9 17391.0 17724.8 16869.6 17082.6 17143.5 17342.3 17457.0 13767.2 16722.0 16943.3 16974.8 17168.7 11473.4 11527.6 11888.1 12009.3 12022.3 12262.0 12595.4 12616.0 12628.2 12889.0 16:38:18 INFO - PID 1634 | -------- Summary: end -------- 16:38:18 INFO - PID 1634 | 16:38:19 INFO - TEST-INFO | 1634: exit 0 16:38:19 INFO - TEST-OK | dromaeo_css | took 1118568ms 16:38:19 INFO - TEST-START | kraken 16:38:19 INFO - operating with platform_type : mac_ 16:38:19 INFO - Initialising browser for kraken test... 16:38:19 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpVvgOmZ/profile http://localhost:49241/getInfo.html) 16:38:21 INFO - PID 1644 | __metrics Screen width/height:1600/1200 16:38:21 INFO - PID 1644 | colorDepth:24 16:38:21 INFO - PID 1644 | Browser inner width/height: 1024/689 16:38:21 INFO - PID 1644 | __metrics 16:38:21 INFO - PID 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:38:21 INFO - PID 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:22 INFO - TEST-INFO | 1644: exit 0 16:38:22 INFO - Browser initialized. 16:38:22 INFO - Running cycle 1/1 for kraken test... 16:38:22 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpVvgOmZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:35 INFO - PID 1645 | RSS: Main: 241373184 16:38:35 INFO - PID 1645 | 16:38:37 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:38 INFO - PID 1645 | RSS: Main: 312066048 16:38:38 INFO - PID 1645 | 16:38:41 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 16:38:42 INFO - PID 1645 | RSS: Main: 293957632 16:38:42 INFO - PID 1645 | 16:38:45 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 16:38:45 INFO - PID 1645 | RSS: Main: 387964928 16:38:45 INFO - PID 1645 | 16:38:47 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 16:38:48 INFO - PID 1645 | RSS: Main: 290668544 16:38:48 INFO - PID 1645 | 16:38:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:51 INFO - PID 1645 | RSS: Main: 292745216 16:38:51 INFO - PID 1645 | 16:38:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:54 INFO - PID 1645 | RSS: Main: 357392384 16:38:54 INFO - PID 1645 | 16:38:57 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:58 INFO - PID 1645 | RSS: Main: 382279680 16:38:58 INFO - PID 1645 | 16:39:00 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 16:39:01 INFO - PID 1645 | RSS: Main: 398163968 16:39:01 INFO - PID 1645 | 16:39:02 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:03 INFO - PID 1645 | RSS: Main: 332292096 16:39:03 INFO - PID 1645 | 16:39:05 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:05 INFO - PID 1645 | RSS: Main: 333926400 16:39:05 INFO - PID 1645 | 16:39:08 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:08 INFO - PID 1645 | RSS: Main: 336121856 16:39:08 INFO - PID 1645 | 16:39:11 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:12 INFO - PID 1645 | RSS: Main: 350670848 16:39:12 INFO - PID 1645 | 16:39:15 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:16 INFO - PID 1645 | RSS: Main: 343334912 16:39:16 INFO - PID 1645 | 16:39:17 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 16:39:18 INFO - PID 1645 | RSS: Main: 386220032 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | __start_tp_report 16:39:18 INFO - PID 1645 | _x_x_mozilla_page_load 16:39:18 INFO - PID 1645 | _x_x_mozilla_page_load_details 16:39:18 INFO - PID 1645 | |i|pagename|runs| 16:39:18 INFO - PID 1645 | |0;ai-astar;113;112;112;112;112;113;111;110;111;111 16:39:18 INFO - PID 1645 | |1;audio-beat-detection;171;142;112;153;111;107;107;142;140;95 16:39:18 INFO - PID 1645 | |2;audio-dft;188;185;184;187;187;184;184;187;181;183 16:39:18 INFO - PID 1645 | |3;audio-fft;81;59;58;88;59;59;57;58;80;58 16:39:18 INFO - PID 1645 | |4;audio-oscillator;95;70;87;69;70;67;89;68;69;90 16:39:18 INFO - PID 1645 | |5;imaging-gaussian-blur;89;88;89;88;89;88;89;89;89;89 16:39:18 INFO - PID 1645 | |6;imaging-darkroom;95;96;98;96;95;96;96;96;95;96 16:39:18 INFO - PID 1645 | |7;imaging-desaturate;86;86;87;86;85;83;86;86;87;86 16:39:18 INFO - PID 1645 | |8;json-parse-financial;50;48;47;48;47;47;47;48;47;47 16:39:18 INFO - PID 1645 | |9;json-stringify-tinderbox;52;58;56;67;61;59;57;55;57;57 16:39:18 INFO - PID 1645 | |10;stanford-crypto-aes;81;84;83;83;81;83;82;82;82;82 16:39:18 INFO - PID 1645 | |11;stanford-crypto-ccm;139;138;142;144;148;134;141;155;202;151 16:39:18 INFO - PID 1645 | |12;stanford-crypto-pbkdf2;177;188;215;173;214;203;183;186;181;186 16:39:18 INFO - PID 1645 | |13;stanford-crypto-sha256-iterative;68;68;67;66;67;67;68;67;68;67 16:39:18 INFO - PID 1645 | __end_tp_report 16:39:18 INFO - PID 1645 | __start_cc_report 16:39:18 INFO - PID 1645 | _x_x_mozilla_cycle_collect,2219 16:39:18 INFO - PID 1645 | __end_cc_report 16:39:18 INFO - PID 1645 | __startTimestamp1492731558176__endTimestamp 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | ------- Summary: start ------- 16:39:18 INFO - PID 1645 | Number of tests: 14 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.95 (0.8%) stddev-sans-first:0.88 16:39:18 INFO - PID 1645 | Values: 113.0 112.0 112.0 112.0 112.0 113.0 111.0 110.0 111.0 111.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:142.00 stddev:24.78 (17.5%) stddev-sans-first:20.83 16:39:18 INFO - PID 1645 | Values: 171.0 142.0 112.0 153.0 111.0 107.0 107.0 142.0 140.0 95.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:2.21 (1.2%) stddev-sans-first:2.06 16:39:18 INFO - PID 1645 | Values: 188.0 185.0 184.0 187.0 187.0 184.0 184.0 187.0 181.0 183.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.00 stddev:12.13 (20.6%) stddev-sans-first:11.53 16:39:18 INFO - PID 1645 | Values: 81.0 59.0 58.0 88.0 59.0 59.0 57.0 58.0 80.0 58.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.50 stddev:11.27 (14.4%) stddev-sans-first:9.99 16:39:18 INFO - PID 1645 | Values: 95.0 70.0 87.0 69.0 70.0 67.0 89.0 68.0 69.0 90.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:39:18 INFO - PID 1645 | Values: 89.0 88.0 89.0 88.0 89.0 88.0 89.0 89.0 89.0 89.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 16:39:18 INFO - PID 1645 | Values: 95.0 96.0 98.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.20 16:39:18 INFO - PID 1645 | Values: 86.0 86.0 87.0 86.0 85.0 83.0 86.0 86.0 87.0 86.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:47.50 stddev:0.97 (2.0%) stddev-sans-first:0.50 16:39:18 INFO - PID 1645 | Values: 50.0 48.0 47.0 48.0 47.0 47.0 47.0 48.0 47.0 47.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:57.50 stddev:3.98 (6.9%) stddev-sans-first:3.61 16:39:18 INFO - PID 1645 | Values: 52.0 58.0 56.0 67.0 61.0 59.0 57.0 55.0 57.0 57.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.95 (1.1%) stddev-sans-first:0.88 16:39:18 INFO - PID 1645 | Values: 81.0 84.0 83.0 83.0 81.0 83.0 82.0 82.0 82.0 82.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:146.00 stddev:19.53 (13.4%) stddev-sans-first:20.35 16:39:18 INFO - PID 1645 | Values: 139.0 138.0 142.0 144.0 148.0 134.0 141.0 155.0 202.0 151.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:187.00 stddev:14.87 (8.0%) stddev-sans-first:14.94 16:39:18 INFO - PID 1645 | Values: 177.0 188.0 215.0 173.0 214.0 203.0 183.0 186.0 181.0 186.0 16:39:18 INFO - PID 1645 | 16:39:18 INFO - PID 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:39:18 INFO - PID 1645 | Values: 68.0 68.0 67.0 66.0 67.0 67.0 68.0 67.0 68.0 67.0 16:39:18 INFO - PID 1645 | -------- Summary: end -------- 16:39:18 INFO - PID 1645 | 16:39:19 INFO - TEST-INFO | 1645: exit 0 16:39:19 INFO - TEST-OK | kraken | took 60141ms 16:39:19 INFO - SUITE-END | took 1178s 16:39:19 INFO - Completed test suite (00:19:38) 16:39:19 INFO - javascript benchmark 16:39:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7701.636018722701, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3447.7758945668547, 3466.947995780063, 3472.0972547137753, 3484.0418884806677, 3512.3326567952085, 6047.516198704104, 6071.483923866476, 6072.908906366402, 6098.401972603836, 6101.35935726749, 4853.272009198622, 6041.093835924603, 6072.574919755608, 6087.939120608793, 6095.847603809907, 4781.880452988686, 5095.923561146586, 5285.445028272034, 5314.282571852808, 5323.733813309338, 5169.56058735008, 5336.866578335534, 5344.412114667383, 5373.596980226479, 5391.649542779726, 5237.711925844096, 5250.238715386247, 5294.6029047821185, 5337.733113344318, 5360.249565060894, 5233.345831771028, 5263.973680131613, 5265.157574788054, 5301.681899086028, 5346.705931173784, 5241.947580524184, 5256.342957130359, 5275.920861187085, 5294.49702278283, 5311.282976798121, 5813.563982701315, 5848.853778655525, 5904.439078287556, 6047.274327080779, 6047.697615119227, 6319.8736025279695, 6335.936640633627, 6336.144620476222, 6355.87288254237, 6357.904631430486, 6434.4852411807415, 6439.0, 6439.93560064398, 6452.193475815523, 6454.451371633417, 5053.722045287471, 5997.790077347272, 6087.9391206087375, 6099.298580663191, 6137.877242455171, 5229.843104706865, 5496.422875598085, 6569.474442044625, 6584.913489274312, 6598.670066496656, 6293.937060629427, 6307.905381419282, 6325.810225693236, 6327.145835312174, 6329.778457753957, 6366.363363663597, 6456.483481321483, 6473.935260647428, 6480.384363485461, 6482.837929051717, 5612.494875461147, 6296.874062518724, 6303.873922521524, 6320.841978950563, 6330.905036424458, 6344.746210151542, 6349.46029587481, 6360.14138091361, 6371.904421433682, 6394.936050639434, 5190.714510701872, 5209.348831396075, 5217.165253559412, 5223.138182199895, 5243.9213411798855, 4585.908281834411, 4596.287575425815, 4657.836975705834, 4680.789364478606, 4730.52694730531, 6070.271567411939, 6075.665838378844, 6080.087986802015, 6089.817305480843, 6097.420745029215, 6288.5283603728985, 6421.101045853584, 6457.418832305021, 6492.480601551864, 6500.219973603198, 6160.630362178284, 6216.720247588869, 6222.439980401786, 6223.37766223374, 6229.626222426669, 5688.260526131577, 5692.345380281321, 5698.430156984268, 5701.258836351248, 5733.77064917407, 5401.2168235606405, 6399.104125422445, 6483.967580162069, 6487.708053137526, 6494.123293355431, 6328.525360598066, 6329.873402531832, 6419.967900160656, 6437.420632143129, 6506.219253689587, 6703.463722902254, 6709.36261055199, 6710.496712746466, 6711.664416779239, 6725.630090345078, 6326.145970294136, 6336.3030066693545, 6337.7148028337915, 6344.873102537831, 6362.681865906594, 5300.840974770763, 6302.117703521419, 6363.745450181941, 6370.140031095928, 6380.87238255223, 6226.315105338319, 6237.126802247598, 6242.282137554058, 6252.906206406817, 6268.185135932482, 6206.224221972254, 6308.653024083719, 6323.430891219812, 6338.524610654312, 6339.4928405726505, 5205.0, 6237.625742455467, 6250.749970001149, 6274.309825919237, 6292.182016337847, 6268.305804060658, 6285.811425657238, 6300.873982520416, 6302.243730752339, 6306.085617585332, 6085.69571521431, 6131.407250743203, 6145.600535965148, 6189.133521306931, 6242.812715618538], "value": 5865.302763242429, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.3242727468015, 803.465695312617, 1117.033765792589, 1135.420935322985, 1138.0042462845015, 36286.27427451449, 36675.083122921904, 36988.0, 37026.70406535772, 37030.0, 38623.80688096555, 38805.80597097018, 38932.41601375974, 39018.41472377917, 39046.0, 5927.288725352963, 6070.210872586557, 8427.831443371144, 8566.614502347378, 8573.01410337813, 8308.127646597111, 8478.236958673719, 8515.574221288942, 8521.318294536453, 8523.232909038185, 8533.573321333939, 8588.484690918534, 8590.055093939662, 8593.0, 8594.87107693385, 8495.532745699014, 8557.957210213972, 8558.015828179745, 8560.914390856075, 8563.186497282748, 8400.243978041945, 8451.619677114544, 8457.53483558404, 8462.61918213682, 8463.111373305775, 36183.0, 36466.63533364685, 36474.088147796254, 36487.27025459476, 36521.0, 3574.3208790330013, 3585.6235095315137, 3596.748227624041, 3599.2981368633127, 3603.1352475405715, 30179.547306790417, 30238.84880575583, 30259.94090206854, 30294.242643933856, 30331.696683033108, 3144.8427578620976, 3167.7465802735724, 3190.361927614463, 3201.183698156978, 3201.3117179806222, 220828.0, 286032.0, 286546.5672671644, 286796.56601717067, 287735.0, 38948.2210355797, 38986.6101338983, 39056.02359941024, 48058.0, 48249.5175048245, 38073.80963095222, 39798.80100599537, 48037.279440808416, 48039.75980120077, 48057.75971120192, 13168.802467962989, 13230.272335021666, 13232.338383080807, 13273.800892986614, 13292.800607990888, 10755.56977720898, 10760.838587421194, 10774.353538787698, 10779.083777878968, 10813.891861081289, 12049.337286449154, 12054.517819287306, 12079.0, 12102.515899363927, 12183.147179697513, 5121.897562048738, 5125.513076257749, 5132.230165475208, 5134.306868572769, 5137.614678899097, 1008.1732978957331, 1009.2682804966487, 1011.8229309870743, 1044.7440377107657, 1057.1278695076592, 21246.362609121752, 22935.426614334774, 24246.78694080781, 24388.87805560961, 24443.75556244415, 1097.8243481042996, 1098.9285696429706, 1137.9829302560468, 1138.6413279816832, 1162.7441962768178, 11586.88413115875, 11787.587434439753, 12378.257304561756, 12383.318917459446, 12396.75206495865, 311898.0, 312191.0, 312458.0, 312467.0, 313421.0, 50518.74740626274, 50636.240456393185, 50700.239496406844, 50737.73155671138, 50776.492235077916, 1349.3927732520406, 1473.8820894328428, 1521.269790500588, 1537.5233677559993, 1537.7001484710374, 21851.235206767687, 23725.64411533794, 23755.881220593787, 23839.642405363586, 23971.880140599187, 36468.0, 36586.45120323144, 36607.26785464329, 36632.45051324285, 36736.0, 293915.0, 294223.0, 294368.0, 295087.5245623758, 295590.0, 28490.287742805765, 28586.14241572756, 32812.19532925712, 32881.83559082285, 33005.0, 41218.58781412148, 42013.0, 42095.1580968385, 42200.36699449449, 42205.0, 27673.446531068865, 27976.0, 28910.0, 29364.11907642774, 29792.255193620334, 25628.743712562635, 28746.281342966595, 28902.566461502673, 29566.0, 30070.69929300679, 35801.46297805587, 35811.74658886927, 35884.923452296476, 35931.46102808408, 36099.917002489965, 28659.426811464073, 29249.85375073111, 29387.85306073456, 30153.0, 30225.0, 20775.792242077387, 21461.712297262213, 21938.45153871166, 23473.943672534435, 23828.761712382653], "value": 16904.38931536195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.9165979314447, 426.62830624621284, 434.86953913825846, 441.81664609187186, 451.9683622146449, 17563.034033128188, 21550.56898862022, 22955.885220573873, 23074.307770766904, 23401.414964625892, 22422.32733018012, 22764.317070487912, 23616.76383236167, 23721.881390593066, 24089.277321680333, 5080.872978175556, 5694.032014557535, 5905.320888097859, 6150.784722534723, 6380.3300653431415, 6223.346548612399, 6364.172657554512, 6364.268109167436, 6367.4906007519285, 6369.968150159266, 6071.78748743794, 6208.689565521729, 6221.875562488747, 6270.686465676721, 6300.653464059475, 6092.238470191226, 6162.22972128484, 6198.101275315076, 6245.781397651083, 6253.374662533733, 5511.807086751945, 5592.384837667853, 5593.440655934414, 5596.076647353182, 5597.63615365, 26823.597646035327, 27813.582796258073, 27833.16500504988, 27840.860795696095, 28166.577501337495, 2217.323716266538, 2271.0234599122373, 2272.863628182314, 2276.84062115652, 2278.7493375728654, 13543.932280338633, 17654.91172544142, 18155.27378904842, 18529.0, 18743.250269989185, 2146.6565349544153, 2193.243331050785, 2228.721409823772, 2230.241717815934, 2234.2850287907877, 145226.27386862997, 145797.0, 146536.0, 147046.0, 148839.2558037203, 11093.611723589636, 11705.122115841175, 11984.280943143265, 12505.687357816127, 12592.370381480889, 14222.669786452634, 14596.927015364856, 15052.021618594756, 15096.773548396783, 15102.697946041018, 8710.21608055278, 8784.121587841164, 8823.470591764515, 8848.336374771918, 8970.506622135845, 8345.582720863933, 8353.498790072616, 8515.787105322417, 8523.829523409497, 8559.443636163629, 7593.734219302298, 7689.461737678421, 7748.883766743504, 7813.921860781433, 7821.843563128706, 2152.4824998376107, 2168.837337199685, 2180.3835397523035, 2184.421128400975, 2212.889355532217, 903.9300002993073, 982.2338575910801, 985.5614251657944, 1027.8561001459802, 1041.4480325427535, 21112.683309750366, 22016.77983220179, 22034.44913877134, 22084.779152208273, 22105.77894221037, 1007.8236308645958, 1012.4128005756644, 1029.6447725534829, 1047.2145890582065, 1048.7587854793287, 10965.0, 11226.691667782768, 11256.986871181633, 11261.43692815356, 11268.15488838324, 543888.0, 551942.0, 557589.0, 559992.0, 563393.0, 132588.0, 133795.0, 136172.0, 137894.31052844672, 140460.59539404477, 1171.1275100050348, 1177.4877928101132, 1201.0331682995097, 1201.6274954763876, 1204.7831390349645, 17345.653086938444, 18191.636167276843, 18416.447506574823, 18734.063296834833, 18836.811631883505, 55895.0, 58085.0, 58384.70807645935, 59247.703761480916, 59289.703551481965, 63559.0466142999, 81289.0, 82190.0, 82594.0, 82626.58686706529, 8606.719219406987, 8663.826723465621, 8820.735377938672, 9166.954165229132, 9223.44659320443, 14292.285385730464, 14369.928150359181, 14444.638884027983, 14504.995776457105, 14903.552893413214, 9976.900230997888, 11902.880971190178, 11984.880151198377, 12251.142420030512, 12386.442610082388, 11422.600208992646, 11565.959063683973, 11640.708982275512, 11824.940875295568, 11908.52365905354, 10479.95200479946, 11956.58151964677, 12112.878871211175, 12510.249385036926, 12626.810597841224, 7347.8163045924275, 8785.165409286108, 8912.242459391024, 8915.0, 9053.818923621358, 10450.634227801991, 10714.357138571711, 10793.244472886823, 10894.0, 10962.397068161328], "value": 10455.48894049013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.1045465220282, 1429.5925661186564, 1443.797868298438, 1455.1341951538836, 1458.7082583483307, 11514.769704605913, 12057.854503822124, 12062.698432539191, 12081.456334464949, 12089.395530223486, 11503.42482875857, 11964.521419143246, 11999.0, 12004.45979930903, 12030.759384812298, 2540.3776074861685, 2581.8838152283097, 2587.676540432446, 2590.5337039332912, 2591.0931174089105, 2121.427214652043, 2422.0675040109595, 2518.6347979542957, 2569.550328692481, 2573.7812285955715, 2177.0, 2202.922897698581, 2464.2114523352534, 2550.910718124866, 2552.310876063462, 2470.7776300133073, 2490.452100537879, 2503.0738626708053, 2505.3235626380956, 2506.448581312108, 2515.00657240389, 2524.0913271222344, 2527.3049911274547, 2528.026709716754, 2529.152733834168, 11844.28934263947, 11942.462589183508, 11978.401079945968, 11984.262281969153, 11995.16033877629, 6509.316521765241, 6755.594664320108, 6759.15510561175, 6766.25571187169, 6767.42476889465, 3886.7756656653064, 4112.650424713903, 4236.851710190129, 4262.680298977589, 4270.060586670958, 1078.9352638841694, 1268.3594784633792, 1269.428757059327, 1308.5420102963888, 1314.5333406640696, 16640.417585384454, 16800.49598512059, 16810.66378672432, 16813.0, 16824.411145609967, 5391.541718953855, 5469.535089517356, 5593.300837395325, 5697.088465845445, 5721.628094173865, 12507.874921250854, 12525.812112818316, 12531.0, 12569.994400447942, 12593.181443206162, 6590.340965903371, 6590.538662293689, 6591.0, 6592.011198320194, 6599.505037122139, 5982.282126144891, 5990.73041713124, 6018.909716354258, 6114.633122012693, 6243.219597550306, 4266.573342665771, 4380.255356589388, 4383.956160438419, 4444.6666500012625, 4449.110177964355, 1102.2174256278133, 1276.049343239274, 1299.2983788753968, 1311.4557458654742, 1320.0627554436458, 659.8350412396901, 676.2730065179853, 761.9370977486376, 773.4160708665034, 785.1716439156744, 5960.582759206901, 6140.508759299245, 6772.762953296709, 6934.47991400647, 7097.574145551283, 580.1761498671896, 584.1325631437312, 586.7447660267712, 598.064029793372, 704.0706267726654, 3379.5606571145595, 3880.631340022693, 4165.146145040259, 4275.700700950903, 4476.619487343547, 14260.643483912985, 15035.097894126387, 15205.391784328724, 15361.308741106677, 15377.769333460006, 14832.406703731946, 15253.542393728207, 15339.0, 15461.690766184613, 15480.225988700746, 8531.0, 8613.569321534023, 8644.351673624504, 8755.0807165248, 8788.824223515494, 6320.652364120017, 6632.270450250372, 6752.662366881538, 6807.004917836136, 6809.69356378974, 13474.19154850712, 13632.0, 13800.0, 14011.859881401055, 14044.087134336236, 13867.375968081662, 14132.15207087578, 14136.0, 14201.147931123753, 14413.639659008608, 8878.334124940784, 8886.555672216235, 8999.280057595246, 9009.27925765924, 9013.909860901307, 10893.618723344962, 10918.78162436731, 11025.393603351893, 11040.668779936615, 11054.170937179904, 7088.751893683696, 9205.76985575366, 9255.86116208244, 9322.813543728951, 9360.48517331526, 9124.908750912406, 9184.908150918405, 9218.585163667516, 9237.12247336502, 9312.8336365636, 7730.458867879194, 7908.802279942817, 7966.92033079685, 7973.561454120079, 7981.122076571689, 5521.199426083276, 5630.155476678531, 5667.943320566742, 5672.716364181857, 5793.797217097382, 6049.969750151397, 6142.341567776586, 6163.96918015407, 6169.074638804215, 6262.561620686691], "value": 5326.80203522761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.0782315470222, 398.68503881933253, 402.7053024526148, 407.10843253275345, 409.9979500102499, 5868.178455016296, 5894.705264736762, 5933.406659334064, 5950.49420799232, 5972.148633923476, 4622.745748983804, 4713.670043096985, 5486.969821166164, 5680.034394152994, 5738.43794183624, 4444.355568442574, 4445.355423463596, 4463.620592249663, 4469.687121901468, 4492.079123779634, 3655.9709361304467, 4456.509783923766, 4460.910781784362, 4461.955380446203, 4476.843310484133, 3836.865709700161, 3861.362875125615, 4222.366645003243, 4255.425517555122, 4377.540358262384, 4404.4054052702795, 4405.713628614129, 4409.074094440171, 4409.801558929824, 4434.179676759793, 3915.8237879295502, 3922.7450215735885, 3925.2934471795065, 3928.5285765708013, 3934.272159650474, 4379.474463064453, 5633.662030257479, 5686.260786097822, 5717.714114294268, 5741.569382296345, 4608.976955115237, 5336.91994620081, 5345.305110335631, 5346.866328341823, 5350.197470379435, 6203.534734894901, 6217.285012223607, 6218.378162183745, 6237.688115594247, 6253.812385628438, 3553.6446355364515, 3681.631836816324, 3864.8840534784003, 4032.8790136295665, 4241.724287921275, 6247.656378899159, 6415.0, 6421.325760795143, 6504.284528701839, 6604.174478190226, 4199.454070970754, 4267.743935363888, 4278.422412974209, 4280.058387154821, 4291.721038132574, 4162.500499939966, 4328.480582330078, 4368.825246990148, 4370.0, 4370.628496577827, 4951.579115775127, 4955.752212389366, 5049.444561098277, 5053.7220452875445, 5061.8734531637, 6183.690815459209, 6187.566870319034, 6190.226221722285, 6196.721147548371, 6207.317195108534, 1409.6828213652052, 1458.6936743283818, 1466.8730341005585, 1484.094702231638, 1487.137460273039, 911.4030310146865, 968.7261251454315, 970.6408628807245, 988.8763904511936, 993.8956409577034, 5942.970285148633, 5954.404559544011, 5983.790567330123, 6000.099985002197, 6011.0, 6401.167848179707, 6403.711832967528, 6410.083412047507, 6458.192725909262, 6458.61248325102, 4932.926006109911, 5852.752650811707, 5927.1405646181065, 5946.870094682083, 5949.25634295713, 2921.5617657351568, 2934.3837794063484, 3090.2188030772486, 3319.369319829225, 3358.8503357850996, 6095.329513753483, 6240.875182496416, 6624.205095388585, 6625.734970601122, 6650.442013522742, 5746.770129194869, 6009.5961615353335, 6393.392627700361, 6564.934350656432, 6593.044008618724, 5783.595148339576, 5790.565707571949, 5955.642661440327, 6630.602163870087, 6636.568623039487, 5201.349831271091, 5814.592978491465, 6380.117865229676, 6380.457661098859, 6403.103565500741, 6027.246594175728, 6305.779297724741, 6315.336889626523, 6322.462590679844, 6332.778352757631, 6258.405451482102, 6478.805635830932, 6481.287058423664, 6642.236142843635, 6722.529422940543, 3795.0132965428634, 4074.7351422157467, 4666.78999445019, 4717.693349932243, 4745.0509898019845, 4969.0807200668, 5438.592105592017, 5758.452946970031, 5765.5675824314185, 6191.535634827316, 6264.686765661608, 6269.153664255267, 6269.341719119427, 6269.3417191196095, 6301.149344838388, 5465.6447330923365, 5908.231929849092, 6282.937170628235, 6294.527910406646, 6301.527385446018, 4887.828925987574, 5493.148561972901, 6093.969530152321, 6127.111568822585, 6171.444569988723, 5054.21659642756, 5863.853403664772, 6280.0, 6294.402031806971, 6309.469698861656, 4743.715377077387, 4996.7534089205465, 6052.576319657582, 6105.419985101408, 6110.511159107172], "value": 4542.919437083065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.651780627492, 860.1613426908765, 860.3719284922007, 860.6084231674585, 880.6389380354054, 12295.63113106606, 12782.872171278274, 12910.160839545422, 15433.228338583081, 15491.302891369887, 14632.12207267562, 16270.83729162708, 17543.73684394735, 17850.464486065437, 18077.728834067468, 972.4602845420789, 986.0287616697548, 987.9407235565853, 988.6045581767279, 993.6373223773306, 654.947604191666, 670.8926571748522, 938.5494962418044, 959.7120863740885, 971.8833739951216, 1027.8047171037517, 1028.1928685981507, 1028.4806172882684, 1029.3000759483548, 1037.9273450858443, 1022.396785896321, 1023.0741179232806, 1023.8617786598788, 1024.51335615582, 1030.3302853145478, 756.451572609859, 759.8784194528904, 762.1349768013289, 763.6372722956606, 765.586583245047, 16002.519924402286, 16258.75611865823, 16415.179241037902, 16425.83574164255, 16738.83261167385, 16632.168391580373, 16689.91655041717, 16842.663146736995, 17076.2315695794, 17133.657326853518, 13781.724365512633, 13797.724045519133, 13902.930485347508, 14006.719865602732, 14077.225752583603, 3463.5843698756057, 3486.4944583035317, 3487.319972605343, 3490.912727181815, 3492.860285588599, 124714.0, 125896.0, 125934.0, 126677.36661316727, 127844.0, 12010.579629713093, 12202.633920982385, 13089.214647121204, 13265.204087754766, 13443.395047222899, 25313.62029569558, 25353.366165846, 25902.352441188745, 26329.341766455993, 26349.47301053968, 6613.801585952429, 7494.21310762373, 7623.085229772463, 7779.7666070017995, 7884.053913530413, 3787.8484860605818, 3848.615138486185, 3856.3444214483607, 3865.3042452358845, 3868.0716628009077, 4263.5096963849555, 4289.871303860889, 4332.6317263033, 4362.280223763107, 4433.091216300651, 936.5832204668857, 959.6305422412421, 960.7934294126796, 964.320154291223, 964.5611246882652, 631.8294060603612, 659.4823063894916, 664.3190729502298, 675.2302375292171, 697.9616121113286, 9669.0, 11159.549258596331, 11276.210665253353, 11564.0, 11650.41747912601, 662.6852245183595, 662.7382184037278, 669.926308106108, 683.1938312790954, 695.9860802783916, 5349.625526213128, 5547.916781248285, 5569.164625306236, 5617.634853734494, 5633.464820842096, 102543.4872825631, 103621.0, 105732.94267057232, 107665.0, 108266.0, 94025.5298723502, 94679.52660236655, 97954.0, 98476.52285215727, 98847.50576247073, 59447.77145590202, 69826.30173698299, 76179.61910190525, 80800.0, 80834.0, 9457.716268511957, 12576.685582860136, 12680.873191267969, 12703.110782245154, 12709.428075736429, 38426.23147536978, 39341.40987885127, 39655.80172099121, 40392.99017524585, 42429.0, 67597.0, 68721.0, 69333.65333173302, 69444.0, 69687.6515617439, 16210.918945405198, 16892.0, 16924.407645732834, 16968.575785604964, 16998.660026799644, 18072.186751595946, 18111.547211319823, 18124.184411701768, 18672.15975281143, 18694.439166825017, 16751.832481675516, 17151.656966860843, 17356.91321543384, 17391.0, 17724.822751772834, 16869.578260543094, 17082.572935676708, 17143.485695429157, 17342.30630774755, 17457.0, 13767.173969561858, 16722.0, 16943.32226710918, 16974.830251697324, 17168.74246886273, 11473.4263286837, 11527.596534121265, 11888.108391870472, 12009.339486327986, 12022.27866328023, 12262.0, 12595.370231488205, 12616.0, 12628.242305461701, 12889.033322501038], "value": 8318.208753526955, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 112.0, 112.0, 113.0, 111.0, 110.0, 111.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 142.0, 112.0, 153.0, 111.0, 107.0, 107.0, 142.0, 140.0, 95.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 184.0, 187.0, 187.0, 184.0, 184.0, 187.0, 181.0, 183.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 59.0, 59.0, 57.0, 58.0, 80.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 87.0, 69.0, 70.0, 67.0, 89.0, 68.0, 69.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 89.0, 88.0, 89.0, 89.0, 89.0, 89.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 86.0, 85.0, 83.0, 86.0, 86.0, 87.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 47.0, 48.0, 47.0, 47.0, 47.0, 48.0, 47.0, 47.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 58.0, 56.0, 67.0, 61.0, 59.0, 57.0, 55.0, 57.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 83.0, 83.0, 81.0, 83.0, 82.0, 82.0, 82.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 142.0, 144.0, 148.0, 134.0, 141.0, 155.0, 202.0, 151.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 188.0, 215.0, 173.0, 214.0, 203.0, 183.0, 186.0, 181.0, 186.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0], "value": 67.3, "unit": "score"}]}]} 16:39:19 INFO - Return code: 0 16:39:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:39:19 ERROR - # TBPL SUCCESS # 16:39:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:19 INFO - 2017-04-20 16:39:19.492 screenresolution[1649:9687] starting screenresolution argv=screenresolution get 16:39:19 INFO - 2017-04-20 16:39:19.496 screenresolution[1649:9687] Display 0: 1600x1200x32@60 16:39:19 INFO - 2017-04-20 16:39:19.502 screenresolution[1650:9690] starting screenresolution argv=screenresolution list 16:39:19 INFO - Available Modes on Display 0 16:39:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:19 INFO - Intel Iris: 16:39:19 INFO - Chipset Model: Intel Iris 16:39:19 INFO - Type: GPU 16:39:19 INFO - Bus: Built-In 16:39:19 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:19 INFO - Vendor: Intel (0x8086) 16:39:19 INFO - Device ID: 0x0a2e 16:39:19 INFO - Revision ID: 0x0009 16:39:19 INFO - Displays: 16:39:19 INFO - Display: 16:39:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:19 INFO - Display Serial Number: 1600x1200 60 16:39:19 INFO - Main Display: Yes 16:39:19 INFO - Mirror: Off 16:39:19 INFO - Online: Yes 16:39:19 INFO - Rotation: Supported 16:39:19 INFO - Return code: 0 16:39:19 INFO - Running post-action listener: _resource_record_post_action 16:39:19 INFO - [mozharness: 2017-04-20 23:39:19.749125Z] Finished run-tests step (success) 16:39:19 INFO - Running post-run listener: _resource_record_post_run 16:39:19 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 37663744; Write bytes: 516301824; Read time: 242; Write time: 1614 16:39:19 INFO - TinderboxPrint: CPU usage
53.2% 16:39:19 INFO - TinderboxPrint: I/O read bytes / time
37,663,744 / 242 16:39:19 INFO - TinderboxPrint: I/O write bytes / time
516,301,824 / 1,614 16:39:19 INFO - TinderboxPrint: CPU idle
2,243.6 (46.8%) 16:39:19 INFO - TinderboxPrint: CPU system
952.4 (19.9%) 16:39:19 INFO - TinderboxPrint: CPU user
1,601.8 (33.4%) 16:39:19 INFO - TinderboxPrint: Swap in / out
245,735,424 / 0 16:39:19 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207473152; Write bytes: 206669824; Read time: 15963; Write time: 465 16:39:19 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 33784832; Write bytes: 302439424; Read time: 217; Write time: 1120 16:39:20 INFO - Running post-run listener: _upload_blobber_files 16:39:20 INFO - Blob upload gear active. 16:39:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:39:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:39:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:39:20 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:21 INFO - (blobuploader) - INFO - Done attempting. 16:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:22 INFO - (blobuploader) - INFO - Done attempting. 16:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:39:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:24 INFO - (blobuploader) - INFO - Done attempting. 16:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:26 INFO - (blobuploader) - INFO - Done attempting. 16:39:26 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:26 INFO - Return code: 0 16:39:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e18e6156cdc3cc384b4cb402c2b269dad7bec4e4f4a8eb23253cafb5430324c9e9e6245fde2d4c3456c0071eaa4c337573a88ba04e2f13c20b1f5046beb8d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca675d149f370644784efab7f0ec0568095997c6748b71afc20f40ffecf4a1a6007042fcf5c450babd40811b646154bc92d97324af18ed96bb7293e04ac2ec3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb071279652ae286bc38fa141bf7560606c3c20fd719374623a611def5603ce7ec02d50b5c762fbfc3e9db449aab798da5485b86b44ef028d3618c64b3ccd30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a53f8e3fc3d4c186a9f1ae1391c4631617863feec9cbbbc5a4b1a8df4b69e2808276386c1d635e9a98b01f8a6228fe94442fd29bce275311abd1160d248ae426"} 16:39:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:26 INFO - Contents: 16:39:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e18e6156cdc3cc384b4cb402c2b269dad7bec4e4f4a8eb23253cafb5430324c9e9e6245fde2d4c3456c0071eaa4c337573a88ba04e2f13c20b1f5046beb8d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca675d149f370644784efab7f0ec0568095997c6748b71afc20f40ffecf4a1a6007042fcf5c450babd40811b646154bc92d97324af18ed96bb7293e04ac2ec3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb071279652ae286bc38fa141bf7560606c3c20fd719374623a611def5603ce7ec02d50b5c762fbfc3e9db449aab798da5485b86b44ef028d3618c64b3ccd30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a53f8e3fc3d4c186a9f1ae1391c4631617863feec9cbbbc5a4b1a8df4b69e2808276386c1d635e9a98b01f8a6228fe94442fd29bce275311abd1160d248ae426"} 16:39:26 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:26 INFO - Copying logs to upload dir... 16:39:26 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.397234 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-20 16:39:26.906986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 16:39:26.912299) ========= 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.8hnF05bYbM/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.EVP6iZjnDk/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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/Firefox/sha512/3e18e6156cdc3cc384b4cb402c2b269dad7bec4e4f4a8eb23253cafb5430324c9e9e6245fde2d4c3456c0071eaa4c337573a88ba04e2f13c20b1f5046beb8d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca675d149f370644784efab7f0ec0568095997c6748b71afc20f40ffecf4a1a6007042fcf5c450babd40811b646154bc92d97324af18ed96bb7293e04ac2ec3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb071279652ae286bc38fa141bf7560606c3c20fd719374623a611def5603ce7ec02d50b5c762fbfc3e9db449aab798da5485b86b44ef028d3618c64b3ccd30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a53f8e3fc3d4c186a9f1ae1391c4631617863feec9cbbbc5a4b1a8df4b69e2808276386c1d635e9a98b01f8a6228fe94442fd29bce275311abd1160d248ae426"} build_url:https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010756 build_url: 'https://queue.taskcluster.net/v1/task/MiZJfqHmTsW2SksXp-29Cw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e18e6156cdc3cc384b4cb402c2b269dad7bec4e4f4a8eb23253cafb5430324c9e9e6245fde2d4c3456c0071eaa4c337573a88ba04e2f13c20b1f5046beb8d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fca675d149f370644784efab7f0ec0568095997c6748b71afc20f40ffecf4a1a6007042fcf5c450babd40811b646154bc92d97324af18ed96bb7293e04ac2ec3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deb071279652ae286bc38fa141bf7560606c3c20fd719374623a611def5603ce7ec02d50b5c762fbfc3e9db449aab798da5485b86b44ef028d3618c64b3ccd30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a53f8e3fc3d4c186a9f1ae1391c4631617863feec9cbbbc5a4b1a8df4b69e2808276386c1d635e9a98b01f8a6228fe94442fd29bce275311abd1160d248ae426"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 16:39:26.949710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 16:39:26.950064) ========= 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.8hnF05bYbM/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.EVP6iZjnDk/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 16:39:26.998721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 16:39:26.999087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 16:39:26.999437) ========= ========= Total master_lag: 0.36 =========