builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1492775144.67 results: success (0) buildid: 20170421030241 builduid: b91f1f8bed7144c994c1b97fdbe89188 revision: dd530a59750adcaa0d48fa4f69b0cdb52715852a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.669247) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.669711) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.670012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.707557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.707969) ========= 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.H3OSW40RiT/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.sNgexf3cd0/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-21 04:45:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.15M=0.001s 2017-04-21 04:45:44 (8.15 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.868702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.869041) ========= 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.H3OSW40RiT/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.sNgexf3cd0/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.021968 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:44.917999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 04:45:44.918426) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd530a59750adcaa0d48fa4f69b0cdb52715852a --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 dd530a59750adcaa0d48fa4f69b0cdb52715852a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H3OSW40RiT/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.sNgexf3cd0/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-21 04:45:45,003 truncating revision to first 12 chars 2017-04-21 04:45:45,003 Setting DEBUG logging. 2017-04-21 04:45:45,003 attempt 1/10 2017-04-21 04:45:45,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd530a59750a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 04:45:46,448 unpacking tar archive at: mozilla-central-dd530a59750a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.693781 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 04:45:46.640553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:46.641419) ========= script_repo_revision: dd530a59750adcaa0d48fa4f69b0cdb52715852a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:46.642182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:46.642465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 04:45:46.663085) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-21 04:45:46.663896) ========= /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.H3OSW40RiT/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.sNgexf3cd0/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:45:46 INFO - MultiFileLogger online at 20170421 04:45:46 in /builds/slave/test 04:45:46 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 04:45:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:46 INFO - {'append_to_log': False, 04:45:46 INFO - 'base_work_dir': '/builds/slave/test', 04:45:46 INFO - 'blob_upload_branch': 'Firefox', 04:45:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:46 INFO - 'branch': 'Firefox', 04:45:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:46 INFO - 'config_files': ('talos/mac_config.py',), 04:45:46 INFO - 'default_actions': ('clobber', 04:45:46 INFO - 'read-buildbot-config', 04:45:46 INFO - 'download-and-extract', 04:45:46 INFO - 'populate-webroot', 04:45:46 INFO - 'create-virtualenv', 04:45:46 INFO - 'install', 04:45:46 INFO - 'run-tests'), 04:45:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:46 INFO - 'download_minidump_stackwalk': True, 04:45:46 INFO - 'download_symbols': 'ondemand', 04:45:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:46 INFO - 'gecko_profile': False, 04:45:46 INFO - 'gecko_profile_interval': 0, 04:45:46 INFO - 'installer_path': 'installer.exe', 04:45:46 INFO - 'log_level': 'info', 04:45:46 INFO - 'log_name': 'talos', 04:45:46 INFO - 'log_to_console': True, 04:45:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:45:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:45:46 INFO - 'opt_config_files': (), 04:45:46 INFO - 'pip_index': False, 04:45:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:46 INFO - 'cmd': ('bash', 04:45:46 INFO - '-c', 04:45:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:46 INFO - 'enabled': True, 04:45:46 INFO - 'halt_on_failure': False, 04:45:46 INFO - 'name': 'check_screen_resolution'},), 04:45:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:46 INFO - 'cmd': ('bash', 04:45:46 INFO - '-c', 04:45:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:46 INFO - 'enabled': True, 04:45:46 INFO - 'halt_on_failure': False, 04:45:46 INFO - 'name': 'check_screen_resolution'},), 04:45:46 INFO - 'run_cmd_checks_enabled': True, 04:45:46 INFO - 'suite': 'dromaeojs', 04:45:46 INFO - 'system_bits': '32', 04:45:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:46 INFO - 'title': 't-yosemite-r7-0028', 04:45:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:46 INFO - 'use_talos_json': True, 04:45:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:46 INFO - 'work_dir': 'build'} 04:45:46 INFO - [mozharness: 2017-04-21 11:45:46.880631Z] Running clobber step. 04:45:46 INFO - Running pre-action listener: _resource_record_pre_action 04:45:46 INFO - Running main action method: clobber 04:45:46 INFO - rmtree: /builds/slave/test/build 04:45:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:47 INFO - Running post-action listener: _resource_record_post_action 04:45:47 INFO - [mozharness: 2017-04-21 11:45:47.041574Z] Finished clobber step (success) 04:45:47 INFO - [mozharness: 2017-04-21 11:45:47.041701Z] Running read-buildbot-config step. 04:45:47 INFO - Running pre-action listener: _resource_record_pre_action 04:45:47 INFO - Running main action method: read_buildbot_config 04:45:47 INFO - Using buildbot properties: 04:45:47 INFO - { 04:45:47 INFO - "project": "", 04:45:47 INFO - "product": "firefox", 04:45:47 INFO - "script_repo_revision": "production", 04:45:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:45:47 INFO - "repository": "", 04:45:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:45:47 INFO - "buildid": "20170421030241", 04:45:47 INFO - "stage_platform": "macosx64", 04:45:47 INFO - "basedir": "/builds/slave/test", 04:45:47 INFO - "nightly_build": "True", 04:45:47 INFO - "buildnumber": 84, 04:45:47 INFO - "slavename": "t-yosemite-r7-0028", 04:45:47 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:45:47 INFO - "platform": "yosemite_r7", 04:45:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:45:47 INFO - "branch": "mozilla-central", 04:45:47 INFO - "repo_path": "mozilla-central", 04:45:47 INFO - "revision": "dd530a59750adcaa0d48fa4f69b0cdb52715852a", 04:45:47 INFO - "pgo_build": "False", 04:45:47 INFO - "builduid": "b91f1f8bed7144c994c1b97fdbe89188", 04:45:47 INFO - "slavebuilddir": "test" 04:45:47 INFO - } 04:45:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:45:47 INFO - Running post-action listener: _resource_record_post_action 04:45:47 INFO - [mozharness: 2017-04-21 11:45:47.045179Z] Finished read-buildbot-config step (success) 04:45:47 INFO - [mozharness: 2017-04-21 11:45:47.045301Z] Running download-and-extract step. 04:45:47 INFO - Running pre-action listener: _resource_record_pre_action 04:45:47 INFO - Running main action method: download_and_extract 04:45:47 INFO - mkdir: /builds/slave/test/build/tests 04:45:47 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')]} 04:45:47 INFO - trying https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/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 04:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/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 04:45:48 INFO - Downloaded 1325 bytes. 04:45:48 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:45:48 INFO - Using the following test package requirements: 04:45:48 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:45:48 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:45:48 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:45:48 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:45:48 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'jsshell-mac.zip'], 04:45:48 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:45:48 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:45:48 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:45:48 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:45:48 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:45:48 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:45:48 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:45:48 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:45:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:45:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:45:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:45:50 INFO - Content-Length response header: 52522817 04:45:50 INFO - Bytes received: 52522817 04:46:06 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 04:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:46:08 INFO - Content-Length response header: 52522817 04:46:08 INFO - Bytes received: 52522817 04:46:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:46:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:46:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:46:24 INFO - Content-Length response header: 14408811 04:46:24 INFO - Bytes received: 14408811 04:46:25 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')]} 04:46:25 INFO - trying https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/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 04:46:27 INFO - Downloaded 71099795 bytes. 04:46:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:27 INFO - mkdir: /builds/slave/test/properties 04:46:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:27 INFO - Contents: 04:46:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:27 INFO - Running post-action listener: _resource_record_post_action 04:46:27 INFO - Running post-action listener: set_extra_try_arguments 04:46:27 INFO - [mozharness: 2017-04-21 11:46:27.762222Z] Finished download-and-extract step (success) 04:46:27 INFO - [mozharness: 2017-04-21 11:46:27.762346Z] Running populate-webroot step. 04:46:27 INFO - Running pre-action listener: _resource_record_pre_action 04:46:27 INFO - Running main action method: populate_webroot 04:46:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:27 INFO - '--tppagecycles', 04:46:27 INFO - '7'], 04:46:27 INFO - 'tests': ['tsvgm']}}, 04:46:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['damp', 'tps']}, 04:46:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'tests': ['damp', 'tps']}, 04:46:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['dromaeo_dom']}, 04:46:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:46:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:46:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['a11yr', 04:46:27 INFO - 'ts_paint', 04:46:27 INFO - 'tpaint', 04:46:27 INFO - 'sessionrestore', 04:46:27 INFO - 'sessionrestore_no_auto_restore', 04:46:27 INFO - 'tabpaint']}, 04:46:27 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:27 INFO - 'ts_paint', 04:46:27 INFO - 'tpaint', 04:46:27 INFO - 'sessionrestore', 04:46:27 INFO - 'sessionrestore_no_auto_restore', 04:46:27 INFO - 'tabpaint']}, 04:46:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:27 INFO - 'ts_paint', 04:46:27 INFO - 'tpaint', 04:46:27 INFO - 'sessionrestore', 04:46:27 INFO - 'sessionrestore_no_auto_restore', 04:46:27 INFO - 'tabpaint']}, 04:46:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:27 INFO - 'ts_paint', 04:46:27 INFO - 'tpaint', 04:46:27 INFO - 'sessionrestore', 04:46:27 INFO - 'sessionrestore_no_auto_restore', 04:46:27 INFO - 'tabpaint']}, 04:46:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['a11yr', 04:46:27 INFO - 'ts_paint', 04:46:27 INFO - 'tpaint', 04:46:27 INFO - 'sessionrestore', 04:46:27 INFO - 'sessionrestore_no_auto_restore', 04:46:27 INFO - 'tabpaint']}, 04:46:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['a11yr', 04:46:27 INFO - 'ts_paint', 04:46:27 INFO - 'tpaint', 04:46:27 INFO - 'sessionrestore', 04:46:27 INFO - 'sessionrestore_no_auto_restore', 04:46:27 INFO - 'tabpaint']}, 04:46:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:46:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:46:27 INFO - 'bloom_basic_ref']}, 04:46:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['tsvgx', 04:46:27 INFO - 'tsvgr_opacity', 04:46:27 INFO - 'tart', 04:46:27 INFO - 'tscrollx', 04:46:27 INFO - 'cart', 04:46:27 INFO - 'tsvg_static']}, 04:46:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:27 INFO - 'tsvgr_opacity', 04:46:27 INFO - 'tart', 04:46:27 INFO - 'tscrollx', 04:46:27 INFO - 'cart', 04:46:27 INFO - 'tsvg_static']}, 04:46:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'talos_options': ['--disable-e10s'], 04:46:27 INFO - 'tests': ['tp5o']}, 04:46:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'talos_options': ['--disable-e10s', 04:46:27 INFO - '--xperf_path', 04:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:27 INFO - 'tests': ['tp5n']}, 04:46:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:27 INFO - 'talos_options': ['--xperf_path', 04:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:27 INFO - 'tests': ['tp5n']}}, 04:46:27 INFO - 'talos.zip': {'path': '', 04:46:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:27 INFO - Running post-action listener: _resource_record_post_action 04:46:27 INFO - [mozharness: 2017-04-21 11:46:27.780972Z] Finished populate-webroot step (success) 04:46:27 INFO - [mozharness: 2017-04-21 11:46:27.781079Z] Running create-virtualenv step. 04:46:27 INFO - Running pre-action listener: _resource_record_pre_action 04:46:27 INFO - Running main action method: create_virtualenv 04:46:27 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:27 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 04:46:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:27 INFO - Using real prefix '/tools/python27' 04:46:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:31 INFO - Installing pip.................done. 04:46:31 INFO - Return code: 0 04:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:46:31 INFO - Reading from file tmpfile_stdout 04:46:31 INFO - Output received: 04:46:31 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) 04:46:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:31 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')]} 04:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:31 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')]} 04:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:31 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:31 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 04:46:31 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 04:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:31 INFO - 'HOME': '/Users/cltbld', 04:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:31 INFO - 'LOGNAME': 'cltbld', 04:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:31 INFO - 'MOZ_NO_REMOTE': '1', 04:46:31 INFO - 'NO_EM_RESTART': '1', 04:46:31 INFO - 'PAGER': '/bin/cat', 04:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:31 INFO - 'PWD': '/builds/slave/test', 04:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:31 INFO - 'SHELL': '/bin/bash', 04:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:31 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:31 INFO - 'USER': 'cltbld', 04:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:31 INFO - 'XPC_FLAGS': '0x0', 04:46:31 INFO - 'XPC_SERVICE_NAME': '0', 04:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:32 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 04:46:32 INFO - Cleaning up... 04:46:32 INFO - Return code: 0 04:46:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:32 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')]} 04:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:32 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')]} 04:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:32 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:32 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 04:46:32 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 04:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:32 INFO - 'HOME': '/Users/cltbld', 04:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:32 INFO - 'LOGNAME': 'cltbld', 04:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:32 INFO - 'MOZ_NO_REMOTE': '1', 04:46:32 INFO - 'NO_EM_RESTART': '1', 04:46:32 INFO - 'PAGER': '/bin/cat', 04:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:32 INFO - 'PWD': '/builds/slave/test', 04:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:32 INFO - 'SHELL': '/bin/bash', 04:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:32 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:32 INFO - 'USER': 'cltbld', 04:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:32 INFO - 'XPC_FLAGS': '0x0', 04:46:32 INFO - 'XPC_SERVICE_NAME': '0', 04:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:32 INFO - Downloading/unpacking psutil>=3.1.1 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 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 04:46:32 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 04:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:35 INFO - Installing collected packages: psutil 04:46:35 INFO - Running setup.py install for psutil 04:46:35 INFO - building 'psutil._psutil_osx' extension 04:46:35 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 04:46:36 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 04:46:36 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 04:46:36 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 04:46:36 INFO - building 'psutil._psutil_posix' extension 04:46:36 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 04:46:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:36 INFO - ^ 04:46:36 INFO - 1 warning generated. 04:46:36 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 04:46:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:36 INFO - Successfully installed psutil 04:46:36 INFO - Cleaning up... 04:46:36 INFO - Return code: 0 04:46:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:46:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:36 INFO - 'HOME': '/Users/cltbld', 04:46:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:36 INFO - 'LOGNAME': 'cltbld', 04:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:36 INFO - 'MOZ_NO_REMOTE': '1', 04:46:36 INFO - 'NO_EM_RESTART': '1', 04:46:36 INFO - 'PAGER': '/bin/cat', 04:46:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:36 INFO - 'PWD': '/builds/slave/test', 04:46:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:36 INFO - 'SHELL': '/bin/bash', 04:46:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:36 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:36 INFO - 'USER': 'cltbld', 04:46:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:36 INFO - 'XPC_FLAGS': '0x0', 04:46:36 INFO - 'XPC_SERVICE_NAME': '0', 04:46:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:37 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 04:46:37 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 04:46:37 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 04:46:37 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 04:46:37 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 04:46:37 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 04:46:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:39 INFO - Installing collected packages: mozsystemmonitor 04:46:39 INFO - Running setup.py install for mozsystemmonitor 04:46:39 INFO - Successfully installed mozsystemmonitor 04:46:39 INFO - Cleaning up... 04:46:39 INFO - Return code: 0 04:46:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:39 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')]} 04:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:40 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 04:46:40 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 04:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:40 INFO - 'HOME': '/Users/cltbld', 04:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:40 INFO - 'LOGNAME': 'cltbld', 04:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:40 INFO - 'MOZ_NO_REMOTE': '1', 04:46:40 INFO - 'NO_EM_RESTART': '1', 04:46:40 INFO - 'PAGER': '/bin/cat', 04:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:40 INFO - 'PWD': '/builds/slave/test', 04:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:40 INFO - 'SHELL': '/bin/bash', 04:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:40 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:40 INFO - 'USER': 'cltbld', 04:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:40 INFO - 'XPC_FLAGS': '0x0', 04:46:40 INFO - 'XPC_SERVICE_NAME': '0', 04:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:41 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46:43 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 04:46:43 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 04:46:43 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 04:46:43 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 04:46:43 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 04:46:43 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 04:46:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:44 INFO - warning: no files found matching '*.txt' 04:46:44 INFO - no previously-included directories found matching 'build' 04:46:44 INFO - no previously-included directories found matching 'dist' 04:46:44 INFO - no previously-included directories found matching '.git*' 04:46:44 INFO - Installing collected packages: jsonschema, functools32 04:46:44 INFO - Running setup.py install for functools32 04:46:44 INFO - warning: no files found matching '*.txt' 04:46:44 INFO - no previously-included directories found matching 'build' 04:46:44 INFO - no previously-included directories found matching 'dist' 04:46:44 INFO - no previously-included directories found matching '.git*' 04:46:44 INFO - Successfully installed jsonschema functools32 04:46:44 INFO - Cleaning up... 04:46:44 INFO - Return code: 0 04:46:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:44 INFO - 'HOME': '/Users/cltbld', 04:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:44 INFO - 'LOGNAME': 'cltbld', 04:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:44 INFO - 'MOZ_NO_REMOTE': '1', 04:46:44 INFO - 'NO_EM_RESTART': '1', 04:46:44 INFO - 'PAGER': '/bin/cat', 04:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:44 INFO - 'PWD': '/builds/slave/test', 04:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:44 INFO - 'SHELL': '/bin/bash', 04:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:44 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:44 INFO - 'USER': 'cltbld', 04:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:44 INFO - 'XPC_FLAGS': '0x0', 04:46:44 INFO - 'XPC_SERVICE_NAME': '0', 04:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:46:45 INFO - Cleaning up... 04:46:45 INFO - Return code: 0 04:46:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:45 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')]} 04:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:45 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')]} 04:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:45 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:45 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 04:46:45 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 04:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:45 INFO - 'HOME': '/Users/cltbld', 04:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:45 INFO - 'LOGNAME': 'cltbld', 04:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:45 INFO - 'MOZ_NO_REMOTE': '1', 04:46:45 INFO - 'NO_EM_RESTART': '1', 04:46:45 INFO - 'PAGER': '/bin/cat', 04:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:45 INFO - 'PWD': '/builds/slave/test', 04:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:45 INFO - 'SHELL': '/bin/bash', 04:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:45 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:45 INFO - 'USER': 'cltbld', 04:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:45 INFO - 'XPC_FLAGS': '0x0', 04:46:45 INFO - 'XPC_SERVICE_NAME': '0', 04:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:45 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 04:46:45 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 04:46:45 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 04:46:45 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 04:46:45 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 04:46:45 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 04:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:49 INFO - Downloading docopt-0.6.1.tar.gz 04:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:49 INFO - Running setup.py install for blobuploader 04:46:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:49 INFO - Running setup.py install for requests 04:46:49 INFO - Running setup.py install for docopt 04:46:50 INFO - Successfully installed blobuploader requests docopt 04:46:50 INFO - Cleaning up... 04:46:50 INFO - Return code: 0 04:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:50 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:50 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 04:46:50 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 04:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:50 INFO - 'HOME': '/Users/cltbld', 04:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:50 INFO - 'LOGNAME': 'cltbld', 04:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:50 INFO - 'MOZ_NO_REMOTE': '1', 04:46:50 INFO - 'NO_EM_RESTART': '1', 04:46:50 INFO - 'PAGER': '/bin/cat', 04:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:50 INFO - 'PWD': '/builds/slave/test', 04:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:50 INFO - 'SHELL': '/bin/bash', 04:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:50 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:50 INFO - 'USER': 'cltbld', 04:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:50 INFO - 'XPC_FLAGS': '0x0', 04:46:50 INFO - 'XPC_SERVICE_NAME': '0', 04:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Wfpee9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Be7HJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DoAf9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xw6GwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-2T5v_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:50 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-crfxIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pOl3dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UDdkuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wAlc0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-9gYMP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-cP6nKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-AwV_Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qfmIBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-db91M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-RqL4T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:51 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-W3qhTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:52 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-39dpBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:52 INFO - Running setup.py install for manifestparser 04:46:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Running setup.py install for mozcrash 04:46:52 INFO - Running setup.py install for mozdebug 04:46:52 INFO - Running setup.py install for mozdevice 04:46:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Running setup.py install for mozfile 04:46:52 INFO - Running setup.py install for mozhttpd 04:46:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozinfo 04:46:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozInstall 04:46:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozleak 04:46:53 INFO - Running setup.py install for mozlog 04:46:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for moznetwork 04:46:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:53 INFO - Running setup.py install for mozprocess 04:46:53 INFO - Running setup.py install for mozprofile 04:46:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Running setup.py install for mozrunner 04:46:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Running setup.py install for mozscreenshot 04:46:54 INFO - Running setup.py install for moztest 04:46:54 INFO - Running setup.py install for mozversion 04:46:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:54 INFO - Cleaning up... 04:46:54 INFO - Return code: 0 04:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:54 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')]} 04:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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')]} 04:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:46:54 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 04:46:54 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 04:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:54 INFO - 'HOME': '/Users/cltbld', 04:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:54 INFO - 'LOGNAME': 'cltbld', 04:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:54 INFO - 'MOZ_NO_REMOTE': '1', 04:46:54 INFO - 'NO_EM_RESTART': '1', 04:46:54 INFO - 'PAGER': '/bin/cat', 04:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:54 INFO - 'PWD': '/builds/slave/test', 04:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:54 INFO - 'SHELL': '/bin/bash', 04:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:46:54 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:54 INFO - 'USER': 'cltbld', 04:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:54 INFO - 'XPC_FLAGS': '0x0', 04:46:54 INFO - 'XPC_SERVICE_NAME': '0', 04:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7moAl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4fFd4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-zaDbSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-TLKLLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JrtRz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JuDUL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-syyC3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7ji1NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wUi3Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:55 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)) 04:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-eH5lKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-n9AMx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-iGZhBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-unyczr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-B51Ty7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-AdY9F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-PuxHba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:56 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)) 04:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:56 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Hi3EBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 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)) 04:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:59 INFO - Downloading blessings-1.6.tar.gz 04:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:59 INFO - Installing collected packages: blessings 04:46:59 INFO - Running setup.py install for blessings 04:46:59 INFO - Successfully installed blessings 04:46:59 INFO - Cleaning up... 04:46:59 INFO - Return code: 0 04:46:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:00 INFO - Reading from file tmpfile_stdout 04:47:00 INFO - Current package versions: 04:47:00 INFO - blessings == 1.6 04:47:00 INFO - blobuploader == 1.2.4 04:47:00 INFO - docopt == 0.6.1 04:47:00 INFO - functools32 == 3.2.3-2 04:47:00 INFO - jsonschema == 2.5.1 04:47:00 INFO - manifestparser == 1.1 04:47:00 INFO - mozInstall == 1.12 04:47:00 INFO - mozcrash == 1.0 04:47:00 INFO - mozdebug == 0.1 04:47:00 INFO - mozdevice == 0.50 04:47:00 INFO - mozfile == 1.2 04:47:00 INFO - mozhttpd == 0.7 04:47:00 INFO - mozinfo == 0.9 04:47:00 INFO - mozleak == 0.1 04:47:00 INFO - mozlog == 3.4 04:47:00 INFO - moznetwork == 0.27 04:47:00 INFO - mozprocess == 0.25 04:47:00 INFO - mozprofile == 0.28 04:47:00 INFO - mozrunner == 6.13 04:47:00 INFO - mozscreenshot == 0.1 04:47:00 INFO - mozsystemmonitor == 0.3 04:47:00 INFO - moztest == 0.8 04:47:00 INFO - mozversion == 1.4 04:47:00 INFO - psutil == 3.1.1 04:47:00 INFO - requests == 1.2.3 04:47:00 INFO - wsgiref == 0.1.2 04:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:00 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')]} 04:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:00 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')]} 04:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:00 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:47:00 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 04:47:00 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 04:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:00 INFO - 'HOME': '/Users/cltbld', 04:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:00 INFO - 'LOGNAME': 'cltbld', 04:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:00 INFO - 'MOZ_NO_REMOTE': '1', 04:47:00 INFO - 'NO_EM_RESTART': '1', 04:47:00 INFO - 'PAGER': '/bin/cat', 04:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:00 INFO - 'PWD': '/builds/slave/test', 04:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:00 INFO - 'SHELL': '/bin/bash', 04:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:47:00 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:00 INFO - 'USER': 'cltbld', 04:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:00 INFO - 'XPC_FLAGS': '0x0', 04:47:00 INFO - 'XPC_SERVICE_NAME': '0', 04:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 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)) 04:47:00 INFO - Cleaning up... 04:47:00 INFO - Return code: 0 04:47:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:00 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')]} 04:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:00 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')]} 04:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:00 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 0x109656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd835df480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, '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.H3OSW40RiT/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.sNgexf3cd0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 04:47:00 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 04:47:00 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 04:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:00 INFO - 'HOME': '/Users/cltbld', 04:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:00 INFO - 'LOGNAME': 'cltbld', 04:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:00 INFO - 'MOZ_NO_REMOTE': '1', 04:47:00 INFO - 'NO_EM_RESTART': '1', 04:47:00 INFO - 'PAGER': '/bin/cat', 04:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:00 INFO - 'PWD': '/builds/slave/test', 04:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:00 INFO - 'SHELL': '/bin/bash', 04:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:47:00 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:00 INFO - 'USER': 'cltbld', 04:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:00 INFO - 'XPC_FLAGS': '0x0', 04:47:00 INFO - 'XPC_SERVICE_NAME': '0', 04:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:00 INFO - Cleaning up... 04:47:00 INFO - Return code: 0 04:47:00 INFO - Running post-action listener: _resource_record_post_action 04:47:00 INFO - Running post-action listener: _start_resource_monitoring 04:47:00 INFO - Starting resource monitoring. 04:47:00 INFO - [mozharness: 2017-04-21 11:47:00.701699Z] Finished create-virtualenv step (success) 04:47:00 INFO - [mozharness: 2017-04-21 11:47:00.702658Z] Running install step. 04:47:00 INFO - Running pre-action listener: _resource_record_pre_action 04:47:00 INFO - Running main action method: install 04:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:00 INFO - Reading from file tmpfile_stdout 04:47:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:01 INFO - Reading from file tmpfile_stdout 04:47:01 INFO - Output received: 04:47:01 INFO - Usage: mozinstall [options] installer 04:47:01 INFO - Options: 04:47:01 INFO - -h, --help show this help message and exit 04:47:01 INFO - -d DEST, --destination=DEST 04:47:01 INFO - Directory to install application into. [default: 04:47:01 INFO - "/builds/slave/test"] 04:47:01 INFO - --app=APP Application being installed. [default: firefox] 04:47:01 INFO - mkdir: /builds/slave/test/build/application 04:47:01 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'] 04:47:01 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 04:47:20 INFO - Reading from file tmpfile_stdout 04:47:20 INFO - Output received: 04:47:20 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:47:20 INFO - Running post-action listener: _resource_record_post_action 04:47:20 INFO - [mozharness: 2017-04-21 11:47:20.938647Z] Finished install step (success) 04:47:20 INFO - [mozharness: 2017-04-21 11:47:20.938775Z] Running run-tests step. 04:47:20 INFO - Running pre-action listener: _resource_record_pre_action 04:47:20 INFO - Running main action method: run_tests 04:47:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:20 INFO - 2017-04-21 04:47:20.951 screenresolution[1882:9360] starting screenresolution argv=screenresolution get 04:47:20 INFO - 2017-04-21 04:47:20.954 screenresolution[1882:9360] Display 0: 1600x1200x32@60 04:47:20 INFO - 2017-04-21 04:47:20.959 screenresolution[1883:9363] starting screenresolution argv=screenresolution list 04:47:20 INFO - Available Modes on Display 0 04:47:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:21 INFO - Intel Iris: 04:47:21 INFO - Chipset Model: Intel Iris 04:47:21 INFO - Type: GPU 04:47:21 INFO - Bus: Built-In 04:47:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:21 INFO - Vendor: Intel (0x8086) 04:47:21 INFO - Device ID: 0x0a2e 04:47:21 INFO - Revision ID: 0x0009 04:47:21 INFO - Displays: 04:47:21 INFO - Display: 04:47:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:21 INFO - Display Serial Number: 1600x1200 60 04:47:21 INFO - Main Display: Yes 04:47:21 INFO - Mirror: Off 04:47:21 INFO - Online: Yes 04:47:21 INFO - Rotation: Supported 04:47:21 INFO - Return code: 0 04:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:21 INFO - Python 2.7.3 04:47:21 INFO - Return code: 0 04:47:21 INFO - grabbing minidump binary from tooltool 04:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:21 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 0x109434d30>, '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 0x10935adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109429be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:21 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 04:47:21 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 04:47:21 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 04:47:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:21 INFO - Return code: 0 04:47:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:21 INFO - ENV: RUST_BACKTRACE is now 1 04:47:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:21 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 04:47:21 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --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 04:47:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3OSW40RiT/Render', 04:47:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:21 INFO - 'HOME': '/Users/cltbld', 04:47:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:21 INFO - 'LOGNAME': 'cltbld', 04:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:21 INFO - 'MOZ_NO_REMOTE': '1', 04:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:21 INFO - 'NO_EM_RESTART': '1', 04:47:21 INFO - 'PAGER': '/bin/cat', 04:47:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:21 INFO - 'PWD': '/builds/slave/test', 04:47:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:21 INFO - 'RUST_BACKTRACE': '1', 04:47:21 INFO - 'SHELL': '/bin/bash', 04:47:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sNgexf3cd0/Listeners', 04:47:21 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 04:47:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:21 INFO - 'USER': 'cltbld', 04:47:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:21 INFO - 'XPC_FLAGS': '0x0', 04:47:21 INFO - 'XPC_SERVICE_NAME': '0', 04:47:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:21 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 04:47:21 INFO - mozversion application_buildid: 20170421030241 04:47:21 INFO - mozversion application_changeset: dd530a59750adcaa0d48fa4f69b0cdb52715852a 04:47:21 INFO - mozversion application_display_name: Nightly 04:47:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:21 INFO - mozversion application_name: Firefox 04:47:21 INFO - mozversion application_remotingname: firefox 04:47:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:21 INFO - mozversion application_vendor: Mozilla 04:47:21 INFO - mozversion application_version: 55.0a1 04:47:21 INFO - mozversion platform_buildid: 20170421030241 04:47:21 INFO - mozversion platform_changeset: dd530a59750adcaa0d48fa4f69b0cdb52715852a 04:47:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:21 INFO - mozversion platform_version: 55.0a1 04:47:21 INFO - using testdate: 1492775241 04:47:21 INFO - actual date: 1492775241 04:47:21 INFO - starting webserver on 'localhost:49382' 04:47:21 INFO - SUITE-START | Running 2 tests 04:47:21 INFO - TEST-START | dromaeo_css 04:47:21 INFO - operating with platform_type : mac_ 04:47:21 INFO - Initialising browser for dromaeo_css test... 04:47:21 INFO - TEST-INFO | started process 1893 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpt5Ve0F/profile http://localhost:49382/getInfo.html) 04:47:24 INFO - PID 1893 | __metrics Screen width/height:1600/1200 04:47:24 INFO - PID 1893 | colorDepth:24 04:47:24 INFO - PID 1893 | Browser inner width/height: 1024/689 04:47:24 INFO - PID 1893 | __metrics 04:47:24 INFO - PID 1893 | 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" 04:47:24 INFO - PID 1893 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:25 INFO - TEST-INFO | 1893: exit 0 04:47:25 INFO - Browser initialized. 04:47:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:25 INFO - TEST-INFO | started process 1896 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpt5Ve0F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:37 INFO - PID 1896 | RSS: Main: 243060736 04:47:37 INFO - PID 1896 | 04:50:42 INFO - PID 1896 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49382/tests/dromaeo/cssquery-ext.html) 04:50:44 INFO - PID 1896 | RSS: Main: 415338496 04:50:44 INFO - PID 1896 | 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | A coding exception was thrown and uncaught in a Task. 04:52:27 INFO - PID 1896 | 04:52:27 ERROR - PID 1896 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:27 INFO - PID 1896 | Full stack: 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | A coding exception was thrown and uncaught in a Task. 04:52:27 INFO - PID 1896 | 04:52:27 ERROR - PID 1896 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:27 INFO - PID 1896 | Full stack: 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | A coding exception was thrown and uncaught in a Task. 04:52:27 INFO - PID 1896 | 04:52:27 ERROR - PID 1896 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:27 INFO - PID 1896 | Full stack: 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | ************************* 04:52:27 INFO - PID 1896 | A coding exception was thrown and uncaught in a Task. 04:52:27 INFO - PID 1896 | 04:52:27 ERROR - PID 1896 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:27 INFO - PID 1896 | Full stack: 04:52:27 INFO - PID 1896 | ************************* 04:53:47 INFO - PID 1896 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-ext.html (next: http://localhost:49382/tests/dromaeo/cssquery-jquery.html) 04:53:48 INFO - PID 1896 | RSS: Main: 367570944 04:53:48 INFO - PID 1896 | 04:56:50 INFO - PID 1896 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49382/tests/dromaeo/cssquery-mootools.html) 04:56:50 INFO - PID 1896 | RSS: Main: 336359424 04:56:50 INFO - PID 1896 | 04:59:53 INFO - PID 1896 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49382/tests/dromaeo/cssquery-prototype.html) 04:59:53 INFO - PID 1896 | RSS: Main: 332689408 04:59:53 INFO - PID 1896 | 05:02:57 INFO - PID 1896 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49382/tests/dromaeo/cssquery-yui.html) 05:02:58 INFO - PID 1896 | RSS: Main: 335929344 05:02:58 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | Cycle 1(1): loaded http://localhost:49382/tests/dromaeo/cssquery-yui.html (next: http://localhost:49382/tests/dromaeo/cssquery-dojo.html) 05:06:00 INFO - PID 1896 | RSS: Main: 378417152 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | __start_tp_report 05:06:00 INFO - PID 1896 | _x_x_mozilla_page_load 05:06:00 INFO - PID 1896 | _x_x_mozilla_page_load_details 05:06:00 INFO - PID 1896 | |i|pagename|runs| 05:06:00 INFO - PID 1896 | |0;dojo.html;3534.3638145133864;3548.2371290172614;3551.5915669697984;3583.910402239942;3621.1128273572963;5942.435468630484;6098.847528811782;6122.448979591842;6140.754369825202;6173.567850250484;6090.299615544213;6124.075808605194;6131.529590167202;6142.652254521286;6206.255249370082;5291.788328466876;5298.072837253465;5323.254744335796;5336.146216605344;5342.225377320306;5374.7850085996515;5411.215373770801;5451.209574611679;5457.399686034533;5504.972475137639;4447.822087116511;5252;5313.229581710669;5413;5425.755840987145;4395.230834603932;5327.680339179662;5353.411124776271;5373.704446255454;5421.512063914227;5274.182501712241;5299.470052994709;5306.761195746162;5315.202719592092;5316.043112239795;5971.820845374602;6047.879042419127;6127.142200091991;6133.172021777048;6160.383961603804;6322.620642761449;6328.810135695937;6463.095166676669;6549.770758023494;6561.704723287464;6612.471002319803;6616;6623.569467984614;6643.734250629969;6644.4020038196795;6170.50635949123;6239.376062393815;6244.188255526752;6245.094461303131;6247.250329960389;6535.803925882231;6584.209894812653;6694.49791265657;6797.116374871334;6806.693698783567;6230.314665386803;6290.402411770874;6307.810765677037;6397.328280530571;6401.967990160019;6448.548601597937;6552.901706474407;6579.1447111876105;6580.2103747549645;6588.868222635616;6508.60948343101;6513.478921686254;6524.543281970216;6524.836879077966;6538.803835884931;6258.186435763413;6313.05304204373;6560.081588577603;6561.901571476432;6587.736490540325;5160.354955630546;5166.044281807877;5167.199084141964;5170.586353091744;5224.399194092728;4682.367880336179;4698.1778188816825;4709.175894218498;4721.527847215251;4733.550312720355;6244.625322480666;6255.186825712628;6279.309275979638;6285.151504546919;6286.339934306923;6639.900401493885;6655.234648015444;6666.500012499082;6668.199816022011;6678.866422671519;6128.014278093809;6144.678894037804;6193.225846769154;6257.124002639634;6272.717727702173;5855.121731740273;5881;5884.735186916599;5888.352281249059;5926.644401335933;6789.25318214996;6899.137607799025;6900.378965893094;6908.758193463204;6913.274106218774;6347.39699728525;6403.775867844789;6412.326705695835;6654.667266636746;6663.666816659244;5734.942650573441;6679.632620205741;6724.092247546519;6727.024581435567;6806.285340039224;6524.380183882524;6532.05285233629;6541.953287473982;6550.868982620225;6574.868502629825;6575.704093315908;6639.7012134455035;6644.435223006099;6653.933460665331;6665.566738162004;5160.200168973815;5487.533559647474;6405.807825765234;6416.069669897745;6422.839429014312;6233.158523599437;6264.31092579825;6265.561410701207;6271.717772700331;6273.341299163522;5303.7878484860175;6234.594751341148;6253.905566525931;6257.655828929453;6289.213848268966;6404.423601875854;6411.96794016027;6412.679366031586;6419.4864410846085;6425.421712045938;6264.718087686157;6270.811875643738;6280.591761535668;6288.622682638873;6295.685215739286 05:06:00 INFO - PID 1896 | |1;ext.html;740.7333359990403;787.354369417078;808.8301456694093;1120.6862078617985;1136.2330426961798;26954.5956810648;36215.81892090539;36365.72719954799;36425;36516.81741591295;31946.520802187984;38354.61645383545;38397.04007399816;38525.42211866824;38643.227135457346;5984.875369243921;8291.83416331673;8435.873461898076;8438.11399803021;8445.36659750518;4239.300515414953;4287.807048682801;4297.785110744466;4360.476742790854;4534.274516077428;8245.216704413102;8402.915970840306;8403.327733781283;8410.243078122967;8450.535220562866;8367.372447066495;8408.159184081604;8418.663253469855;8434.072252052269;8439.620217090214;8232.423730338818;8277.668893244323;8307.460015098999;8307.750767476986;8320.542370169638;36418.81790591057;36556.26887462263;36578.81710591457;36596;36699.633003670155;3540.7875527468177;3605.170810713524;3632.219072899339;3634.018814919983;3634.491171236029;30027.69972300271;30072.24819379533;30084.54873176882;30143;30145.09564713062;3051.359214564944;3094.4430002599524;3110.377924415126;3116.1586371679746;3122.469180239365;288570;294426.52786736144;295143;295207;296929;48097.75951120222;48300.758496207294;48316;48387.19353677581;48450.515494845306;49934;50009.4995250236;50018.49981500211;50090.24864627034;50104.498955009985;13653.112547684368;13777.173369597856;13779.517716879862;13782.448702052006;13785.586432407044;11253.831192532118;11264;11269.774604508028;11292.661220163409;11303.265287756269;10617.84073238902;10745.14038876888;11919.165658404001;12036.555613326282;12174.965127964046;5353.197020446886;5409.594280428983;5413.7834486620095;5419.783208671688;5449.455054494519;957.2246480350938;988.125508924607;1012.9139023183112;1036.5750042482546;1071.989280107189;21375;22363.88818055932;23213.651795223086;23292;24106.15628453031;970.9174720148867;1113.9721506962392;1145.8510393648771;1152.3546813784308;1168.4683469021575;11956.58151964677;12193.756124877631;12222.755544889053;12226.694332641755;12591.37043147839;295809;296458;296506;296657;297025;53007;53021.469785302426;53139.734301329016;53194.202086968726;53261;1400.43982407038;1470.8970372073852;1506.261931653482;1551.4957638767446;1559.3684557754127;22002.679839209697;23594.056237750297;23644.645330320403;23757.406064848517;24088;29432.705672942997;35697.643023569435;35720.82139589285;35756;35791.46312805258;231036;275092;275464;275608;276610;33460.83269583636;33557.328853423285;33579.66420335863;33621.15947101342;33787.15532111619;37053.44419833651;37213.06967325838;37490;43562.56437435712;44788.55211447974;28679.283017924718;30111.849440752656;30320.5451918217;30365.56603773631;30394.720395969947;28451.28871778222;29204.853975730835;29769;30014.54978175373;30358.544621831134;36023;36123.819380902925;36209.63790362168;36223.63776362203;36228;28748.88466849101;30121;30158.547621785252;30359.848200759738;30540.778368864998;23504.52990940206;23572.41068973221;23588.764112358658;23926.803659817288;23968.76031239735 05:06:00 INFO - PID 1896 | |2;jquery.html;422.3075466844004;424.38040460927033;436.3716248602011;449.47411528511645;458.3399904138043;19151.808481915195;20899.477513062182;21503.24738634148;21681;21727.23954661587;21473.355799326044;21790.89104554479;21791.67312490314;22136.225232116878;22649;5745.856353591173;6075.787347442841;6084.148219249309;6085.300190478085;6086.330503644595;5691.4877661010505;5970.6119102258435;6021.789237376693;6041.335453100178;6042.516598672096;5770.6249093808765;6003.459688628022;6019.759209631609;6021.909671354933;6024.759009639609;5855;5956.583039187259;5971.313298970631;5975.402459754033;5993.760249590011;5262.131748261532;5269.262303277545;5320.122179840322;5322.1484562470205;5326.067938110815;26106.648137131844;26443;26460.60309095365;26817.793199306077;27048.59427108595;2274.1130958926033;2285.440067183534;2320.6519022146645;2320.953580928389;2323.1752727781563;16962.660746785117;17334.7399789002;17484.47546573605;17569.486102779494;17696.469105926844;1869.8597605179666;2172.663237198237;2179.574982878339;2182.9563408731897;2187.453136715821;159231;160100;161528.19235903746;161797;163122;11007.61473348445;11809.763804723858;11976.940115299367;12070.034397248199;12141.817872731739;15990;16037.278322475517;16043.438479653156;16050.518484445485;16053.277602507915;8473.915260847436;8699.43453675509;8720.476771393736;8848.513331766686;8900.73297801067;6952.443804495628;8282.590644893446;8342.288756154274;8530.573471326408;8557.657693692307;6294.779682711175;7350.191478937312;7518.812029699192;7547.245275472409;7566.35685966688;2048.3445297504954;2055.8663686860605;2057.1051592557287;2062.123597471069;2239.6976408185014;948.5304774136708;952.4523399045438;977.9755506112405;1008.253892119826;1020.5815615597569;17809.554761131076;20557;20668.17327306921;20782.272620458512;21263.8936805315;943.2878176976338;1008.7592261518226;1023.488255872064;1035.570238351091;1036.7097212780434;9752;9763.560639771227;10729.088027517748;10920.2901811382;12478.313692746986;575409;583704.0814795899;586690;587710;590776;123183.76816231903;125460;128629;134259;140104;1171.7949358862336;1223.4127618742875;1223.590097317391;1245;1246.9002479801775;21098.156073756876;21847.67228491542;21920.342389728332;21973.340799776033;22020.779792201873;53936.1005434099;54569.908601826945;55560.44351573188;55974;56307;75952.62023689847;76480.61759691166;76656.23343766714;77073.45853083019;77856.61071694606;8623.094575069777;8821.382503224713;8877.644894204417;8963.417377870417;9096.590653420744;13748.243846588533;13807.51673691416;13857.37641806101;14195.716085678436;14254.786178207129;10131.240156988402;11231.438428078727;11805.527778888749;12005.159638825548;12222.572209972608;10849.837252441377;11268.08374684256;11401.372924489233;11662.88337116652;11842.28946263227;11875;12028.218165819193;12329.321887296284;12381.319027453577;12484.438200280827;11582.667993180556;12043.337616431181;12938.676533086747;13194.076414651267;13317.934565234564;10204.336718113298;11220.821813709443;11775;12063.155579109378;12220.572279970158 05:06:00 INFO - PID 1896 | |3;mootools.html;1211.9697007574814;1251.5181655062802;1294.825198598189;1453.2806260900857;1466.7433199190139;9758.756031099218;11553.942230288858;11858.644240672773;11873.940630296858;11878.990285825716;11480.655580332583;11589.6523104307;11591.710207244823;11607.419629018537;11640.883591164085;2434.245383930983;2461.0155937625004;2465.457599328145;2472.184179220862;2479.3305807431984;2108.9683654745113;2176.85850419723;2245.9663105053437;2341.496578235679;2346.307839187435;2492.0530198524534;2505.4613258149493;2524.192258477288;2529.9747002530016;2539.4540173862706;2495.1641200197955;2531.227975467482;2532.9746702532925;2533.0754274689607;2534.3410713214603;2426.5268272686835;2453.914113006036;2472.171822439485;2475.393528585508;2480.541099896525;11406.942965285203;11527.884721152848;11539.653810385618;11561.364124973123;11598.956093951585;6435.356464353574;6676.098726671886;6678.098456708331;6680.498962577777;6717.16035495563;3764.642358975893;3937.3503371943593;4125.711200215986;4256.127493863782;4276.636485898703;1248.7814632439377;1258.6979125009932;1280.8847203751707;1297.8118172864977;1304.706441050756;15942.60143496422;16319.347226110942;16339;16340.591485212846;16422.507324780276;5754;5888.234529511136;5900.232969713909;5908;5998.310194327621;13661.248631325174;13679.974001949893;13701.794473082911;13704.52034178799;13725.794113088312;6769.8646027079185;6775.966120169368;6780.220274668476;6786.8642627148165;6790.932090679129;5188.792448302102;6069.150318955261;6146.108814221912;6207.472364848948;6229.626222426669;4152.688548358825;4232.534421213664;4241.151769646021;4248.1078973415315;4255.6169944705125;1305.9477620895059;1347.1782212850153;1438.8273407191205;1481.7258807120718;1482.1107335598554;769.7305942919933;771.7574704725388;784.5410434895535;789.1753117991713;804.9897378789582;5970.582059255898;6289.905651415233;6376.904346434807;6438;6803.7618683345845;907.7458311672742;921.8202450522084;926.7266156483853;938.1041105743998;941.6562954521551;3203.439398105322;3722.683571896419;3796.0130366105013;3800.144967382372;3819.713521485844;14402.927985360217;14562.927185364006;14576.927115364355;14581.708365832836;14784.63038424048;14235.857641423454;14518.274086295643;14690.824734021253;14692.045017073857;14724;7664.233576642291;8330.208630180245;8338.124496927736;8365.038020627706;8371.581420929051;6336.366363363627;6366.840828979127;6504.447121994684;6525.804505129114;6537.05212744159;13012.024098192484;13044.347782610641;13062.281574513492;13261.734765304833;13399.665008374868;13418.060735748404;13528.661783455493;13564.93217533906;13599.252041137437;13712.314384280546;9254.074592540692;9372.859407108763;9482.810343792948;9514.809703805746;9530.761730956781;10334.431606261727;10410.895891040993;10432.947835260775;10441.843372349269;10442.791144177227;8786.253168480494;9053.456792592466;9072.909270907207;9173.633054677739;9231.907680923105;8818.5590720465;8852.955735221283;8872.423292485968;8904.19862212404;8911.975122860695;7849.450538462253;8053.194680532134;8068.515889046676;8068.677252910053;8069.677212911418;5733;5754.9424505754405;5857.560682948711;5876.236089308362;5996.610220335664;5753.165790960371;5874.206982057368;6025.698715064142;6051.546134039877;6106.053561697944 05:06:00 INFO - PID 1896 | |4;prototype.html;395.99802000989996;404.40350483037514;406.88200421877656;407.34417587683805;409.42271397329773;5770.538356931446;5774.5091667208335;5840.335504381253;5843.941560584398;5873.706314684265;4632.409882341187;5407.864803379917;5426.375966763823;5559.833205003846;5699.715014249292;3638.5088013118157;4372.73763574185;4373.781310934456;4377.277749171399;4410.933835992447;4371.704854951145;4388.319810429389;4402.7578483183415;4411.09572537629;4438.800253988578;3720.21875406165;4247.681423893205;4323.632491238232;4345.174416860802;4390.297552391618;3723.5531736191697;3797.9240415191816;4021.2761702893467;4336.262835318003;4369.781510924473;3590.784552926833;3822.4266360045935;3880.7581573896364;3887.358585833334;3888;4547.272436410191;4643.442786865564;5243.846353802158;5311.256424100629;5520.447955204488;4590.449146102455;4972.328735620717;5169.147090730025;5221.556167725748;5235.293235413246;6044.123602077718;6045.637261764308;6052.909206361908;6113.144159817629;6159.938400616026;3463.930721385583;3901.6878649708237;4141.213169497816;4378.839607504014;4395.604395604379;5568.554515638739;5802.94197058024;6277.591956522811;6324;6358.841028974266;4119.176164766998;4213.5154457237195;4216.494020717472;4217.520545549934;4224.957750422518;3373.865045398157;4096.5903409659395;4235.682323825726;4285.692863676609;4292.270314046619;4168.583141685868;4293.2701440755145;4594.471635761864;4655.975685349218;4896.46138924718;4800.9274064598685;5938.298074376148;5947.167396564484;5976.370397025295;5993.61041532299;1195.4082729049003;1379.92410417426;1437.360374633278;1451.8112645356036;1452.469848505309;955.4219697083304;978.8042391521724;984.5569493727851;995.6664517386612;997.9251556133319;4966.90066198674;5605.523530499871;5838.299404071454;5841.970790146107;5864.32560255576;5291.576673866081;6001.789937352171;6234.719437625317;6263.248410190807;6276.529260305495;4948.604111671058;5349.438308977579;5770.769169233267;5796.000379868939;5827;3100.093442532826;3238.36851813894;3276.2300859298048;3286.7370610351113;3291.8024918504966;6457.773977910844;6473.996530537775;6491.805245842538;6494.642794646245;6592.76925307612;5218.582513398919;5414.7021913795115;6384.361563843579;6403.551751377358;6502.869942601122;5380.78476860929;6097.4817140543555;6114.144019837227;6131.681688437007;6450.709718062604;5495.780168793363;6104.748526551957;6187.535934804998;6199.3490683477585;6251.624902505864;5169.948300516947;5265.4997775211295;6118.174046503665;6123.724432400463;6135.570510064431;6035.879282414415;6172.197614310111;6346.873062538816;6379.553431259767;6482.546221764431;4133.91732165361;4204.474440694913;4204.642605378454;4221.606869732919;4243.575642435731;4617.376654151646;5724.398938111438;6226.937730622636;6268.435840774352;6272.905906411316;5732.34078081026;5998.890205312031;6111.786087486917;6115.785947491817;6134.2332208473945;6067.817965461043;6108.267007959073;6115.205023346936;6123.173371594956;6145.83229186471;5756.251687280626;5964.7912323068485;5997.880042399041;6007.459328660441;6056;5722.971385143048;5795.710214489343;6066.514678825595;6076.33160352352;6076.908846367396;5150.278960945546;5304.496072873225;5305.987958183094;5903.498202652822;5995.5803093783015 05:06:00 INFO - PID 1896 | |5;yui.html;705.2207310921428;851;854.3976496569915;858.1632907914784;873.6854732296374;10758.623448179314;13120.868791312085;17275.56811079722;17605.64788704225;17647.5588110297;16225.26986285617;16296.75554866675;16370.263338149782;16391.18044097796;16410.507684769476;930.1953809954391;967.2068903499134;976.6484065736329;977.4965892565334;978.2760757039811;658.2561705273058;677.6814896998403;681.4003676764465;687.1204857782047;687.1410736579276;1002.6089824968268;1019.0115587879744;1036.3678156324636;1040.9167266618651;1042.5360714482058;1028.1158203944601;1031.4224034540682;1034.312182398704;1035.6841163445147;1042.7810159866438;510.4206725366735;765.7740966414921;769.273036980054;769.9759320104248;781.6287263549825;11931.343776092312;15380;15687.215639217993;15716.92141539285;15787.684246315124;15621.921890390475;16532.09073500969;16767.993920364817;16768.83231167697;16769.664606707796;13342.33288335589;13693.657658558615;13838.723225535434;13862.098963567436;13871.237081960488;3402.5576675032335;3429.091290807938;3446.362422951737;3523.1016090896915;3579.6062433132333;96312;101699.49150254275;103265;104457.47771261171;105650.47174764077;11226.494807733672;13110.213387196798;13367.732645347232;13506.932465337806;13599.388027538784;17985.640287194183;19291.807081929;23550.64674029891;24665.136720214705;24788.876055619607;7458.925410745932;7698.807529811799;7703.499272547267;7709.575973321409;7712.421568382394;3744.4196149596855;3771.132639492932;3790.6967442604528;3831.9042023949623;3846.9807650961566;3855.4409610606303;4341.869743907688;4436.866893993185;4449.132419178294;4470.776461176928;913.3697748553477;936.438137117724;955.412421360858;955.9139677429065;957.2007373842919;650.1093501902424;673.5016088094873;675.2808259203932;682.3858527325348;692.9916970807463;10823.188260880466;11118.944405277922;11180.888191117985;11779.88220117805;11813.88186118145;625.2122325869437;644.2719726708789;650.778735230024;672.1497305908031;678.1252184681705;5141.203113517411;5174.741262936838;5203.453637368022;5259.684418934876;5415.647982881179;91990;93333;93796;94826.52586737022;96022.03977960271;75076.24923750802;78754;82159;82995.75506367409;83685;58131.837363252496;65418.67290663516;68842.87769640902;69424;71286;10612.0449159576;10723.30298530593;10810.56757729682;10941.343519388862;10980.1215902726;39046.516501830956;39402.60597393989;40065.799671001456;40913.795431022656;41027.1794564113;50766.7308317295;50795.23807142822;50951.74524127356;51687;52939;11771.470283837076;13463.663408414868;13530.729385412433;13870;13958.860411395755;15004.474843380429;15036.097834129987;15065.09609423438;15290.770638440656;15305;13939.16365018102;14044.859551404765;14099;14099.224542650252;14266.785998209827;13893.930530347283;14000.229987350793;14122.858771412566;14184;14301.141931484144;13762.862371376157;13833.861661383256;13884.652883677989;13919.373628186959;14056.437742490185;9079.409838360485;10313.845292320471;10437.791244175225;10454.111400530735;10617.362958222531;10936.945315273373;11191.66425007251;11325.716857078309;11353.659390218307;11682.532698692297 05:06:00 INFO - PID 1896 | __end_tp_report 05:06:00 INFO - PID 1896 | __start_cc_report 05:06:00 INFO - PID 1896 | _x_x_mozilla_cycle_collect,1870 05:06:00 INFO - PID 1896 | __end_cc_report 05:06:00 INFO - PID 1896 | __startTimestamp1492776360746__endTimestamp 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | ------- Summary: start ------- 05:06:00 INFO - PID 1896 | Number of tests: 6 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | [#0] dojo.html Cycles:165 Average:6034.45 Median:6264.72 stddev:715.18 (11.4%) stddev-sans-first:689.95 05:06:00 INFO - PID 1896 | Values: 3534.4 3548.2 3551.6 3583.9 3621.1 5942.4 6098.8 6122.4 6140.8 6173.6 6090.3 6124.1 6131.5 6142.7 6206.3 5291.8 5298.1 5323.3 5336.1 5342.2 5374.8 5411.2 5451.2 5457.4 5505.0 4447.8 5252.0 5313.2 5413.0 5425.8 4395.2 5327.7 5353.4 5373.7 5421.5 5274.2 5299.5 5306.8 5315.2 5316.0 5971.8 6047.9 6127.1 6133.2 6160.4 6322.6 6328.8 6463.1 6549.8 6561.7 6612.5 6616.0 6623.6 6643.7 6644.4 6170.5 6239.4 6244.2 6245.1 6247.3 6535.8 6584.2 6694.5 6797.1 6806.7 6230.3 6290.4 6307.8 6397.3 6402.0 6448.5 6552.9 6579.1 6580.2 6588.9 6508.6 6513.5 6524.5 6524.8 6538.8 6258.2 6313.1 6560.1 6561.9 6587.7 5160.4 5166.0 5167.2 5170.6 5224.4 4682.4 4698.2 4709.2 4721.5 4733.6 6244.6 6255.2 6279.3 6285.2 6286.3 6639.9 6655.2 6666.5 6668.2 6678.9 6128.0 6144.7 6193.2 6257.1 6272.7 5855.1 5881.0 5884.7 5888.4 5926.6 6789.3 6899.1 6900.4 6908.8 6913.3 6347.4 6403.8 6412.3 6654.7 6663.7 5734.9 6679.6 6724.1 6727.0 6806.3 6524.4 6532.1 6542.0 6550.9 6574.9 6575.7 6639.7 6644.4 6653.9 6665.6 5160.2 5487.5 6405.8 6416.1 6422.8 6233.2 6264.3 6265.6 6271.7 6273.3 5303.8 6234.6 6253.9 6257.7 6289.2 6404.4 6412.0 6412.7 6419.5 6425.4 6264.7 6270.8 6280.6 6288.6 6295.7 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | [#1] ext.html Cycles:180 Average:43157.41 Median:17534.49 stddev:75080.87 (428.2%) stddev-sans-first:75223.95 05:06:00 INFO - PID 1896 | Values: 740.7 787.4 808.8 1120.7 1136.2 26954.6 36215.8 36365.7 36425.0 36516.8 31946.5 38354.6 38397.0 38525.4 38643.2 5984.9 8291.8 8435.9 8438.1 8445.4 4239.3 4287.8 4297.8 4360.5 4534.3 8245.2 8402.9 8403.3 8410.2 8450.5 8367.4 8408.2 8418.7 8434.1 8439.6 8232.4 8277.7 8307.5 8307.8 8320.5 36418.8 36556.3 36578.8 36596.0 36699.6 3540.8 3605.2 3632.2 3634.0 3634.5 30027.7 30072.2 30084.5 30143.0 30145.1 3051.4 3094.4 3110.4 3116.2 3122.5 288570.0 294426.5 295143.0 295207.0 296929.0 48097.8 48300.8 48316.0 48387.2 48450.5 49934.0 50009.5 50018.5 50090.2 50104.5 13653.1 13777.2 13779.5 13782.4 13785.6 11253.8 11264.0 11269.8 11292.7 11303.3 10617.8 10745.1 11919.2 12036.6 12175.0 5353.2 5409.6 5413.8 5419.8 5449.5 957.2 988.1 1012.9 1036.6 1072.0 21375.0 22363.9 23213.7 23292.0 24106.2 970.9 1114.0 1145.9 1152.4 1168.5 11956.6 12193.8 12222.8 12226.7 12591.4 295809.0 296458.0 296506.0 296657.0 297025.0 53007.0 53021.5 53139.7 53194.2 53261.0 1400.4 1470.9 1506.3 1551.5 1559.4 22002.7 23594.1 23644.6 23757.4 24088.0 29432.7 35697.6 35720.8 35756.0 35791.5 231036.0 275092.0 275464.0 275608.0 276610.0 33460.8 33557.3 33579.7 33621.2 33787.2 37053.4 37213.1 37490.0 43562.6 44788.6 28679.3 30111.8 30320.5 30365.6 30394.7 28451.3 29204.9 29769.0 30014.5 30358.5 36023.0 36123.8 36209.6 36223.6 36228.0 28748.9 30121.0 30158.5 30359.8 30540.8 23504.5 23572.4 23588.8 23926.8 23968.8 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | [#2] jquery.html Cycles:180 Average:36706.94 Median:12015.31 stddev:98907.98 (823.2%) stddev-sans-first:99147.92 05:06:00 INFO - PID 1896 | Values: 422.3 424.4 436.4 449.5 458.3 19151.8 20899.5 21503.2 21681.0 21727.2 21473.4 21790.9 21791.7 22136.2 22649.0 5745.9 6075.8 6084.1 6085.3 6086.3 5691.5 5970.6 6021.8 6041.3 6042.5 5770.6 6003.5 6019.8 6021.9 6024.8 5855.0 5956.6 5971.3 5975.4 5993.8 5262.1 5269.3 5320.1 5322.1 5326.1 26106.6 26443.0 26460.6 26817.8 27048.6 2274.1 2285.4 2320.7 2321.0 2323.2 16962.7 17334.7 17484.5 17569.5 17696.5 1869.9 2172.7 2179.6 2183.0 2187.5 159231.0 160100.0 161528.2 161797.0 163122.0 11007.6 11809.8 11976.9 12070.0 12141.8 15990.0 16037.3 16043.4 16050.5 16053.3 8473.9 8699.4 8720.5 8848.5 8900.7 6952.4 8282.6 8342.3 8530.6 8557.7 6294.8 7350.2 7518.8 7547.2 7566.4 2048.3 2055.9 2057.1 2062.1 2239.7 948.5 952.5 978.0 1008.3 1020.6 17809.6 20557.0 20668.2 20782.3 21263.9 943.3 1008.8 1023.5 1035.6 1036.7 9752.0 9763.6 10729.1 10920.3 12478.3 575409.0 583704.1 586690.0 587710.0 590776.0 123183.8 125460.0 128629.0 134259.0 140104.0 1171.8 1223.4 1223.6 1245.0 1246.9 21098.2 21847.7 21920.3 21973.3 22020.8 53936.1 54569.9 55560.4 55974.0 56307.0 75952.6 76480.6 76656.2 77073.5 77856.6 8623.1 8821.4 8877.6 8963.4 9096.6 13748.2 13807.5 13857.4 14195.7 14254.8 10131.2 11231.4 11805.5 12005.2 12222.6 10849.8 11268.1 11401.4 11662.9 11842.3 11875.0 12028.2 12329.3 12381.3 12484.4 11582.7 12043.3 12938.7 13194.1 13317.9 10204.3 11220.8 11775.0 12063.2 12220.6 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | [#3] mootools.html Cycles:180 Average:7060.48 Median:3743.66 stddev:4499.48 (120.2%) stddev-sans-first:4490.64 05:06:00 INFO - PID 1896 | Values: 1212.0 1251.5 1294.8 1453.3 1466.7 9758.8 11553.9 11858.6 11873.9 11879.0 11480.7 11589.7 11591.7 11607.4 11640.9 2434.2 2461.0 2465.5 2472.2 2479.3 2109.0 2176.9 2246.0 2341.5 2346.3 2492.1 2505.5 2524.2 2530.0 2539.5 2495.2 2531.2 2533.0 2533.1 2534.3 2426.5 2453.9 2472.2 2475.4 2480.5 11406.9 11527.9 11539.7 11561.4 11599.0 6435.4 6676.1 6678.1 6680.5 6717.2 3764.6 3937.4 4125.7 4256.1 4276.6 1248.8 1258.7 1280.9 1297.8 1304.7 15942.6 16319.3 16339.0 16340.6 16422.5 5754.0 5888.2 5900.2 5908.0 5998.3 13661.2 13680.0 13701.8 13704.5 13725.8 6769.9 6776.0 6780.2 6786.9 6790.9 5188.8 6069.2 6146.1 6207.5 6229.6 4152.7 4232.5 4241.2 4248.1 4255.6 1305.9 1347.2 1438.8 1481.7 1482.1 769.7 771.8 784.5 789.2 805.0 5970.6 6289.9 6376.9 6438.0 6803.8 907.7 921.8 926.7 938.1 941.7 3203.4 3722.7 3796.0 3800.1 3819.7 14402.9 14562.9 14576.9 14581.7 14784.6 14235.9 14518.3 14690.8 14692.0 14724.0 7664.2 8330.2 8338.1 8365.0 8371.6 6336.4 6366.8 6504.4 6525.8 6537.1 13012.0 13044.3 13062.3 13261.7 13399.7 13418.1 13528.7 13564.9 13599.3 13712.3 9254.1 9372.9 9482.8 9514.8 9530.8 10334.4 10410.9 10432.9 10441.8 10442.8 8786.3 9053.5 9072.9 9173.6 9231.9 8818.6 8853.0 8872.4 8904.2 8912.0 7849.5 8053.2 8068.5 8068.7 8069.7 5733.0 5754.9 5857.6 5876.2 5996.6 5753.2 5874.2 6025.7 6051.5 6106.1 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | [#4] prototype.html Cycles:180 Average:4890.78 Median:5461.08 stddev:1505.32 (27.6%) stddev-sans-first:1471.25 05:06:00 INFO - PID 1896 | Values: 396.0 404.4 406.9 407.3 409.4 5770.5 5774.5 5840.3 5843.9 5873.7 4632.4 5407.9 5426.4 5559.8 5699.7 3638.5 4372.7 4373.8 4377.3 4410.9 4371.7 4388.3 4402.8 4411.1 4438.8 3720.2 4247.7 4323.6 4345.2 4390.3 3723.6 3797.9 4021.3 4336.3 4369.8 3590.8 3822.4 3880.8 3887.4 3888.0 4547.3 4643.4 5243.8 5311.3 5520.4 4590.4 4972.3 5169.1 5221.6 5235.3 6044.1 6045.6 6052.9 6113.1 6159.9 3463.9 3901.7 4141.2 4378.8 4395.6 5568.6 5802.9 6277.6 6324.0 6358.8 4119.2 4213.5 4216.5 4217.5 4225.0 3373.9 4096.6 4235.7 4285.7 4292.3 4168.6 4293.3 4594.5 4656.0 4896.5 4800.9 5938.3 5947.2 5976.4 5993.6 1195.4 1379.9 1437.4 1451.8 1452.5 955.4 978.8 984.6 995.7 997.9 4966.9 5605.5 5838.3 5842.0 5864.3 5291.6 6001.8 6234.7 6263.2 6276.5 4948.6 5349.4 5770.8 5796.0 5827.0 3100.1 3238.4 3276.2 3286.7 3291.8 6457.8 6474.0 6491.8 6494.6 6592.8 5218.6 5414.7 6384.4 6403.6 6502.9 5380.8 6097.5 6114.1 6131.7 6450.7 5495.8 6104.7 6187.5 6199.3 6251.6 5169.9 5265.5 6118.2 6123.7 6135.6 6035.9 6172.2 6346.9 6379.6 6482.5 4133.9 4204.5 4204.6 4221.6 4243.6 4617.4 5724.4 6226.9 6268.4 6272.9 5732.3 5998.9 6111.8 6115.8 6134.2 6067.8 6108.3 6115.2 6123.2 6145.8 5756.3 5964.8 5997.9 6007.5 6056.0 5723.0 5795.7 6066.5 6076.3 6076.9 5150.3 5304.5 5306.0 5903.5 5995.6 05:06:00 INFO - PID 1896 | 05:06:00 INFO - PID 1896 | [#5] yui.html Cycles:180 Average:19246.70 Median:24107.89 stddev:26240.75 (108.8%) stddev-sans-first:26277.43 05:06:00 INFO - PID 1896 | Values: 705.2 851.0 854.4 858.2 873.7 10758.6 13120.9 17275.6 17605.6 17647.6 16225.3 16296.8 16370.3 16391.2 16410.5 930.2 967.2 976.6 977.5 978.3 658.3 677.7 681.4 687.1 687.1 1002.6 1019.0 1036.4 1040.9 1042.5 1028.1 1031.4 1034.3 1035.7 1042.8 510.4 765.8 769.3 770.0 781.6 11931.3 15380.0 15687.2 15716.9 15787.7 15621.9 16532.1 16768.0 16768.8 16769.7 13342.3 13693.7 13838.7 13862.1 13871.2 3402.6 3429.1 3446.4 3523.1 3579.6 96312.0 101699.5 103265.0 104457.5 105650.5 11226.5 13110.2 13367.7 13506.9 13599.4 17985.6 19291.8 23550.6 24665.1 24788.9 7458.9 7698.8 7703.5 7709.6 7712.4 3744.4 3771.1 3790.7 3831.9 3847.0 3855.4 4341.9 4436.9 4449.1 4470.8 913.4 936.4 955.4 955.9 957.2 650.1 673.5 675.3 682.4 693.0 10823.2 11118.9 11180.9 11779.9 11813.9 625.2 644.3 650.8 672.1 678.1 5141.2 5174.7 5203.5 5259.7 5415.6 91990.0 93333.0 93796.0 94826.5 96022.0 75076.2 78754.0 82159.0 82995.8 83685.0 58131.8 65418.7 68842.9 69424.0 71286.0 10612.0 10723.3 10810.6 10941.3 10980.1 39046.5 39402.6 40065.8 40913.8 41027.2 50766.7 50795.2 50951.7 51687.0 52939.0 11771.5 13463.7 13530.7 13870.0 13958.9 15004.5 15036.1 15065.1 15290.8 15305.0 13939.2 14044.9 14099.0 14099.2 14266.8 13893.9 14000.2 14122.9 14184.0 14301.1 13762.9 13833.9 13884.7 13919.4 14056.4 9079.4 10313.8 10437.8 10454.1 10617.4 10936.9 11191.7 11325.7 11353.7 11682.5 05:06:00 INFO - PID 1896 | -------- Summary: end -------- 05:06:00 INFO - PID 1896 | 05:06:01 INFO - TEST-INFO | 1896: exit 0 05:06:01 INFO - TEST-OK | dromaeo_css | took 1119876ms 05:06:01 INFO - TEST-START | kraken 05:06:01 INFO - operating with platform_type : mac_ 05:06:01 INFO - Initialising browser for kraken test... 05:06:01 INFO - TEST-INFO | started process 1901 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpXKuhGk/profile http://localhost:49382/getInfo.html) 05:06:03 INFO - PID 1901 | __metrics Screen width/height:1600/1200 05:06:03 INFO - PID 1901 | colorDepth:24 05:06:03 INFO - PID 1901 | Browser inner width/height: 1024/689 05:06:03 INFO - PID 1901 | __metrics 05:06:04 INFO - PID 1901 | 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" 05:06:04 INFO - PID 1901 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:04 INFO - TEST-INFO | 1901: exit 0 05:06:04 INFO - Browser initialized. 05:06:04 INFO - Running cycle 1/1 for kraken test... 05:06:04 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpXKuhGk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:17 INFO - PID 1903 | RSS: Main: 241967104 05:06:17 INFO - PID 1903 | 05:06:19 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:20 INFO - PID 1903 | RSS: Main: 312901632 05:06:20 INFO - PID 1903 | 05:06:23 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-dft) 05:06:24 INFO - PID 1903 | RSS: Main: 294141952 05:06:24 INFO - PID 1903 | 05:06:27 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-fft) 05:06:27 INFO - PID 1903 | RSS: Main: 387649536 05:06:27 INFO - PID 1903 | 05:06:29 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49382/tests/kraken/driver.html?testName=audio-oscillator) 05:06:30 INFO - PID 1903 | RSS: Main: 289173504 05:06:30 INFO - PID 1903 | 05:06:32 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49382/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:33 INFO - PID 1903 | RSS: Main: 291336192 05:06:33 INFO - PID 1903 | 05:06:35 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49382/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:36 INFO - PID 1903 | RSS: Main: 353898496 05:06:36 INFO - PID 1903 | 05:06:39 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49382/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:40 INFO - PID 1903 | RSS: Main: 375267328 05:06:40 INFO - PID 1903 | 05:06:42 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49382/tests/kraken/driver.html?testName=json-parse-financial) 05:06:43 INFO - PID 1903 | RSS: Main: 385409024 05:06:43 INFO - PID 1903 | 05:06:44 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49382/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:45 INFO - PID 1903 | RSS: Main: 333643776 05:06:45 INFO - PID 1903 | 05:06:47 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:48 INFO - PID 1903 | RSS: Main: 331898880 05:06:48 INFO - PID 1903 | 05:06:50 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:50 INFO - PID 1903 | RSS: Main: 333905920 05:06:50 INFO - PID 1903 | 05:06:53 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:54 INFO - PID 1903 | RSS: Main: 351330304 05:06:54 INFO - PID 1903 | 05:06:57 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:58 INFO - PID 1903 | RSS: Main: 344043520 05:06:58 INFO - PID 1903 | 05:06:59 INFO - PID 1903 | Cycle 1(1): loaded http://localhost:49382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49382/tests/kraken/driver.html?testName=ai-astar) 05:07:00 INFO - PID 1903 | RSS: Main: 386957312 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | __start_tp_report 05:07:00 INFO - PID 1903 | _x_x_mozilla_page_load 05:07:00 INFO - PID 1903 | _x_x_mozilla_page_load_details 05:07:00 INFO - PID 1903 | |i|pagename|runs| 05:07:00 INFO - PID 1903 | |0;ai-astar;112;112;111;113;112;112;112;112;112;112 05:07:00 INFO - PID 1903 | |1;audio-beat-detection;140;110;117;151;111;107;109;107;136;107 05:07:00 INFO - PID 1903 | |2;audio-dft;188;188;188;189;189;188;186;185;188;187 05:07:00 INFO - PID 1903 | |3;audio-fft;79;60;59;89;60;59;59;59;80;57 05:07:00 INFO - PID 1903 | |4;audio-oscillator;93;68;85;70;69;68;89;68;68;90 05:07:00 INFO - PID 1903 | |5;imaging-gaussian-blur;89;90;88;88;89;88;89;90;90;89 05:07:00 INFO - PID 1903 | |6;imaging-darkroom;96;97;97;96;96;97;98;96;97;96 05:07:00 INFO - PID 1903 | |7;imaging-desaturate;86;85;84;86;84;84;84;83;86;85 05:07:00 INFO - PID 1903 | |8;json-parse-financial;48;48;47;48;49;49;48;49;49;49 05:07:00 INFO - PID 1903 | |9;json-stringify-tinderbox;53;53;53;61;64;61;58;56;56;57 05:07:00 INFO - PID 1903 | |10;stanford-crypto-aes;83;83;83;83;81;82;82;82;83;82 05:07:00 INFO - PID 1903 | |11;stanford-crypto-ccm;138;140;148;147;140;136;140;149;176;145 05:07:00 INFO - PID 1903 | |12;stanford-crypto-pbkdf2;184;185;186;173;186;184;187;185;185;181 05:07:00 INFO - PID 1903 | |13;stanford-crypto-sha256-iterative;67;68;67;66;65;68;68;67;67;65 05:07:00 INFO - PID 1903 | __end_tp_report 05:07:00 INFO - PID 1903 | __start_cc_report 05:07:00 INFO - PID 1903 | _x_x_mozilla_cycle_collect,2192 05:07:00 INFO - PID 1903 | __end_cc_report 05:07:00 INFO - PID 1903 | __startTimestamp1492776420092__endTimestamp 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | ------- Summary: start ------- 05:07:00 INFO - PID 1903 | Number of tests: 14 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:07:00 INFO - PID 1903 | Values: 112.0 112.0 111.0 113.0 112.0 112.0 112.0 112.0 112.0 112.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:114.00 stddev:16.44 (14.4%) stddev-sans-first:15.67 05:07:00 INFO - PID 1903 | Values: 140.0 110.0 117.0 151.0 111.0 107.0 109.0 107.0 136.0 107.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#2] audio-dft Cycles:10 Average:187.60 Median:188.00 stddev:1.26 (0.7%) stddev-sans-first:1.33 05:07:00 INFO - PID 1903 | Values: 188.0 188.0 188.0 189.0 189.0 188.0 186.0 185.0 188.0 187.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.00 stddev:11.75 (19.6%) stddev-sans-first:11.50 05:07:00 INFO - PID 1903 | Values: 79.0 60.0 59.0 89.0 60.0 59.0 59.0 59.0 80.0 57.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:77.50 stddev:10.90 (14.1%) stddev-sans-first:9.86 05:07:00 INFO - PID 1903 | Values: 93.0 68.0 85.0 70.0 69.0 68.0 89.0 68.0 68.0 90.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:89.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 05:07:00 INFO - PID 1903 | Values: 89.0 90.0 88.0 88.0 89.0 88.0 89.0 90.0 90.0 89.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:07:00 INFO - PID 1903 | Values: 96.0 97.0 97.0 96.0 96.0 97.0 98.0 96.0 97.0 96.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:1.01 05:07:00 INFO - PID 1903 | Values: 86.0 85.0 84.0 86.0 84.0 84.0 84.0 83.0 86.0 85.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:49.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 05:07:00 INFO - PID 1903 | Values: 48.0 48.0 47.0 48.0 49.0 49.0 48.0 49.0 49.0 49.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.50 stddev:3.82 (6.7%) stddev-sans-first:3.74 05:07:00 INFO - PID 1903 | Values: 53.0 53.0 53.0 61.0 64.0 61.0 58.0 56.0 56.0 57.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 05:07:00 INFO - PID 1903 | Values: 83.0 83.0 83.0 83.0 81.0 82.0 82.0 82.0 83.0 82.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:146.00 stddev:11.48 (7.9%) stddev-sans-first:11.82 05:07:00 INFO - PID 1903 | Values: 138.0 140.0 148.0 147.0 140.0 136.0 140.0 149.0 176.0 145.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:185.00 stddev:4.06 (2.2%) stddev-sans-first:4.30 05:07:00 INFO - PID 1903 | Values: 184.0 185.0 186.0 173.0 186.0 184.0 187.0 185.0 185.0 181.0 05:07:00 INFO - PID 1903 | 05:07:00 INFO - PID 1903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 05:07:00 INFO - PID 1903 | Values: 67.0 68.0 67.0 66.0 65.0 68.0 68.0 67.0 67.0 65.0 05:07:00 INFO - PID 1903 | -------- Summary: end -------- 05:07:00 INFO - PID 1903 | 05:07:01 INFO - TEST-INFO | 1903: exit 0 05:07:01 INFO - TEST-OK | kraken | took 59883ms 05:07:01 INFO - SUITE-END | took 1179s 05:07:01 INFO - Completed test suite (00:19:40) 05:07:01 INFO - javascript benchmark 05:07:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7584.157768959174, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3534.3638145133864, 3548.2371290172614, 3551.5915669697984, 3583.910402239942, 3621.1128273572963, 5942.435468630484, 6098.847528811782, 6122.448979591842, 6140.754369825202, 6173.567850250484, 6090.299615544213, 6124.075808605194, 6131.529590167202, 6142.652254521286, 6206.255249370082, 5291.788328466876, 5298.072837253465, 5323.254744335796, 5336.146216605344, 5342.225377320306, 5374.7850085996515, 5411.215373770801, 5451.209574611679, 5457.399686034533, 5504.972475137639, 4447.822087116511, 5252.0, 5313.229581710669, 5413.0, 5425.755840987145, 4395.230834603932, 5327.680339179662, 5353.411124776271, 5373.704446255454, 5421.512063914227, 5274.182501712241, 5299.470052994709, 5306.761195746162, 5315.202719592092, 5316.043112239795, 5971.820845374602, 6047.879042419127, 6127.142200091991, 6133.172021777048, 6160.383961603804, 6322.620642761449, 6328.810135695937, 6463.095166676669, 6549.770758023494, 6561.704723287464, 6612.471002319803, 6616.0, 6623.569467984614, 6643.734250629969, 6644.4020038196795, 6170.50635949123, 6239.376062393815, 6244.188255526752, 6245.094461303131, 6247.250329960389, 6535.803925882231, 6584.209894812653, 6694.49791265657, 6797.116374871334, 6806.693698783567, 6230.314665386803, 6290.402411770874, 6307.810765677037, 6397.328280530571, 6401.967990160019, 6448.548601597937, 6552.901706474407, 6579.1447111876105, 6580.2103747549645, 6588.868222635616, 6508.60948343101, 6513.478921686254, 6524.543281970216, 6524.836879077966, 6538.803835884931, 6258.186435763413, 6313.05304204373, 6560.081588577603, 6561.901571476432, 6587.736490540325, 5160.354955630546, 5166.044281807877, 5167.199084141964, 5170.586353091744, 5224.399194092728, 4682.367880336179, 4698.1778188816825, 4709.175894218498, 4721.527847215251, 4733.550312720355, 6244.625322480666, 6255.186825712628, 6279.309275979638, 6285.151504546919, 6286.339934306923, 6639.900401493885, 6655.234648015444, 6666.500012499082, 6668.199816022011, 6678.866422671519, 6128.014278093809, 6144.678894037804, 6193.225846769154, 6257.124002639634, 6272.717727702173, 5855.121731740273, 5881.0, 5884.735186916599, 5888.352281249059, 5926.644401335933, 6789.25318214996, 6899.137607799025, 6900.378965893094, 6908.758193463204, 6913.274106218774, 6347.39699728525, 6403.775867844789, 6412.326705695835, 6654.667266636746, 6663.666816659244, 5734.942650573441, 6679.632620205741, 6724.092247546519, 6727.024581435567, 6806.285340039224, 6524.380183882524, 6532.05285233629, 6541.953287473982, 6550.868982620225, 6574.868502629825, 6575.704093315908, 6639.7012134455035, 6644.435223006099, 6653.933460665331, 6665.566738162004, 5160.200168973815, 5487.533559647474, 6405.807825765234, 6416.069669897745, 6422.839429014312, 6233.158523599437, 6264.31092579825, 6265.561410701207, 6271.717772700331, 6273.341299163522, 5303.7878484860175, 6234.594751341148, 6253.905566525931, 6257.655828929453, 6289.213848268966, 6404.423601875854, 6411.96794016027, 6412.679366031586, 6419.4864410846085, 6425.421712045938, 6264.718087686157, 6270.811875643738, 6280.591761535668, 6288.622682638873, 6295.685215739286], "value": 5987.883021258619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.7333359990403, 787.354369417078, 808.8301456694093, 1120.6862078617985, 1136.2330426961798, 26954.5956810648, 36215.81892090539, 36365.72719954799, 36425.0, 36516.81741591295, 31946.520802187984, 38354.61645383545, 38397.04007399816, 38525.42211866824, 38643.227135457346, 5984.875369243921, 8291.83416331673, 8435.873461898076, 8438.11399803021, 8445.36659750518, 4239.300515414953, 4287.807048682801, 4297.785110744466, 4360.476742790854, 4534.274516077428, 8245.216704413102, 8402.915970840306, 8403.327733781283, 8410.243078122967, 8450.535220562866, 8367.372447066495, 8408.159184081604, 8418.663253469855, 8434.072252052269, 8439.620217090214, 8232.423730338818, 8277.668893244323, 8307.460015098999, 8307.750767476986, 8320.542370169638, 36418.81790591057, 36556.26887462263, 36578.81710591457, 36596.0, 36699.633003670155, 3540.7875527468177, 3605.170810713524, 3632.219072899339, 3634.018814919983, 3634.491171236029, 30027.69972300271, 30072.24819379533, 30084.54873176882, 30143.0, 30145.09564713062, 3051.359214564944, 3094.4430002599524, 3110.377924415126, 3116.1586371679746, 3122.469180239365, 288570.0, 294426.52786736144, 295143.0, 295207.0, 296929.0, 48097.75951120222, 48300.758496207294, 48316.0, 48387.19353677581, 48450.515494845306, 49934.0, 50009.4995250236, 50018.49981500211, 50090.24864627034, 50104.498955009985, 13653.112547684368, 13777.173369597856, 13779.517716879862, 13782.448702052006, 13785.586432407044, 11253.831192532118, 11264.0, 11269.774604508028, 11292.661220163409, 11303.265287756269, 10617.84073238902, 10745.14038876888, 11919.165658404001, 12036.555613326282, 12174.965127964046, 5353.197020446886, 5409.594280428983, 5413.7834486620095, 5419.783208671688, 5449.455054494519, 957.2246480350938, 988.125508924607, 1012.9139023183112, 1036.5750042482546, 1071.989280107189, 21375.0, 22363.88818055932, 23213.651795223086, 23292.0, 24106.15628453031, 970.9174720148867, 1113.9721506962392, 1145.8510393648771, 1152.3546813784308, 1168.4683469021575, 11956.58151964677, 12193.756124877631, 12222.755544889053, 12226.694332641755, 12591.37043147839, 295809.0, 296458.0, 296506.0, 296657.0, 297025.0, 53007.0, 53021.469785302426, 53139.734301329016, 53194.202086968726, 53261.0, 1400.43982407038, 1470.8970372073852, 1506.261931653482, 1551.4957638767446, 1559.3684557754127, 22002.679839209697, 23594.056237750297, 23644.645330320403, 23757.406064848517, 24088.0, 29432.705672942997, 35697.643023569435, 35720.82139589285, 35756.0, 35791.46312805258, 231036.0, 275092.0, 275464.0, 275608.0, 276610.0, 33460.83269583636, 33557.328853423285, 33579.66420335863, 33621.15947101342, 33787.15532111619, 37053.44419833651, 37213.06967325838, 37490.0, 43562.56437435712, 44788.55211447974, 28679.283017924718, 30111.849440752656, 30320.5451918217, 30365.56603773631, 30394.720395969947, 28451.28871778222, 29204.853975730835, 29769.0, 30014.54978175373, 30358.544621831134, 36023.0, 36123.819380902925, 36209.63790362168, 36223.63776362203, 36228.0, 28748.88466849101, 30121.0, 30158.547621785252, 30359.848200759738, 30540.778368864998, 23504.52990940206, 23572.41068973221, 23588.764112358658, 23926.803659817288, 23968.76031239735], "value": 16673.63853659097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.3075466844004, 424.38040460927033, 436.3716248602011, 449.47411528511645, 458.3399904138043, 19151.808481915195, 20899.477513062182, 21503.24738634148, 21681.0, 21727.23954661587, 21473.355799326044, 21790.89104554479, 21791.67312490314, 22136.225232116878, 22649.0, 5745.856353591173, 6075.787347442841, 6084.148219249309, 6085.300190478085, 6086.330503644595, 5691.4877661010505, 5970.6119102258435, 6021.789237376693, 6041.335453100178, 6042.516598672096, 5770.6249093808765, 6003.459688628022, 6019.759209631609, 6021.909671354933, 6024.759009639609, 5855.0, 5956.583039187259, 5971.313298970631, 5975.402459754033, 5993.760249590011, 5262.131748261532, 5269.262303277545, 5320.122179840322, 5322.1484562470205, 5326.067938110815, 26106.648137131844, 26443.0, 26460.60309095365, 26817.793199306077, 27048.59427108595, 2274.1130958926033, 2285.440067183534, 2320.6519022146645, 2320.953580928389, 2323.1752727781563, 16962.660746785117, 17334.7399789002, 17484.47546573605, 17569.486102779494, 17696.469105926844, 1869.8597605179666, 2172.663237198237, 2179.574982878339, 2182.9563408731897, 2187.453136715821, 159231.0, 160100.0, 161528.19235903746, 161797.0, 163122.0, 11007.61473348445, 11809.763804723858, 11976.940115299367, 12070.034397248199, 12141.817872731739, 15990.0, 16037.278322475517, 16043.438479653156, 16050.518484445485, 16053.277602507915, 8473.915260847436, 8699.43453675509, 8720.476771393736, 8848.513331766686, 8900.73297801067, 6952.443804495628, 8282.590644893446, 8342.288756154274, 8530.573471326408, 8557.657693692307, 6294.779682711175, 7350.191478937312, 7518.812029699192, 7547.245275472409, 7566.35685966688, 2048.3445297504954, 2055.8663686860605, 2057.1051592557287, 2062.123597471069, 2239.6976408185014, 948.5304774136708, 952.4523399045438, 977.9755506112405, 1008.253892119826, 1020.5815615597569, 17809.554761131076, 20557.0, 20668.17327306921, 20782.272620458512, 21263.8936805315, 943.2878176976338, 1008.7592261518226, 1023.488255872064, 1035.570238351091, 1036.7097212780434, 9752.0, 9763.560639771227, 10729.088027517748, 10920.2901811382, 12478.313692746986, 575409.0, 583704.0814795899, 586690.0, 587710.0, 590776.0, 123183.76816231903, 125460.0, 128629.0, 134259.0, 140104.0, 1171.7949358862336, 1223.4127618742875, 1223.590097317391, 1245.0, 1246.9002479801775, 21098.156073756876, 21847.67228491542, 21920.342389728332, 21973.340799776033, 22020.779792201873, 53936.1005434099, 54569.908601826945, 55560.44351573188, 55974.0, 56307.0, 75952.62023689847, 76480.61759691166, 76656.23343766714, 77073.45853083019, 77856.61071694606, 8623.094575069777, 8821.382503224713, 8877.644894204417, 8963.417377870417, 9096.590653420744, 13748.243846588533, 13807.51673691416, 13857.37641806101, 14195.716085678436, 14254.786178207129, 10131.240156988402, 11231.438428078727, 11805.527778888749, 12005.159638825548, 12222.572209972608, 10849.837252441377, 11268.08374684256, 11401.372924489233, 11662.88337116652, 11842.28946263227, 11875.0, 12028.218165819193, 12329.321887296284, 12381.319027453577, 12484.438200280827, 11582.667993180556, 12043.337616431181, 12938.676533086747, 13194.076414651267, 13317.934565234564, 10204.336718113298, 11220.821813709443, 11775.0, 12063.155579109378, 12220.572279970158], "value": 10480.429670339672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.9697007574814, 1251.5181655062802, 1294.825198598189, 1453.2806260900857, 1466.7433199190139, 9758.756031099218, 11553.942230288858, 11858.644240672773, 11873.940630296858, 11878.990285825716, 11480.655580332583, 11589.6523104307, 11591.710207244823, 11607.419629018537, 11640.883591164085, 2434.245383930983, 2461.0155937625004, 2465.457599328145, 2472.184179220862, 2479.3305807431984, 2108.9683654745113, 2176.85850419723, 2245.9663105053437, 2341.496578235679, 2346.307839187435, 2492.0530198524534, 2505.4613258149493, 2524.192258477288, 2529.9747002530016, 2539.4540173862706, 2495.1641200197955, 2531.227975467482, 2532.9746702532925, 2533.0754274689607, 2534.3410713214603, 2426.5268272686835, 2453.914113006036, 2472.171822439485, 2475.393528585508, 2480.541099896525, 11406.942965285203, 11527.884721152848, 11539.653810385618, 11561.364124973123, 11598.956093951585, 6435.356464353574, 6676.098726671886, 6678.098456708331, 6680.498962577777, 6717.16035495563, 3764.642358975893, 3937.3503371943593, 4125.711200215986, 4256.127493863782, 4276.636485898703, 1248.7814632439377, 1258.6979125009932, 1280.8847203751707, 1297.8118172864977, 1304.706441050756, 15942.60143496422, 16319.347226110942, 16339.0, 16340.591485212846, 16422.507324780276, 5754.0, 5888.234529511136, 5900.232969713909, 5908.0, 5998.310194327621, 13661.248631325174, 13679.974001949893, 13701.794473082911, 13704.52034178799, 13725.794113088312, 6769.8646027079185, 6775.966120169368, 6780.220274668476, 6786.8642627148165, 6790.932090679129, 5188.792448302102, 6069.150318955261, 6146.108814221912, 6207.472364848948, 6229.626222426669, 4152.688548358825, 4232.534421213664, 4241.151769646021, 4248.1078973415315, 4255.6169944705125, 1305.9477620895059, 1347.1782212850153, 1438.8273407191205, 1481.7258807120718, 1482.1107335598554, 769.7305942919933, 771.7574704725388, 784.5410434895535, 789.1753117991713, 804.9897378789582, 5970.582059255898, 6289.905651415233, 6376.904346434807, 6438.0, 6803.7618683345845, 907.7458311672742, 921.8202450522084, 926.7266156483853, 938.1041105743998, 941.6562954521551, 3203.439398105322, 3722.683571896419, 3796.0130366105013, 3800.144967382372, 3819.713521485844, 14402.927985360217, 14562.927185364006, 14576.927115364355, 14581.708365832836, 14784.63038424048, 14235.857641423454, 14518.274086295643, 14690.824734021253, 14692.045017073857, 14724.0, 7664.233576642291, 8330.208630180245, 8338.124496927736, 8365.038020627706, 8371.581420929051, 6336.366363363627, 6366.840828979127, 6504.447121994684, 6525.804505129114, 6537.05212744159, 13012.024098192484, 13044.347782610641, 13062.281574513492, 13261.734765304833, 13399.665008374868, 13418.060735748404, 13528.661783455493, 13564.93217533906, 13599.252041137437, 13712.314384280546, 9254.074592540692, 9372.859407108763, 9482.810343792948, 9514.809703805746, 9530.761730956781, 10334.431606261727, 10410.895891040993, 10432.947835260775, 10441.843372349269, 10442.791144177227, 8786.253168480494, 9053.456792592466, 9072.909270907207, 9173.633054677739, 9231.907680923105, 8818.5590720465, 8852.955735221283, 8872.423292485968, 8904.19862212404, 8911.975122860695, 7849.450538462253, 8053.194680532134, 8068.515889046676, 8068.677252910053, 8069.677212911418, 5733.0, 5754.9424505754405, 5857.560682948711, 5876.236089308362, 5996.610220335664, 5753.165790960371, 5874.206982057368, 6025.698715064142, 6051.546134039877, 6106.053561697944], "value": 5330.185268679374, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.99802000989996, 404.40350483037514, 406.88200421877656, 407.34417587683805, 409.42271397329773, 5770.538356931446, 5774.5091667208335, 5840.335504381253, 5843.941560584398, 5873.706314684265, 4632.409882341187, 5407.864803379917, 5426.375966763823, 5559.833205003846, 5699.715014249292, 3638.5088013118157, 4372.73763574185, 4373.781310934456, 4377.277749171399, 4410.933835992447, 4371.704854951145, 4388.319810429389, 4402.7578483183415, 4411.09572537629, 4438.800253988578, 3720.21875406165, 4247.681423893205, 4323.632491238232, 4345.174416860802, 4390.297552391618, 3723.5531736191697, 3797.9240415191816, 4021.2761702893467, 4336.262835318003, 4369.781510924473, 3590.784552926833, 3822.4266360045935, 3880.7581573896364, 3887.358585833334, 3888.0, 4547.272436410191, 4643.442786865564, 5243.846353802158, 5311.256424100629, 5520.447955204488, 4590.449146102455, 4972.328735620717, 5169.147090730025, 5221.556167725748, 5235.293235413246, 6044.123602077718, 6045.637261764308, 6052.909206361908, 6113.144159817629, 6159.938400616026, 3463.930721385583, 3901.6878649708237, 4141.213169497816, 4378.839607504014, 4395.604395604379, 5568.554515638739, 5802.94197058024, 6277.591956522811, 6324.0, 6358.841028974266, 4119.176164766998, 4213.5154457237195, 4216.494020717472, 4217.520545549934, 4224.957750422518, 3373.865045398157, 4096.5903409659395, 4235.682323825726, 4285.692863676609, 4292.270314046619, 4168.583141685868, 4293.2701440755145, 4594.471635761864, 4655.975685349218, 4896.46138924718, 4800.9274064598685, 5938.298074376148, 5947.167396564484, 5976.370397025295, 5993.61041532299, 1195.4082729049003, 1379.92410417426, 1437.360374633278, 1451.8112645356036, 1452.469848505309, 955.4219697083304, 978.8042391521724, 984.5569493727851, 995.6664517386612, 997.9251556133319, 4966.90066198674, 5605.523530499871, 5838.299404071454, 5841.970790146107, 5864.32560255576, 5291.576673866081, 6001.789937352171, 6234.719437625317, 6263.248410190807, 6276.529260305495, 4948.604111671058, 5349.438308977579, 5770.769169233267, 5796.000379868939, 5827.0, 3100.093442532826, 3238.36851813894, 3276.2300859298048, 3286.7370610351113, 3291.8024918504966, 6457.773977910844, 6473.996530537775, 6491.805245842538, 6494.642794646245, 6592.76925307612, 5218.582513398919, 5414.7021913795115, 6384.361563843579, 6403.551751377358, 6502.869942601122, 5380.78476860929, 6097.4817140543555, 6114.144019837227, 6131.681688437007, 6450.709718062604, 5495.780168793363, 6104.748526551957, 6187.535934804998, 6199.3490683477585, 6251.624902505864, 5169.948300516947, 5265.4997775211295, 6118.174046503665, 6123.724432400463, 6135.570510064431, 6035.879282414415, 6172.197614310111, 6346.873062538816, 6379.553431259767, 6482.546221764431, 4133.91732165361, 4204.474440694913, 4204.642605378454, 4221.606869732919, 4243.575642435731, 4617.376654151646, 5724.398938111438, 6226.937730622636, 6268.435840774352, 6272.905906411316, 5732.34078081026, 5998.890205312031, 6111.786087486917, 6115.785947491817, 6134.2332208473945, 6067.817965461043, 6108.267007959073, 6115.205023346936, 6123.173371594956, 6145.83229186471, 5756.251687280626, 5964.7912323068485, 5997.880042399041, 6007.459328660441, 6056.0, 5722.971385143048, 5795.710214489343, 6066.514678825595, 6076.33160352352, 6076.908846367396, 5150.278960945546, 5304.496072873225, 5305.987958183094, 5903.498202652822, 5995.5803093783015], "value": 4433.810584238522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.2207310921428, 851.0, 854.3976496569915, 858.1632907914784, 873.6854732296374, 10758.623448179314, 13120.868791312085, 17275.56811079722, 17605.64788704225, 17647.5588110297, 16225.26986285617, 16296.75554866675, 16370.263338149782, 16391.18044097796, 16410.507684769476, 930.1953809954391, 967.2068903499134, 976.6484065736329, 977.4965892565334, 978.2760757039811, 658.2561705273058, 677.6814896998403, 681.4003676764465, 687.1204857782047, 687.1410736579276, 1002.6089824968268, 1019.0115587879744, 1036.3678156324636, 1040.9167266618651, 1042.5360714482058, 1028.1158203944601, 1031.4224034540682, 1034.312182398704, 1035.6841163445147, 1042.7810159866438, 510.4206725366735, 765.7740966414921, 769.273036980054, 769.9759320104248, 781.6287263549825, 11931.343776092312, 15380.0, 15687.215639217993, 15716.92141539285, 15787.684246315124, 15621.921890390475, 16532.09073500969, 16767.993920364817, 16768.83231167697, 16769.664606707796, 13342.33288335589, 13693.657658558615, 13838.723225535434, 13862.098963567436, 13871.237081960488, 3402.5576675032335, 3429.091290807938, 3446.362422951737, 3523.1016090896915, 3579.6062433132333, 96312.0, 101699.49150254275, 103265.0, 104457.47771261171, 105650.47174764077, 11226.494807733672, 13110.213387196798, 13367.732645347232, 13506.932465337806, 13599.388027538784, 17985.640287194183, 19291.807081929, 23550.64674029891, 24665.136720214705, 24788.876055619607, 7458.925410745932, 7698.807529811799, 7703.499272547267, 7709.575973321409, 7712.421568382394, 3744.4196149596855, 3771.132639492932, 3790.6967442604528, 3831.9042023949623, 3846.9807650961566, 3855.4409610606303, 4341.869743907688, 4436.866893993185, 4449.132419178294, 4470.776461176928, 913.3697748553477, 936.438137117724, 955.412421360858, 955.9139677429065, 957.2007373842919, 650.1093501902424, 673.5016088094873, 675.2808259203932, 682.3858527325348, 692.9916970807463, 10823.188260880466, 11118.944405277922, 11180.888191117985, 11779.88220117805, 11813.88186118145, 625.2122325869437, 644.2719726708789, 650.778735230024, 672.1497305908031, 678.1252184681705, 5141.203113517411, 5174.741262936838, 5203.453637368022, 5259.684418934876, 5415.647982881179, 91990.0, 93333.0, 93796.0, 94826.52586737022, 96022.03977960271, 75076.24923750802, 78754.0, 82159.0, 82995.75506367409, 83685.0, 58131.837363252496, 65418.67290663516, 68842.87769640902, 69424.0, 71286.0, 10612.0449159576, 10723.30298530593, 10810.56757729682, 10941.343519388862, 10980.1215902726, 39046.516501830956, 39402.60597393989, 40065.799671001456, 40913.795431022656, 41027.1794564113, 50766.7308317295, 50795.23807142822, 50951.74524127356, 51687.0, 52939.0, 11771.470283837076, 13463.663408414868, 13530.729385412433, 13870.0, 13958.860411395755, 15004.474843380429, 15036.097834129987, 15065.09609423438, 15290.770638440656, 15305.0, 13939.16365018102, 14044.859551404765, 14099.0, 14099.224542650252, 14266.785998209827, 13893.930530347283, 14000.229987350793, 14122.858771412566, 14184.0, 14301.141931484144, 13762.862371376157, 13833.861661383256, 13884.652883677989, 13919.373628186959, 14056.437742490185, 9079.409838360485, 10313.845292320471, 10437.791244175225, 10454.111400530735, 10617.362958222531, 10936.945315273373, 11191.66425007251, 11325.716857078309, 11353.659390218307, 11682.532698692297], "value": 7695.01803248404, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1416.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 117.0, 151.0, 111.0, 107.0, 109.0, 107.0, 136.0, 107.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 188.0, 188.0, 189.0, 189.0, 188.0, 186.0, 185.0, 188.0, 187.0], "value": 187.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 89.0, 60.0, 59.0, 59.0, 59.0, 80.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 68.0, 85.0, 70.0, 69.0, 68.0, 89.0, 68.0, 68.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 88.0, 89.0, 88.0, 89.0, 90.0, 90.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 98.0, 96.0, 97.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 86.0, 84.0, 84.0, 84.0, 83.0, 86.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 47.0, 48.0, 49.0, 49.0, 48.0, 49.0, 49.0, 49.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 61.0, 64.0, 61.0, 58.0, 56.0, 56.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 81.0, 82.0, 82.0, 82.0, 83.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 148.0, 147.0, 140.0, 136.0, 140.0, 149.0, 176.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 186.0, 173.0, 186.0, 184.0, 187.0, 185.0, 185.0, 181.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 65.0, 68.0, 68.0, 67.0, 67.0, 65.0], "value": 66.8, "unit": "score"}]}]} 05:07:01 INFO - Return code: 0 05:07:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:01 ERROR - # TBPL SUCCESS # 05:07:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:01 INFO - 2017-04-21 05:07:01.947 screenresolution[1907:11552] starting screenresolution argv=screenresolution get 05:07:01 INFO - 2017-04-21 05:07:01.950 screenresolution[1907:11552] Display 0: 1600x1200x32@60 05:07:01 INFO - 2017-04-21 05:07:01.956 screenresolution[1908:11555] starting screenresolution argv=screenresolution list 05:07:01 INFO - Available Modes on Display 0 05:07:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:02 INFO - Intel Iris: 05:07:02 INFO - Chipset Model: Intel Iris 05:07:02 INFO - Type: GPU 05:07:02 INFO - Bus: Built-In 05:07:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:02 INFO - Vendor: Intel (0x8086) 05:07:02 INFO - Device ID: 0x0a2e 05:07:02 INFO - Revision ID: 0x0009 05:07:02 INFO - Displays: 05:07:02 INFO - Display: 05:07:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:02 INFO - Display Serial Number: 1600x1200 60 05:07:02 INFO - Main Display: Yes 05:07:02 INFO - Mirror: Off 05:07:02 INFO - Online: Yes 05:07:02 INFO - Rotation: Supported 05:07:02 INFO - Return code: 0 05:07:02 INFO - Running post-action listener: _resource_record_post_action 05:07:02 INFO - [mozharness: 2017-04-21 12:07:02.193156Z] Finished run-tests step (success) 05:07:02 INFO - Running post-run listener: _resource_record_post_run 05:07:02 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 2215936; Write bytes: 513786880; Read time: 19; Write time: 1673 05:07:02 INFO - TinderboxPrint: CPU usage
53.5% 05:07:02 INFO - TinderboxPrint: I/O read bytes / time
2,215,936 / 19 05:07:02 INFO - TinderboxPrint: I/O write bytes / time
513,786,880 / 1,673 05:07:02 INFO - TinderboxPrint: CPU idle
2,236.3 (46.5%) 05:07:02 INFO - TinderboxPrint: CPU system
962.6 (20.0%) 05:07:02 INFO - TinderboxPrint: CPU user
1,606.8 (33.4%) 05:07:02 INFO - TinderboxPrint: Swap in / out
210,300,928 / 0 05:07:02 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207366656; Write bytes: 203022336; Read time: 16005; Write time: 368 05:07:02 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 1306624; Write bytes: 303584256; Read time: 14; Write time: 1275 05:07:02 INFO - Running post-run listener: _upload_blobber_files 05:07:02 INFO - Blob upload gear active. 05:07:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:02 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 05:07:02 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'] 05:07:02 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 05:07:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:04 INFO - (blobuploader) - INFO - Done attempting. 05:07:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:05 INFO - (blobuploader) - INFO - Done attempting. 05:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:06 INFO - (blobuploader) - INFO - Done attempting. 05:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:08 INFO - (blobuploader) - INFO - Done attempting. 05:07:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:08 INFO - Return code: 0 05:07:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad71052266394f5605920f6bdb4890a9d9724a957d5705689a915e7ae312681b31f20e1fe125581b4cf7ac1d4620f65609213b24b47bca215bdfd8dee500c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e307a55f7e3e66ec613b1625ad30eb221ec85e1308a888e57a210ab406938d5a3093235b6584f0b0a5d371452962cf67110c7a2a6bcaa71e6e9bda0de3c98f53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e6c149fb6c561bb6476ca72c84868cdccdeae3c4f507f573d391978272da30d5c0a88a5b13495517c0dba68f7c96780282763af3adf831fdb257560d5d60bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c511060f0f06e28c3bb7a7db130b97d2b5ceedf557cd1913b2d7b6b3a4197308f0eed2335c25bb30d190798b69eedc09e93eeab746f30f22144e08c4ccaa95ac"} 05:07:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:08 INFO - Contents: 05:07:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad71052266394f5605920f6bdb4890a9d9724a957d5705689a915e7ae312681b31f20e1fe125581b4cf7ac1d4620f65609213b24b47bca215bdfd8dee500c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e307a55f7e3e66ec613b1625ad30eb221ec85e1308a888e57a210ab406938d5a3093235b6584f0b0a5d371452962cf67110c7a2a6bcaa71e6e9bda0de3c98f53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e6c149fb6c561bb6476ca72c84868cdccdeae3c4f507f573d391978272da30d5c0a88a5b13495517c0dba68f7c96780282763af3adf831fdb257560d5d60bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c511060f0f06e28c3bb7a7db130b97d2b5ceedf557cd1913b2d7b6b3a4197308f0eed2335c25bb30d190798b69eedc09e93eeab746f30f22144e08c4ccaa95ac"} 05:07:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:08 INFO - Copying logs to upload dir... 05:07:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.400683 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-21 05:07:08.118862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 05:07:08.122667) ========= 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.H3OSW40RiT/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.sNgexf3cd0/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/1ad71052266394f5605920f6bdb4890a9d9724a957d5705689a915e7ae312681b31f20e1fe125581b4cf7ac1d4620f65609213b24b47bca215bdfd8dee500c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e307a55f7e3e66ec613b1625ad30eb221ec85e1308a888e57a210ab406938d5a3093235b6584f0b0a5d371452962cf67110c7a2a6bcaa71e6e9bda0de3c98f53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e6c149fb6c561bb6476ca72c84868cdccdeae3c4f507f573d391978272da30d5c0a88a5b13495517c0dba68f7c96780282763af3adf831fdb257560d5d60bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c511060f0f06e28c3bb7a7db130b97d2b5ceedf557cd1913b2d7b6b3a4197308f0eed2335c25bb30d190798b69eedc09e93eeab746f30f22144e08c4ccaa95ac"} build_url:https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011038 build_url: 'https://queue.taskcluster.net/v1/task/ELgb0ajkThiF6poamFl6Yw/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/1ad71052266394f5605920f6bdb4890a9d9724a957d5705689a915e7ae312681b31f20e1fe125581b4cf7ac1d4620f65609213b24b47bca215bdfd8dee500c7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e307a55f7e3e66ec613b1625ad30eb221ec85e1308a888e57a210ab406938d5a3093235b6584f0b0a5d371452962cf67110c7a2a6bcaa71e6e9bda0de3c98f53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8e6c149fb6c561bb6476ca72c84868cdccdeae3c4f507f573d391978272da30d5c0a88a5b13495517c0dba68f7c96780282763af3adf831fdb257560d5d60bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c511060f0f06e28c3bb7a7db130b97d2b5ceedf557cd1913b2d7b6b3a4197308f0eed2335c25bb30d190798b69eedc09e93eeab746f30f22144e08c4ccaa95ac"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 05:07:08.161621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 05:07:08.161988) ========= 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.H3OSW40RiT/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.sNgexf3cd0/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005267 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 05:07:08.211048) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 05:07:08.211374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 05:07:08.211707) ========= ========= Total master_lag: 0.21 =========