builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0328 starttime: 1492172758.63 results: success (0) buildid: 20170414030225 builduid: 956a059a4b004398a141ac7eb03cff05 revision: cda24082bff8864a6e53726feeae33cae9e17309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.628904) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.629426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.629777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.657931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.658527) ========= 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.ONepHiehxX/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.hiN9HKjBB0/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-14 05:25:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 211M=0s 2017-04-14 05:25:58 (211 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162912 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.850820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.851641) ========= 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.ONepHiehxX/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.hiN9HKjBB0/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.030403 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:25:58.907834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-14 05:25:58.908259) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cda24082bff8864a6e53726feeae33cae9e17309 --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 cda24082bff8864a6e53726feeae33cae9e17309 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ONepHiehxX/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.hiN9HKjBB0/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-14 05:25:59,015 truncating revision to first 12 chars 2017-04-14 05:25:59,015 Setting DEBUG logging. 2017-04-14 05:25:59,015 attempt 1/10 2017-04-14 05:25:59,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cda24082bff8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-14 05:26:00,826 unpacking tar archive at: mozilla-central-cda24082bff8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.092262 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-14 05:26:01.031759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:01.032577) ========= script_repo_revision: cda24082bff8864a6e53726feeae33cae9e17309 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:01.033665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:01.034348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:01.058913) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-14 05:26:01.059505) ========= /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.ONepHiehxX/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.hiN9HKjBB0/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:26:01 INFO - MultiFileLogger online at 20170414 05:26:01 in /builds/slave/test 05:26:01 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 05:26:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:01 INFO - {'append_to_log': False, 05:26:01 INFO - 'base_work_dir': '/builds/slave/test', 05:26:01 INFO - 'blob_upload_branch': 'Firefox', 05:26:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:01 INFO - 'branch': 'Firefox', 05:26:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:01 INFO - 'config_files': ('talos/mac_config.py',), 05:26:01 INFO - 'default_actions': ('clobber', 05:26:01 INFO - 'read-buildbot-config', 05:26:01 INFO - 'download-and-extract', 05:26:01 INFO - 'populate-webroot', 05:26:01 INFO - 'create-virtualenv', 05:26:01 INFO - 'install', 05:26:01 INFO - 'run-tests'), 05:26:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:01 INFO - 'download_minidump_stackwalk': True, 05:26:01 INFO - 'download_symbols': 'ondemand', 05:26:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:01 INFO - 'gecko_profile': False, 05:26:01 INFO - 'gecko_profile_interval': 0, 05:26:01 INFO - 'installer_path': 'installer.exe', 05:26:01 INFO - 'log_level': 'info', 05:26:01 INFO - 'log_name': 'talos', 05:26:01 INFO - 'log_to_console': True, 05:26:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:26:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:26:01 INFO - 'opt_config_files': (), 05:26:01 INFO - 'pip_index': False, 05:26:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:01 INFO - 'cmd': ('bash', 05:26:01 INFO - '-c', 05:26:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:01 INFO - 'enabled': True, 05:26:01 INFO - 'halt_on_failure': False, 05:26:01 INFO - 'name': 'check_screen_resolution'},), 05:26:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:01 INFO - 'cmd': ('bash', 05:26:01 INFO - '-c', 05:26:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:01 INFO - 'enabled': True, 05:26:01 INFO - 'halt_on_failure': False, 05:26:01 INFO - 'name': 'check_screen_resolution'},), 05:26:01 INFO - 'run_cmd_checks_enabled': True, 05:26:01 INFO - 'suite': 'dromaeojs', 05:26:01 INFO - 'system_bits': '32', 05:26:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:01 INFO - 'title': 't-yosemite-r7-0328', 05:26:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:01 INFO - 'use_talos_json': True, 05:26:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:01 INFO - 'work_dir': 'build'} 05:26:01 INFO - [mozharness: 2017-04-14 12:26:01.276562Z] Running clobber step. 05:26:01 INFO - Running pre-action listener: _resource_record_pre_action 05:26:01 INFO - Running main action method: clobber 05:26:01 INFO - rmtree: /builds/slave/test/build 05:26:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:03 INFO - Running post-action listener: _resource_record_post_action 05:26:03 INFO - [mozharness: 2017-04-14 12:26:03.884737Z] Finished clobber step (success) 05:26:03 INFO - [mozharness: 2017-04-14 12:26:03.884897Z] Running read-buildbot-config step. 05:26:03 INFO - Running pre-action listener: _resource_record_pre_action 05:26:03 INFO - Running main action method: read_buildbot_config 05:26:03 INFO - Using buildbot properties: 05:26:03 INFO - { 05:26:03 INFO - "project": "", 05:26:03 INFO - "product": "firefox", 05:26:03 INFO - "script_repo_revision": "production", 05:26:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:26:03 INFO - "repository": "", 05:26:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:26:03 INFO - "buildid": "20170414030225", 05:26:03 INFO - "stage_platform": "macosx64", 05:26:03 INFO - "basedir": "/builds/slave/test", 05:26:03 INFO - "nightly_build": "True", 05:26:03 INFO - "buildnumber": 76, 05:26:03 INFO - "slavename": "t-yosemite-r7-0328", 05:26:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:26:03 INFO - "platform": "yosemite_r7", 05:26:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:26:03 INFO - "branch": "mozilla-central", 05:26:03 INFO - "repo_path": "mozilla-central", 05:26:03 INFO - "revision": "cda24082bff8864a6e53726feeae33cae9e17309", 05:26:03 INFO - "pgo_build": "False", 05:26:03 INFO - "builduid": "956a059a4b004398a141ac7eb03cff05", 05:26:03 INFO - "slavebuilddir": "test" 05:26:03 INFO - } 05:26:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:26:03 INFO - Running post-action listener: _resource_record_post_action 05:26:03 INFO - [mozharness: 2017-04-14 12:26:03.888281Z] Finished read-buildbot-config step (success) 05:26:03 INFO - [mozharness: 2017-04-14 12:26:03.888381Z] Running download-and-extract step. 05:26:03 INFO - Running pre-action listener: _resource_record_pre_action 05:26:03 INFO - Running main action method: download_and_extract 05:26:03 INFO - mkdir: /builds/slave/test/build/tests 05:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:03 INFO - trying https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:26:03 INFO - Downloading https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/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 05:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/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 05:26:05 INFO - Downloaded 1325 bytes. 05:26:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:26:05 INFO - Using the following test package requirements: 05:26:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:26:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:26:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:26:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:26:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'jsshell-mac.zip'], 05:26:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:26:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:26:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:26:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:26:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:26:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:26:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:26:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:26:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:05 INFO - Fetch https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:26:06 INFO - Expected file size: 52600910 05:26:06 INFO - Obtained file size: 52600910 05:26:22 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:26:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:26:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:22 INFO - Fetch https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:26:24 INFO - Expected file size: 52600910 05:26:24 INFO - Obtained file size: 52600910 05:26:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:26:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:26:40 INFO - Fetch https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:26:41 INFO - Expected file size: 14408853 05:26:41 INFO - Obtained file size: 14408853 05:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:41 INFO - trying https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:26:41 INFO - Downloading https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/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 05:26:43 INFO - Downloaded 71200349 bytes. 05:26:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:26:43 INFO - mkdir: /builds/slave/test/properties 05:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:43 INFO - Contents: 05:26:43 INFO - build_url:https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:26:44 INFO - Running post-action listener: _resource_record_post_action 05:26:44 INFO - Running post-action listener: set_extra_try_arguments 05:26:44 INFO - [mozharness: 2017-04-14 12:26:44.165402Z] Finished download-and-extract step (success) 05:26:44 INFO - [mozharness: 2017-04-14 12:26:44.165526Z] Running populate-webroot step. 05:26:44 INFO - Running pre-action listener: _resource_record_pre_action 05:26:44 INFO - Running main action method: populate_webroot 05:26:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:44 INFO - '--tppagecycles', 05:26:44 INFO - '7'], 05:26:44 INFO - 'tests': ['tsvgm']}}, 05:26:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['damp', 'tps']}, 05:26:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'tests': ['damp', 'tps']}, 05:26:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['dromaeo_dom']}, 05:26:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:26:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:26:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['a11yr', 05:26:44 INFO - 'ts_paint', 05:26:44 INFO - 'tpaint', 05:26:44 INFO - 'sessionrestore', 05:26:44 INFO - 'sessionrestore_no_auto_restore', 05:26:44 INFO - 'tabpaint']}, 05:26:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:44 INFO - 'ts_paint', 05:26:44 INFO - 'tpaint', 05:26:44 INFO - 'sessionrestore', 05:26:44 INFO - 'sessionrestore_no_auto_restore', 05:26:44 INFO - 'tabpaint']}, 05:26:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:44 INFO - 'ts_paint', 05:26:44 INFO - 'tpaint', 05:26:44 INFO - 'sessionrestore', 05:26:44 INFO - 'sessionrestore_no_auto_restore', 05:26:44 INFO - 'tabpaint']}, 05:26:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:44 INFO - 'ts_paint', 05:26:44 INFO - 'tpaint', 05:26:44 INFO - 'sessionrestore', 05:26:44 INFO - 'sessionrestore_no_auto_restore', 05:26:44 INFO - 'tabpaint']}, 05:26:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['a11yr', 05:26:44 INFO - 'ts_paint', 05:26:44 INFO - 'tpaint', 05:26:44 INFO - 'sessionrestore', 05:26:44 INFO - 'sessionrestore_no_auto_restore', 05:26:44 INFO - 'tabpaint']}, 05:26:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['a11yr', 05:26:44 INFO - 'ts_paint', 05:26:44 INFO - 'tpaint', 05:26:44 INFO - 'sessionrestore', 05:26:44 INFO - 'sessionrestore_no_auto_restore', 05:26:44 INFO - 'tabpaint']}, 05:26:44 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:26:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:26:44 INFO - 'bloom_basic_ref']}, 05:26:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['tsvgx', 05:26:44 INFO - 'tsvgr_opacity', 05:26:44 INFO - 'tart', 05:26:44 INFO - 'tscrollx', 05:26:44 INFO - 'cart', 05:26:44 INFO - 'tsvg_static']}, 05:26:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:44 INFO - 'tsvgr_opacity', 05:26:44 INFO - 'tart', 05:26:44 INFO - 'tscrollx', 05:26:44 INFO - 'cart', 05:26:44 INFO - 'tsvg_static']}, 05:26:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'talos_options': ['--disable-e10s'], 05:26:44 INFO - 'tests': ['tp5o']}, 05:26:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:26:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'talos_options': ['--disable-e10s', 05:26:44 INFO - '--xperf_path', 05:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:44 INFO - 'tests': ['tp5n']}, 05:26:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:26:44 INFO - 'talos_options': ['--xperf_path', 05:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:44 INFO - 'tests': ['tp5n']}}, 05:26:44 INFO - 'talos.zip': {'path': '', 05:26:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:44 INFO - Running post-action listener: _resource_record_post_action 05:26:44 INFO - [mozharness: 2017-04-14 12:26:44.184680Z] Finished populate-webroot step (success) 05:26:44 INFO - [mozharness: 2017-04-14 12:26:44.184813Z] Running create-virtualenv step. 05:26:44 INFO - Running pre-action listener: _resource_record_pre_action 05:26:44 INFO - Running main action method: create_virtualenv 05:26:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:26:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:44 INFO - Using real prefix '/tools/python27' 05:26:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:47 INFO - Installing pip.................done. 05:26:47 INFO - Return code: 0 05:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:26:48 INFO - Reading from file tmpfile_stdout 05:26:48 INFO - Output received: 05:26:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:26:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:48 INFO - 'HOME': '/Users/cltbld', 05:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:48 INFO - 'LOGNAME': 'cltbld', 05:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:48 INFO - 'MOZ_NO_REMOTE': '1', 05:26:48 INFO - 'NO_EM_RESTART': '1', 05:26:48 INFO - 'PAGER': '/bin/cat', 05:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:48 INFO - 'PWD': '/builds/slave/test', 05:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:48 INFO - 'SHELL': '/bin/bash', 05:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:26:48 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:48 INFO - 'USER': 'cltbld', 05:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:48 INFO - 'XPC_FLAGS': '0x0', 05:26:48 INFO - 'XPC_SERVICE_NAME': '0', 05:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:26:48 INFO - Cleaning up... 05:26:48 INFO - Return code: 0 05:26:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:48 INFO - 'HOME': '/Users/cltbld', 05:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:48 INFO - 'LOGNAME': 'cltbld', 05:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:48 INFO - 'MOZ_NO_REMOTE': '1', 05:26:48 INFO - 'NO_EM_RESTART': '1', 05:26:48 INFO - 'PAGER': '/bin/cat', 05:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:48 INFO - 'PWD': '/builds/slave/test', 05:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:48 INFO - 'SHELL': '/bin/bash', 05:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:26:48 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:48 INFO - 'USER': 'cltbld', 05:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:48 INFO - 'XPC_FLAGS': '0x0', 05:26:48 INFO - 'XPC_SERVICE_NAME': '0', 05:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:48 INFO - Downloading/unpacking psutil>=3.1.1 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:52 INFO - Installing collected packages: psutil 05:26:52 INFO - Running setup.py install for psutil 05:26:52 INFO - building 'psutil._psutil_osx' extension 05:26:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:26:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:26:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:26:52 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 05:26:53 INFO - building 'psutil._psutil_posix' extension 05:26:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:26:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:26:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:26:53 INFO - ^ 05:26:53 INFO - 1 warning generated. 05:26:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:53 INFO - Successfully installed psutil 05:26:53 INFO - Cleaning up... 05:26:53 INFO - Return code: 0 05:26:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:54 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 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:26:54 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 05:26:54 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 05:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:54 INFO - 'HOME': '/Users/cltbld', 05:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:54 INFO - 'LOGNAME': 'cltbld', 05:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:54 INFO - 'MOZ_NO_REMOTE': '1', 05:26:54 INFO - 'NO_EM_RESTART': '1', 05:26:54 INFO - 'PAGER': '/bin/cat', 05:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:54 INFO - 'PWD': '/builds/slave/test', 05:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:54 INFO - 'SHELL': '/bin/bash', 05:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:26:54 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:54 INFO - 'USER': 'cltbld', 05:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:54 INFO - 'XPC_FLAGS': '0x0', 05:26:54 INFO - 'XPC_SERVICE_NAME': '0', 05:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:54 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 05:26:54 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 05:26:54 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 05:26:54 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 05:26:54 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 05:26:54 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 05:26:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:57 INFO - Installing collected packages: mozsystemmonitor 05:26:57 INFO - Running setup.py install for mozsystemmonitor 05:26:57 INFO - Successfully installed mozsystemmonitor 05:26:57 INFO - Cleaning up... 05:26:57 INFO - Return code: 0 05:26:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:57 INFO - 'HOME': '/Users/cltbld', 05:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:57 INFO - 'LOGNAME': 'cltbld', 05:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:57 INFO - 'MOZ_NO_REMOTE': '1', 05:26:57 INFO - 'NO_EM_RESTART': '1', 05:26:57 INFO - 'PAGER': '/bin/cat', 05:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:57 INFO - 'PWD': '/builds/slave/test', 05:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:57 INFO - 'SHELL': '/bin/bash', 05:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:26:57 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:57 INFO - 'USER': 'cltbld', 05:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:57 INFO - 'XPC_FLAGS': '0x0', 05:26:57 INFO - 'XPC_SERVICE_NAME': '0', 05:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:57 INFO - Downloading/unpacking jsonschema==2.5.1 05:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:01 INFO - warning: no files found matching '*.txt' 05:27:01 INFO - no previously-included directories found matching 'build' 05:27:01 INFO - no previously-included directories found matching 'dist' 05:27:01 INFO - no previously-included directories found matching '.git*' 05:27:01 INFO - Installing collected packages: jsonschema, functools32 05:27:01 INFO - Running setup.py install for functools32 05:27:01 INFO - warning: no files found matching '*.txt' 05:27:01 INFO - no previously-included directories found matching 'build' 05:27:01 INFO - no previously-included directories found matching 'dist' 05:27:01 INFO - no previously-included directories found matching '.git*' 05:27:01 INFO - Successfully installed jsonschema functools32 05:27:01 INFO - Cleaning up... 05:27:01 INFO - Return code: 0 05:27:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:01 INFO - 'HOME': '/Users/cltbld', 05:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:01 INFO - 'LOGNAME': 'cltbld', 05:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:01 INFO - 'MOZ_NO_REMOTE': '1', 05:27:01 INFO - 'NO_EM_RESTART': '1', 05:27:01 INFO - 'PAGER': '/bin/cat', 05:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:01 INFO - 'PWD': '/builds/slave/test', 05:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:01 INFO - 'SHELL': '/bin/bash', 05:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:01 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:01 INFO - 'USER': 'cltbld', 05:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:01 INFO - 'XPC_FLAGS': '0x0', 05:27:01 INFO - 'XPC_SERVICE_NAME': '0', 05:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:01 INFO - Cleaning up... 05:27:01 INFO - Return code: 0 05:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:01 INFO - 'HOME': '/Users/cltbld', 05:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:01 INFO - 'LOGNAME': 'cltbld', 05:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:01 INFO - 'MOZ_NO_REMOTE': '1', 05:27:01 INFO - 'NO_EM_RESTART': '1', 05:27:01 INFO - 'PAGER': '/bin/cat', 05:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:01 INFO - 'PWD': '/builds/slave/test', 05:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:01 INFO - 'SHELL': '/bin/bash', 05:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:01 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:01 INFO - 'USER': 'cltbld', 05:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:01 INFO - 'XPC_FLAGS': '0x0', 05:27:01 INFO - 'XPC_SERVICE_NAME': '0', 05:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:01 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 05:27:01 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 05:27:01 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 05:27:01 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 05:27:01 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 05:27:01 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 05:27:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:05 INFO - Downloading docopt-0.6.1.tar.gz 05:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:05 INFO - Running setup.py install for blobuploader 05:27:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:05 INFO - Running setup.py install for requests 05:27:06 INFO - Running setup.py install for docopt 05:27:06 INFO - Successfully installed blobuploader requests docopt 05:27:06 INFO - Cleaning up... 05:27:06 INFO - Return code: 0 05:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:06 INFO - 'HOME': '/Users/cltbld', 05:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:06 INFO - 'LOGNAME': 'cltbld', 05:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:06 INFO - 'MOZ_NO_REMOTE': '1', 05:27:06 INFO - 'NO_EM_RESTART': '1', 05:27:06 INFO - 'PAGER': '/bin/cat', 05:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:06 INFO - 'PWD': '/builds/slave/test', 05:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:06 INFO - 'SHELL': '/bin/bash', 05:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:06 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:06 INFO - 'USER': 'cltbld', 05:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:06 INFO - 'XPC_FLAGS': '0x0', 05:27:06 INFO - 'XPC_SERVICE_NAME': '0', 05:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-n4wyB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-jDbQbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-0aUXL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-s_RBCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-54B9yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-_29Ue1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-43yC8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-LYMSws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-VjaDHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:07 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-_9lKoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-vAqglU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-k0rUDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-DFogH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Dyp8rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-qcRY0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-1z9bsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:08 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-NHuaze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:08 INFO - Running setup.py install for manifestparser 05:27:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:08 INFO - Running setup.py install for mozcrash 05:27:09 INFO - Running setup.py install for mozdebug 05:27:09 INFO - Running setup.py install for mozdevice 05:27:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Running setup.py install for mozfile 05:27:09 INFO - Running setup.py install for mozhttpd 05:27:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Running setup.py install for mozinfo 05:27:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Running setup.py install for mozInstall 05:27:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Running setup.py install for mozleak 05:27:10 INFO - Running setup.py install for mozlog 05:27:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for moznetwork 05:27:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozprocess 05:27:10 INFO - Running setup.py install for mozprofile 05:27:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozrunner 05:27:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozscreenshot 05:27:11 INFO - Running setup.py install for moztest 05:27:11 INFO - Running setup.py install for mozversion 05:27:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:11 INFO - Cleaning up... 05:27:11 INFO - Return code: 0 05:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:27:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:11 INFO - 'HOME': '/Users/cltbld', 05:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:11 INFO - 'LOGNAME': 'cltbld', 05:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:11 INFO - 'MOZ_NO_REMOTE': '1', 05:27:11 INFO - 'NO_EM_RESTART': '1', 05:27:11 INFO - 'PAGER': '/bin/cat', 05:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:11 INFO - 'PWD': '/builds/slave/test', 05:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:11 INFO - 'SHELL': '/bin/bash', 05:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:11 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:11 INFO - 'USER': 'cltbld', 05:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:11 INFO - 'XPC_FLAGS': '0x0', 05:27:11 INFO - 'XPC_SERVICE_NAME': '0', 05:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:11 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-XT8wXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:11 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-mPkgxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:11 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-3xX5yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:11 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)) 05:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:11 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-nCnNev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-mylbfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-txkUCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-U33jZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-EyzEe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-3yeqNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-k0bY4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-tWcIZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-1Seolt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:12 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)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Pr2o82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:12 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)) 05:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:12 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-LyAwBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:13 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-aWbgtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:13 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-QVRrtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:13 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-D_fxso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:16 INFO - Downloading blessings-1.6.tar.gz 05:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:16 INFO - Installing collected packages: blessings 05:27:16 INFO - Running setup.py install for blessings 05:27:16 INFO - Successfully installed blessings 05:27:16 INFO - Cleaning up... 05:27:16 INFO - Return code: 0 05:27:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:16 INFO - Reading from file tmpfile_stdout 05:27:16 INFO - Current package versions: 05:27:16 INFO - blessings == 1.6 05:27:16 INFO - blobuploader == 1.2.4 05:27:16 INFO - docopt == 0.6.1 05:27:16 INFO - functools32 == 3.2.3-2 05:27:16 INFO - jsonschema == 2.5.1 05:27:16 INFO - manifestparser == 1.1 05:27:16 INFO - mozInstall == 1.12 05:27:16 INFO - mozcrash == 1.0 05:27:16 INFO - mozdebug == 0.1 05:27:16 INFO - mozdevice == 0.50 05:27:16 INFO - mozfile == 1.2 05:27:16 INFO - mozhttpd == 0.7 05:27:16 INFO - mozinfo == 0.9 05:27:16 INFO - mozleak == 0.1 05:27:16 INFO - mozlog == 3.4 05:27:16 INFO - moznetwork == 0.27 05:27:16 INFO - mozprocess == 0.25 05:27:16 INFO - mozprofile == 0.28 05:27:16 INFO - mozrunner == 6.13 05:27:16 INFO - mozscreenshot == 0.1 05:27:16 INFO - mozsystemmonitor == 0.3 05:27:16 INFO - moztest == 0.8 05:27:16 INFO - mozversion == 1.4 05:27:16 INFO - psutil == 3.1.1 05:27:16 INFO - requests == 1.2.3 05:27:16 INFO - wsgiref == 0.1.2 05:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:16 INFO - 'HOME': '/Users/cltbld', 05:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:16 INFO - 'LOGNAME': 'cltbld', 05:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:16 INFO - 'MOZ_NO_REMOTE': '1', 05:27:16 INFO - 'NO_EM_RESTART': '1', 05:27:16 INFO - 'PAGER': '/bin/cat', 05:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:16 INFO - 'PWD': '/builds/slave/test', 05:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:16 INFO - 'SHELL': '/bin/bash', 05:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:16 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:16 INFO - 'USER': 'cltbld', 05:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:16 INFO - 'XPC_FLAGS': '0x0', 05:27:16 INFO - 'XPC_SERVICE_NAME': '0', 05:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 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)) 05:27:16 INFO - Cleaning up... 05:27:16 INFO - Return code: 0 05:27:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:16 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 0x10c62db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c630768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa949d95250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, '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.ONepHiehxX/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.hiN9HKjBB0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 05:27:16 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 05:27:16 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 05:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:16 INFO - 'HOME': '/Users/cltbld', 05:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:16 INFO - 'LOGNAME': 'cltbld', 05:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:16 INFO - 'MOZ_NO_REMOTE': '1', 05:27:16 INFO - 'NO_EM_RESTART': '1', 05:27:16 INFO - 'PAGER': '/bin/cat', 05:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:16 INFO - 'PWD': '/builds/slave/test', 05:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:16 INFO - 'SHELL': '/bin/bash', 05:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:16 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:16 INFO - 'USER': 'cltbld', 05:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:16 INFO - 'XPC_FLAGS': '0x0', 05:27:16 INFO - 'XPC_SERVICE_NAME': '0', 05:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:17 INFO - Cleaning up... 05:27:17 INFO - Return code: 0 05:27:17 INFO - Running post-action listener: _resource_record_post_action 05:27:17 INFO - Running post-action listener: _start_resource_monitoring 05:27:17 INFO - Starting resource monitoring. 05:27:17 INFO - [mozharness: 2017-04-14 12:27:17.247179Z] Finished create-virtualenv step (success) 05:27:17 INFO - [mozharness: 2017-04-14 12:27:17.248120Z] Running install step. 05:27:17 INFO - Running pre-action listener: _resource_record_pre_action 05:27:17 INFO - Running main action method: install 05:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:17 INFO - Reading from file tmpfile_stdout 05:27:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:17 INFO - Reading from file tmpfile_stdout 05:27:17 INFO - Output received: 05:27:17 INFO - Usage: mozinstall [options] installer 05:27:17 INFO - Options: 05:27:17 INFO - -h, --help show this help message and exit 05:27:17 INFO - -d DEST, --destination=DEST 05:27:17 INFO - Directory to install application into. [default: 05:27:17 INFO - "/builds/slave/test"] 05:27:17 INFO - --app=APP Application being installed. [default: firefox] 05:27:17 INFO - mkdir: /builds/slave/test/build/application 05:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:27:37 INFO - Reading from file tmpfile_stdout 05:27:37 INFO - Output received: 05:27:37 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:27:37 INFO - Running post-action listener: _resource_record_post_action 05:27:37 INFO - [mozharness: 2017-04-14 12:27:37.460809Z] Finished install step (success) 05:27:37 INFO - [mozharness: 2017-04-14 12:27:37.460950Z] Running run-tests step. 05:27:37 INFO - Running pre-action listener: _resource_record_pre_action 05:27:37 INFO - Running main action method: run_tests 05:27:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:27:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:27:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:27:37 INFO - 2017-04-14 05:27:37.475 screenresolution[1627:7397] starting screenresolution argv=screenresolution get 05:27:37 INFO - 2017-04-14 05:27:37.478 screenresolution[1627:7397] Display 0: 1600x1200x32@60 05:27:37 INFO - 2017-04-14 05:27:37.483 screenresolution[1628:7400] starting screenresolution argv=screenresolution list 05:27:37 INFO - Available Modes on Display 0 05:27:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:27:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:27:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:27:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:27:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:27:37 INFO - Intel Iris: 05:27:37 INFO - Chipset Model: Intel Iris 05:27:37 INFO - Type: GPU 05:27:37 INFO - Bus: Built-In 05:27:37 INFO - VRAM (Dynamic, Max): 1536 MB 05:27:37 INFO - Vendor: Intel (0x8086) 05:27:37 INFO - Device ID: 0x0a2e 05:27:37 INFO - Revision ID: 0x0009 05:27:37 INFO - Displays: 05:27:37 INFO - Display: 05:27:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:27:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:27:37 INFO - Display Serial Number: 1600x1200 60 05:27:37 INFO - Main Display: Yes 05:27:37 INFO - Mirror: Off 05:27:37 INFO - Online: Yes 05:27:37 INFO - Rotation: Supported 05:27:37 INFO - Return code: 0 05:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:37 INFO - Python 2.7.3 05:27:37 INFO - Return code: 0 05:27:37 INFO - grabbing minidump binary from tooltool 05:27:37 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')]} 05:27:37 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 0x10c40bd30>, '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 0x10c331db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c400be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:37 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 05:27:37 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 05:27:37 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 05:27:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:37 INFO - Return code: 0 05:27:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:27:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:37 INFO - ENV: RUST_BACKTRACE is now 1 05:27:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:27:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:37 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/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 05:27:37 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/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0328 --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 05:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONepHiehxX/Render', 05:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:37 INFO - 'HOME': '/Users/cltbld', 05:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:37 INFO - 'LOGNAME': 'cltbld', 05:27:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:37 INFO - 'MOZ_NO_REMOTE': '1', 05:27:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:37 INFO - 'NO_EM_RESTART': '1', 05:27:37 INFO - 'PAGER': '/bin/cat', 05:27:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:37 INFO - 'PWD': '/builds/slave/test', 05:27:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:37 INFO - 'RUST_BACKTRACE': '1', 05:27:37 INFO - 'SHELL': '/bin/bash', 05:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hiN9HKjBB0/Listeners', 05:27:37 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 05:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:37 INFO - 'USER': 'cltbld', 05:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:37 INFO - 'XPC_FLAGS': '0x0', 05:27:37 INFO - 'XPC_SERVICE_NAME': '0', 05:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:37 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/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 05:27:38 INFO - mozversion application_buildid: 20170414030225 05:27:38 INFO - mozversion application_changeset: cda24082bff8864a6e53726feeae33cae9e17309 05:27:38 INFO - mozversion application_display_name: Nightly 05:27:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:38 INFO - mozversion application_name: Firefox 05:27:38 INFO - mozversion application_remotingname: firefox 05:27:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:27:38 INFO - mozversion application_vendor: Mozilla 05:27:38 INFO - mozversion application_version: 55.0a1 05:27:38 INFO - mozversion platform_buildid: 20170414030225 05:27:38 INFO - mozversion platform_changeset: cda24082bff8864a6e53726feeae33cae9e17309 05:27:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:27:38 INFO - mozversion platform_version: 55.0a1 05:27:38 INFO - using testdate: 1492172858 05:27:38 INFO - actual date: 1492172858 05:27:38 INFO - starting webserver on 'localhost:49246' 05:27:38 INFO - SUITE-START | Running 2 tests 05:27:38 INFO - TEST-START | dromaeo_css 05:27:38 INFO - operating with platform_type : mac_ 05:27:38 INFO - Initialising browser for dromaeo_css test... 05:27:38 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpE0j_ZU/profile http://localhost:49246/getInfo.html) 05:27:41 INFO - PID 1638 | __metrics Screen width/height:1600/1200 05:27:41 INFO - PID 1638 | colorDepth:24 05:27:41 INFO - PID 1638 | Browser inner width/height: 1024/689 05:27:41 INFO - PID 1638 | __metrics 05:27:41 INFO - PID 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:27:41 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:42 INFO - TEST-INFO | 1638: exit 0 05:27:42 INFO - Browser initialized. 05:27:42 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:42 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpE0j_ZU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:54 INFO - PID 1641 | RSS: Main: 243208192 05:27:54 INFO - PID 1641 | 05:30:58 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 05:31:01 INFO - PID 1641 | RSS: Main: 428789760 05:31:01 INFO - PID 1641 | 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 05:32:43 INFO - PID 1641 | 05:32:43 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:32:43 INFO - PID 1641 | Full stack: 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 05:32:43 INFO - PID 1641 | 05:32:43 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:32:43 INFO - PID 1641 | Full stack: 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 05:32:43 INFO - PID 1641 | 05:32:43 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:32:43 INFO - PID 1641 | Full stack: 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | ************************* 05:32:43 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 05:32:43 INFO - PID 1641 | 05:32:43 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:32:43 INFO - PID 1641 | Full stack: 05:32:43 INFO - PID 1641 | ************************* 05:34:03 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 05:34:04 INFO - PID 1641 | RSS: Main: 367718400 05:34:04 INFO - PID 1641 | 05:37:06 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 05:37:07 INFO - PID 1641 | RSS: Main: 327077888 05:37:07 INFO - PID 1641 | 05:40:09 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 05:40:10 INFO - PID 1641 | RSS: Main: 334663680 05:40:10 INFO - PID 1641 | 05:43:13 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 05:43:14 INFO - PID 1641 | RSS: Main: 333889536 05:43:14 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 05:46:17 INFO - PID 1641 | RSS: Main: 375390208 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | __start_tp_report 05:46:17 INFO - PID 1641 | _x_x_mozilla_page_load 05:46:17 INFO - PID 1641 | _x_x_mozilla_page_load_details 05:46:17 INFO - PID 1641 | |i|pagename|runs| 05:46:17 INFO - PID 1641 | |0;dojo.html;3444.7588668793196;3459.757816952814;3464.6362131976143;3471.0107619328487;3521.9823900880506;5930.288365396159;6094;6119.969400152993;6128.57100003;6131.662758548284;6106.450419462248;6123.173371594833;6136.7335323661255;6167.691615419233;6206.472449841769;5174.275601415805;5340.172273297626;5359.464053594629;5373.194020896867;5439.755211015494;5406.135018397057;5469.179623056533;5477.863053423656;5477.986572484103;5521.972390138044;5276.366835979707;5340.706261155635;5344.412114667383;5353.250544923714;5429.701366424845;5354.14333706609;5362.490563396471;5379.946200538023;5425.26758887553;5438.510534051915;5257.342832145981;5298.549623282026;5312.574994000471;5316.893662126775;5332.626716129873;5983.282006159246;6099.176611157525;6110.725017374184;6123.785667501661;6136.539759518054;6384.744610215585;6388.776392826228;6397.8400539986405;6464.321246269121;6511.479081673455;6564.507661925327;6568.704408301638;6586.341365863424;6589.472842172662;6606.207255129415;6067.332593414721;6201.596896201778;6211.9689401552705;6233.750649974041;6234.1583886175695;6533.477321814244;6626.039224312544;6629.105070815378;6739.427148692318;6743.5953842769595;6323.241211054703;6390.584612000205;6392.360763923571;6393.744250229939;6393.808185754435;6477.384648458389;6554.344565543408;6559.442447392025;6566.474682025522;6575.868482630321;6285.560010799291;6468.708908099147;6474.352564743488;6487.805365838938;6495.317991610813;6286.9056964145575;6341.524385671093;6470.708818103197;6493.318201588765;6510.7721229756735;5239.083160446907;5240.842774716764;5242.633015688942;5249.448807875195;5278.2346559749385;4642.837500687459;4644.744539050384;4664.55686709762;4665.883352916204;4697.295405689174;6123.203983482208;6157.138000679908;6162;6163.260408750889;6166.691665416712;6412.294647588855;6444.2589102252905;6467.773627923;6475.449586785082;6480.287168411471;6144.525313924626;6149.754009839557;6158.846028849314;6182.381761823872;6191.380861913773;5693.231413759172;5748.568857335633;5763.2507773989955;5767.192593036978;5791.884162316815;6681.198256209286;6721.899171512431;6738.7304507819135;6739.224989126314;6749.122614060141;6262.3111457738705;6339.778107766206;6357.078223657451;6542;6654.966725166343;6743.5953842769595;6770.086038384952;6775.1531058617675;6784.423324017514;6784.457243420613;6446.806595802133;6468.15913931186;6476.967615161894;6479.4816414685765;6487.708053137714;6085.479902370879;6237.563370564017;6485.481161507162;6611.834704132243;6626.602403855784;6251.218597675291;6353.777617783356;6368.108464814837;6381.457576106083;6415.101885736094;6354.809355719336;6400.743970241138;6412.6793660317735;6427.742890284337;6435.549511534147;6123.191113103653;6250.781222657367;6303.9684801575695;6305.464035556845;6315.715792789244;5943.227380440515;6249.0626406039455;6283.654399007915;6318.304986451395;6367.713452894724;6241.344658810759;6252.09344645033;6252.874942501034;6263.874722505433;6280.089387038763 05:46:17 INFO - PID 1641 | |1;ext.html;738.3945164964728;805.5247404031622;825.933925285977;1131.3042478875489;1151.033132168978;27523;36330;36877.81561092198;36892.81553592235;36940.630593694055;37996.24007519848;38236;38354.424683629695;38379.232415351675;38403;8407.999999999985;8584.656613735444;8593.097724738906;8598.398112132154;8599.44103633265;6098.969505152468;6265.843353916143;8368;8548.78628034298;8558.186972237627;8533.274671652885;8628.09405012474;8631.913680863205;8635.827283454328;8641.567921603926;7180.820479488002;8599.61301741423;8603.956980215122;8610.870836937389;8611.870821937677;8487.66049358025;8578.871316930252;8579.227869491713;8580.785480362978;8609.655613775441;36549.72075977328;36863.63136368629;36865.63134368649;36917;36932.26135477275;3601.9459708104137;3638.6361363863402;3638.7089032877307;3640.1627625645983;3640.8361623726996;30206.24484387886;30227.848860755556;30343.696563034307;30378.392432151453;30381.544276835866;3148.8583013764437;3182.6314684685576;3203.471427214507;3205.983970080158;3215.244417561871;273181.63409183023;278286;279457;280303;280499;48227.75886120547;48420.54738357855;48448.27327590019;48461.5153848464;48468;50832;50869.74565127151;50960.23559646608;50998.235026474635;51035.74482127566;14162.221077840612;14278.928605356907;14282;14298.925730967683;14317;9614.029124029557;10008.249381296431;11553.826692599618;11748.236364636272;11768.529258829722;10532.684019479428;10668.826429092793;11226.887731122748;11940.641780746591;12140.635780926586;4494.348319493655;4699.694519856198;5201;5225.5582754659;5378.300820893259;908.4413085952092;1025.179856115105;1041.416806588313;1052.742078190833;1091.2143256855052;23766.524669506514;23784.16755413552;23822.642660360107;23933.521329573658;24248.757512425003;1128.4865386249237;1128.954841806335;1131.9830202546968;1166.1953252255917;1182.2906256246183;11650.941745291218;12215.389230538438;12239.094354578938;12239.276462662088;12257.757226351378;278698;279749;279884;280259;281102;51621;51623;51638.48361516412;51708.48291517112;51778;1524.6340878189155;1549.9457518987008;1565.3738504598252;1568.1688704986375;1575.314738088935;17036.233369498153;20606.587868242852;22255.998480068112;23249;23430;36206;36228.09429764277;36246.09384765402;36285.81857090697;36301.45547816732;257327.713361432;257430;257783;258090.41909581414;258632;33617;33649.663503365635;33653.663463365054;33664.99005029853;33708.66291337055;35173.824130879184;35401.64598354087;43044.35433468563;43578;43580.34629480497;22447;27457.039003635575;28678.426431470838;29770.958016469318;30006.54990175193;28808.567871481526;29503.85248073746;29594.556081659222;29766.107016788665;29844.85077574598;27503.31241718973;34218.315633687685;34785.47821782726;35593.64406355903;35600.64399355973;28588;29273.165519468886;29770.553441697957;29843.95546155874;30114.397712045196;22352.88823555872;23193.265569876374;23232.76767232306;23330;23344.299671009896 05:46:17 INFO - PID 1641 | |2;jquery.html;389.92350355693566;431.874756320667;433.77877282585894;445.8016182798654;466.3308152800731;15019.624509387271;21053.473663158427;22510.887445562792;23318.883405582947;23580.528389432202;18388.816111838878;18570.628587428244;23812;23881.402964925885;24203.27390178293;6100.359462256466;6195.380461953813;6231.6572588507615;6234.127222188898;6289.308176100625;3710.3321402147603;5999.16011758352;6183.165272688197;6194.039923811793;6200.658963756991;3861.961380386202;5214.634975551713;5944.791932282371;6202.4417802397775;6226.43962043416;6073.696315184267;6107.969460152715;6202.565820392574;6215.098810672473;6217.378262173792;5408.675479471244;5501.724913754297;5504.504594586507;5505.724713764336;5513.724313784335;27693.584596231074;28493.857530712423;29226.707732922823;29290.121296361143;29667.70332296671;2166.295953815016;2215.0918123569422;2215.412915577357;2218.3123231798195;2227.4431392151964;17216.56958576033;17769.555761106076;18216.089195540302;18344.174512146987;18393.264269429208;2109.4390151287935;2148.7743786902306;2173;2189.5620875824898;2191.1783081344497;170423;172352.99999999875;172830;173517.26482735138;174499;11315.773684526428;12151.939240303918;12312.26126432417;12476.563320283747;12715.173513721578;12613.936930315289;12668.873311266954;15345.6163595911;15365.923170384076;15369.615759605877;7822.726204582812;9138;9205.493697846548;9247;9257.907420925705;7535.886961695579;8292.212239837207;8556.61495232716;8865.379423440298;8874.245689116367;7008.649567521604;7078.079849619619;7820.569868657279;7862.567558784207;7863.842723145505;1809.936652217166;2157.9892100539396;2161.8378621603442;2161.956760864774;2289.919852805144;954.9856752148723;955.6798472511647;964.4309857184295;990.4700984973005;1004.924630652704;20617.79382206189;21133.471663208544;21189.576208475744;21304.632550327147;21451.03470343838;984.2568860510412;985.3102828020415;1011.6560369474414;1015.8780946286493;1018.8064267789244;9256.72229833106;9862.654807081717;10839.945800271105;10873.456327183609;10881;549884;568682;575491;581387;581780;99827.50086249522;130897;135479;135953;137009;1118.278710231912;1128.937908415045;1170.2568868768394;1173.3663821536445;1173.8297946797666;17348.826511735228;18073.277068917097;18278.268869245083;18464.630707386044;18608.44174674762;51232.74383628207;52399.21401179062;52424;56434;57364.71317643385;53014;70516.64741676259;71883.64058179676;72899.54200915845;74849.62575187089;7597.924020759942;8413.747587572383;8640.265577425738;8953.59708813118;9138.223251023737;14017;14067.788983165055;14249;14521.85478145205;14544.98185127031;11642.6507204784;11643;11810.940945295219;12056.698582535157;12132.636020919386;11196.272242304223;11336.94331528337;11342.773144536897;11362.14783891195;11717.472713728073;11725.648230553097;12021.879781202077;12051.397430128634;12103.152779305716;12155.331456769962;8499.320054395757;8595.65617375298;8784;8984.146506081912;9141.085891410805;9806.85289720669;11239.943800280946;11689.824652630388;12039.75920481603;12183 05:46:17 INFO - PID 1641 | |3;mootools.html;1264.6838290427393;1374.292239496659;1444.2850788859516;1469.375515405953;1470.2869108482391;11673.1828771986;12175.939120304409;12185.878141218585;12215.633530994073;12236.20464669797;11591.072714182867;12086.274823510596;12118.818217726719;12151.635450936465;12176.878231217685;2543.7329080446566;2570.7429257074236;2589.2491177558486;2595.8442493450452;2600.712647239619;2141.7108690326763;2431.331383869441;2528.8609126498036;2572.1640466848257;2576.5233431815172;2015.939521814348;2195.1987524553583;2408.2414039577475;2474.7030356357263;2496.8127390445698;2442.9022839086415;2463.4334103156284;2470.3824043989002;2472.911918755751;2474.2329877737957;2439.207257641256;2451.8038556915403;2453.9263822085186;2459.053264493165;2459.95080098397;11778.116641251854;12026.977706894924;12033.51865925362;12049.03607711381;12067.698307542294;6508.739650413978;6731.865362692768;6776.085228494188;6779.559328643622;6782.593044417302;4061.5735347788354;4254.532001479834;4351.5648435156545;4443.822247110112;4449.510553839075;1251.7934540800757;1255.6609715376796;1280.0335746511416;1310.246608200279;1316.7103237287781;14556.34496447673;15810;16655.33378664852;16803.747943780854;16821.411250606292;5498.670079795225;5530.695811730313;5642.492175704207;5746.13807928814;5771.105478650816;12524.499020039279;12528.373581320897;12536.561220357426;12540.623781286577;12560.937195313965;6666.766663166863;6667.533272670867;6675;6677.1319728435965;6677.332266773284;5972.014617588136;6108.816735497942;6133.815985520441;6206.689665516707;6228.968855155696;4298.892527686833;4415;4418.182636212311;4467.30756732707;4493.505714371417;1266.094742259289;1283.6277479531018;1299.4217573179844;1301.6680746409604;1306.8693130686854;677.5866721300004;713.9535930164523;800.3277247112453;811.3914564076942;825.5665775467927;5554.527865131428;6668.366505182;6885.862282754317;7279;7334;821.2690705272313;913.6710784117712;919.3059240273684;929.9070092990647;956.407027642852;4298.949722455176;4338.1323735252445;4362.432883725095;4379.737215767064;4415.602595766396;14567.854321456862;15272.465463708717;15294.847051529565;15340.92329538345;15358.232088395536;14632;15014.699706005818;15028.323725432381;15238.238088095552;15248.847511524964;8468.534230617252;8515.57422128891;8633.395662303705;8676.696315628922;8748.562571871382;6586.637734924625;6692.196936367667;6763.357481039294;6784.898226526705;6849.828754281183;13420.194788312732;13452.260125693181;13530.120542164728;13801.723965520834;13815.516456923959;13755.656108596964;13934.930325348714;14105.647358816112;14108.153510789385;14151.929240353733;8771.298296136167;9091.227245684191;9095.226905713089;9096.636134554808;9146.95426522863;10798.67603971882;10881.727956801144;11007.449627518752;11014.889851101387;11020.063294620048;9256.213221876216;9270.860937086083;9344.439333640003;9352.111549402796;9352.251819854258;9110.180083792226;9110.544472776468;9129.45223286605;9142.171565687022;9200.26397888154;6614.239362473377;8188.631511582113;8219.835603287782;8236.176382361717;8257.463264887763;5943;5959.404059594006;6138.600990935575;6169.2288463942;6227.688615569294;5998.670073145844;6084.969575152096;6197.504199663926;6292.4966002720585;6365.649889256136 05:46:17 INFO - PID 1641 | |4;prototype.html;400.5073759276092;402.13340251757467;409.3000968344131;411.4178437510921;417.8997040710229;5670.262865827442;6021.548383871211;6024.969875150629;6062.696520248146;6076.483498902588;5001.449840517549;5608.794109266507;5644.971775141119;5853.912191317134;5902.793402230912;4253.680973926952;4529.569690879362;4535.183666939949;4536.54634536547;4546.8408605698805;4514.887127821814;4551.975805443765;4554.43069616298;4568.565986231302;4584.220682483986;4363.621925314161;4457.665675074366;4486.663500237495;4512.751798651073;4514.390557274759;3870.9806450967844;4454.554544545552;4461.933071003921;4475.686701930867;4481.5070342262325;3449.4653328734084;3837.8678289904547;3979.781112038837;3981.5222173339093;4010.5588385277597;5457.508824205801;5482.259894914216;5747.655140691572;5793.333766616851;5874.236349274567;4177.874663760092;4889.3643826302705;5122.820701275475;5160.8967820643375;5210.296609957645;5100.591952643779;6371.458426033792;6373.71318290678;6374.330695277022;6420.678966051725;4108.91782164355;4162.667946257199;4244.936325955113;4303.655707543389;4309.525952145262;6098.57309988301;6365.045243213509;6535.869282614416;6565.54041217115;6699.933000669979;4235.470566179228;4313.309870420718;4333.913321733611;4347.3261644445165;4352.280849064602;4190.835918881226;4260.339647354665;4365.289503921641;4381.518033016366;4400.295952647561;4212.7682977435925;5099.404919531721;5149.841285710685;5155.304033955368;5160.503453998298;6388.84027899297;6400.0719895614875;6402.583832050995;6404.7117879695525;6417.39034791694;1180;1310.5151094095245;1490.7316682996948;1513.7729340598778;1520.787089807428;873.8121303919688;983.2085171436919;997.1225321716988;1005.4118340770585;1009.4347165587294;5372.597055220874;5784.471472401831;5877.382874798084;6051.243594550681;6115.96942015296;4836.854894353175;6237.812865614039;6520.109168341222;6522.836929076716;6541.738330466823;4960.652754307164;5376.8118115865755;5783.913241301384;5828.154917537018;6025.487833534111;3393.52490651309;3400.829958502065;3431.330890476333;3431.742619303512;3447.276072024903;5235.816746413857;6326.367363263636;6769.695363708645;6816.352446517573;6837.623930683761;5602.047651899187;6317.936820631827;6714.462842972551;6791.898121528181;6823.931760682429;6455.838604034937;6733.192016957996;6769.999999999902;6814.93185068143;6871;5441.490238796034;6082.239720034996;6453.1610890583925;6473.611583305017;6523.836904077246;6205.751769929152;6397.424231819158;6402.167718196791;6459.870802584016;6474.514411419068;6589.341065893373;6702.765403210864;6715.496337774589;6750.5274630775375;6795.150606174228;4254.702170848134;4330.5236423993965;4343.522212556553;4364.105358401456;4364.956350436455;5634.464725851038;6490.710071291882;6534.705938232886;6567.686462707382;6604;5339.4126646068125;5464.480874316933;6330.335314791881;6342.302346741947;6357.332480089709;5646.858828529155;5983.431574000463;6116.418940200674;6350.7142178603;6371.139896113966;6165.5375846810775;6195.783147589813;6201.503879689524;6210.4100110489435;6232.220972378453;5966.0766224550525;6064.999275119732;6387.073874288295;6426.196725409324;6426.678666066771;5262.42113367537;5422.755975981011;5682.835018821214;6234.750609975732;6287.591306565058 05:46:17 INFO - PID 1641 | |5;yui.html;717.5120917775911;774.9341305988991;882.4484697064335;883.8409086364452;883.9071897450767;13113.606591802238;17778.91110544447;17871;18495.167717452714;18496.35262765802;16155.353785848552;17296.221670024846;17703.29186832525;17719.822801771978;17821;780.3055280800093;936.2650319499195;937.3906960475712;937.5640327247828;939.2392162348485;686.8866637004888;696.6656005117546;969.2585172343163;998.5556427389814;1015.2030655935092;1031.5254982707963;1032.4373216596973;1034.5499707627168;1036.160709825044;1037.5538518437106;1026.5534492495788;1026.7535791410082;1028.074732740532;1028.963986260481;1035.2494441529907;763.5685837501794;764.6100488750722;765.4374035084264;765.628670095009;769.9923000769977;16217;16419.6716065678;16602.25289861959;16964.40624578146;17163.828361716347;16734.83265167345;16902.323907043705;16904.661906761918;17156.914215428842;17207.741883871753;14022.228777417238;14131;14172.149671019772;14542.70914581713;14737;3572.6605972432576;3579.8926032219074;3582.9104272393397;3591.7665351752053;3596.1908570571672;87692.56153719254;113836.43081784621;118972.31818340915;120054;120325;11315.321080735182;11693.181477296677;13101.737965240642;13503;13503.662408439672;17858.46424607264;20559;25253.35853169538;25675.743242567707;25702;7596.506227095221;7899.565523896241;7908.5650289234645;7938.047434307805;7949.046114466186;3722.8883133506038;3778.1876896467393;3806.238752249506;3807.2956503047026;3808.7524310919703;4297.312430011246;4297.462817147856;4451.443569553806;4452.554744525586;4460.799264033127;821.7247222180637;929.4376901974343;959.5154447004218;965.285688590438;971.9308760363543;643.5848877474003;667.4560233409852;668.1414382518537;677.6916502991127;693.9271376505495;10841.403722795165;11177.608783692694;11202.215844890943;11748.118891083031;11848.70378240551;627.6713393310777;653.2259272761793;662.6057495789997;685.3454950522239;692.2005084127841;4330.069035157457;4763.476017638057;4799.352087468147;4849.781759820817;5101.770420331094;98219.01780982241;98917;99419;102047;103789;63339.68330158412;71570;81923.59038204771;82428.17571824206;92435;77975.61012194902;78325.21674783294;78550;79467.8079828803;80826;8418.536980465888;12146.392680366123;12197.817032744693;12227.327496987751;12346.197497162655;32676.673233267364;37887.62112378951;38117.66588169401;38178.2364352717;39538.40692389559;64046.67976660087;64227;71153;71629.28370716226;74600;16239.59401014984;17047.891887027305;17060.914695426443;17090.65818683644;17142.142892855558;17796.822031779517;18227.270909164014;18271.908640456713;18317.816821832144;18333.3583324583;16316.755248671518;16640.916795415946;16821.747673785147;16847.747283791;17017.893836900563;16702.916485417496;16852.57868553296;16867.578310542336;16923.323067077177;17037.722170837485;15958.680826383175;16111.516654500383;16326.510204693877;16442.013479191286;16478.176091195633;11033.172512061788;11642.88357116418;11650.65048048526;12166.75666486683;12325.137240393087;12407.627771166879;13451.192928424325;13650.539784086444;13808.1024733392;13875.86124138786 05:46:17 INFO - PID 1641 | __end_tp_report 05:46:17 INFO - PID 1641 | __start_cc_report 05:46:17 INFO - PID 1641 | _x_x_mozilla_cycle_collect,2052 05:46:17 INFO - PID 1641 | __end_cc_report 05:46:17 INFO - PID 1641 | __startTimestamp1492173977281__endTimestamp 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | ------- Summary: start ------- 05:46:17 INFO - PID 1641 | Number of tests: 6 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:6031.88 Median:6251.22 stddev:680.65 (10.9%) stddev-sans-first:651.78 05:46:17 INFO - PID 1641 | Values: 3444.8 3459.8 3464.6 3471.0 3522.0 5930.3 6094.0 6120.0 6128.6 6131.7 6106.5 6123.2 6136.7 6167.7 6206.5 5174.3 5340.2 5359.5 5373.2 5439.8 5406.1 5469.2 5477.9 5478.0 5522.0 5276.4 5340.7 5344.4 5353.3 5429.7 5354.1 5362.5 5379.9 5425.3 5438.5 5257.3 5298.5 5312.6 5316.9 5332.6 5983.3 6099.2 6110.7 6123.8 6136.5 6384.7 6388.8 6397.8 6464.3 6511.5 6564.5 6568.7 6586.3 6589.5 6606.2 6067.3 6201.6 6212.0 6233.8 6234.2 6533.5 6626.0 6629.1 6739.4 6743.6 6323.2 6390.6 6392.4 6393.7 6393.8 6477.4 6554.3 6559.4 6566.5 6575.9 6285.6 6468.7 6474.4 6487.8 6495.3 6286.9 6341.5 6470.7 6493.3 6510.8 5239.1 5240.8 5242.6 5249.4 5278.2 4642.8 4644.7 4664.6 4665.9 4697.3 6123.2 6157.1 6162.0 6163.3 6166.7 6412.3 6444.3 6467.8 6475.4 6480.3 6144.5 6149.8 6158.8 6182.4 6191.4 5693.2 5748.6 5763.3 5767.2 5791.9 6681.2 6721.9 6738.7 6739.2 6749.1 6262.3 6339.8 6357.1 6542.0 6655.0 6743.6 6770.1 6775.2 6784.4 6784.5 6446.8 6468.2 6477.0 6479.5 6487.7 6085.5 6237.6 6485.5 6611.8 6626.6 6251.2 6353.8 6368.1 6381.5 6415.1 6354.8 6400.7 6412.7 6427.7 6435.5 6123.2 6250.8 6304.0 6305.5 6315.7 5943.2 6249.1 6283.7 6318.3 6367.7 6241.3 6252.1 6252.9 6263.9 6280.1 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:42023.09 Median:3210.61 stddev:71229.62 (2218.6%) stddev-sans-first:71361.99 05:46:17 INFO - PID 1641 | Values: 738.4 805.5 825.9 1131.3 1151.0 27523.0 36330.0 36877.8 36892.8 36940.6 37996.2 38236.0 38354.4 38379.2 38403.0 8408.0 8584.7 8593.1 8598.4 8599.4 6099.0 6265.8 8368.0 8548.8 8558.2 8533.3 8628.1 8631.9 8635.8 8641.6 7180.8 8599.6 8604.0 8610.9 8611.9 8487.7 8578.9 8579.2 8580.8 8609.7 36549.7 36863.6 36865.6 36917.0 36932.3 3601.9 3638.6 3638.7 3640.2 3640.8 30206.2 30227.8 30343.7 30378.4 30381.5 3148.9 3182.6 3203.5 3206.0 3215.2 273181.6 278286.0 279457.0 280303.0 280499.0 48227.8 48420.5 48448.3 48461.5 48468.0 50832.0 50869.7 50960.2 50998.2 51035.7 14162.2 14278.9 14282.0 14298.9 14317.0 9614.0 10008.2 11553.8 11748.2 11768.5 10532.7 10668.8 11226.9 11940.6 12140.6 4494.3 4699.7 5201.0 5225.6 5378.3 908.4 1025.2 1041.4 1052.7 1091.2 23766.5 23784.2 23822.6 23933.5 24248.8 1128.5 1129.0 1132.0 1166.2 1182.3 11650.9 12215.4 12239.1 12239.3 12257.8 278698.0 279749.0 279884.0 280259.0 281102.0 51621.0 51623.0 51638.5 51708.5 51778.0 1524.6 1549.9 1565.4 1568.2 1575.3 17036.2 20606.6 22256.0 23249.0 23430.0 36206.0 36228.1 36246.1 36285.8 36301.5 257327.7 257430.0 257783.0 258090.4 258632.0 33617.0 33649.7 33653.7 33665.0 33708.7 35173.8 35401.6 43044.4 43578.0 43580.3 22447.0 27457.0 28678.4 29771.0 30006.5 28808.6 29503.9 29594.6 29766.1 29844.9 27503.3 34218.3 34785.5 35593.6 35600.6 28588.0 29273.2 29770.6 29844.0 30114.4 22352.9 23193.3 23232.8 23330.0 23344.3 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:36185.17 Median:23449.71 stddev:97202.45 (414.5%) stddev-sans-first:97437.97 05:46:17 INFO - PID 1641 | Values: 389.9 431.9 433.8 445.8 466.3 15019.6 21053.5 22510.9 23318.9 23580.5 18388.8 18570.6 23812.0 23881.4 24203.3 6100.4 6195.4 6231.7 6234.1 6289.3 3710.3 5999.2 6183.2 6194.0 6200.7 3862.0 5214.6 5944.8 6202.4 6226.4 6073.7 6108.0 6202.6 6215.1 6217.4 5408.7 5501.7 5504.5 5505.7 5513.7 27693.6 28493.9 29226.7 29290.1 29667.7 2166.3 2215.1 2215.4 2218.3 2227.4 17216.6 17769.6 18216.1 18344.2 18393.3 2109.4 2148.8 2173.0 2189.6 2191.2 170423.0 172353.0 172830.0 173517.3 174499.0 11315.8 12151.9 12312.3 12476.6 12715.2 12613.9 12668.9 15345.6 15365.9 15369.6 7822.7 9138.0 9205.5 9247.0 9257.9 7535.9 8292.2 8556.6 8865.4 8874.2 7008.6 7078.1 7820.6 7862.6 7863.8 1809.9 2158.0 2161.8 2162.0 2289.9 955.0 955.7 964.4 990.5 1004.9 20617.8 21133.5 21189.6 21304.6 21451.0 984.3 985.3 1011.7 1015.9 1018.8 9256.7 9862.7 10839.9 10873.5 10881.0 549884.0 568682.0 575491.0 581387.0 581780.0 99827.5 130897.0 135479.0 135953.0 137009.0 1118.3 1128.9 1170.3 1173.4 1173.8 17348.8 18073.3 18278.3 18464.6 18608.4 51232.7 52399.2 52424.0 56434.0 57364.7 53014.0 70516.6 71883.6 72899.5 74849.6 7597.9 8413.7 8640.3 8953.6 9138.2 14017.0 14067.8 14249.0 14521.9 14545.0 11642.7 11643.0 11810.9 12056.7 12132.6 11196.3 11336.9 11342.8 11362.1 11717.5 11725.6 12021.9 12051.4 12103.2 12155.3 8499.3 8595.7 8784.0 8984.1 9141.1 9806.9 11239.9 11689.8 12039.8 12183.0 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:7207.39 Median:4158.05 stddev:4574.05 (110.0%) stddev-sans-first:4565.08 05:46:17 INFO - PID 1641 | Values: 1264.7 1374.3 1444.3 1469.4 1470.3 11673.2 12175.9 12185.9 12215.6 12236.2 11591.1 12086.3 12118.8 12151.6 12176.9 2543.7 2570.7 2589.2 2595.8 2600.7 2141.7 2431.3 2528.9 2572.2 2576.5 2015.9 2195.2 2408.2 2474.7 2496.8 2442.9 2463.4 2470.4 2472.9 2474.2 2439.2 2451.8 2453.9 2459.1 2460.0 11778.1 12027.0 12033.5 12049.0 12067.7 6508.7 6731.9 6776.1 6779.6 6782.6 4061.6 4254.5 4351.6 4443.8 4449.5 1251.8 1255.7 1280.0 1310.2 1316.7 14556.3 15810.0 16655.3 16803.7 16821.4 5498.7 5530.7 5642.5 5746.1 5771.1 12524.5 12528.4 12536.6 12540.6 12560.9 6666.8 6667.5 6675.0 6677.1 6677.3 5972.0 6108.8 6133.8 6206.7 6229.0 4298.9 4415.0 4418.2 4467.3 4493.5 1266.1 1283.6 1299.4 1301.7 1306.9 677.6 714.0 800.3 811.4 825.6 5554.5 6668.4 6885.9 7279.0 7334.0 821.3 913.7 919.3 929.9 956.4 4298.9 4338.1 4362.4 4379.7 4415.6 14567.9 15272.5 15294.8 15340.9 15358.2 14632.0 15014.7 15028.3 15238.2 15248.8 8468.5 8515.6 8633.4 8676.7 8748.6 6586.6 6692.2 6763.4 6784.9 6849.8 13420.2 13452.3 13530.1 13801.7 13815.5 13755.7 13934.9 14105.6 14108.2 14151.9 8771.3 9091.2 9095.2 9096.6 9147.0 10798.7 10881.7 11007.4 11014.9 11020.1 9256.2 9270.9 9344.4 9352.1 9352.3 9110.2 9110.5 9129.5 9142.2 9200.3 6614.2 8188.6 8219.8 8236.2 8257.5 5943.0 5959.4 6138.6 6169.2 6227.7 5998.7 6085.0 6197.5 6292.5 6365.6 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5119.34 Median:5658.56 stddev:1586.03 (28.0%) stddev-sans-first:1550.43 05:46:17 INFO - PID 1641 | Values: 400.5 402.1 409.3 411.4 417.9 5670.3 6021.5 6025.0 6062.7 6076.5 5001.4 5608.8 5645.0 5853.9 5902.8 4253.7 4529.6 4535.2 4536.5 4546.8 4514.9 4552.0 4554.4 4568.6 4584.2 4363.6 4457.7 4486.7 4512.8 4514.4 3871.0 4454.6 4461.9 4475.7 4481.5 3449.5 3837.9 3979.8 3981.5 4010.6 5457.5 5482.3 5747.7 5793.3 5874.2 4177.9 4889.4 5122.8 5160.9 5210.3 5100.6 6371.5 6373.7 6374.3 6420.7 4108.9 4162.7 4244.9 4303.7 4309.5 6098.6 6365.0 6535.9 6565.5 6699.9 4235.5 4313.3 4333.9 4347.3 4352.3 4190.8 4260.3 4365.3 4381.5 4400.3 4212.8 5099.4 5149.8 5155.3 5160.5 6388.8 6400.1 6402.6 6404.7 6417.4 1180.0 1310.5 1490.7 1513.8 1520.8 873.8 983.2 997.1 1005.4 1009.4 5372.6 5784.5 5877.4 6051.2 6116.0 4836.9 6237.8 6520.1 6522.8 6541.7 4960.7 5376.8 5783.9 5828.2 6025.5 3393.5 3400.8 3431.3 3431.7 3447.3 5235.8 6326.4 6769.7 6816.4 6837.6 5602.0 6317.9 6714.5 6791.9 6823.9 6455.8 6733.2 6770.0 6814.9 6871.0 5441.5 6082.2 6453.2 6473.6 6523.8 6205.8 6397.4 6402.2 6459.9 6474.5 6589.3 6702.8 6715.5 6750.5 6795.2 4254.7 4330.5 4343.5 4364.1 4365.0 5634.5 6490.7 6534.7 6567.7 6604.0 5339.4 5464.5 6330.3 6342.3 6357.3 5646.9 5983.4 6116.4 6350.7 6371.1 6165.5 6195.8 6201.5 6210.4 6232.2 5966.1 6065.0 6387.1 6426.2 6426.7 5262.4 5422.8 5682.8 6234.8 6287.6 05:46:17 INFO - PID 1641 | 05:46:17 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:21100.84 Median:18495.76 stddev:28814.70 (155.8%) stddev-sans-first:28854.89 05:46:17 INFO - PID 1641 | Values: 717.5 774.9 882.4 883.8 883.9 13113.6 17778.9 17871.0 18495.2 18496.4 16155.4 17296.2 17703.3 17719.8 17821.0 780.3 936.3 937.4 937.6 939.2 686.9 696.7 969.3 998.6 1015.2 1031.5 1032.4 1034.5 1036.2 1037.6 1026.6 1026.8 1028.1 1029.0 1035.2 763.6 764.6 765.4 765.6 770.0 16217.0 16419.7 16602.3 16964.4 17163.8 16734.8 16902.3 16904.7 17156.9 17207.7 14022.2 14131.0 14172.1 14542.7 14737.0 3572.7 3579.9 3582.9 3591.8 3596.2 87692.6 113836.4 118972.3 120054.0 120325.0 11315.3 11693.2 13101.7 13503.0 13503.7 17858.5 20559.0 25253.4 25675.7 25702.0 7596.5 7899.6 7908.6 7938.0 7949.0 3722.9 3778.2 3806.2 3807.3 3808.8 4297.3 4297.5 4451.4 4452.6 4460.8 821.7 929.4 959.5 965.3 971.9 643.6 667.5 668.1 677.7 693.9 10841.4 11177.6 11202.2 11748.1 11848.7 627.7 653.2 662.6 685.3 692.2 4330.1 4763.5 4799.4 4849.8 5101.8 98219.0 98917.0 99419.0 102047.0 103789.0 63339.7 71570.0 81923.6 82428.2 92435.0 77975.6 78325.2 78550.0 79467.8 80826.0 8418.5 12146.4 12197.8 12227.3 12346.2 32676.7 37887.6 38117.7 38178.2 39538.4 64046.7 64227.0 71153.0 71629.3 74600.0 16239.6 17047.9 17060.9 17090.7 17142.1 17796.8 18227.3 18271.9 18317.8 18333.4 16316.8 16640.9 16821.7 16847.7 17017.9 16702.9 16852.6 16867.6 16923.3 17037.7 15958.7 16111.5 16326.5 16442.0 16478.2 11033.2 11642.9 11650.7 12166.8 12325.1 12407.6 13451.2 13650.5 13808.1 13875.9 05:46:17 INFO - PID 1641 | -------- Summary: end -------- 05:46:17 INFO - PID 1641 | 05:46:17 INFO - TEST-INFO | 1641: exit 0 05:46:17 INFO - TEST-OK | dromaeo_css | took 1119933ms 05:46:17 INFO - TEST-START | kraken 05:46:17 INFO - operating with platform_type : mac_ 05:46:17 INFO - Initialising browser for kraken test... 05:46:17 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpU8jf1V/profile http://localhost:49246/getInfo.html) 05:46:20 INFO - PID 1653 | __metrics Screen width/height:1600/1200 05:46:20 INFO - PID 1653 | colorDepth:24 05:46:20 INFO - PID 1653 | Browser inner width/height: 1024/689 05:46:20 INFO - PID 1653 | __metrics 05:46:20 INFO - PID 1653 | 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:46:20 INFO - PID 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:21 INFO - TEST-INFO | 1653: exit 0 05:46:21 INFO - Browser initialized. 05:46:21 INFO - Running cycle 1/1 for kraken test... 05:46:21 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpU8jf1V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:33 INFO - PID 1654 | RSS: Main: 243277824 05:46:33 INFO - PID 1654 | 05:46:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:37 INFO - PID 1654 | RSS: Main: 313458688 05:46:37 INFO - PID 1654 | 05:46:40 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 05:46:41 INFO - PID 1654 | RSS: Main: 294227968 05:46:41 INFO - PID 1654 | 05:46:44 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 05:46:45 INFO - PID 1654 | RSS: Main: 385548288 05:46:45 INFO - PID 1654 | 05:46:46 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 05:46:47 INFO - PID 1654 | RSS: Main: 288546816 05:46:47 INFO - PID 1654 | 05:46:49 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:50 INFO - PID 1654 | RSS: Main: 290910208 05:46:50 INFO - PID 1654 | 05:46:53 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:53 INFO - PID 1654 | RSS: Main: 356712448 05:46:53 INFO - PID 1654 | 05:46:56 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:57 INFO - PID 1654 | RSS: Main: 374775808 05:46:57 INFO - PID 1654 | 05:46:59 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 05:47:00 INFO - PID 1654 | RSS: Main: 384655360 05:47:00 INFO - PID 1654 | 05:47:02 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:02 INFO - PID 1654 | RSS: Main: 332267520 05:47:02 INFO - PID 1654 | 05:47:04 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:05 INFO - PID 1654 | RSS: Main: 333041664 05:47:05 INFO - PID 1654 | 05:47:07 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:08 INFO - PID 1654 | RSS: Main: 317014016 05:47:08 INFO - PID 1654 | 05:47:11 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:11 INFO - PID 1654 | RSS: Main: 334516224 05:47:11 INFO - PID 1654 | 05:47:14 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:15 INFO - PID 1654 | RSS: Main: 345403392 05:47:15 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 05:47:17 INFO - PID 1654 | RSS: Main: 388329472 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | __start_tp_report 05:47:17 INFO - PID 1654 | _x_x_mozilla_page_load 05:47:17 INFO - PID 1654 | _x_x_mozilla_page_load_details 05:47:17 INFO - PID 1654 | |i|pagename|runs| 05:47:17 INFO - PID 1654 | |0;ai-astar;110;110;110;109;108;109;109;110;116;161 05:47:17 INFO - PID 1654 | |1;audio-beat-detection;141;117;147;181;141;109;108;105;135;110 05:47:17 INFO - PID 1654 | |2;audio-dft;188;183;182;186;188;185;188;194;182;186 05:47:17 INFO - PID 1654 | |3;audio-fft;81;59;60;90;62;58;58;61;82;61 05:47:17 INFO - PID 1654 | |4;audio-oscillator;88;72;87;69;70;68;91;68;68;89 05:47:17 INFO - PID 1654 | |5;imaging-gaussian-blur;85;86;86;86;86;86;85;89;88;86 05:47:17 INFO - PID 1654 | |6;imaging-darkroom;93;93;94;94;94;94;96;93;102;123 05:47:17 INFO - PID 1654 | |7;imaging-desaturate;85;83;82;84;83;83;83;86;84;85 05:47:17 INFO - PID 1654 | |8;json-parse-financial;51;47;47;67;40;40;48;53;67;76 05:47:17 INFO - PID 1654 | |9;json-stringify-tinderbox;55;58;65;64;60;63;59;58;59;60 05:47:17 INFO - PID 1654 | |10;stanford-crypto-aes;102;84;83;84;83;83;83;82;83;83 05:47:17 INFO - PID 1654 | |11;stanford-crypto-ccm;143;146;150;138;138;137;134;137;179;155 05:47:17 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;185;187;187;182;182;185;182;185;184;181 05:47:17 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;69;67;67;68;68;69;68;68;69;71 05:47:17 INFO - PID 1654 | __end_tp_report 05:47:17 INFO - PID 1654 | __start_cc_report 05:47:17 INFO - PID 1654 | _x_x_mozilla_cycle_collect,2215 05:47:17 INFO - PID 1654 | __end_cc_report 05:47:17 INFO - PID 1654 | __startTimestamp1492174037602__endTimestamp 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | ------- Summary: start ------- 05:47:17 INFO - PID 1654 | Number of tests: 14 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:115.20 Median:110.00 stddev:16.24 (14.8%) stddev-sans-first:17.12 05:47:17 INFO - PID 1654 | Values: 110.0 110.0 110.0 109.0 108.0 109.0 109.0 110.0 116.0 161.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:138.00 stddev:24.20 (17.5%) stddev-sans-first:25.31 05:47:17 INFO - PID 1654 | Values: 141.0 117.0 147.0 181.0 141.0 109.0 108.0 105.0 135.0 110.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:186.20 Median:187.00 stddev:3.61 (1.9%) stddev-sans-first:3.77 05:47:17 INFO - PID 1654 | Values: 188.0 183.0 182.0 186.0 188.0 185.0 188.0 194.0 182.0 186.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.50 stddev:12.12 (19.7%) stddev-sans-first:11.78 05:47:17 INFO - PID 1654 | Values: 81.0 59.0 60.0 90.0 62.0 58.0 58.0 61.0 82.0 61.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.50 stddev:10.23 (12.9%) stddev-sans-first:10.05 05:47:17 INFO - PID 1654 | Values: 88.0 72.0 87.0 69.0 70.0 68.0 91.0 68.0 68.0 89.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:86.00 stddev:1.25 (1.5%) stddev-sans-first:1.24 05:47:17 INFO - PID 1654 | Values: 85.0 86.0 86.0 86.0 86.0 86.0 85.0 89.0 88.0 86.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:94.00 stddev:9.32 (9.9%) stddev-sans-first:9.74 05:47:17 INFO - PID 1654 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 96.0 93.0 102.0 123.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 05:47:17 INFO - PID 1654 | Values: 85.0 83.0 82.0 84.0 83.0 83.0 83.0 86.0 84.0 85.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:52.00 stddev:12.28 (23.6%) stddev-sans-first:12.99 05:47:17 INFO - PID 1654 | Values: 51.0 47.0 47.0 67.0 40.0 40.0 48.0 53.0 67.0 76.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:3.07 (5.1%) stddev-sans-first:2.65 05:47:17 INFO - PID 1654 | Values: 55.0 58.0 65.0 64.0 60.0 63.0 59.0 58.0 59.0 60.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.00 stddev:6.00 (7.2%) stddev-sans-first:0.60 05:47:17 INFO - PID 1654 | Values: 102.0 84.0 83.0 84.0 83.0 83.0 83.0 82.0 83.0 83.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:144.50 stddev:13.45 (9.3%) stddev-sans-first:14.23 05:47:17 INFO - PID 1654 | Values: 143.0 146.0 150.0 138.0 138.0 137.0 134.0 137.0 179.0 155.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:185.00 stddev:2.16 (1.2%) stddev-sans-first:2.26 05:47:17 INFO - PID 1654 | Values: 185.0 187.0 187.0 182.0 182.0 185.0 182.0 185.0 184.0 181.0 05:47:17 INFO - PID 1654 | 05:47:17 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 05:47:17 INFO - PID 1654 | Values: 69.0 67.0 67.0 68.0 68.0 69.0 68.0 68.0 69.0 71.0 05:47:17 INFO - PID 1654 | -------- Summary: end -------- 05:47:17 INFO - PID 1654 | 05:47:18 INFO - TEST-INFO | 1654: exit 0 05:47:18 INFO - TEST-OK | kraken | took 60876ms 05:47:18 INFO - SUITE-END | took 1180s 05:47:19 INFO - Completed test suite (00:19:41) 05:47:19 INFO - javascript benchmark 05:47:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7739.217040764077, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3444.7588668793196, 3459.757816952814, 3464.6362131976143, 3471.0107619328487, 3521.9823900880506, 5930.288365396159, 6094.0, 6119.969400152993, 6128.57100003, 6131.662758548284, 6106.450419462248, 6123.173371594833, 6136.7335323661255, 6167.691615419233, 6206.472449841769, 5174.275601415805, 5340.172273297626, 5359.464053594629, 5373.194020896867, 5439.755211015494, 5406.135018397057, 5469.179623056533, 5477.863053423656, 5477.986572484103, 5521.972390138044, 5276.366835979707, 5340.706261155635, 5344.412114667383, 5353.250544923714, 5429.701366424845, 5354.14333706609, 5362.490563396471, 5379.946200538023, 5425.26758887553, 5438.510534051915, 5257.342832145981, 5298.549623282026, 5312.574994000471, 5316.893662126775, 5332.626716129873, 5983.282006159246, 6099.176611157525, 6110.725017374184, 6123.785667501661, 6136.539759518054, 6384.744610215585, 6388.776392826228, 6397.8400539986405, 6464.321246269121, 6511.479081673455, 6564.507661925327, 6568.704408301638, 6586.341365863424, 6589.472842172662, 6606.207255129415, 6067.332593414721, 6201.596896201778, 6211.9689401552705, 6233.750649974041, 6234.1583886175695, 6533.477321814244, 6626.039224312544, 6629.105070815378, 6739.427148692318, 6743.5953842769595, 6323.241211054703, 6390.584612000205, 6392.360763923571, 6393.744250229939, 6393.808185754435, 6477.384648458389, 6554.344565543408, 6559.442447392025, 6566.474682025522, 6575.868482630321, 6285.560010799291, 6468.708908099147, 6474.352564743488, 6487.805365838938, 6495.317991610813, 6286.9056964145575, 6341.524385671093, 6470.708818103197, 6493.318201588765, 6510.7721229756735, 5239.083160446907, 5240.842774716764, 5242.633015688942, 5249.448807875195, 5278.2346559749385, 4642.837500687459, 4644.744539050384, 4664.55686709762, 4665.883352916204, 4697.295405689174, 6123.203983482208, 6157.138000679908, 6162.0, 6163.260408750889, 6166.691665416712, 6412.294647588855, 6444.2589102252905, 6467.773627923, 6475.449586785082, 6480.287168411471, 6144.525313924626, 6149.754009839557, 6158.846028849314, 6182.381761823872, 6191.380861913773, 5693.231413759172, 5748.568857335633, 5763.2507773989955, 5767.192593036978, 5791.884162316815, 6681.198256209286, 6721.899171512431, 6738.7304507819135, 6739.224989126314, 6749.122614060141, 6262.3111457738705, 6339.778107766206, 6357.078223657451, 6542.0, 6654.966725166343, 6743.5953842769595, 6770.086038384952, 6775.1531058617675, 6784.423324017514, 6784.457243420613, 6446.806595802133, 6468.15913931186, 6476.967615161894, 6479.4816414685765, 6487.708053137714, 6085.479902370879, 6237.563370564017, 6485.481161507162, 6611.834704132243, 6626.602403855784, 6251.218597675291, 6353.777617783356, 6368.108464814837, 6381.457576106083, 6415.101885736094, 6354.809355719336, 6400.743970241138, 6412.6793660317735, 6427.742890284337, 6435.549511534147, 6123.191113103653, 6250.781222657367, 6303.9684801575695, 6305.464035556845, 6315.715792789244, 5943.227380440515, 6249.0626406039455, 6283.654399007915, 6318.304986451395, 6367.713452894724, 6241.344658810759, 6252.09344645033, 6252.874942501034, 6263.874722505433, 6280.089387038763], "value": 5986.398602479858, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.3945164964728, 805.5247404031622, 825.933925285977, 1131.3042478875489, 1151.033132168978, 27523.0, 36330.0, 36877.81561092198, 36892.81553592235, 36940.630593694055, 37996.24007519848, 38236.0, 38354.424683629695, 38379.232415351675, 38403.0, 8407.999999999985, 8584.656613735444, 8593.097724738906, 8598.398112132154, 8599.44103633265, 6098.969505152468, 6265.843353916143, 8368.0, 8548.78628034298, 8558.186972237627, 8533.274671652885, 8628.09405012474, 8631.913680863205, 8635.827283454328, 8641.567921603926, 7180.820479488002, 8599.61301741423, 8603.956980215122, 8610.870836937389, 8611.870821937677, 8487.66049358025, 8578.871316930252, 8579.227869491713, 8580.785480362978, 8609.655613775441, 36549.72075977328, 36863.63136368629, 36865.63134368649, 36917.0, 36932.26135477275, 3601.9459708104137, 3638.6361363863402, 3638.7089032877307, 3640.1627625645983, 3640.8361623726996, 30206.24484387886, 30227.848860755556, 30343.696563034307, 30378.392432151453, 30381.544276835866, 3148.8583013764437, 3182.6314684685576, 3203.471427214507, 3205.983970080158, 3215.244417561871, 273181.63409183023, 278286.0, 279457.0, 280303.0, 280499.0, 48227.75886120547, 48420.54738357855, 48448.27327590019, 48461.5153848464, 48468.0, 50832.0, 50869.74565127151, 50960.23559646608, 50998.235026474635, 51035.74482127566, 14162.221077840612, 14278.928605356907, 14282.0, 14298.925730967683, 14317.0, 9614.029124029557, 10008.249381296431, 11553.826692599618, 11748.236364636272, 11768.529258829722, 10532.684019479428, 10668.826429092793, 11226.887731122748, 11940.641780746591, 12140.635780926586, 4494.348319493655, 4699.694519856198, 5201.0, 5225.5582754659, 5378.300820893259, 908.4413085952092, 1025.179856115105, 1041.416806588313, 1052.742078190833, 1091.2143256855052, 23766.524669506514, 23784.16755413552, 23822.642660360107, 23933.521329573658, 24248.757512425003, 1128.4865386249237, 1128.954841806335, 1131.9830202546968, 1166.1953252255917, 1182.2906256246183, 11650.941745291218, 12215.389230538438, 12239.094354578938, 12239.276462662088, 12257.757226351378, 278698.0, 279749.0, 279884.0, 280259.0, 281102.0, 51621.0, 51623.0, 51638.48361516412, 51708.48291517112, 51778.0, 1524.6340878189155, 1549.9457518987008, 1565.3738504598252, 1568.1688704986375, 1575.314738088935, 17036.233369498153, 20606.587868242852, 22255.998480068112, 23249.0, 23430.0, 36206.0, 36228.09429764277, 36246.09384765402, 36285.81857090697, 36301.45547816732, 257327.713361432, 257430.0, 257783.0, 258090.41909581414, 258632.0, 33617.0, 33649.663503365635, 33653.663463365054, 33664.99005029853, 33708.66291337055, 35173.824130879184, 35401.64598354087, 43044.35433468563, 43578.0, 43580.34629480497, 22447.0, 27457.039003635575, 28678.426431470838, 29770.958016469318, 30006.54990175193, 28808.567871481526, 29503.85248073746, 29594.556081659222, 29766.107016788665, 29844.85077574598, 27503.31241718973, 34218.315633687685, 34785.47821782726, 35593.64406355903, 35600.64399355973, 28588.0, 29273.165519468886, 29770.553441697957, 29843.95546155874, 30114.397712045196, 22352.88823555872, 23193.265569876374, 23232.76767232306, 23330.0, 23344.299671009896], "value": 16869.19398747325, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.92350355693566, 431.874756320667, 433.77877282585894, 445.8016182798654, 466.3308152800731, 15019.624509387271, 21053.473663158427, 22510.887445562792, 23318.883405582947, 23580.528389432202, 18388.816111838878, 18570.628587428244, 23812.0, 23881.402964925885, 24203.27390178293, 6100.359462256466, 6195.380461953813, 6231.6572588507615, 6234.127222188898, 6289.308176100625, 3710.3321402147603, 5999.16011758352, 6183.165272688197, 6194.039923811793, 6200.658963756991, 3861.961380386202, 5214.634975551713, 5944.791932282371, 6202.4417802397775, 6226.43962043416, 6073.696315184267, 6107.969460152715, 6202.565820392574, 6215.098810672473, 6217.378262173792, 5408.675479471244, 5501.724913754297, 5504.504594586507, 5505.724713764336, 5513.724313784335, 27693.584596231074, 28493.857530712423, 29226.707732922823, 29290.121296361143, 29667.70332296671, 2166.295953815016, 2215.0918123569422, 2215.412915577357, 2218.3123231798195, 2227.4431392151964, 17216.56958576033, 17769.555761106076, 18216.089195540302, 18344.174512146987, 18393.264269429208, 2109.4390151287935, 2148.7743786902306, 2173.0, 2189.5620875824898, 2191.1783081344497, 170423.0, 172352.99999999875, 172830.0, 173517.26482735138, 174499.0, 11315.773684526428, 12151.939240303918, 12312.26126432417, 12476.563320283747, 12715.173513721578, 12613.936930315289, 12668.873311266954, 15345.6163595911, 15365.923170384076, 15369.615759605877, 7822.726204582812, 9138.0, 9205.493697846548, 9247.0, 9257.907420925705, 7535.886961695579, 8292.212239837207, 8556.61495232716, 8865.379423440298, 8874.245689116367, 7008.649567521604, 7078.079849619619, 7820.569868657279, 7862.567558784207, 7863.842723145505, 1809.936652217166, 2157.9892100539396, 2161.8378621603442, 2161.956760864774, 2289.919852805144, 954.9856752148723, 955.6798472511647, 964.4309857184295, 990.4700984973005, 1004.924630652704, 20617.79382206189, 21133.471663208544, 21189.576208475744, 21304.632550327147, 21451.03470343838, 984.2568860510412, 985.3102828020415, 1011.6560369474414, 1015.8780946286493, 1018.8064267789244, 9256.72229833106, 9862.654807081717, 10839.945800271105, 10873.456327183609, 10881.0, 549884.0, 568682.0, 575491.0, 581387.0, 581780.0, 99827.50086249522, 130897.0, 135479.0, 135953.0, 137009.0, 1118.278710231912, 1128.937908415045, 1170.2568868768394, 1173.3663821536445, 1173.8297946797666, 17348.826511735228, 18073.277068917097, 18278.268869245083, 18464.630707386044, 18608.44174674762, 51232.74383628207, 52399.21401179062, 52424.0, 56434.0, 57364.71317643385, 53014.0, 70516.64741676259, 71883.64058179676, 72899.54200915845, 74849.62575187089, 7597.924020759942, 8413.747587572383, 8640.265577425738, 8953.59708813118, 9138.223251023737, 14017.0, 14067.788983165055, 14249.0, 14521.85478145205, 14544.98185127031, 11642.6507204784, 11643.0, 11810.940945295219, 12056.698582535157, 12132.636020919386, 11196.272242304223, 11336.94331528337, 11342.773144536897, 11362.14783891195, 11717.472713728073, 11725.648230553097, 12021.879781202077, 12051.397430128634, 12103.152779305716, 12155.331456769962, 8499.320054395757, 8595.65617375298, 8784.0, 8984.146506081912, 9141.085891410805, 9806.85289720669, 11239.943800280946, 11689.824652630388, 12039.75920481603, 12183.0], "value": 10290.718420414487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.6838290427393, 1374.292239496659, 1444.2850788859516, 1469.375515405953, 1470.2869108482391, 11673.1828771986, 12175.939120304409, 12185.878141218585, 12215.633530994073, 12236.20464669797, 11591.072714182867, 12086.274823510596, 12118.818217726719, 12151.635450936465, 12176.878231217685, 2543.7329080446566, 2570.7429257074236, 2589.2491177558486, 2595.8442493450452, 2600.712647239619, 2141.7108690326763, 2431.331383869441, 2528.8609126498036, 2572.1640466848257, 2576.5233431815172, 2015.939521814348, 2195.1987524553583, 2408.2414039577475, 2474.7030356357263, 2496.8127390445698, 2442.9022839086415, 2463.4334103156284, 2470.3824043989002, 2472.911918755751, 2474.2329877737957, 2439.207257641256, 2451.8038556915403, 2453.9263822085186, 2459.053264493165, 2459.95080098397, 11778.116641251854, 12026.977706894924, 12033.51865925362, 12049.03607711381, 12067.698307542294, 6508.739650413978, 6731.865362692768, 6776.085228494188, 6779.559328643622, 6782.593044417302, 4061.5735347788354, 4254.532001479834, 4351.5648435156545, 4443.822247110112, 4449.510553839075, 1251.7934540800757, 1255.6609715376796, 1280.0335746511416, 1310.246608200279, 1316.7103237287781, 14556.34496447673, 15810.0, 16655.33378664852, 16803.747943780854, 16821.411250606292, 5498.670079795225, 5530.695811730313, 5642.492175704207, 5746.13807928814, 5771.105478650816, 12524.499020039279, 12528.373581320897, 12536.561220357426, 12540.623781286577, 12560.937195313965, 6666.766663166863, 6667.533272670867, 6675.0, 6677.1319728435965, 6677.332266773284, 5972.014617588136, 6108.816735497942, 6133.815985520441, 6206.689665516707, 6228.968855155696, 4298.892527686833, 4415.0, 4418.182636212311, 4467.30756732707, 4493.505714371417, 1266.094742259289, 1283.6277479531018, 1299.4217573179844, 1301.6680746409604, 1306.8693130686854, 677.5866721300004, 713.9535930164523, 800.3277247112453, 811.3914564076942, 825.5665775467927, 5554.527865131428, 6668.366505182, 6885.862282754317, 7279.0, 7334.0, 821.2690705272313, 913.6710784117712, 919.3059240273684, 929.9070092990647, 956.407027642852, 4298.949722455176, 4338.1323735252445, 4362.432883725095, 4379.737215767064, 4415.602595766396, 14567.854321456862, 15272.465463708717, 15294.847051529565, 15340.92329538345, 15358.232088395536, 14632.0, 15014.699706005818, 15028.323725432381, 15238.238088095552, 15248.847511524964, 8468.534230617252, 8515.57422128891, 8633.395662303705, 8676.696315628922, 8748.562571871382, 6586.637734924625, 6692.196936367667, 6763.357481039294, 6784.898226526705, 6849.828754281183, 13420.194788312732, 13452.260125693181, 13530.120542164728, 13801.723965520834, 13815.516456923959, 13755.656108596964, 13934.930325348714, 14105.647358816112, 14108.153510789385, 14151.929240353733, 8771.298296136167, 9091.227245684191, 9095.226905713089, 9096.636134554808, 9146.95426522863, 10798.67603971882, 10881.727956801144, 11007.449627518752, 11014.889851101387, 11020.063294620048, 9256.213221876216, 9270.860937086083, 9344.439333640003, 9352.111549402796, 9352.251819854258, 9110.180083792226, 9110.544472776468, 9129.45223286605, 9142.171565687022, 9200.26397888154, 6614.239362473377, 8188.631511582113, 8219.835603287782, 8236.176382361717, 8257.463264887763, 5943.0, 5959.404059594006, 6138.600990935575, 6169.2288463942, 6227.688615569294, 5998.670073145844, 6084.969575152096, 6197.504199663926, 6292.4966002720585, 6365.649889256136], "value": 5427.051505558086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.5073759276092, 402.13340251757467, 409.3000968344131, 411.4178437510921, 417.8997040710229, 5670.262865827442, 6021.548383871211, 6024.969875150629, 6062.696520248146, 6076.483498902588, 5001.449840517549, 5608.794109266507, 5644.971775141119, 5853.912191317134, 5902.793402230912, 4253.680973926952, 4529.569690879362, 4535.183666939949, 4536.54634536547, 4546.8408605698805, 4514.887127821814, 4551.975805443765, 4554.43069616298, 4568.565986231302, 4584.220682483986, 4363.621925314161, 4457.665675074366, 4486.663500237495, 4512.751798651073, 4514.390557274759, 3870.9806450967844, 4454.554544545552, 4461.933071003921, 4475.686701930867, 4481.5070342262325, 3449.4653328734084, 3837.8678289904547, 3979.781112038837, 3981.5222173339093, 4010.5588385277597, 5457.508824205801, 5482.259894914216, 5747.655140691572, 5793.333766616851, 5874.236349274567, 4177.874663760092, 4889.3643826302705, 5122.820701275475, 5160.8967820643375, 5210.296609957645, 5100.591952643779, 6371.458426033792, 6373.71318290678, 6374.330695277022, 6420.678966051725, 4108.91782164355, 4162.667946257199, 4244.936325955113, 4303.655707543389, 4309.525952145262, 6098.57309988301, 6365.045243213509, 6535.869282614416, 6565.54041217115, 6699.933000669979, 4235.470566179228, 4313.309870420718, 4333.913321733611, 4347.3261644445165, 4352.280849064602, 4190.835918881226, 4260.339647354665, 4365.289503921641, 4381.518033016366, 4400.295952647561, 4212.7682977435925, 5099.404919531721, 5149.841285710685, 5155.304033955368, 5160.503453998298, 6388.84027899297, 6400.0719895614875, 6402.583832050995, 6404.7117879695525, 6417.39034791694, 1180.0, 1310.5151094095245, 1490.7316682996948, 1513.7729340598778, 1520.787089807428, 873.8121303919688, 983.2085171436919, 997.1225321716988, 1005.4118340770585, 1009.4347165587294, 5372.597055220874, 5784.471472401831, 5877.382874798084, 6051.243594550681, 6115.96942015296, 4836.854894353175, 6237.812865614039, 6520.109168341222, 6522.836929076716, 6541.738330466823, 4960.652754307164, 5376.8118115865755, 5783.913241301384, 5828.154917537018, 6025.487833534111, 3393.52490651309, 3400.829958502065, 3431.330890476333, 3431.742619303512, 3447.276072024903, 5235.816746413857, 6326.367363263636, 6769.695363708645, 6816.352446517573, 6837.623930683761, 5602.047651899187, 6317.936820631827, 6714.462842972551, 6791.898121528181, 6823.931760682429, 6455.838604034937, 6733.192016957996, 6769.999999999902, 6814.93185068143, 6871.0, 5441.490238796034, 6082.239720034996, 6453.1610890583925, 6473.611583305017, 6523.836904077246, 6205.751769929152, 6397.424231819158, 6402.167718196791, 6459.870802584016, 6474.514411419068, 6589.341065893373, 6702.765403210864, 6715.496337774589, 6750.5274630775375, 6795.150606174228, 4254.702170848134, 4330.5236423993965, 4343.522212556553, 4364.105358401456, 4364.956350436455, 5634.464725851038, 6490.710071291882, 6534.705938232886, 6567.686462707382, 6604.0, 5339.4126646068125, 5464.480874316933, 6330.335314791881, 6342.302346741947, 6357.332480089709, 5646.858828529155, 5983.431574000463, 6116.418940200674, 6350.7142178603, 6371.139896113966, 6165.5375846810775, 6195.783147589813, 6201.503879689524, 6210.4100110489435, 6232.220972378453, 5966.0766224550525, 6064.999275119732, 6387.073874288295, 6426.196725409324, 6426.678666066771, 5262.42113367537, 5422.755975981011, 5682.835018821214, 6234.750609975732, 6287.591306565058], "value": 4627.101985075896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.5120917775911, 774.9341305988991, 882.4484697064335, 883.8409086364452, 883.9071897450767, 13113.606591802238, 17778.91110544447, 17871.0, 18495.167717452714, 18496.35262765802, 16155.353785848552, 17296.221670024846, 17703.29186832525, 17719.822801771978, 17821.0, 780.3055280800093, 936.2650319499195, 937.3906960475712, 937.5640327247828, 939.2392162348485, 686.8866637004888, 696.6656005117546, 969.2585172343163, 998.5556427389814, 1015.2030655935092, 1031.5254982707963, 1032.4373216596973, 1034.5499707627168, 1036.160709825044, 1037.5538518437106, 1026.5534492495788, 1026.7535791410082, 1028.074732740532, 1028.963986260481, 1035.2494441529907, 763.5685837501794, 764.6100488750722, 765.4374035084264, 765.628670095009, 769.9923000769977, 16217.0, 16419.6716065678, 16602.25289861959, 16964.40624578146, 17163.828361716347, 16734.83265167345, 16902.323907043705, 16904.661906761918, 17156.914215428842, 17207.741883871753, 14022.228777417238, 14131.0, 14172.149671019772, 14542.70914581713, 14737.0, 3572.6605972432576, 3579.8926032219074, 3582.9104272393397, 3591.7665351752053, 3596.1908570571672, 87692.56153719254, 113836.43081784621, 118972.31818340915, 120054.0, 120325.0, 11315.321080735182, 11693.181477296677, 13101.737965240642, 13503.0, 13503.662408439672, 17858.46424607264, 20559.0, 25253.35853169538, 25675.743242567707, 25702.0, 7596.506227095221, 7899.565523896241, 7908.5650289234645, 7938.047434307805, 7949.046114466186, 3722.8883133506038, 3778.1876896467393, 3806.238752249506, 3807.2956503047026, 3808.7524310919703, 4297.312430011246, 4297.462817147856, 4451.443569553806, 4452.554744525586, 4460.799264033127, 821.7247222180637, 929.4376901974343, 959.5154447004218, 965.285688590438, 971.9308760363543, 643.5848877474003, 667.4560233409852, 668.1414382518537, 677.6916502991127, 693.9271376505495, 10841.403722795165, 11177.608783692694, 11202.215844890943, 11748.118891083031, 11848.70378240551, 627.6713393310777, 653.2259272761793, 662.6057495789997, 685.3454950522239, 692.2005084127841, 4330.069035157457, 4763.476017638057, 4799.352087468147, 4849.781759820817, 5101.770420331094, 98219.01780982241, 98917.0, 99419.0, 102047.0, 103789.0, 63339.68330158412, 71570.0, 81923.59038204771, 82428.17571824206, 92435.0, 77975.61012194902, 78325.21674783294, 78550.0, 79467.8079828803, 80826.0, 8418.536980465888, 12146.392680366123, 12197.817032744693, 12227.327496987751, 12346.197497162655, 32676.673233267364, 37887.62112378951, 38117.66588169401, 38178.2364352717, 39538.40692389559, 64046.67976660087, 64227.0, 71153.0, 71629.28370716226, 74600.0, 16239.59401014984, 17047.891887027305, 17060.914695426443, 17090.65818683644, 17142.142892855558, 17796.822031779517, 18227.270909164014, 18271.908640456713, 18317.816821832144, 18333.3583324583, 16316.755248671518, 16640.916795415946, 16821.747673785147, 16847.747283791, 17017.893836900563, 16702.916485417496, 16852.57868553296, 16867.578310542336, 16923.323067077177, 17037.722170837485, 15958.680826383175, 16111.516654500383, 16326.510204693877, 16442.013479191286, 16478.176091195633, 11033.172512061788, 11642.88357116418, 11650.65048048526, 12166.75666486683, 12325.137240393087, 12407.627771166879, 13451.192928424325, 13650.539784086444, 13808.1024733392, 13875.86124138786], "value": 8233.283369692588, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1439.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 109.0, 108.0, 109.0, 109.0, 110.0, 116.0, 161.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 147.0, 181.0, 141.0, 109.0, 108.0, 105.0, 135.0, 110.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 182.0, 186.0, 188.0, 185.0, 188.0, 194.0, 182.0, 186.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 90.0, 62.0, 58.0, 58.0, 61.0, 82.0, 61.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 87.0, 69.0, 70.0, 68.0, 91.0, 68.0, 68.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 85.0, 89.0, 88.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0, 93.0, 102.0, 123.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 84.0, 83.0, 83.0, 83.0, 86.0, 84.0, 85.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 47.0, 47.0, 67.0, 40.0, 40.0, 48.0, 53.0, 67.0, 76.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 65.0, 64.0, 60.0, 63.0, 59.0, 58.0, 59.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 82.0, 83.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 150.0, 138.0, 138.0, 137.0, 134.0, 137.0, 179.0, 155.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 187.0, 182.0, 182.0, 185.0, 182.0, 185.0, 184.0, 181.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 71.0], "value": 68.4, "unit": "score"}]}]} 05:47:19 INFO - Return code: 0 05:47:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:19 ERROR - # TBPL SUCCESS # 05:47:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:19 INFO - 2017-04-14 05:47:19.431 screenresolution[1659:9761] starting screenresolution argv=screenresolution get 05:47:19 INFO - 2017-04-14 05:47:19.433 screenresolution[1659:9761] Display 0: 1600x1200x32@60 05:47:19 INFO - 2017-04-14 05:47:19.439 screenresolution[1660:9764] starting screenresolution argv=screenresolution list 05:47:19 INFO - Available Modes on Display 0 05:47:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:19 INFO - Intel Iris: 05:47:19 INFO - Chipset Model: Intel Iris 05:47:19 INFO - Type: GPU 05:47:19 INFO - Bus: Built-In 05:47:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:19 INFO - Vendor: Intel (0x8086) 05:47:19 INFO - Device ID: 0x0a2e 05:47:19 INFO - Revision ID: 0x0009 05:47:19 INFO - Displays: 05:47:19 INFO - Display: 05:47:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:19 INFO - Display Serial Number: 1600x1200 60 05:47:19 INFO - Main Display: Yes 05:47:19 INFO - Mirror: Off 05:47:19 INFO - Online: Yes 05:47:19 INFO - Rotation: Supported 05:47:19 INFO - Return code: 0 05:47:19 INFO - Running post-action listener: _resource_record_post_action 05:47:19 INFO - [mozharness: 2017-04-14 12:47:19.676893Z] Finished run-tests step (success) 05:47:19 INFO - Running post-run listener: _resource_record_post_run 05:47:19 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 38204928; Write bytes: 513789440; Read time: 243; Write time: 1588 05:47:19 INFO - TinderboxPrint: CPU usage
53.2% 05:47:19 INFO - TinderboxPrint: I/O read bytes / time
38,204,928 / 243 05:47:19 INFO - TinderboxPrint: I/O write bytes / time
513,789,440 / 1,588 05:47:19 INFO - TinderboxPrint: CPU idle
2,246.9 (46.8%) 05:47:19 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 05:47:19 INFO - TinderboxPrint: CPU user
1,602.7 (33.3%) 05:47:19 INFO - TinderboxPrint: Swap in / out
246,112,256 / 0 05:47:19 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207616512; Write bytes: 205477376; Read time: 16147; Write time: 450 05:47:19 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 35894784; Write bytes: 301111296; Read time: 219; Write time: 1110 05:47:20 INFO - Running post-run listener: _upload_blobber_files 05:47:20 INFO - Blob upload gear active. 05:47:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:47:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:21 INFO - (blobuploader) - INFO - Done attempting. 05:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:22 INFO - (blobuploader) - INFO - Done attempting. 05:47:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:47:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:23 INFO - (blobuploader) - INFO - Done attempting. 05:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:25 INFO - (blobuploader) - INFO - Done attempting. 05:47:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:25 INFO - Return code: 0 05:47:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e62d15c37da6dc5ed34ee661ff4b556ae2def86d346315af0a484f3f253e8c90e109bb675cdb8503efd28240457114879b027af61944b423d63a3bb2f5e2c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703e8043c96acd35b87bc9bf0c2cb110a6606e4d840310147da33897ac4258a1cfefab2d71ffc009d003afff453ed91804a3473507d0beb8728a8fcf7ffcacd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c778e4f351790a3638b19f6d18afae7858954a85d488f50fcfe60cb5d9c26def820b109a136bfd074427b9733fe240b0788cc54069bf193d69bbc9ad9b010fe0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93853fd8b456885d7d5662532885558ad557b6124cb0525d591552b839233d59d9a23a4720a58bc072ea4bb01078125647907ac4215431cc2f62abcaeb55073e"} 05:47:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:25 INFO - Contents: 05:47:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e62d15c37da6dc5ed34ee661ff4b556ae2def86d346315af0a484f3f253e8c90e109bb675cdb8503efd28240457114879b027af61944b423d63a3bb2f5e2c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703e8043c96acd35b87bc9bf0c2cb110a6606e4d840310147da33897ac4258a1cfefab2d71ffc009d003afff453ed91804a3473507d0beb8728a8fcf7ffcacd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c778e4f351790a3638b19f6d18afae7858954a85d488f50fcfe60cb5d9c26def820b109a136bfd074427b9733fe240b0788cc54069bf193d69bbc9ad9b010fe0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93853fd8b456885d7d5662532885558ad557b6124cb0525d591552b839233d59d9a23a4720a58bc072ea4bb01078125647907ac4215431cc2f62abcaeb55073e"} 05:47:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:25 INFO - Copying logs to upload dir... 05:47:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.527989 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-14 05:47:25.632249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:25.635954) ========= 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.ONepHiehxX/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.hiN9HKjBB0/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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/4e62d15c37da6dc5ed34ee661ff4b556ae2def86d346315af0a484f3f253e8c90e109bb675cdb8503efd28240457114879b027af61944b423d63a3bb2f5e2c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703e8043c96acd35b87bc9bf0c2cb110a6606e4d840310147da33897ac4258a1cfefab2d71ffc009d003afff453ed91804a3473507d0beb8728a8fcf7ffcacd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c778e4f351790a3638b19f6d18afae7858954a85d488f50fcfe60cb5d9c26def820b109a136bfd074427b9733fe240b0788cc54069bf193d69bbc9ad9b010fe0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93853fd8b456885d7d5662532885558ad557b6124cb0525d591552b839233d59d9a23a4720a58bc072ea4bb01078125647907ac4215431cc2f62abcaeb55073e"} build_url:https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/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/4e62d15c37da6dc5ed34ee661ff4b556ae2def86d346315af0a484f3f253e8c90e109bb675cdb8503efd28240457114879b027af61944b423d63a3bb2f5e2c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/703e8043c96acd35b87bc9bf0c2cb110a6606e4d840310147da33897ac4258a1cfefab2d71ffc009d003afff453ed91804a3473507d0beb8728a8fcf7ffcacd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c778e4f351790a3638b19f6d18afae7858954a85d488f50fcfe60cb5d9c26def820b109a136bfd074427b9733fe240b0788cc54069bf193d69bbc9ad9b010fe0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93853fd8b456885d7d5662532885558ad557b6124cb0525d591552b839233d59d9a23a4720a58bc072ea4bb01078125647907ac4215431cc2f62abcaeb55073e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:25.670643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:25.671832) ========= 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.ONepHiehxX/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.hiN9HKjBB0/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.005232 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:25.720796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 05:47:25.721109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 05:47:25.721496) ========= ========= Total master_lag: 0.20 =========