builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0128 starttime: 1493034724.27 results: success (0) buildid: 20170424032920 builduid: 8090bfd39fe44179be8e4fb93bb38648 revision: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.275270) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.275739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.276017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.303282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.303654) ========= 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.G7UclQw6gN/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.mhhaXkD99u/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-24 04:52:04-- 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% 9.08M=0.001s 2017-04-24 04:52:04 (9.08 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103496 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.432819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.433155) ========= 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.G7UclQw6gN/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.mhhaXkD99u/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.028336 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:04.485244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 04:52:04.485722) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e17cbb839dd225a2da7e5d5bec43cf94e11749d8 --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 e17cbb839dd225a2da7e5d5bec43cf94e11749d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G7UclQw6gN/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.mhhaXkD99u/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-24 04:52:04,596 truncating revision to first 12 chars 2017-04-24 04:52:04,596 Setting DEBUG logging. 2017-04-24 04:52:04,596 attempt 1/10 2017-04-24 04:52:04,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e17cbb839dd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 04:52:06,450 unpacking tar archive at: mozilla-central-e17cbb839dd2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.151365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 04:52:06.661536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:06.661882) ========= script_repo_revision: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:06.662288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:06.662556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:52:06.683471) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-04-24 04:52:06.683872) ========= /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.G7UclQw6gN/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.mhhaXkD99u/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:52:06 INFO - MultiFileLogger online at 20170424 04:52:06 in /builds/slave/test 04:52:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:52:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:06 INFO - {'append_to_log': False, 04:52:06 INFO - 'base_work_dir': '/builds/slave/test', 04:52:06 INFO - 'blob_upload_branch': 'Firefox', 04:52:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:06 INFO - 'branch': 'Firefox', 04:52:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:06 INFO - 'config_files': ('talos/mac_config.py',), 04:52:06 INFO - 'default_actions': ('clobber', 04:52:06 INFO - 'read-buildbot-config', 04:52:06 INFO - 'download-and-extract', 04:52:06 INFO - 'populate-webroot', 04:52:06 INFO - 'create-virtualenv', 04:52:06 INFO - 'install', 04:52:06 INFO - 'run-tests'), 04:52:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:06 INFO - 'download_minidump_stackwalk': True, 04:52:06 INFO - 'download_symbols': 'ondemand', 04:52:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:06 INFO - 'gecko_profile': False, 04:52:06 INFO - 'gecko_profile_interval': 0, 04:52:06 INFO - 'installer_path': 'installer.exe', 04:52:06 INFO - 'log_level': 'info', 04:52:06 INFO - 'log_name': 'talos', 04:52:06 INFO - 'log_to_console': True, 04:52:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:52:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:52:06 INFO - 'opt_config_files': (), 04:52:06 INFO - 'pip_index': False, 04:52:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:06 INFO - 'cmd': ('bash', 04:52:06 INFO - '-c', 04:52:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:06 INFO - 'enabled': True, 04:52:06 INFO - 'halt_on_failure': False, 04:52:06 INFO - 'name': 'check_screen_resolution'},), 04:52:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:06 INFO - 'cmd': ('bash', 04:52:06 INFO - '-c', 04:52:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:06 INFO - 'enabled': True, 04:52:06 INFO - 'halt_on_failure': False, 04:52:06 INFO - 'name': 'check_screen_resolution'},), 04:52:06 INFO - 'run_cmd_checks_enabled': True, 04:52:06 INFO - 'suite': 'dromaeojs', 04:52:06 INFO - 'system_bits': '32', 04:52:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:06 INFO - 'title': 't-yosemite-r7-0128', 04:52:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:06 INFO - 'use_talos_json': True, 04:52:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:06 INFO - 'work_dir': 'build'} 04:52:06 INFO - [mozharness: 2017-04-24 11:52:06.899809Z] Running clobber step. 04:52:06 INFO - Running pre-action listener: _resource_record_pre_action 04:52:06 INFO - Running main action method: clobber 04:52:06 INFO - rmtree: /builds/slave/test/build 04:52:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:09 INFO - Running post-action listener: _resource_record_post_action 04:52:09 INFO - [mozharness: 2017-04-24 11:52:09.426880Z] Finished clobber step (success) 04:52:09 INFO - [mozharness: 2017-04-24 11:52:09.427006Z] Running read-buildbot-config step. 04:52:09 INFO - Running pre-action listener: _resource_record_pre_action 04:52:09 INFO - Running main action method: read_buildbot_config 04:52:09 INFO - Using buildbot properties: 04:52:09 INFO - { 04:52:09 INFO - "project": "", 04:52:09 INFO - "product": "firefox", 04:52:09 INFO - "script_repo_revision": "production", 04:52:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:52:09 INFO - "repository": "", 04:52:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:52:09 INFO - "buildid": "20170424032920", 04:52:09 INFO - "pgo_build": "False", 04:52:09 INFO - "basedir": "/builds/slave/test", 04:52:09 INFO - "buildnumber": 35, 04:52:09 INFO - "slavename": "t-yosemite-r7-0128", 04:52:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:52:09 INFO - "platform": "yosemite_r7", 04:52:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:52:09 INFO - "branch": "mozilla-central", 04:52:09 INFO - "repo_path": "mozilla-central", 04:52:09 INFO - "revision": "e17cbb839dd225a2da7e5d5bec43cf94e11749d8", 04:52:09 INFO - "stage_platform": "macosx64", 04:52:09 INFO - "builduid": "8090bfd39fe44179be8e4fb93bb38648", 04:52:09 INFO - "slavebuilddir": "test" 04:52:09 INFO - } 04:52:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:52:09 INFO - Running post-action listener: _resource_record_post_action 04:52:09 INFO - [mozharness: 2017-04-24 11:52:09.430203Z] Finished read-buildbot-config step (success) 04:52:09 INFO - [mozharness: 2017-04-24 11:52:09.430336Z] Running download-and-extract step. 04:52:09 INFO - Running pre-action listener: _resource_record_pre_action 04:52:09 INFO - Running main action method: download_and_extract 04:52:09 INFO - mkdir: /builds/slave/test/build/tests 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:09 INFO - trying https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:52:09 INFO - Downloading https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:52:10 INFO - Downloaded 1325 bytes. 04:52:10 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:52:10 INFO - Using the following test package requirements: 04:52:10 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:52:10 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:52:10 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:52:10 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:52:10 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'jsshell-mac.zip'], 04:52:10 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:52:10 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:52:10 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:52:10 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:52:10 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:52:10 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:10 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:52:10 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:52:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:52:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:10 INFO - Fetch https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:52:12 INFO - Content-Length response header: 52523633 04:52:12 INFO - Bytes received: 52523633 04:52:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:52:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:52:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:28 INFO - Fetch https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:52:30 INFO - Content-Length response header: 52523633 04:52:30 INFO - Bytes received: 52523633 04:52:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:52:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:52:46 INFO - Fetch https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:52:48 INFO - Content-Length response header: 14408822 04:52:48 INFO - Bytes received: 14408822 04:52: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')]} 04:52:48 INFO - trying https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:48 INFO - Downloading https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:52:50 INFO - Downloaded 71039720 bytes. 04:52:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:50 INFO - mkdir: /builds/slave/test/properties 04:52:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:50 INFO - Contents: 04:52:50 INFO - build_url:https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:58 INFO - Running post-action listener: _resource_record_post_action 04:52:58 INFO - Running post-action listener: set_extra_try_arguments 04:52:58 INFO - [mozharness: 2017-04-24 11:52:58.410835Z] Finished download-and-extract step (success) 04:52:58 INFO - [mozharness: 2017-04-24 11:52:58.410990Z] Running populate-webroot step. 04:52:58 INFO - Running pre-action listener: _resource_record_pre_action 04:52:58 INFO - Running main action method: populate_webroot 04:52:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:58 INFO - '--tppagecycles', 04:52:58 INFO - '7'], 04:52:58 INFO - 'tests': ['tsvgm']}}, 04:52:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['damp', 'tps']}, 04:52:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'tests': ['damp', 'tps']}, 04:52:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['dromaeo_dom']}, 04:52:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:52:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:52:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['a11yr', 04:52:58 INFO - 'ts_paint', 04:52:58 INFO - 'tpaint', 04:52:58 INFO - 'sessionrestore', 04:52:58 INFO - 'sessionrestore_no_auto_restore', 04:52:58 INFO - 'tabpaint']}, 04:52:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:58 INFO - 'ts_paint', 04:52:58 INFO - 'tpaint', 04:52:58 INFO - 'sessionrestore', 04:52:58 INFO - 'sessionrestore_no_auto_restore', 04:52:58 INFO - 'tabpaint']}, 04:52:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:52:58 INFO - 'ts_paint', 04:52:58 INFO - 'tpaint', 04:52:58 INFO - 'sessionrestore', 04:52:58 INFO - 'sessionrestore_no_auto_restore', 04:52:58 INFO - 'tabpaint']}, 04:52:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:52:58 INFO - 'ts_paint', 04:52:58 INFO - 'tpaint', 04:52:58 INFO - 'sessionrestore', 04:52:58 INFO - 'sessionrestore_no_auto_restore', 04:52:58 INFO - 'tabpaint']}, 04:52:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['a11yr', 04:52:58 INFO - 'ts_paint', 04:52:58 INFO - 'tpaint', 04:52:58 INFO - 'sessionrestore', 04:52:58 INFO - 'sessionrestore_no_auto_restore', 04:52:58 INFO - 'tabpaint']}, 04:52:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['a11yr', 04:52:58 INFO - 'ts_paint', 04:52:58 INFO - 'tpaint', 04:52:58 INFO - 'sessionrestore', 04:52:58 INFO - 'sessionrestore_no_auto_restore', 04:52:58 INFO - 'tabpaint']}, 04:52:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:52:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:52:58 INFO - 'bloom_basic_ref']}, 04:52:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['tsvgx', 04:52:58 INFO - 'tsvgr_opacity', 04:52:58 INFO - 'tart', 04:52:58 INFO - 'tscrollx', 04:52:58 INFO - 'cart', 04:52:58 INFO - 'tsvg_static']}, 04:52:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:58 INFO - 'tsvgr_opacity', 04:52:58 INFO - 'tart', 04:52:58 INFO - 'tscrollx', 04:52:58 INFO - 'cart', 04:52:58 INFO - 'tsvg_static']}, 04:52:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'talos_options': ['--disable-e10s'], 04:52:58 INFO - 'tests': ['tp5o']}, 04:52:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'talos_options': ['--disable-e10s', 04:52:58 INFO - '--xperf_path', 04:52:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:58 INFO - 'tests': ['tp5n']}, 04:52:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:58 INFO - 'talos_options': ['--xperf_path', 04:52:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:58 INFO - 'tests': ['tp5n']}}, 04:52:58 INFO - 'talos.zip': {'path': '', 04:52:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:58 INFO - Running post-action listener: _resource_record_post_action 04:52:58 INFO - [mozharness: 2017-04-24 11:52:58.430001Z] Finished populate-webroot step (success) 04:52:58 INFO - [mozharness: 2017-04-24 11:52:58.430118Z] Running create-virtualenv step. 04:52:58 INFO - Running pre-action listener: _resource_record_pre_action 04:52:58 INFO - Running main action method: create_virtualenv 04:52:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:52:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:58 INFO - Using real prefix '/tools/python27' 04:52:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:02 INFO - Installing pip.................done. 04:53:02 INFO - Return code: 0 04:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:02 INFO - Reading from file tmpfile_stdout 04:53:02 INFO - Output received: 04:53:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:53:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:03 INFO - 'HOME': '/Users/cltbld', 04:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:03 INFO - 'LOGNAME': 'cltbld', 04:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:03 INFO - 'MOZ_NO_REMOTE': '1', 04:53:03 INFO - 'NO_EM_RESTART': '1', 04:53:03 INFO - 'PAGER': '/bin/cat', 04:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:03 INFO - 'PWD': '/builds/slave/test', 04:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:03 INFO - 'SHELL': '/bin/bash', 04:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:03 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:03 INFO - 'USER': 'cltbld', 04:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:03 INFO - 'XPC_FLAGS': '0x0', 04:53:03 INFO - 'XPC_SERVICE_NAME': '0', 04:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:53:03 INFO - Cleaning up... 04:53:03 INFO - Return code: 0 04:53:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:03 INFO - 'HOME': '/Users/cltbld', 04:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:03 INFO - 'LOGNAME': 'cltbld', 04:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:03 INFO - 'MOZ_NO_REMOTE': '1', 04:53:03 INFO - 'NO_EM_RESTART': '1', 04:53:03 INFO - 'PAGER': '/bin/cat', 04:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:03 INFO - 'PWD': '/builds/slave/test', 04:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:03 INFO - 'SHELL': '/bin/bash', 04:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:03 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:03 INFO - 'USER': 'cltbld', 04:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:03 INFO - 'XPC_FLAGS': '0x0', 04:53:03 INFO - 'XPC_SERVICE_NAME': '0', 04:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:04 INFO - Downloading/unpacking psutil>=3.1.1 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:08 INFO - Installing collected packages: psutil 04:53:08 INFO - Running setup.py install for psutil 04:53:08 INFO - building 'psutil._psutil_osx' extension 04:53:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:53:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:53:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:53:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:53:09 INFO - building 'psutil._psutil_posix' extension 04:53:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:53:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:09 INFO - ^ 04:53:09 INFO - 1 warning generated. 04:53:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:09 INFO - Successfully installed psutil 04:53:09 INFO - Cleaning up... 04:53:09 INFO - Return code: 0 04:53:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:09 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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:09 INFO - 'HOME': '/Users/cltbld', 04:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:09 INFO - 'LOGNAME': 'cltbld', 04:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:09 INFO - 'MOZ_NO_REMOTE': '1', 04:53:09 INFO - 'NO_EM_RESTART': '1', 04:53:09 INFO - 'PAGER': '/bin/cat', 04:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:09 INFO - 'PWD': '/builds/slave/test', 04:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:09 INFO - 'SHELL': '/bin/bash', 04:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:09 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:09 INFO - 'USER': 'cltbld', 04:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:09 INFO - 'XPC_FLAGS': '0x0', 04:53:09 INFO - 'XPC_SERVICE_NAME': '0', 04:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:12 INFO - Installing collected packages: mozsystemmonitor 04:53:12 INFO - Running setup.py install for mozsystemmonitor 04:53:12 INFO - Successfully installed mozsystemmonitor 04:53:12 INFO - Cleaning up... 04:53:12 INFO - Return code: 0 04:53:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:12 INFO - 'HOME': '/Users/cltbld', 04:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:12 INFO - 'LOGNAME': 'cltbld', 04:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:12 INFO - 'MOZ_NO_REMOTE': '1', 04:53:12 INFO - 'NO_EM_RESTART': '1', 04:53:12 INFO - 'PAGER': '/bin/cat', 04:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:12 INFO - 'PWD': '/builds/slave/test', 04:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:12 INFO - 'SHELL': '/bin/bash', 04:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:12 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:12 INFO - 'USER': 'cltbld', 04:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:12 INFO - 'XPC_FLAGS': '0x0', 04:53:12 INFO - 'XPC_SERVICE_NAME': '0', 04:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:12 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:15 INFO - warning: no files found matching '*.txt' 04:53:15 INFO - no previously-included directories found matching 'build' 04:53:15 INFO - no previously-included directories found matching 'dist' 04:53:15 INFO - no previously-included directories found matching '.git*' 04:53:15 INFO - Installing collected packages: jsonschema, functools32 04:53:15 INFO - Running setup.py install for functools32 04:53:16 INFO - warning: no files found matching '*.txt' 04:53:16 INFO - no previously-included directories found matching 'build' 04:53:16 INFO - no previously-included directories found matching 'dist' 04:53:16 INFO - no previously-included directories found matching '.git*' 04:53:16 INFO - Successfully installed jsonschema functools32 04:53:16 INFO - Cleaning up... 04:53:16 INFO - Return code: 0 04:53:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', '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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:53: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 functools32==3.2.3-2 04:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:16 INFO - 'HOME': '/Users/cltbld', 04:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:16 INFO - 'LOGNAME': 'cltbld', 04:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:16 INFO - 'MOZ_NO_REMOTE': '1', 04:53:16 INFO - 'NO_EM_RESTART': '1', 04:53:16 INFO - 'PAGER': '/bin/cat', 04:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:16 INFO - 'PWD': '/builds/slave/test', 04:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:16 INFO - 'SHELL': '/bin/bash', 04:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:16 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:16 INFO - 'USER': 'cltbld', 04:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:16 INFO - 'XPC_FLAGS': '0x0', 04:53:16 INFO - 'XPC_SERVICE_NAME': '0', 04:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:16 INFO - Cleaning up... 04:53:16 INFO - Return code: 0 04:53:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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', '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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53: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 blobuploader==1.2.4 04:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:16 INFO - 'HOME': '/Users/cltbld', 04:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:16 INFO - 'LOGNAME': 'cltbld', 04:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:16 INFO - 'MOZ_NO_REMOTE': '1', 04:53:16 INFO - 'NO_EM_RESTART': '1', 04:53:16 INFO - 'PAGER': '/bin/cat', 04:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:16 INFO - 'PWD': '/builds/slave/test', 04:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:16 INFO - 'SHELL': '/bin/bash', 04:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:16 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:16 INFO - 'USER': 'cltbld', 04:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:16 INFO - 'XPC_FLAGS': '0x0', 04:53:16 INFO - 'XPC_SERVICE_NAME': '0', 04:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:19 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:20 INFO - Downloading docopt-0.6.1.tar.gz 04:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:20 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:20 INFO - Running setup.py install for blobuploader 04:53:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:20 INFO - Running setup.py install for requests 04:53:21 INFO - Running setup.py install for docopt 04:53:21 INFO - Successfully installed blobuploader requests docopt 04:53:21 INFO - Cleaning up... 04:53:21 INFO - Return code: 0 04:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:21 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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:21 INFO - 'HOME': '/Users/cltbld', 04:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:21 INFO - 'LOGNAME': 'cltbld', 04:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:21 INFO - 'MOZ_NO_REMOTE': '1', 04:53:21 INFO - 'NO_EM_RESTART': '1', 04:53:21 INFO - 'PAGER': '/bin/cat', 04:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:21 INFO - 'PWD': '/builds/slave/test', 04:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:21 INFO - 'SHELL': '/bin/bash', 04:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:21 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:21 INFO - 'USER': 'cltbld', 04:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:21 INFO - 'XPC_FLAGS': '0x0', 04:53:21 INFO - 'XPC_SERVICE_NAME': '0', 04:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:21 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-uSDbXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-tzERo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-soGXOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-PKK1Bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-rBzj4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-0rqAor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-QKLlcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-7ntyxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-VWtJYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-hq4iYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:22 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-s5qsAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:23 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-uLTNnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:23 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-wpnZLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:23 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-QGB3Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:23 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-08i2vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:23 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-NIytg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:23 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-cYCVvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:23 INFO - Running setup.py install for manifestparser 04:53:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:23 INFO - Running setup.py install for mozcrash 04:53:23 INFO - Running setup.py install for mozdebug 04:53:24 INFO - Running setup.py install for mozdevice 04:53:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Running setup.py install for mozfile 04:53:24 INFO - Running setup.py install for mozhttpd 04:53:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Running setup.py install for mozinfo 04:53:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Running setup.py install for mozInstall 04:53:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:24 INFO - Running setup.py install for mozleak 04:53:24 INFO - Running setup.py install for mozlog 04:53:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for moznetwork 04:53:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozprocess 04:53:25 INFO - Running setup.py install for mozprofile 04:53:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozrunner 04:53:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:25 INFO - Running setup.py install for mozscreenshot 04:53:25 INFO - Running setup.py install for moztest 04:53:26 INFO - Running setup.py install for mozversion 04:53:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:26 INFO - Cleaning up... 04:53:26 INFO - Return code: 0 04:53:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:26 INFO - 'HOME': '/Users/cltbld', 04:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:26 INFO - 'LOGNAME': 'cltbld', 04:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:26 INFO - 'MOZ_NO_REMOTE': '1', 04:53:26 INFO - 'NO_EM_RESTART': '1', 04:53:26 INFO - 'PAGER': '/bin/cat', 04:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:26 INFO - 'PWD': '/builds/slave/test', 04:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:26 INFO - 'SHELL': '/bin/bash', 04:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:26 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:26 INFO - 'USER': 'cltbld', 04:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:26 INFO - 'XPC_FLAGS': '0x0', 04:53:26 INFO - 'XPC_SERVICE_NAME': '0', 04:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:26 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-ZNRjj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:26 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-fzG2vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:26 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-RntNdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:26 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-21LxAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:26 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-2VIgzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-dFtyZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-bhsEu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-fLZEeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-EntJZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-0KqNv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-I5FUAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-dUUvJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-zog5iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-bZWLBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:27 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-NHqUAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:28 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-R4s6rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:28 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-rA8w3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:30 INFO - Downloading blessings-1.6.tar.gz 04:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:31 INFO - Installing collected packages: blessings 04:53:31 INFO - Running setup.py install for blessings 04:53:31 INFO - Successfully installed blessings 04:53:31 INFO - Cleaning up... 04:53:31 INFO - Return code: 0 04:53:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:31 INFO - Reading from file tmpfile_stdout 04:53:31 INFO - Current package versions: 04:53:31 INFO - blessings == 1.6 04:53:31 INFO - blobuploader == 1.2.4 04:53:31 INFO - docopt == 0.6.1 04:53:31 INFO - functools32 == 3.2.3-2 04:53:31 INFO - jsonschema == 2.5.1 04:53:31 INFO - manifestparser == 1.1 04:53:31 INFO - mozInstall == 1.12 04:53:31 INFO - mozcrash == 1.0 04:53:31 INFO - mozdebug == 0.1 04:53:31 INFO - mozdevice == 0.50 04:53:31 INFO - mozfile == 1.2 04:53:31 INFO - mozhttpd == 0.7 04:53:31 INFO - mozinfo == 0.9 04:53:31 INFO - mozleak == 0.1 04:53:31 INFO - mozlog == 3.4 04:53:31 INFO - moznetwork == 0.27 04:53:31 INFO - mozprocess == 0.25 04:53:31 INFO - mozprofile == 0.28 04:53:31 INFO - mozrunner == 6.13 04:53:31 INFO - mozscreenshot == 0.1 04:53:31 INFO - mozsystemmonitor == 0.3 04:53:31 INFO - moztest == 0.8 04:53:31 INFO - mozversion == 1.4 04:53:31 INFO - psutil == 3.1.1 04:53:31 INFO - requests == 1.2.3 04:53:31 INFO - wsgiref == 0.1.2 04:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 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 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:31 INFO - 'HOME': '/Users/cltbld', 04:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:31 INFO - 'LOGNAME': 'cltbld', 04:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:31 INFO - 'MOZ_NO_REMOTE': '1', 04:53:31 INFO - 'NO_EM_RESTART': '1', 04:53:31 INFO - 'PAGER': '/bin/cat', 04:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:31 INFO - 'PWD': '/builds/slave/test', 04:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:31 INFO - 'SHELL': '/bin/bash', 04:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:31 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:31 INFO - 'USER': 'cltbld', 04:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:31 INFO - 'XPC_FLAGS': '0x0', 04:53:31 INFO - 'XPC_SERVICE_NAME': '0', 04:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:31 INFO - Cleaning up... 04:53:31 INFO - Return code: 0 04:53:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10774eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107751768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924b57fda0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, '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.G7UclQw6gN/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.mhhaXkD99u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:31 INFO - 'HOME': '/Users/cltbld', 04:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:31 INFO - 'LOGNAME': 'cltbld', 04:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:31 INFO - 'MOZ_NO_REMOTE': '1', 04:53:31 INFO - 'NO_EM_RESTART': '1', 04:53:31 INFO - 'PAGER': '/bin/cat', 04:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:31 INFO - 'PWD': '/builds/slave/test', 04:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:31 INFO - 'SHELL': '/bin/bash', 04:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:31 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:31 INFO - 'USER': 'cltbld', 04:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:31 INFO - 'XPC_FLAGS': '0x0', 04:53:31 INFO - 'XPC_SERVICE_NAME': '0', 04:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:32 INFO - Cleaning up... 04:53:32 INFO - Return code: 0 04:53:32 INFO - Running post-action listener: _resource_record_post_action 04:53:32 INFO - Running post-action listener: _start_resource_monitoring 04:53:32 INFO - Starting resource monitoring. 04:53:32 INFO - [mozharness: 2017-04-24 11:53:32.176502Z] Finished create-virtualenv step (success) 04:53:32 INFO - [mozharness: 2017-04-24 11:53:32.177513Z] Running install step. 04:53:32 INFO - Running pre-action listener: _resource_record_pre_action 04:53:32 INFO - Running main action method: install 04:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:32 INFO - Reading from file tmpfile_stdout 04:53:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:32 INFO - Reading from file tmpfile_stdout 04:53:32 INFO - Output received: 04:53:32 INFO - Usage: mozinstall [options] installer 04:53:32 INFO - Options: 04:53:32 INFO - -h, --help show this help message and exit 04:53:32 INFO - -d DEST, --destination=DEST 04:53:32 INFO - Directory to install application into. [default: 04:53:32 INFO - "/builds/slave/test"] 04:53:32 INFO - --app=APP Application being installed. [default: firefox] 04:53:32 INFO - mkdir: /builds/slave/test/build/application 04:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:53:52 INFO - Reading from file tmpfile_stdout 04:53:52 INFO - Output received: 04:53:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:53:52 INFO - Running post-action listener: _resource_record_post_action 04:53:52 INFO - [mozharness: 2017-04-24 11:53:52.542080Z] Finished install step (success) 04:53:52 INFO - [mozharness: 2017-04-24 11:53:52.542231Z] Running run-tests step. 04:53:52 INFO - Running pre-action listener: _resource_record_pre_action 04:53:52 INFO - Running main action method: run_tests 04:53:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:52 INFO - 2017-04-24 04:53:52.554 screenresolution[1624:7436] starting screenresolution argv=screenresolution get 04:53:52 INFO - 2017-04-24 04:53:52.557 screenresolution[1624:7436] Display 0: 1600x1200x32@60 04:53:52 INFO - 2017-04-24 04:53:52.561 screenresolution[1625:7439] starting screenresolution argv=screenresolution list 04:53:52 INFO - Available Modes on Display 0 04:53:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:52 INFO - Intel Iris: 04:53:52 INFO - Chipset Model: Intel Iris 04:53:52 INFO - Type: GPU 04:53:52 INFO - Bus: Built-In 04:53:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:52 INFO - Vendor: Intel (0x8086) 04:53:52 INFO - Device ID: 0x0a2e 04:53:52 INFO - Revision ID: 0x0009 04:53:52 INFO - Displays: 04:53:52 INFO - Display: 04:53:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:52 INFO - Display Serial Number: 1600x1200 60 04:53:52 INFO - Main Display: Yes 04:53:52 INFO - Mirror: Off 04:53:52 INFO - Online: Yes 04:53:52 INFO - Rotation: Supported 04:53:52 INFO - Return code: 0 04:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:52 INFO - Python 2.7.3 04:53:52 INFO - Return code: 0 04:53:52 INFO - grabbing minidump binary from tooltool 04:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:52 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 0x10752cd30>, '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 0x107452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107521be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:53:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:53:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:53:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:52 INFO - Return code: 0 04:53:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:53:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:52 INFO - ENV: RUST_BACKTRACE is now 1 04:53:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:53:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G7UclQw6gN/Render', 04:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:52 INFO - 'HOME': '/Users/cltbld', 04:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:52 INFO - 'LOGNAME': 'cltbld', 04:53:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:52 INFO - 'MOZ_NO_REMOTE': '1', 04:53:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:52 INFO - 'NO_EM_RESTART': '1', 04:53:52 INFO - 'PAGER': '/bin/cat', 04:53:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:52 INFO - 'PWD': '/builds/slave/test', 04:53:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:52 INFO - 'RUST_BACKTRACE': '1', 04:53:52 INFO - 'SHELL': '/bin/bash', 04:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mhhaXkD99u/Listeners', 04:53:52 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 04:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:52 INFO - 'USER': 'cltbld', 04:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:52 INFO - 'XPC_FLAGS': '0x0', 04:53:52 INFO - 'XPC_SERVICE_NAME': '0', 04:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:53:53 INFO - mozversion application_buildid: 20170424032920 04:53:53 INFO - mozversion application_changeset: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 04:53:53 INFO - mozversion application_display_name: Nightly 04:53:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:53 INFO - mozversion application_name: Firefox 04:53:53 INFO - mozversion application_remotingname: firefox 04:53:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:53 INFO - mozversion application_vendor: Mozilla 04:53:53 INFO - mozversion application_version: 55.0a1 04:53:53 INFO - mozversion platform_buildid: 20170424032920 04:53:53 INFO - mozversion platform_changeset: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 04:53:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:53 INFO - mozversion platform_version: 55.0a1 04:53:53 INFO - using testdate: 1493034833 04:53:53 INFO - actual date: 1493034833 04:53:53 INFO - starting webserver on 'localhost:49243' 04:53:53 INFO - SUITE-START | Running 2 tests 04:53:53 INFO - TEST-START | dromaeo_css 04:53:53 INFO - operating with platform_type : mac_ 04:53:53 INFO - Initialising browser for dromaeo_css test... 04:53:53 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpXtRXQg/profile http://localhost:49243/getInfo.html) 04:53:55 INFO - PID 1635 | __metrics Screen width/height:1600/1200 04:53:55 INFO - PID 1635 | colorDepth:24 04:53:55 INFO - PID 1635 | Browser inner width/height: 1024/689 04:53:55 INFO - PID 1635 | __metrics 04:53:55 INFO - PID 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:55 INFO - PID 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:56 INFO - TEST-INFO | 1635: exit 0 04:53:56 INFO - Browser initialized. 04:53:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:56 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpXtRXQg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:09 INFO - PID 1639 | RSS: Main: 241913856 04:54:09 INFO - PID 1639 | 04:57:14 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 04:57:16 INFO - PID 1639 | RSS: Main: 402808832 04:57:16 INFO - PID 1639 | 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:58 INFO - PID 1639 | 04:58:58 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:58 INFO - PID 1639 | Full stack: 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:58 INFO - PID 1639 | 04:58:58 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:58 INFO - PID 1639 | Full stack: 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:58 INFO - PID 1639 | 04:58:58 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:58 INFO - PID 1639 | Full stack: 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | ************************* 04:58:58 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:58:58 INFO - PID 1639 | 04:58:58 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:58 INFO - PID 1639 | Full stack: 04:58:58 INFO - PID 1639 | ************************* 05:00:18 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 05:00:19 INFO - PID 1639 | RSS: Main: 366116864 05:00:19 INFO - PID 1639 | 05:03:21 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 05:03:22 INFO - PID 1639 | RSS: Main: 330014720 05:03:22 INFO - PID 1639 | 05:06:24 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 05:06:25 INFO - PID 1639 | RSS: Main: 360271872 05:06:25 INFO - PID 1639 | 05:09:28 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 05:09:29 INFO - PID 1639 | RSS: Main: 335192064 05:09:29 INFO - PID 1639 | 05:12:31 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 05:12:32 INFO - PID 1639 | RSS: Main: 378273792 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | __start_tp_report 05:12:32 INFO - PID 1639 | _x_x_mozilla_page_load 05:12:32 INFO - PID 1639 | _x_x_mozilla_page_load_details 05:12:32 INFO - PID 1639 | |i|pagename|runs| 05:12:32 INFO - PID 1639 | |0;dojo.html;2944.249216449805;3491.3017396520686;3508.35095507331;3547.148684315764;3590.85636574537;5921.85195370116;6111.083337499377;6178.567500274982;6189.938100618992;6199.44205021548;6012.158297838306;6071.757129714806;6072.058830881209;6079.756809727605;6107.083937409391;5206;5214.947850521503;5239.633225674204;5259.737013149346;5343.038253114438;5303.337082864642;5323.095073837457;5334.813281535147;5339.22581225722;5346.492083252104;5335.226392173133;5335.893282134355;5340.118880384732;5341.011912796126;5346;5315.3621565412395;5324.92012619811;5328.094223981932;5329.333833270841;5333.973330133344;5202.0896343140175;5293.179557168645;5307.363116426053;5334.439883812182;5342.465753424665;6166.691665416756;6208.782692605737;6209.565330426872;6217.782377616807;6227.626342419469;6246.281677607088;6459.870802583969;6478.54650174488;6507.414332710032;6543.967280163616;6453.386928241809;6466.191726034246;6594.505412094064;6668.466522678174;6680.599164050124;6230.657313847737;6231.6572588507615;6235.688215589203;6240.53196010292;6259.248890133168;6743.089682892844;6750.1562304711915;6764.898526522008;6767.120274364301;6798.252192258848;6254.874902501924;6329.430351268408;6329.461995730322;6377.7448902044325;6403.4877209824035;5412.377576578665;6447;6514.022896565553;6540.50946179029;6558.278589355167;6349.841253968688;6364.109024736541;6415.101885735908;6424.614523128534;6427.421532062137;6286.4342209201395;6412.967935160387;6417.326180750954;6417.679116044179;6448.580842245239;5158.380994280636;5186.325777648957;5210.557102646242;5249.868753281122;5273.6572122811895;4650.534946505322;4667.8599642010795;4679.344891715163;4688.765561721901;4712.740799256006;6128.3258841527395;6177.011678131477;6187.566870319124;6206.441420272107;6210.254769427697;6320.399562041599;6406.839829004219;6411.326810684905;6542.607443553402;6614;6151;6162.476189523851;6191.349908259568;6191.783287584913;6193.876122477525;5738.684372359477;5742.109972954198;5756.280464941882;5763.423657634287;5801.419858014165;6446.742130314735;6534.705938232696;6642.268528891761;6771;6781.050652908498;6347.301796802441;6482.2869484357625;6620.735170593315;6624.105745724266;6640.402363787282;6719.865602688016;6734.158230221223;6769.458443324621;6771.052052712723;6780.898286525805;6357.110004599453;6476.643784591893;6483.481321494175;6495.188101487314;6496.1230233919705;5450.836474905759;6291.874162516632;6361.777337793155;6363.61818290904;6546.247181573989;5941.851453713692;5992.101184822312;6296.496280297473;6317.052442133717;6323.177986861679;6201.131841542097;6227.968860155852;6305.4009869062365;6305.959516679696;6392.680365981775;5651.519620832275;5914.319853216935;6241.687915604292;6276.184096067482;6302;6277.309495955533;6303.401176888188;6309.90535141964;6313.842153946188;6320.494360451061;5788.594798364243;6144.972159187547;6219.906701399392;6232.8130156095385;6263.311035785969 05:12:32 INFO - PID 1639 | |1;ext.html;669.3440428380187;725.7967769024672;774.8915151878737;1102.2394547762049;1116.9664910052702;26380;35709.2858142837;36237;36258.368373423225;36452;37986.810065949634;38240.043998900044;38339.424908626395;38379.232415351675;38389;8303.875441868391;8453.830923381529;8454.830903381928;8455;8458.830823383529;5995.820125396245;6125.356837532062;6125.632462052269;6128.356522565134;6133.1413602095745;8293.33653307734;8482.448640838356;8492.872606910902;8500.022497412783;8502.362322825782;8362.707305244317;8457.66169353225;8465.280451161658;8466.195711407468;8468.195521425454;8234.794130146734;8316.542590157538;8321.625526851307;8330.166983301622;8331.95834020826;36438;36511.4523282151;36531.63468365309;36614.63385366139;36740;3570.892873213808;3596.5684117906017;3601.405768048269;3602.4596310553366;3613.8554457821656;30017.099487015425;30060.84969575138;30082;30121.397572048656;30124.8493757532;3102.937941241185;3110.440120778259;3146.4493713600027;3155.7317628001647;3159.952600710991;207802.9609851941;284730;291009.5449522739;292105.53947230126;294053.05946940684;47556.28665570019;47573;47575;47581.52418475771;47754.761226193645;49784.751076244385;49803.50196498061;49805.50194498081;49827.75086124546;49843.25235121476;13578.93210533941;13677.31613419325;13679.452821887213;13682.04225704211;13694.863051369359;11147.442627868737;11150.442477876073;11153.776924461465;11164.720881977853;11197.66407007791;8807.163319484638;10646;10704.625338113285;12115.39423028845;12456.564020259248;4353.760543170156;5129.487051294841;5150.330457040561;5185.377754669388;5192.792288308426;824.6371596497522;877.2061284537504;886.1404437695425;963.8987906269881;984.9510271560765;19907.502312442306;23497.882510587337;23615.40961475977;23953;24082;1068.1828401273033;1100.471773548701;1111.5887121765;1119.5074167366333;1125.6341688951125;11957.581484647995;12019.63941081769;12047.277163370225;12051.915327620556;12054;307712;308807.45596272324;309465;309599;310376;50662.74668626707;50714.74642626763;50775;50842.745786271575;50956.49043509518;1452.07793051411;1494.1110039526463;1505.0969418348902;1509.8641122298827;1518.1498360917922;23138.07447702073;23217.3034808956;23297;23346.416339591648;23602.409939750956;36789.81605091957;36869.81565092158;36875.63124368722;36956.706515271835;37181;274735;275119;275761;275937;276495;26788.464230715665;32575.837120814245;33011;33189.50215746814;33225.335493290484;42793.358099627905;42800.78599606982;42844;42874;42918.35622465728;24542.161000079595;28572.85713571419;29503.819847205872;29887.850560747058;30343.960271523814;29600.96396626108;29632.703672963857;29859;30030;30127.246818829706;36076.09809754777;36084.81957590195;36139.457908131924;36150.8192459036;36252.81873590615;27354.316142096606;28196.718032819408;28762.712372876;29146.417071658023;30186.698133018388;21545;23360;23480;23845.761542385048;24226.030958762156 05:12:32 INFO - PID 1639 | |2;jquery.html;388.11316142614135;426.7981719966925;437.48158432257765;440.9184300904332;458.00841178847816;17642.294308227672;19318.90340548297;20774.376768696926;22136.778632213674;22285.108595656155;22614.886925565348;22626.88686556569;22873.885630571865;22951.59008304129;23297.670232976692;5948.613340132899;6026.728797204125;6096.420840020191;6187.659678717669;6229.781957631484;3596.172880237547;3657.3782456982376;6070.484008859252;6181.258249010102;6181.505479561624;3647.270545890819;3682.668559829615;3766.303233901723;5856.677882716449;6142.969285153568;5908.438698323653;6058.96970515149;6142.293636231823;6162.84592885177;6165.242905771834;5411.675299482004;5412.4858138477175;5417.431169727161;5423.023855705971;5433.320834895638;20936.895315523478;26063.73936260632;27142.72857271422;27468.725312746818;27785.583216251773;2230.2194232018824;2271.6478945763433;2273.1362082408746;2278.0659929428853;2279.327598358488;16864.747028794576;17823.93056416606;18009.00950447725;18034.90982545092;18324.725129123075;2092.1317653173915;2110.767815540289;2144.303101492021;2145.4314606629255;2167.826573874086;164172;164217.53673694903;165457;166302;166860.828479289;10270.845937310947;11289.661310160709;12344.876551234553;12622.747545049047;12658.873411265953;16222.675546489005;16344.427945021867;16380.590485237726;16424.01455912649;16426.342946282253;8448.986121665439;8743.737687869374;8796.560171991376;8964.506952117696;9025.187733104052;7330.413566914634;8340.165983401732;8348.457350272334;8361.958190209132;8504.447210931394;6245.812625621239;7486.775396737998;7622.961885190539;7666.463347565728;7683.615819209129;1724.6981778188767;1928.852332861945;2071.2336435518955;2149.398168512788;2161.362398092535;907.1654078248027;917.9082091790901;918.4810582021137;954.1651055326589;960.4429430930044;20199.59600808005;21016.474588135417;21031.57936841285;21033.474163146042;21072.36782896485;941.5762906692016;976.8827740671165;981.8281800684852;987.6049580167991;993.8062077894741;10087.848682269772;10674.519646615765;10706.197035222389;10822.08012318946;10928.672139835817;541638.7115481771;545775;546981;565325;566271;118718.40640796741;122589.38705306416;124267.37866310791;126883;132034.33982830023;1116.1684545014016;1128.227164392394;1138.2032577195996;1143.4225716013527;1202.7293858881856;21363.14547418148;21620.45948851291;21670.24154154597;21791.23730669419;22062.558748824613;54291.72854135862;56817;57593.42406576048;58251;58363;76005.61997189978;77192.61403692946;79972.60013699894;80136;81900.59049704713;7515.6993720250575;8408.285295749929;8805.471671699719;8928;9091.54542272897;14053.508127215498;14212;14229.857701423267;14658.120512769268;14728;11754.353510557;11877.406129693309;12005.099617528545;12032.15774895784;12085.456154473246;9424.81150376975;11398.601048963246;11407.372594507382;11556.711082223012;11693.415329233674;11875.465604048011;12156.270623762603;12184.817227741414;12267.87732122703;12448.128630996105;8721.738347849574;8764.780880477783;8789.736307910773;9059.682911098344;9144;11712.590059347882;11802.881971180179;12026;12132.575359862363;12138.75722485563 05:12:32 INFO - PID 1639 | |3;mootools.html;1242.9502819887205;1337.4449603414585;1462.6635873749037;1467.4350375105594;1476.23235917323;11217.943910280448;11713.531458741661;11732.882671173285;11738.823917641243;11760.7647847043;11313;11666.066714662828;11693.239939403933;11736.7652646947;11760.353180575064;2517.3958250019955;2562;2564.781993530552;2567.152839562949;2567.3838278813137;2060.7527096748336;2141.8714877107345;2459.18846780562;2537.0486067724605;2543.338731929702;2166.6100101981638;2474.9010039598393;2561.474897645978;2564.397366618843;2567.82025258232;2476.3932836455006;2504.136073054793;2514.094925826719;2517.332906779705;2519.508695804319;2480.516299321633;2497.7377375375504;2499.3501689560844;2504.2236906559024;2506.323292710976;11586.536538538448;11842.703932401759;11844.407779610985;11864.644060678194;11870.406479676069;5408.756605952742;6807.3873351398615;6819.931800682029;6822.215445223764;6829.658517074126;4117.419393253751;4263.59495847894;4291.935620965688;4366.235908715994;4413.337999300099;1244.2907542700664;1249.1006475337742;1297.2735268249717;1301.6225294664537;1301.9804702929464;16614.169291535374;16720.916395417946;16727.247273872705;16751.07869067201;16763.329466821313;5463.9180412293845;5476.479734425223;5568.498835104779;5666.291713535808;5795.8551036224435;10958.342499450058;12333.876661233453;12349.19730217533;12361.567345142877;12364.319962402154;6644.534882558174;6649.800505984828;6650.168728908887;6650.800475985729;6651.66741662915;5999.100134979788;6127.448529632355;6134.8159555213415;6255.718492667841;6260.311365749764;3934.940975885364;3983.2830090583975;4300.61294483498;4323.399003747148;4387.912241755147;1111.3054341036852;1165.6386520178771;1264.2351377416715;1283.8459384873875;1302.5831733845268;675.6689222281046;740.8407192453649;780.1418439716267;782.2451334462271;831.0650518167062;4441.533638967927;5139.612304677791;6313.116163737081;7124.536905101152;7135.7365021133355;921.8202450522084;932.7528205025674;943.495230051919;961.1157734883924;965.8937516873139;4200.6219440250525;4599.701019433726;4602.171609110393;4688.578027977498;4769.833055843029;14474.565763027125;14551.563453096423;15025.94818362704;15091.924540377227;15300.540983770505;14619.853801462063;14792.408303667948;14964.251787410803;14987.850121498646;15187.924060379628;8500.957495212608;8553.444026138406;8737.257333126629;8741.076963068115;8746.431481953652;6869.073786475097;7047.894281585678;7071.639125945688;7095.410175286087;7118.679659415235;11361.772764544497;13023.413946372246;13434.193948363129;13763.38064787067;13775.242361670204;13481.662958426117;14070.507532236732;14095.224762638154;14117;14127.858721412655;8571.957140214508;9074.911010678761;9163.725088247096;9558.904410955802;9623.037696230322;10540.683779486628;10678.73303167427;10747.516361763583;10759.246852720235;10772.515236814206;9108.863367049367;9121.543922803701;9175.678851240174;9207.493587852465;9222.44665320083;8888.688895888612;8912.242459391024;8925.196732294125;8982.461052336881;9130.543472826464;8100.270975612223;8267.421280510547;8271.17288271168;8273.46222495536;8327.625256863335;5767.826965191051;5913.58604897653;5937.435943585352;6144.969275153596;6204.472619827185;5446.455354464521;5987.281526216708;6000.729967151401;6076.33160352352;6326.177596912372 05:12:32 INFO - PID 1639 | |4;prototype.html;376.6103079636142;387.82160206305105;400.46537871940956;400.8757285241577;403.4029636138513;5525.955396503299;5720.170575266584;5722.771089156434;5777.277840269966;5784.537237021039;4927.679700819444;5198.584113270938;5544.944550554494;5547.805826796063;5567.860803479915;3204;3643.526341575605;4231.090315582157;4250.48994120706;4357.368181613664;4345.521992580813;4357.908204062052;4366.039471316305;4385.232584297751;4395.527498288077;4376.7260451156435;4395.033092719596;4401.7235001849585;4418.7127836690515;4437.312216606431;4180.5610410906875;4299.570042995707;4304.375865499516;4351.891202719958;4403.559644035603;3552.520409744677;3581.3732596795458;3922.4704664870164;3937.8818635440985;3940.349842276021;5502.174673798922;5524.723763811793;5532.640378375393;5548.112302031696;5552.194931734916;5121.617163365908;5216;5240.432188227741;5289.910485358262;5311.760970756325;5323.148296272617;5494.780208791643;6014.969970119986;6097.390260973912;6124.142620033199;4484.349769283468;4487.753173575485;4496.628528298867;4501.6687651138245;4510.548945105496;5037.496250374933;6004.568149899254;6048.637081775064;6065.939340606582;6281.183446152017;3708.8145592720257;4255;4269.423627810268;4284.785760711952;4317.84887528935;4557.931631025537;4671.6262698984;4675.672702910763;4676.228422310349;4703.63689961679;4961.305417241589;5071.54356107952;5100.8778068824795;5190.2214667800135;5259.868503287448;5560.388357280696;6069.393060693896;6077.908831367533;6120.1737765401995;6413.967930160319;1309.508934149694;1443.826740791112;1530.043722673329;1590.705719441907;1595.6010997250687;1021.3259248895694;1066.99466502667;1104.9337039777638;1135.7785231879704;1140.224647239885;5003.524665156877;5504.165584480464;5505.339359276913;5524.1989911462615;5535.667859928417;5331.3868905076415;6101.078160379467;6123.908141377883;6137.60105593135;6141.477974372139;5261.737183076034;5504.779808807602;5540.473655002768;5623.409541998113;5637.661740295595;3034.4386288536693;3189.2824114574037;3208.6470488246273;3210.7431405487973;3214;5994.8253299102;6235.875282494325;6347.746090156435;6360.300366959631;6368.012957991426;6007.88854062;6130.877382452326;6278.372162783777;6296.716647750863;6303.495720342362;5228.215767634885;6053.364396738279;6062.848058868889;6323.336049714806;6338.809835704937;5933.495652869555;6262.964536525738;6278.937210627835;6296.937030629819;6310.305866354789;5908.231929849092;6083.1483592298;6209.937900621117;6213.099100630474;6222.875542489215;6059.484943779828;6183.4541364658835;6368.917284061628;6393.8721225576155;6433.131527243762;3508.9824550877083;4191;4210.179015092028;4216.8313267470185;4218.6835987300465;5994.940050599613;6174.969125154345;6265.216847894013;6270.49836013127;6291.182146320949;5399.757010934439;5636.887262254814;6030.758769649165;6030.819075427744;6044.697765111639;4212.536620971752;5193.454687257935;5749.8275051748515;5990.9700451497465;6041.909371359346;4839.274108883555;5882.352941176553;5898.793542226002;5906.940930590639;5932.2584676915385;5189.6886186828915;6036.8188954331445;6056.818295451144;6062.575619706578;6078.024641991459;4723.409573803275;5460.235567020541;5645.322561292671;5867.149263356704;5911.261092363455 05:12:32 INFO - PID 1639 | |5;yui.html;705.2172088981226;858.3733874271782;859.901111372192;861.470195829565;866.0516734176075;12826.615201543957;17816.50568920352;17970.01164935928;18497.98261095639;18554.81445185546;16315.59211019725;16322;16788.328466861312;16836.494905152864;17033.488995330128;938.5823308627663;954.3319676226669;955.6941778630841;956.0296299256261;956.2588993530001;650.531617235592;667.199360767079;917.1837065012145;933.4446004627235;935.303199116659;950.7147855643314;978.6232300564299;979.4025644356972;980.7842274699555;1001.7896241789233;869.952152631605;977.3842479238106;977.7799995001068;979.3095867413457;980.4950450517989;724.0189543169035;726.7964969808462;727.396261103283;730.4996077686801;745.2100773180446;15736.055836649837;15762.133082680448;15770.290336934866;15914.283857226337;16425.67148657032;16250.349986000545;16352.591185220346;16610.169491525496;16697.666046678998;16925.661486770317;13386.19682819034;13576.389062492113;13634.795478067837;13810.65473363164;13880.305984700724;3440.4839274108836;3467.8612855486003;3469.3928562501715;3470.3753324401596;3476.9826150869085;123498.38250808779;124498.75501244962;126011;127003;128972.3551382237;11715.824262636068;11772.352520611277;11919.165658404001;11931.463084161234;12074.818877716842;19683.409497715093;19883.204671812964;20044.59910801776;20045.799542004686;20056.89687067196;7301.963490182515;7333.936579195986;7372.115346158388;7372.48392612512;7376.7049318026675;3833.7316387852584;3850.6534411902503;3855.614438556122;3901.2197560488016;3912.6478616924614;4193.287141186006;4266.765327906933;4276.957230427718;4277.871663850089;4282.550332215073;825.6573521988307;836.8493671139132;837.2548431895618;837.2632083766247;913.1690161952724;636.7994081864198;657.8881590129594;665.6505334699225;691.1050190003856;695.2456584605759;10800.297980631234;11752.530933633296;11819.133556009805;11825.822612660817;12171.513139474322;616.6916541729136;644.2816259870305;656.5502630697891;663.5222639699409;678.7217240931293;5498.395176530578;5572.219889215513;5594.552435805207;5624.072028115315;5687.943120568824;101668.96662066717;105222;105622.94377056131;105813;108412;81294;83388.58305708432;95139.52430237943;95941.52029239948;99213.03147874148;51286;72448.82653520403;72678;73885.89171162437;74342.02631894664;12195.817062743889;12221.022318214344;12625.242485450903;12647.367631618567;12711.682207944876;32905.341893162484;40129;40136.996575085854;41039.589604103574;41303.58696413117;52328.47671523388;63680.68159659172;66346.33653663595;67551;68302.65848670725;16366.09986450709;16449.753253700965;16537.751933721243;16782.66434671324;16819.747703784207;18265.817341826412;18315.725264121316;18711.438656840317;18759;18781.530461738566;16449.177541122655;16615.750763738313;16898.324067037673;17027.91486042562;17482.73775893337;16587.419440319532;16591.087490188154;16707.24817383245;16746.246418910934;16903.577410564834;16236.51290461288;16415.671686566442;16436.67126657436;16449.753253701445;16584.336626534805;11256.943715281372;11346.886531134583;11746.85868838387;11963.880361196276;12012.579559715368;11708.648740537797;12684.809727854274;13100;13811.309434528433;13822.308884555932 05:12:32 INFO - PID 1639 | __end_tp_report 05:12:32 INFO - PID 1639 | __start_cc_report 05:12:32 INFO - PID 1639 | _x_x_mozilla_cycle_collect,1620 05:12:32 INFO - PID 1639 | __end_cc_report 05:12:32 INFO - PID 1639 | __startTimestamp1493035952058__endTimestamp 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | ------- Summary: start ------- 05:12:32 INFO - PID 1639 | Number of tests: 6 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:5995.49 Median:6231.66 stddev:695.84 (11.2%) stddev-sans-first:655.51 05:12:32 INFO - PID 1639 | Values: 2944.2 3491.3 3508.4 3547.1 3590.9 5921.9 6111.1 6178.6 6189.9 6199.4 6012.2 6071.8 6072.1 6079.8 6107.1 5206.0 5214.9 5239.6 5259.7 5343.0 5303.3 5323.1 5334.8 5339.2 5346.5 5335.2 5335.9 5340.1 5341.0 5346.0 5315.4 5324.9 5328.1 5329.3 5334.0 5202.1 5293.2 5307.4 5334.4 5342.5 6166.7 6208.8 6209.6 6217.8 6227.6 6246.3 6459.9 6478.5 6507.4 6544.0 6453.4 6466.2 6594.5 6668.5 6680.6 6230.7 6231.7 6235.7 6240.5 6259.2 6743.1 6750.2 6764.9 6767.1 6798.3 6254.9 6329.4 6329.5 6377.7 6403.5 5412.4 6447.0 6514.0 6540.5 6558.3 6349.8 6364.1 6415.1 6424.6 6427.4 6286.4 6413.0 6417.3 6417.7 6448.6 5158.4 5186.3 5210.6 5249.9 5273.7 4650.5 4667.9 4679.3 4688.8 4712.7 6128.3 6177.0 6187.6 6206.4 6210.3 6320.4 6406.8 6411.3 6542.6 6614.0 6151.0 6162.5 6191.3 6191.8 6193.9 5738.7 5742.1 5756.3 5763.4 5801.4 6446.7 6534.7 6642.3 6771.0 6781.1 6347.3 6482.3 6620.7 6624.1 6640.4 6719.9 6734.2 6769.5 6771.1 6780.9 6357.1 6476.6 6483.5 6495.2 6496.1 5450.8 6291.9 6361.8 6363.6 6546.2 5941.9 5992.1 6296.5 6317.1 6323.2 6201.1 6228.0 6305.4 6306.0 6392.7 5651.5 5914.3 6241.7 6276.2 6302.0 6277.3 6303.4 6309.9 6313.8 6320.5 5788.6 6145.0 6219.9 6232.8 6263.3 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43171.60 Median:33207.42 stddev:75387.18 (227.0%) stddev-sans-first:75531.12 05:12:32 INFO - PID 1639 | Values: 669.3 725.8 774.9 1102.2 1117.0 26380.0 35709.3 36237.0 36258.4 36452.0 37986.8 38240.0 38339.4 38379.2 38389.0 8303.9 8453.8 8454.8 8455.0 8458.8 5995.8 6125.4 6125.6 6128.4 6133.1 8293.3 8482.4 8492.9 8500.0 8502.4 8362.7 8457.7 8465.3 8466.2 8468.2 8234.8 8316.5 8321.6 8330.2 8332.0 36438.0 36511.5 36531.6 36614.6 36740.0 3570.9 3596.6 3601.4 3602.5 3613.9 30017.1 30060.8 30082.0 30121.4 30124.8 3102.9 3110.4 3146.4 3155.7 3160.0 207803.0 284730.0 291009.5 292105.5 294053.1 47556.3 47573.0 47575.0 47581.5 47754.8 49784.8 49803.5 49805.5 49827.8 49843.3 13578.9 13677.3 13679.5 13682.0 13694.9 11147.4 11150.4 11153.8 11164.7 11197.7 8807.2 10646.0 10704.6 12115.4 12456.6 4353.8 5129.5 5150.3 5185.4 5192.8 824.6 877.2 886.1 963.9 985.0 19907.5 23497.9 23615.4 23953.0 24082.0 1068.2 1100.5 1111.6 1119.5 1125.6 11957.6 12019.6 12047.3 12051.9 12054.0 307712.0 308807.5 309465.0 309599.0 310376.0 50662.7 50714.7 50775.0 50842.7 50956.5 1452.1 1494.1 1505.1 1509.9 1518.1 23138.1 23217.3 23297.0 23346.4 23602.4 36789.8 36869.8 36875.6 36956.7 37181.0 274735.0 275119.0 275761.0 275937.0 276495.0 26788.5 32575.8 33011.0 33189.5 33225.3 42793.4 42800.8 42844.0 42874.0 42918.4 24542.2 28572.9 29503.8 29887.9 30344.0 29601.0 29632.7 29859.0 30030.0 30127.2 36076.1 36084.8 36139.5 36150.8 36252.8 27354.3 28196.7 28762.7 29146.4 30186.7 21545.0 23360.0 23480.0 23845.8 24226.0 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:35794.31 Median:2278.70 stddev:94122.76 (4130.6%) stddev-sans-first:94349.25 05:12:32 INFO - PID 1639 | Values: 388.1 426.8 437.5 440.9 458.0 17642.3 19318.9 20774.4 22136.8 22285.1 22614.9 22626.9 22873.9 22951.6 23297.7 5948.6 6026.7 6096.4 6187.7 6229.8 3596.2 3657.4 6070.5 6181.3 6181.5 3647.3 3682.7 3766.3 5856.7 6143.0 5908.4 6059.0 6142.3 6162.8 6165.2 5411.7 5412.5 5417.4 5423.0 5433.3 20936.9 26063.7 27142.7 27468.7 27785.6 2230.2 2271.6 2273.1 2278.1 2279.3 16864.7 17823.9 18009.0 18034.9 18324.7 2092.1 2110.8 2144.3 2145.4 2167.8 164172.0 164217.5 165457.0 166302.0 166860.8 10270.8 11289.7 12344.9 12622.7 12658.9 16222.7 16344.4 16380.6 16424.0 16426.3 8449.0 8743.7 8796.6 8964.5 9025.2 7330.4 8340.2 8348.5 8362.0 8504.4 6245.8 7486.8 7623.0 7666.5 7683.6 1724.7 1928.9 2071.2 2149.4 2161.4 907.2 917.9 918.5 954.2 960.4 20199.6 21016.5 21031.6 21033.5 21072.4 941.6 976.9 981.8 987.6 993.8 10087.8 10674.5 10706.2 10822.1 10928.7 541638.7 545775.0 546981.0 565325.0 566271.0 118718.4 122589.4 124267.4 126883.0 132034.3 1116.2 1128.2 1138.2 1143.4 1202.7 21363.1 21620.5 21670.2 21791.2 22062.6 54291.7 56817.0 57593.4 58251.0 58363.0 76005.6 77192.6 79972.6 80136.0 81900.6 7515.7 8408.3 8805.5 8928.0 9091.5 14053.5 14212.0 14229.9 14658.1 14728.0 11754.4 11877.4 12005.1 12032.2 12085.5 9424.8 11398.6 11407.4 11556.7 11693.4 11875.5 12156.3 12184.8 12267.9 12448.1 8721.7 8764.8 8789.7 9059.7 9144.0 11712.6 11802.9 12026.0 12132.6 12138.8 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7129.04 Median:3959.11 stddev:4525.84 (114.3%) stddev-sans-first:4516.92 05:12:32 INFO - PID 1639 | Values: 1243.0 1337.4 1462.7 1467.4 1476.2 11217.9 11713.5 11732.9 11738.8 11760.8 11313.0 11666.1 11693.2 11736.8 11760.4 2517.4 2562.0 2564.8 2567.2 2567.4 2060.8 2141.9 2459.2 2537.0 2543.3 2166.6 2474.9 2561.5 2564.4 2567.8 2476.4 2504.1 2514.1 2517.3 2519.5 2480.5 2497.7 2499.4 2504.2 2506.3 11586.5 11842.7 11844.4 11864.6 11870.4 5408.8 6807.4 6819.9 6822.2 6829.7 4117.4 4263.6 4291.9 4366.2 4413.3 1244.3 1249.1 1297.3 1301.6 1302.0 16614.2 16720.9 16727.2 16751.1 16763.3 5463.9 5476.5 5568.5 5666.3 5795.9 10958.3 12333.9 12349.2 12361.6 12364.3 6644.5 6649.8 6650.2 6650.8 6651.7 5999.1 6127.4 6134.8 6255.7 6260.3 3934.9 3983.3 4300.6 4323.4 4387.9 1111.3 1165.6 1264.2 1283.8 1302.6 675.7 740.8 780.1 782.2 831.1 4441.5 5139.6 6313.1 7124.5 7135.7 921.8 932.8 943.5 961.1 965.9 4200.6 4599.7 4602.2 4688.6 4769.8 14474.6 14551.6 15025.9 15091.9 15300.5 14619.9 14792.4 14964.3 14987.9 15187.9 8501.0 8553.4 8737.3 8741.1 8746.4 6869.1 7047.9 7071.6 7095.4 7118.7 11361.8 13023.4 13434.2 13763.4 13775.2 13481.7 14070.5 14095.2 14117.0 14127.9 8572.0 9074.9 9163.7 9558.9 9623.0 10540.7 10678.7 10747.5 10759.2 10772.5 9108.9 9121.5 9175.7 9207.5 9222.4 8888.7 8912.2 8925.2 8982.5 9130.5 8100.3 8267.4 8271.2 8273.5 8327.6 5767.8 5913.6 5937.4 6145.0 6204.5 5446.5 5987.3 6000.7 6076.3 6326.2 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:4933.41 Median:5498.48 stddev:1468.61 (26.7%) stddev-sans-first:1432.35 05:12:32 INFO - PID 1639 | Values: 376.6 387.8 400.5 400.9 403.4 5526.0 5720.2 5722.8 5777.3 5784.5 4927.7 5198.6 5544.9 5547.8 5567.9 3204.0 3643.5 4231.1 4250.5 4357.4 4345.5 4357.9 4366.0 4385.2 4395.5 4376.7 4395.0 4401.7 4418.7 4437.3 4180.6 4299.6 4304.4 4351.9 4403.6 3552.5 3581.4 3922.5 3937.9 3940.3 5502.2 5524.7 5532.6 5548.1 5552.2 5121.6 5216.0 5240.4 5289.9 5311.8 5323.1 5494.8 6015.0 6097.4 6124.1 4484.3 4487.8 4496.6 4501.7 4510.5 5037.5 6004.6 6048.6 6065.9 6281.2 3708.8 4255.0 4269.4 4284.8 4317.8 4557.9 4671.6 4675.7 4676.2 4703.6 4961.3 5071.5 5100.9 5190.2 5259.9 5560.4 6069.4 6077.9 6120.2 6414.0 1309.5 1443.8 1530.0 1590.7 1595.6 1021.3 1067.0 1104.9 1135.8 1140.2 5003.5 5504.2 5505.3 5524.2 5535.7 5331.4 6101.1 6123.9 6137.6 6141.5 5261.7 5504.8 5540.5 5623.4 5637.7 3034.4 3189.3 3208.6 3210.7 3214.0 5994.8 6235.9 6347.7 6360.3 6368.0 6007.9 6130.9 6278.4 6296.7 6303.5 5228.2 6053.4 6062.8 6323.3 6338.8 5933.5 6263.0 6278.9 6296.9 6310.3 5908.2 6083.1 6209.9 6213.1 6222.9 6059.5 6183.5 6368.9 6393.9 6433.1 3509.0 4191.0 4210.2 4216.8 4218.7 5994.9 6175.0 6265.2 6270.5 6291.2 5399.8 5636.9 6030.8 6030.8 6044.7 4212.5 5193.5 5749.8 5991.0 6041.9 4839.3 5882.4 5898.8 5906.9 5932.3 5189.7 6036.8 6056.8 6062.6 6078.0 4723.4 5460.2 5645.3 5867.1 5911.3 05:12:32 INFO - PID 1639 | 05:12:32 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21438.59 Median:26481.12 stddev:30471.42 (115.1%) stddev-sans-first:30517.13 05:12:32 INFO - PID 1639 | Values: 705.2 858.4 859.9 861.5 866.1 12826.6 17816.5 17970.0 18498.0 18554.8 16315.6 16322.0 16788.3 16836.5 17033.5 938.6 954.3 955.7 956.0 956.3 650.5 667.2 917.2 933.4 935.3 950.7 978.6 979.4 980.8 1001.8 870.0 977.4 977.8 979.3 980.5 724.0 726.8 727.4 730.5 745.2 15736.1 15762.1 15770.3 15914.3 16425.7 16250.3 16352.6 16610.2 16697.7 16925.7 13386.2 13576.4 13634.8 13810.7 13880.3 3440.5 3467.9 3469.4 3470.4 3477.0 123498.4 124498.8 126011.0 127003.0 128972.4 11715.8 11772.4 11919.2 11931.5 12074.8 19683.4 19883.2 20044.6 20045.8 20056.9 7302.0 7333.9 7372.1 7372.5 7376.7 3833.7 3850.7 3855.6 3901.2 3912.6 4193.3 4266.8 4277.0 4277.9 4282.6 825.7 836.8 837.3 837.3 913.2 636.8 657.9 665.7 691.1 695.2 10800.3 11752.5 11819.1 11825.8 12171.5 616.7 644.3 656.6 663.5 678.7 5498.4 5572.2 5594.6 5624.1 5687.9 101669.0 105222.0 105622.9 105813.0 108412.0 81294.0 83388.6 95139.5 95941.5 99213.0 51286.0 72448.8 72678.0 73885.9 74342.0 12195.8 12221.0 12625.2 12647.4 12711.7 32905.3 40129.0 40137.0 41039.6 41303.6 52328.5 63680.7 66346.3 67551.0 68302.7 16366.1 16449.8 16537.8 16782.7 16819.7 18265.8 18315.7 18711.4 18759.0 18781.5 16449.2 16615.8 16898.3 17027.9 17482.7 16587.4 16591.1 16707.2 16746.2 16903.6 16236.5 16415.7 16436.7 16449.8 16584.3 11256.9 11346.9 11746.9 11963.9 12012.6 11708.6 12684.8 13100.0 13811.3 13822.3 05:12:32 INFO - PID 1639 | -------- Summary: end -------- 05:12:32 INFO - PID 1639 | 05:12:32 INFO - TEST-INFO | 1639: exit 0 05:12:32 INFO - TEST-OK | dromaeo_css | took 1119616ms 05:12:32 INFO - TEST-START | kraken 05:12:32 INFO - operating with platform_type : mac_ 05:12:32 INFO - Initialising browser for kraken test... 05:12:32 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpJO5sD8/profile http://localhost:49243/getInfo.html) 05:12:35 INFO - PID 1648 | __metrics Screen width/height:1600/1200 05:12:35 INFO - PID 1648 | colorDepth:24 05:12:35 INFO - PID 1648 | Browser inner width/height: 1024/689 05:12:35 INFO - PID 1648 | __metrics 05:12:35 INFO - PID 1648 | 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:12:35 INFO - PID 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:36 INFO - TEST-INFO | 1648: exit 0 05:12:36 INFO - Browser initialized. 05:12:36 INFO - Running cycle 1/1 for kraken test... 05:12:36 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpJO5sD8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:48 INFO - PID 1649 | RSS: Main: 241795072 05:12:48 INFO - PID 1649 | 05:12:51 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:52 INFO - PID 1649 | RSS: Main: 312778752 05:12:52 INFO - PID 1649 | 05:12:54 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 05:12:55 INFO - PID 1649 | RSS: Main: 294436864 05:12:55 INFO - PID 1649 | 05:12:58 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 05:12:59 INFO - PID 1649 | RSS: Main: 386265088 05:12:59 INFO - PID 1649 | 05:13:01 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 05:13:01 INFO - PID 1649 | RSS: Main: 291135488 05:13:01 INFO - PID 1649 | 05:13:03 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:04 INFO - PID 1649 | RSS: Main: 293761024 05:13:04 INFO - PID 1649 | 05:13:07 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:07 INFO - PID 1649 | RSS: Main: 356728832 05:13:07 INFO - PID 1649 | 05:13:10 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:11 INFO - PID 1649 | RSS: Main: 376930304 05:13:11 INFO - PID 1649 | 05:13:14 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 05:13:14 INFO - PID 1649 | RSS: Main: 385818624 05:13:14 INFO - PID 1649 | 05:13:16 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:16 INFO - PID 1649 | RSS: Main: 333918208 05:13:16 INFO - PID 1649 | 05:13:18 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:19 INFO - PID 1649 | RSS: Main: 332632064 05:13:19 INFO - PID 1649 | 05:13:21 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:22 INFO - PID 1649 | RSS: Main: 335704064 05:13:22 INFO - PID 1649 | 05:13:25 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:25 INFO - PID 1649 | RSS: Main: 353259520 05:13:25 INFO - PID 1649 | 05:13:29 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:29 INFO - PID 1649 | RSS: Main: 346021888 05:13:29 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 05:13:31 INFO - PID 1649 | RSS: Main: 389595136 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | __start_tp_report 05:13:31 INFO - PID 1649 | _x_x_mozilla_page_load 05:13:31 INFO - PID 1649 | _x_x_mozilla_page_load_details 05:13:31 INFO - PID 1649 | |i|pagename|runs| 05:13:31 INFO - PID 1649 | |0;ai-astar;110;110;109;110;110;109;109;111;110;111 05:13:31 INFO - PID 1649 | |1;audio-beat-detection;142;109;109;151;109;108;109;112;147;133 05:13:31 INFO - PID 1649 | |2;audio-dft;185;185;186;186;184;183;186;187;186;182 05:13:31 INFO - PID 1649 | |3;audio-fft;81;59;58;88;59;63;65;83;97;89 05:13:31 INFO - PID 1649 | |4;audio-oscillator;92;70;86;70;68;68;88;68;69;89 05:13:31 INFO - PID 1649 | |5;imaging-gaussian-blur;89;89;89;88;89;88;89;88;89;88 05:13:31 INFO - PID 1649 | |6;imaging-darkroom;95;97;96;96;96;96;96;96;96;97 05:13:31 INFO - PID 1649 | |7;imaging-desaturate;84;87;83;84;86;80;79;86;84;84 05:13:31 INFO - PID 1649 | |8;json-parse-financial;51;49;49;48;48;50;49;49;50;49 05:13:31 INFO - PID 1649 | |9;json-stringify-tinderbox;54;54;61;65;66;62;57;57;56;56 05:13:31 INFO - PID 1649 | |10;stanford-crypto-aes;82;85;95;105;107;82;83;80;82;84 05:13:31 INFO - PID 1649 | |11;stanford-crypto-ccm;145;126;149;129;143;149;145;161;201;147 05:13:31 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;184;193;184;195;216;230;230;179;180;181 05:13:31 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;68;68;66;67;69;68;67;68;65;67 05:13:31 INFO - PID 1649 | __end_tp_report 05:13:31 INFO - PID 1649 | __start_cc_report 05:13:31 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2196 05:13:31 INFO - PID 1649 | __end_cc_report 05:13:31 INFO - PID 1649 | __startTimestamp1493036011797__endTimestamp 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | ------- Summary: start ------- 05:13:31 INFO - PID 1649 | Number of tests: 14 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 05:13:31 INFO - PID 1649 | Values: 110.0 110.0 109.0 110.0 110.0 109.0 109.0 111.0 110.0 111.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:122.50 stddev:18.11 (14.8%) stddev-sans-first:17.84 05:13:31 INFO - PID 1649 | Values: 142.0 109.0 109.0 151.0 109.0 108.0 109.0 112.0 147.0 133.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:1.56 (0.8%) stddev-sans-first:1.66 05:13:31 INFO - PID 1649 | Values: 185.0 185.0 186.0 186.0 184.0 183.0 186.0 187.0 186.0 182.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:74.20 Median:82.00 stddev:14.86 (18.1%) stddev-sans-first:15.56 05:13:31 INFO - PID 1649 | Values: 81.0 59.0 58.0 88.0 59.0 63.0 65.0 83.0 97.0 89.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.00 stddev:10.41 (13.3%) stddev-sans-first:9.48 05:13:31 INFO - PID 1649 | Values: 92.0 70.0 86.0 70.0 68.0 68.0 88.0 68.0 69.0 89.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 05:13:31 INFO - PID 1649 | Values: 89.0 89.0 89.0 88.0 89.0 88.0 89.0 88.0 89.0 88.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 05:13:31 INFO - PID 1649 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:84.00 stddev:2.54 (3.0%) stddev-sans-first:2.69 05:13:31 INFO - PID 1649 | Values: 84.0 87.0 83.0 84.0 86.0 80.0 79.0 86.0 84.0 84.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.92 (1.9%) stddev-sans-first:0.71 05:13:31 INFO - PID 1649 | Values: 51.0 49.0 49.0 48.0 48.0 50.0 49.0 49.0 50.0 49.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:4.39 (7.4%) stddev-sans-first:4.30 05:13:31 INFO - PID 1649 | Values: 54.0 54.0 61.0 65.0 66.0 62.0 57.0 57.0 56.0 56.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:82.50 stddev:10.10 (12.2%) stddev-sans-first:10.44 05:13:31 INFO - PID 1649 | Values: 82.0 85.0 95.0 105.0 107.0 82.0 83.0 80.0 82.0 84.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:148.00 stddev:20.67 (14.0%) stddev-sans-first:21.86 05:13:31 INFO - PID 1649 | Values: 145.0 126.0 149.0 129.0 143.0 149.0 145.0 161.0 201.0 147.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.20 Median:194.00 stddev:20.45 (10.5%) stddev-sans-first:21.13 05:13:31 INFO - PID 1649 | Values: 184.0 193.0 184.0 195.0 216.0 230.0 230.0 179.0 180.0 181.0 05:13:31 INFO - PID 1649 | 05:13:31 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 05:13:31 INFO - PID 1649 | Values: 68.0 68.0 66.0 67.0 69.0 68.0 67.0 68.0 65.0 67.0 05:13:31 INFO - PID 1649 | -------- Summary: end -------- 05:13:31 INFO - PID 1649 | 05:13:32 INFO - TEST-INFO | 1649: exit 0 05:13:32 INFO - TEST-OK | kraken | took 60119ms 05:13:32 INFO - SUITE-END | took 1179s 05:13:32 INFO - Completed test suite (00:19:39) 05:13:32 INFO - javascript benchmark 05:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7649.915361474075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.249216449805, 3491.3017396520686, 3508.35095507331, 3547.148684315764, 3590.85636574537, 5921.85195370116, 6111.083337499377, 6178.567500274982, 6189.938100618992, 6199.44205021548, 6012.158297838306, 6071.757129714806, 6072.058830881209, 6079.756809727605, 6107.083937409391, 5206.0, 5214.947850521503, 5239.633225674204, 5259.737013149346, 5343.038253114438, 5303.337082864642, 5323.095073837457, 5334.813281535147, 5339.22581225722, 5346.492083252104, 5335.226392173133, 5335.893282134355, 5340.118880384732, 5341.011912796126, 5346.0, 5315.3621565412395, 5324.92012619811, 5328.094223981932, 5329.333833270841, 5333.973330133344, 5202.0896343140175, 5293.179557168645, 5307.363116426053, 5334.439883812182, 5342.465753424665, 6166.691665416756, 6208.782692605737, 6209.565330426872, 6217.782377616807, 6227.626342419469, 6246.281677607088, 6459.870802583969, 6478.54650174488, 6507.414332710032, 6543.967280163616, 6453.386928241809, 6466.191726034246, 6594.505412094064, 6668.466522678174, 6680.599164050124, 6230.657313847737, 6231.6572588507615, 6235.688215589203, 6240.53196010292, 6259.248890133168, 6743.089682892844, 6750.1562304711915, 6764.898526522008, 6767.120274364301, 6798.252192258848, 6254.874902501924, 6329.430351268408, 6329.461995730322, 6377.7448902044325, 6403.4877209824035, 5412.377576578665, 6447.0, 6514.022896565553, 6540.50946179029, 6558.278589355167, 6349.841253968688, 6364.109024736541, 6415.101885735908, 6424.614523128534, 6427.421532062137, 6286.4342209201395, 6412.967935160387, 6417.326180750954, 6417.679116044179, 6448.580842245239, 5158.380994280636, 5186.325777648957, 5210.557102646242, 5249.868753281122, 5273.6572122811895, 4650.534946505322, 4667.8599642010795, 4679.344891715163, 4688.765561721901, 4712.740799256006, 6128.3258841527395, 6177.011678131477, 6187.566870319124, 6206.441420272107, 6210.254769427697, 6320.399562041599, 6406.839829004219, 6411.326810684905, 6542.607443553402, 6614.0, 6151.0, 6162.476189523851, 6191.349908259568, 6191.783287584913, 6193.876122477525, 5738.684372359477, 5742.109972954198, 5756.280464941882, 5763.423657634287, 5801.419858014165, 6446.742130314735, 6534.705938232696, 6642.268528891761, 6771.0, 6781.050652908498, 6347.301796802441, 6482.2869484357625, 6620.735170593315, 6624.105745724266, 6640.402363787282, 6719.865602688016, 6734.158230221223, 6769.458443324621, 6771.052052712723, 6780.898286525805, 6357.110004599453, 6476.643784591893, 6483.481321494175, 6495.188101487314, 6496.1230233919705, 5450.836474905759, 6291.874162516632, 6361.777337793155, 6363.61818290904, 6546.247181573989, 5941.851453713692, 5992.101184822312, 6296.496280297473, 6317.052442133717, 6323.177986861679, 6201.131841542097, 6227.968860155852, 6305.4009869062365, 6305.959516679696, 6392.680365981775, 5651.519620832275, 5914.319853216935, 6241.687915604292, 6276.184096067482, 6302.0, 6277.309495955533, 6303.401176888188, 6309.90535141964, 6313.842153946188, 6320.494360451061, 5788.594798364243, 6144.972159187547, 6219.906701399392, 6232.8130156095385, 6263.311035785969], "value": 5949.035671087499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.3440428380187, 725.7967769024672, 774.8915151878737, 1102.2394547762049, 1116.9664910052702, 26380.0, 35709.2858142837, 36237.0, 36258.368373423225, 36452.0, 37986.810065949634, 38240.043998900044, 38339.424908626395, 38379.232415351675, 38389.0, 8303.875441868391, 8453.830923381529, 8454.830903381928, 8455.0, 8458.830823383529, 5995.820125396245, 6125.356837532062, 6125.632462052269, 6128.356522565134, 6133.1413602095745, 8293.33653307734, 8482.448640838356, 8492.872606910902, 8500.022497412783, 8502.362322825782, 8362.707305244317, 8457.66169353225, 8465.280451161658, 8466.195711407468, 8468.195521425454, 8234.794130146734, 8316.542590157538, 8321.625526851307, 8330.166983301622, 8331.95834020826, 36438.0, 36511.4523282151, 36531.63468365309, 36614.63385366139, 36740.0, 3570.892873213808, 3596.5684117906017, 3601.405768048269, 3602.4596310553366, 3613.8554457821656, 30017.099487015425, 30060.84969575138, 30082.0, 30121.397572048656, 30124.8493757532, 3102.937941241185, 3110.440120778259, 3146.4493713600027, 3155.7317628001647, 3159.952600710991, 207802.9609851941, 284730.0, 291009.5449522739, 292105.53947230126, 294053.05946940684, 47556.28665570019, 47573.0, 47575.0, 47581.52418475771, 47754.761226193645, 49784.751076244385, 49803.50196498061, 49805.50194498081, 49827.75086124546, 49843.25235121476, 13578.93210533941, 13677.31613419325, 13679.452821887213, 13682.04225704211, 13694.863051369359, 11147.442627868737, 11150.442477876073, 11153.776924461465, 11164.720881977853, 11197.66407007791, 8807.163319484638, 10646.0, 10704.625338113285, 12115.39423028845, 12456.564020259248, 4353.760543170156, 5129.487051294841, 5150.330457040561, 5185.377754669388, 5192.792288308426, 824.6371596497522, 877.2061284537504, 886.1404437695425, 963.8987906269881, 984.9510271560765, 19907.502312442306, 23497.882510587337, 23615.40961475977, 23953.0, 24082.0, 1068.1828401273033, 1100.471773548701, 1111.5887121765, 1119.5074167366333, 1125.6341688951125, 11957.581484647995, 12019.63941081769, 12047.277163370225, 12051.915327620556, 12054.0, 307712.0, 308807.45596272324, 309465.0, 309599.0, 310376.0, 50662.74668626707, 50714.74642626763, 50775.0, 50842.745786271575, 50956.49043509518, 1452.07793051411, 1494.1110039526463, 1505.0969418348902, 1509.8641122298827, 1518.1498360917922, 23138.07447702073, 23217.3034808956, 23297.0, 23346.416339591648, 23602.409939750956, 36789.81605091957, 36869.81565092158, 36875.63124368722, 36956.706515271835, 37181.0, 274735.0, 275119.0, 275761.0, 275937.0, 276495.0, 26788.464230715665, 32575.837120814245, 33011.0, 33189.50215746814, 33225.335493290484, 42793.358099627905, 42800.78599606982, 42844.0, 42874.0, 42918.35622465728, 24542.161000079595, 28572.85713571419, 29503.819847205872, 29887.850560747058, 30343.960271523814, 29600.96396626108, 29632.703672963857, 29859.0, 30030.0, 30127.246818829706, 36076.09809754777, 36084.81957590195, 36139.457908131924, 36150.8192459036, 36252.81873590615, 27354.316142096606, 28196.718032819408, 28762.712372876, 29146.417071658023, 30186.698133018388, 21545.0, 23360.0, 23480.0, 23845.761542385048, 24226.030958762156], "value": 16693.720305248047, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.11316142614135, 426.7981719966925, 437.48158432257765, 440.9184300904332, 458.00841178847816, 17642.294308227672, 19318.90340548297, 20774.376768696926, 22136.778632213674, 22285.108595656155, 22614.886925565348, 22626.88686556569, 22873.885630571865, 22951.59008304129, 23297.670232976692, 5948.613340132899, 6026.728797204125, 6096.420840020191, 6187.659678717669, 6229.781957631484, 3596.172880237547, 3657.3782456982376, 6070.484008859252, 6181.258249010102, 6181.505479561624, 3647.270545890819, 3682.668559829615, 3766.303233901723, 5856.677882716449, 6142.969285153568, 5908.438698323653, 6058.96970515149, 6142.293636231823, 6162.84592885177, 6165.242905771834, 5411.675299482004, 5412.4858138477175, 5417.431169727161, 5423.023855705971, 5433.320834895638, 20936.895315523478, 26063.73936260632, 27142.72857271422, 27468.725312746818, 27785.583216251773, 2230.2194232018824, 2271.6478945763433, 2273.1362082408746, 2278.0659929428853, 2279.327598358488, 16864.747028794576, 17823.93056416606, 18009.00950447725, 18034.90982545092, 18324.725129123075, 2092.1317653173915, 2110.767815540289, 2144.303101492021, 2145.4314606629255, 2167.826573874086, 164172.0, 164217.53673694903, 165457.0, 166302.0, 166860.828479289, 10270.845937310947, 11289.661310160709, 12344.876551234553, 12622.747545049047, 12658.873411265953, 16222.675546489005, 16344.427945021867, 16380.590485237726, 16424.01455912649, 16426.342946282253, 8448.986121665439, 8743.737687869374, 8796.560171991376, 8964.506952117696, 9025.187733104052, 7330.413566914634, 8340.165983401732, 8348.457350272334, 8361.958190209132, 8504.447210931394, 6245.812625621239, 7486.775396737998, 7622.961885190539, 7666.463347565728, 7683.615819209129, 1724.6981778188767, 1928.852332861945, 2071.2336435518955, 2149.398168512788, 2161.362398092535, 907.1654078248027, 917.9082091790901, 918.4810582021137, 954.1651055326589, 960.4429430930044, 20199.59600808005, 21016.474588135417, 21031.57936841285, 21033.474163146042, 21072.36782896485, 941.5762906692016, 976.8827740671165, 981.8281800684852, 987.6049580167991, 993.8062077894741, 10087.848682269772, 10674.519646615765, 10706.197035222389, 10822.08012318946, 10928.672139835817, 541638.7115481771, 545775.0, 546981.0, 565325.0, 566271.0, 118718.40640796741, 122589.38705306416, 124267.37866310791, 126883.0, 132034.33982830023, 1116.1684545014016, 1128.227164392394, 1138.2032577195996, 1143.4225716013527, 1202.7293858881856, 21363.14547418148, 21620.45948851291, 21670.24154154597, 21791.23730669419, 22062.558748824613, 54291.72854135862, 56817.0, 57593.42406576048, 58251.0, 58363.0, 76005.61997189978, 77192.61403692946, 79972.60013699894, 80136.0, 81900.59049704713, 7515.6993720250575, 8408.285295749929, 8805.471671699719, 8928.0, 9091.54542272897, 14053.508127215498, 14212.0, 14229.857701423267, 14658.120512769268, 14728.0, 11754.353510557, 11877.406129693309, 12005.099617528545, 12032.15774895784, 12085.456154473246, 9424.81150376975, 11398.601048963246, 11407.372594507382, 11556.711082223012, 11693.415329233674, 11875.465604048011, 12156.270623762603, 12184.817227741414, 12267.87732122703, 12448.128630996105, 8721.738347849574, 8764.780880477783, 8789.736307910773, 9059.682911098344, 9144.0, 11712.590059347882, 11802.881971180179, 12026.0, 12132.575359862363, 12138.75722485563], "value": 10248.057030182632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.9502819887205, 1337.4449603414585, 1462.6635873749037, 1467.4350375105594, 1476.23235917323, 11217.943910280448, 11713.531458741661, 11732.882671173285, 11738.823917641243, 11760.7647847043, 11313.0, 11666.066714662828, 11693.239939403933, 11736.7652646947, 11760.353180575064, 2517.3958250019955, 2562.0, 2564.781993530552, 2567.152839562949, 2567.3838278813137, 2060.7527096748336, 2141.8714877107345, 2459.18846780562, 2537.0486067724605, 2543.338731929702, 2166.6100101981638, 2474.9010039598393, 2561.474897645978, 2564.397366618843, 2567.82025258232, 2476.3932836455006, 2504.136073054793, 2514.094925826719, 2517.332906779705, 2519.508695804319, 2480.516299321633, 2497.7377375375504, 2499.3501689560844, 2504.2236906559024, 2506.323292710976, 11586.536538538448, 11842.703932401759, 11844.407779610985, 11864.644060678194, 11870.406479676069, 5408.756605952742, 6807.3873351398615, 6819.931800682029, 6822.215445223764, 6829.658517074126, 4117.419393253751, 4263.59495847894, 4291.935620965688, 4366.235908715994, 4413.337999300099, 1244.2907542700664, 1249.1006475337742, 1297.2735268249717, 1301.6225294664537, 1301.9804702929464, 16614.169291535374, 16720.916395417946, 16727.247273872705, 16751.07869067201, 16763.329466821313, 5463.9180412293845, 5476.479734425223, 5568.498835104779, 5666.291713535808, 5795.8551036224435, 10958.342499450058, 12333.876661233453, 12349.19730217533, 12361.567345142877, 12364.319962402154, 6644.534882558174, 6649.800505984828, 6650.168728908887, 6650.800475985729, 6651.66741662915, 5999.100134979788, 6127.448529632355, 6134.8159555213415, 6255.718492667841, 6260.311365749764, 3934.940975885364, 3983.2830090583975, 4300.61294483498, 4323.399003747148, 4387.912241755147, 1111.3054341036852, 1165.6386520178771, 1264.2351377416715, 1283.8459384873875, 1302.5831733845268, 675.6689222281046, 740.8407192453649, 780.1418439716267, 782.2451334462271, 831.0650518167062, 4441.533638967927, 5139.612304677791, 6313.116163737081, 7124.536905101152, 7135.7365021133355, 921.8202450522084, 932.7528205025674, 943.495230051919, 961.1157734883924, 965.8937516873139, 4200.6219440250525, 4599.701019433726, 4602.171609110393, 4688.578027977498, 4769.833055843029, 14474.565763027125, 14551.563453096423, 15025.94818362704, 15091.924540377227, 15300.540983770505, 14619.853801462063, 14792.408303667948, 14964.251787410803, 14987.850121498646, 15187.924060379628, 8500.957495212608, 8553.444026138406, 8737.257333126629, 8741.076963068115, 8746.431481953652, 6869.073786475097, 7047.894281585678, 7071.639125945688, 7095.410175286087, 7118.679659415235, 11361.772764544497, 13023.413946372246, 13434.193948363129, 13763.38064787067, 13775.242361670204, 13481.662958426117, 14070.507532236732, 14095.224762638154, 14117.0, 14127.858721412655, 8571.957140214508, 9074.911010678761, 9163.725088247096, 9558.904410955802, 9623.037696230322, 10540.683779486628, 10678.73303167427, 10747.516361763583, 10759.246852720235, 10772.515236814206, 9108.863367049367, 9121.543922803701, 9175.678851240174, 9207.493587852465, 9222.44665320083, 8888.688895888612, 8912.242459391024, 8925.196732294125, 8982.461052336881, 9130.543472826464, 8100.270975612223, 8267.421280510547, 8271.17288271168, 8273.46222495536, 8327.625256863335, 5767.826965191051, 5913.58604897653, 5937.435943585352, 6144.969275153596, 6204.472619827185, 5446.455354464521, 5987.281526216708, 6000.729967151401, 6076.33160352352, 6326.177596912372], "value": 5382.536342747457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6103079636142, 387.82160206305105, 400.46537871940956, 400.8757285241577, 403.4029636138513, 5525.955396503299, 5720.170575266584, 5722.771089156434, 5777.277840269966, 5784.537237021039, 4927.679700819444, 5198.584113270938, 5544.944550554494, 5547.805826796063, 5567.860803479915, 3204.0, 3643.526341575605, 4231.090315582157, 4250.48994120706, 4357.368181613664, 4345.521992580813, 4357.908204062052, 4366.039471316305, 4385.232584297751, 4395.527498288077, 4376.7260451156435, 4395.033092719596, 4401.7235001849585, 4418.7127836690515, 4437.312216606431, 4180.5610410906875, 4299.570042995707, 4304.375865499516, 4351.891202719958, 4403.559644035603, 3552.520409744677, 3581.3732596795458, 3922.4704664870164, 3937.8818635440985, 3940.349842276021, 5502.174673798922, 5524.723763811793, 5532.640378375393, 5548.112302031696, 5552.194931734916, 5121.617163365908, 5216.0, 5240.432188227741, 5289.910485358262, 5311.760970756325, 5323.148296272617, 5494.780208791643, 6014.969970119986, 6097.390260973912, 6124.142620033199, 4484.349769283468, 4487.753173575485, 4496.628528298867, 4501.6687651138245, 4510.548945105496, 5037.496250374933, 6004.568149899254, 6048.637081775064, 6065.939340606582, 6281.183446152017, 3708.8145592720257, 4255.0, 4269.423627810268, 4284.785760711952, 4317.84887528935, 4557.931631025537, 4671.6262698984, 4675.672702910763, 4676.228422310349, 4703.63689961679, 4961.305417241589, 5071.54356107952, 5100.8778068824795, 5190.2214667800135, 5259.868503287448, 5560.388357280696, 6069.393060693896, 6077.908831367533, 6120.1737765401995, 6413.967930160319, 1309.508934149694, 1443.826740791112, 1530.043722673329, 1590.705719441907, 1595.6010997250687, 1021.3259248895694, 1066.99466502667, 1104.9337039777638, 1135.7785231879704, 1140.224647239885, 5003.524665156877, 5504.165584480464, 5505.339359276913, 5524.1989911462615, 5535.667859928417, 5331.3868905076415, 6101.078160379467, 6123.908141377883, 6137.60105593135, 6141.477974372139, 5261.737183076034, 5504.779808807602, 5540.473655002768, 5623.409541998113, 5637.661740295595, 3034.4386288536693, 3189.2824114574037, 3208.6470488246273, 3210.7431405487973, 3214.0, 5994.8253299102, 6235.875282494325, 6347.746090156435, 6360.300366959631, 6368.012957991426, 6007.88854062, 6130.877382452326, 6278.372162783777, 6296.716647750863, 6303.495720342362, 5228.215767634885, 6053.364396738279, 6062.848058868889, 6323.336049714806, 6338.809835704937, 5933.495652869555, 6262.964536525738, 6278.937210627835, 6296.937030629819, 6310.305866354789, 5908.231929849092, 6083.1483592298, 6209.937900621117, 6213.099100630474, 6222.875542489215, 6059.484943779828, 6183.4541364658835, 6368.917284061628, 6393.8721225576155, 6433.131527243762, 3508.9824550877083, 4191.0, 4210.179015092028, 4216.8313267470185, 4218.6835987300465, 5994.940050599613, 6174.969125154345, 6265.216847894013, 6270.49836013127, 6291.182146320949, 5399.757010934439, 5636.887262254814, 6030.758769649165, 6030.819075427744, 6044.697765111639, 4212.536620971752, 5193.454687257935, 5749.8275051748515, 5990.9700451497465, 6041.909371359346, 4839.274108883555, 5882.352941176553, 5898.793542226002, 5906.940930590639, 5932.2584676915385, 5189.6886186828915, 6036.8188954331445, 6056.818295451144, 6062.575619706578, 6078.024641991459, 4723.409573803275, 5460.235567020541, 5645.322561292671, 5867.149263356704, 5911.261092363455], "value": 4490.7635081681065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.2172088981226, 858.3733874271782, 859.901111372192, 861.470195829565, 866.0516734176075, 12826.615201543957, 17816.50568920352, 17970.01164935928, 18497.98261095639, 18554.81445185546, 16315.59211019725, 16322.0, 16788.328466861312, 16836.494905152864, 17033.488995330128, 938.5823308627663, 954.3319676226669, 955.6941778630841, 956.0296299256261, 956.2588993530001, 650.531617235592, 667.199360767079, 917.1837065012145, 933.4446004627235, 935.303199116659, 950.7147855643314, 978.6232300564299, 979.4025644356972, 980.7842274699555, 1001.7896241789233, 869.952152631605, 977.3842479238106, 977.7799995001068, 979.3095867413457, 980.4950450517989, 724.0189543169035, 726.7964969808462, 727.396261103283, 730.4996077686801, 745.2100773180446, 15736.055836649837, 15762.133082680448, 15770.290336934866, 15914.283857226337, 16425.67148657032, 16250.349986000545, 16352.591185220346, 16610.169491525496, 16697.666046678998, 16925.661486770317, 13386.19682819034, 13576.389062492113, 13634.795478067837, 13810.65473363164, 13880.305984700724, 3440.4839274108836, 3467.8612855486003, 3469.3928562501715, 3470.3753324401596, 3476.9826150869085, 123498.38250808779, 124498.75501244962, 126011.0, 127003.0, 128972.3551382237, 11715.824262636068, 11772.352520611277, 11919.165658404001, 11931.463084161234, 12074.818877716842, 19683.409497715093, 19883.204671812964, 20044.59910801776, 20045.799542004686, 20056.89687067196, 7301.963490182515, 7333.936579195986, 7372.115346158388, 7372.48392612512, 7376.7049318026675, 3833.7316387852584, 3850.6534411902503, 3855.614438556122, 3901.2197560488016, 3912.6478616924614, 4193.287141186006, 4266.765327906933, 4276.957230427718, 4277.871663850089, 4282.550332215073, 825.6573521988307, 836.8493671139132, 837.2548431895618, 837.2632083766247, 913.1690161952724, 636.7994081864198, 657.8881590129594, 665.6505334699225, 691.1050190003856, 695.2456584605759, 10800.297980631234, 11752.530933633296, 11819.133556009805, 11825.822612660817, 12171.513139474322, 616.6916541729136, 644.2816259870305, 656.5502630697891, 663.5222639699409, 678.7217240931293, 5498.395176530578, 5572.219889215513, 5594.552435805207, 5624.072028115315, 5687.943120568824, 101668.96662066717, 105222.0, 105622.94377056131, 105813.0, 108412.0, 81294.0, 83388.58305708432, 95139.52430237943, 95941.52029239948, 99213.03147874148, 51286.0, 72448.82653520403, 72678.0, 73885.89171162437, 74342.02631894664, 12195.817062743889, 12221.022318214344, 12625.242485450903, 12647.367631618567, 12711.682207944876, 32905.341893162484, 40129.0, 40136.996575085854, 41039.589604103574, 41303.58696413117, 52328.47671523388, 63680.68159659172, 66346.33653663595, 67551.0, 68302.65848670725, 16366.09986450709, 16449.753253700965, 16537.751933721243, 16782.66434671324, 16819.747703784207, 18265.817341826412, 18315.725264121316, 18711.438656840317, 18759.0, 18781.530461738566, 16449.177541122655, 16615.750763738313, 16898.324067037673, 17027.91486042562, 17482.73775893337, 16587.419440319532, 16591.087490188154, 16707.24817383245, 16746.246418910934, 16903.577410564834, 16236.51290461288, 16415.671686566442, 16436.67126657436, 16449.753253701445, 16584.336626534805, 11256.943715281372, 11346.886531134583, 11746.85868838387, 11963.880361196276, 12012.579559715368, 11708.648740537797, 12684.809727854274, 13100.0, 13811.309434528433, 13822.308884555932], "value": 8146.290976297064, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 109.0, 151.0, 109.0, 108.0, 109.0, 112.0, 147.0, 133.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 186.0, 186.0, 184.0, 183.0, 186.0, 187.0, 186.0, 182.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 59.0, 63.0, 65.0, 83.0, 97.0, 89.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 70.0, 68.0, 68.0, 88.0, 68.0, 69.0, 89.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 88.0, 89.0, 88.0, 89.0, 88.0, 89.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 83.0, 84.0, 86.0, 80.0, 79.0, 86.0, 84.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 48.0, 48.0, 50.0, 49.0, 49.0, 50.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 61.0, 65.0, 66.0, 62.0, 57.0, 57.0, 56.0, 56.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 95.0, 105.0, 107.0, 82.0, 83.0, 80.0, 82.0, 84.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 149.0, 129.0, 143.0, 149.0, 145.0, 161.0, 201.0, 147.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 193.0, 184.0, 195.0, 216.0, 230.0, 230.0, 179.0, 180.0, 181.0], "value": 197.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 69.0, 68.0, 67.0, 68.0, 65.0, 67.0], "value": 67.3, "unit": "score"}]}]} 05:13:33 INFO - Return code: 0 05:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:33 ERROR - # TBPL SUCCESS # 05:13:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:33 INFO - 2017-04-24 05:13:33.116 screenresolution[1653:9835] starting screenresolution argv=screenresolution get 05:13:33 INFO - 2017-04-24 05:13:33.118 screenresolution[1653:9835] Display 0: 1600x1200x32@60 05:13:33 INFO - 2017-04-24 05:13:33.124 screenresolution[1654:9838] starting screenresolution argv=screenresolution list 05:13:33 INFO - Available Modes on Display 0 05:13:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:33 INFO - Intel Iris: 05:13:33 INFO - Chipset Model: Intel Iris 05:13:33 INFO - Type: GPU 05:13:33 INFO - Bus: Built-In 05:13:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:33 INFO - Vendor: Intel (0x8086) 05:13:33 INFO - Device ID: 0x0a2e 05:13:33 INFO - Revision ID: 0x0009 05:13:33 INFO - Displays: 05:13:33 INFO - Display: 05:13:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:33 INFO - Display Serial Number: 1600x1200 60 05:13:33 INFO - Main Display: Yes 05:13:33 INFO - Mirror: Off 05:13:33 INFO - Online: Yes 05:13:33 INFO - Rotation: Supported 05:13:33 INFO - Return code: 0 05:13:33 INFO - Running post-action listener: _resource_record_post_action 05:13:33 INFO - [mozharness: 2017-04-24 12:13:33.373517Z] Finished run-tests step (success) 05:13:33 INFO - Running post-run listener: _resource_record_post_run 05:13:33 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 37643264; Write bytes: 504358400; Read time: 370; Write time: 1629 05:13:33 INFO - TinderboxPrint: CPU usage
53.3% 05:13:33 INFO - TinderboxPrint: I/O read bytes / time
37,643,264 / 370 05:13:33 INFO - TinderboxPrint: I/O write bytes / time
504,358,400 / 1,629 05:13:33 INFO - TinderboxPrint: CPU idle
2,242.6 (46.7%) 05:13:33 INFO - TinderboxPrint: CPU system
956.9 (19.9%) 05:13:33 INFO - TinderboxPrint: CPU user
1,602.1 (33.4%) 05:13:33 INFO - TinderboxPrint: Swap in / out
245,514,240 / 0 05:13:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205539840; Write bytes: 203141120; Read time: 15986; Write time: 397 05:13:33 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 35550208; Write bytes: 294168064; Read time: 347; Write time: 1203 05:13:33 INFO - Running post-run listener: _upload_blobber_files 05:13:33 INFO - Blob upload gear active. 05:13:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:33 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:13:33 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:13:33 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:13:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:34 INFO - (blobuploader) - INFO - Done attempting. 05:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:35 INFO - (blobuploader) - INFO - Done attempting. 05:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:36 INFO - (blobuploader) - INFO - Done attempting. 05:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:38 INFO - (blobuploader) - INFO - Done attempting. 05:13:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:38 INFO - Return code: 0 05:13:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72ed828f996f7cb9d684531b257db590b52a85ff54b5d582d6e85f8b5b6623adf4dd19fbeb8ecf03479b0ab98bb9dd739d24b4432252c7ce7ef251c733f5d977", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2248bfb9c6afee9232b497cd35c955f9b2c8b815243e46130458c9df4411888ec46512702cd374944a898a4ed6e234c3c6da1052b9fec1e8f30e172209c2acb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ce07538ed833168710e845bbb183eb34fa04e9a5826196398259b3c5f229adf049f67462e32a8845a6d8498bb09cc54ae32db298b24b4ef595c7c28a45a1f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0812d58aec7882ab43e7ecccd8d23e2f4d1c1114ec61345db6c16b4737d713d972da9810f92446f048151f338e4858343c40bedd4d0be7c2195a51f7e41ade4c"} 05:13:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:38 INFO - Contents: 05:13:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72ed828f996f7cb9d684531b257db590b52a85ff54b5d582d6e85f8b5b6623adf4dd19fbeb8ecf03479b0ab98bb9dd739d24b4432252c7ce7ef251c733f5d977", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2248bfb9c6afee9232b497cd35c955f9b2c8b815243e46130458c9df4411888ec46512702cd374944a898a4ed6e234c3c6da1052b9fec1e8f30e172209c2acb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ce07538ed833168710e845bbb183eb34fa04e9a5826196398259b3c5f229adf049f67462e32a8845a6d8498bb09cc54ae32db298b24b4ef595c7c28a45a1f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0812d58aec7882ab43e7ecccd8d23e2f4d1c1114ec61345db6c16b4737d713d972da9810f92446f048151f338e4858343c40bedd4d0be7c2195a51f7e41ade4c"} 05:13:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:38 INFO - Copying logs to upload dir... 05:13:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.327191 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-04-24 05:13:39.050128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:39.053539) ========= 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.G7UclQw6gN/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.mhhaXkD99u/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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/72ed828f996f7cb9d684531b257db590b52a85ff54b5d582d6e85f8b5b6623adf4dd19fbeb8ecf03479b0ab98bb9dd739d24b4432252c7ce7ef251c733f5d977", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2248bfb9c6afee9232b497cd35c955f9b2c8b815243e46130458c9df4411888ec46512702cd374944a898a4ed6e234c3c6da1052b9fec1e8f30e172209c2acb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ce07538ed833168710e845bbb183eb34fa04e9a5826196398259b3c5f229adf049f67462e32a8845a6d8498bb09cc54ae32db298b24b4ef595c7c28a45a1f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0812d58aec7882ab43e7ecccd8d23e2f4d1c1114ec61345db6c16b4737d713d972da9810f92446f048151f338e4858343c40bedd4d0be7c2195a51f7e41ade4c"} build_url:https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011081 build_url: 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/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/72ed828f996f7cb9d684531b257db590b52a85ff54b5d582d6e85f8b5b6623adf4dd19fbeb8ecf03479b0ab98bb9dd739d24b4432252c7ce7ef251c733f5d977", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2248bfb9c6afee9232b497cd35c955f9b2c8b815243e46130458c9df4411888ec46512702cd374944a898a4ed6e234c3c6da1052b9fec1e8f30e172209c2acb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ce07538ed833168710e845bbb183eb34fa04e9a5826196398259b3c5f229adf049f67462e32a8845a6d8498bb09cc54ae32db298b24b4ef595c7c28a45a1f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0812d58aec7882ab43e7ecccd8d23e2f4d1c1114ec61345db6c16b4737d713d972da9810f92446f048151f338e4858343c40bedd4d0be7c2195a51f7e41ade4c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:39.088597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:39.088902) ========= 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.G7UclQw6gN/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.mhhaXkD99u/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.005206 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:39.136671) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 05:13:39.136943) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 05:13:39.137239) ========= ========= Total master_lag: 0.18 =========