builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0303 starttime: 1491048163.42 results: success (0) buildid: 20170401040823 builduid: 76e86c87d9064fa9976f81d6328c6b37 revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:43.424256) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:43.424828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:43.425106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:43.848771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:43.849032) ========= 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.wkda09udCh/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.D6zjfqh5ck/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-01 05:02:43-- 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% 161M=0s 2017-04-01 05:02:44 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174756 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:44.046913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:44.047238) ========= 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.wkda09udCh/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.D6zjfqh5ck/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.020692 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:44.096368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 05:02:44.096717) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --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 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wkda09udCh/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.D6zjfqh5ck/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-01 05:02:44,198 truncating revision to first 12 chars 2017-04-01 05:02:44,198 Setting DEBUG logging. 2017-04-01 05:02:44,198 attempt 1/10 2017-04-01 05:02:44,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0d6ffde320ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 05:02:45,310 unpacking tar archive at: mozilla-central-0d6ffde320ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 05:02:45.512700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:45.513035) ========= script_repo_revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:45.513432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:45.513729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:45.536212) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-01 05:02:45.536488) ========= /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.wkda09udCh/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.D6zjfqh5ck/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:02:45 INFO - MultiFileLogger online at 20170401 05:02:45 in /builds/slave/test 05:02:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:02:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:45 INFO - {'append_to_log': False, 05:02:45 INFO - 'base_work_dir': '/builds/slave/test', 05:02:45 INFO - 'blob_upload_branch': 'Firefox', 05:02:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:45 INFO - 'branch': 'Firefox', 05:02:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:45 INFO - 'config_files': ('talos/mac_config.py',), 05:02:45 INFO - 'default_actions': ('clobber', 05:02:45 INFO - 'read-buildbot-config', 05:02:45 INFO - 'download-and-extract', 05:02:45 INFO - 'populate-webroot', 05:02:45 INFO - 'create-virtualenv', 05:02:45 INFO - 'install', 05:02:45 INFO - 'run-tests'), 05:02:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:45 INFO - 'download_minidump_stackwalk': True, 05:02:45 INFO - 'download_symbols': 'ondemand', 05:02:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:45 INFO - 'gecko_profile': False, 05:02:45 INFO - 'gecko_profile_interval': 0, 05:02:45 INFO - 'installer_path': 'installer.exe', 05:02:45 INFO - 'log_level': 'info', 05:02:45 INFO - 'log_name': 'talos', 05:02:45 INFO - 'log_to_console': True, 05:02:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:02:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:02:45 INFO - 'opt_config_files': (), 05:02:45 INFO - 'pip_index': False, 05:02:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:45 INFO - 'cmd': ('bash', 05:02:45 INFO - '-c', 05:02:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:45 INFO - 'enabled': True, 05:02:45 INFO - 'halt_on_failure': False, 05:02:45 INFO - 'name': 'check_screen_resolution'},), 05:02:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:45 INFO - 'cmd': ('bash', 05:02:45 INFO - '-c', 05:02:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:45 INFO - 'enabled': True, 05:02:45 INFO - 'halt_on_failure': False, 05:02:45 INFO - 'name': 'check_screen_resolution'},), 05:02:45 INFO - 'run_cmd_checks_enabled': True, 05:02:45 INFO - 'suite': 'dromaeojs', 05:02:45 INFO - 'system_bits': '32', 05:02:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:45 INFO - 'title': 't-yosemite-r7-0303', 05:02:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:45 INFO - 'use_talos_json': True, 05:02:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:45 INFO - 'work_dir': 'build'} 05:02:45 INFO - [mozharness: 2017-04-01 12:02:45.762820Z] Running clobber step. 05:02:45 INFO - Running pre-action listener: _resource_record_pre_action 05:02:45 INFO - Running main action method: clobber 05:02:45 INFO - rmtree: /builds/slave/test/build 05:02:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:47 INFO - Running post-action listener: _resource_record_post_action 05:02:47 INFO - [mozharness: 2017-04-01 12:02:47.778522Z] Finished clobber step (success) 05:02:47 INFO - [mozharness: 2017-04-01 12:02:47.778646Z] Running read-buildbot-config step. 05:02:47 INFO - Running pre-action listener: _resource_record_pre_action 05:02:47 INFO - Running main action method: read_buildbot_config 05:02:47 INFO - Using buildbot properties: 05:02:47 INFO - { 05:02:47 INFO - "project": "", 05:02:47 INFO - "product": "firefox", 05:02:47 INFO - "script_repo_revision": "production", 05:02:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:02:47 INFO - "repository": "", 05:02:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:02:47 INFO - "buildid": "20170401040823", 05:02:47 INFO - "stage_platform": "macosx64", 05:02:47 INFO - "basedir": "/builds/slave/test", 05:02:47 INFO - "nightly_build": "True", 05:02:47 INFO - "buildnumber": 90, 05:02:47 INFO - "slavename": "t-yosemite-r7-0303", 05:02:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:02:47 INFO - "platform": "yosemite_r7", 05:02:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:02:47 INFO - "branch": "mozilla-central", 05:02:47 INFO - "repo_path": "mozilla-central", 05:02:47 INFO - "revision": "0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c", 05:02:47 INFO - "pgo_build": "False", 05:02:47 INFO - "builduid": "76e86c87d9064fa9976f81d6328c6b37", 05:02:47 INFO - "slavebuilddir": "test" 05:02:47 INFO - } 05:02:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:02:47 INFO - Running post-action listener: _resource_record_post_action 05:02:47 INFO - [mozharness: 2017-04-01 12:02:47.781993Z] Finished read-buildbot-config step (success) 05:02:47 INFO - [mozharness: 2017-04-01 12:02:47.782114Z] Running download-and-extract step. 05:02:47 INFO - Running pre-action listener: _resource_record_pre_action 05:02:47 INFO - Running main action method: download_and_extract 05:02:47 INFO - mkdir: /builds/slave/test/build/tests 05:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:47 INFO - trying https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:02:47 INFO - Downloading https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:02:49 INFO - Downloaded 1325 bytes. 05:02:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:02:49 INFO - Using the following test package requirements: 05:02:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:02:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:02:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:02:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:02:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'jsshell-mac.zip'], 05:02:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:02:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:02:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:02:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:02:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:02:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:02:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:02:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:02:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:02:49 INFO - Fetch https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:02:50 INFO - Expected file size: 52515537 05:02:50 INFO - Obtained file size: 52515537 05:03:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:03:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:03:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:03:08 INFO - Expected file size: 52515537 05:03:08 INFO - Obtained file size: 52515537 05:03:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:03:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:03:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:03:24 INFO - Expected file size: 14404152 05:03:24 INFO - Obtained file size: 14404152 05:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:25 INFO - trying https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:03:25 INFO - Downloading https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:03:27 INFO - Downloaded 75579452 bytes. 05:03:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:03:27 INFO - mkdir: /builds/slave/test/properties 05:03:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:27 INFO - Contents: 05:03:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:03:28 INFO - Running post-action listener: _resource_record_post_action 05:03:28 INFO - Running post-action listener: set_extra_try_arguments 05:03:28 INFO - [mozharness: 2017-04-01 12:03:28.006098Z] Finished download-and-extract step (success) 05:03:28 INFO - [mozharness: 2017-04-01 12:03:28.006236Z] Running populate-webroot step. 05:03:28 INFO - Running pre-action listener: _resource_record_pre_action 05:03:28 INFO - Running main action method: populate_webroot 05:03:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:28 INFO - '--tppagecycles', 05:03:28 INFO - '7'], 05:03:28 INFO - 'tests': ['tsvgm']}}, 05:03:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['damp', 'tps']}, 05:03:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'tests': ['damp', 'tps']}, 05:03:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['dromaeo_dom']}, 05:03:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['basic_compositor_video']}, 05:03:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:03:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['a11yr', 05:03:28 INFO - 'ts_paint', 05:03:28 INFO - 'tpaint', 05:03:28 INFO - 'sessionrestore', 05:03:28 INFO - 'sessionrestore_no_auto_restore', 05:03:28 INFO - 'tabpaint']}, 05:03:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:28 INFO - 'ts_paint', 05:03:28 INFO - 'tpaint', 05:03:28 INFO - 'sessionrestore', 05:03:28 INFO - 'sessionrestore_no_auto_restore', 05:03:28 INFO - 'tabpaint']}, 05:03:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:28 INFO - 'ts_paint', 05:03:28 INFO - 'tpaint', 05:03:28 INFO - 'sessionrestore', 05:03:28 INFO - 'sessionrestore_no_auto_restore', 05:03:28 INFO - 'tabpaint']}, 05:03:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:28 INFO - 'ts_paint', 05:03:28 INFO - 'tpaint', 05:03:28 INFO - 'sessionrestore', 05:03:28 INFO - 'sessionrestore_no_auto_restore', 05:03:28 INFO - 'tabpaint']}, 05:03:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['a11yr', 05:03:28 INFO - 'ts_paint', 05:03:28 INFO - 'tpaint', 05:03:28 INFO - 'sessionrestore', 05:03:28 INFO - 'sessionrestore_no_auto_restore', 05:03:28 INFO - 'tabpaint']}, 05:03:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['a11yr', 05:03:28 INFO - 'ts_paint', 05:03:28 INFO - 'tpaint', 05:03:28 INFO - 'sessionrestore', 05:03:28 INFO - 'sessionrestore_no_auto_restore', 05:03:28 INFO - 'tabpaint']}, 05:03:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['tsvgx', 05:03:28 INFO - 'tsvgr_opacity', 05:03:28 INFO - 'tart', 05:03:28 INFO - 'tscrollx', 05:03:28 INFO - 'cart', 05:03:28 INFO - 'tsvg_static']}, 05:03:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:28 INFO - 'tsvgr_opacity', 05:03:28 INFO - 'tart', 05:03:28 INFO - 'tscrollx', 05:03:28 INFO - 'cart', 05:03:28 INFO - 'tsvg_static']}, 05:03:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'talos_options': ['--disable-e10s'], 05:03:28 INFO - 'tests': ['tp5o']}, 05:03:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:03:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'talos_options': ['--disable-e10s', 05:03:28 INFO - '--xperf_path', 05:03:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:28 INFO - 'tests': ['tp5n']}, 05:03:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:03:28 INFO - 'talos_options': ['--xperf_path', 05:03:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:28 INFO - 'tests': ['tp5n']}}, 05:03:28 INFO - 'talos.zip': {'path': '', 05:03:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:28 INFO - Running post-action listener: _resource_record_post_action 05:03:28 INFO - [mozharness: 2017-04-01 12:03:28.024682Z] Finished populate-webroot step (success) 05:03:28 INFO - [mozharness: 2017-04-01 12:03:28.024801Z] Running create-virtualenv step. 05:03:28 INFO - Running pre-action listener: _resource_record_pre_action 05:03:28 INFO - Running main action method: create_virtualenv 05:03:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:03:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:28 INFO - Using real prefix '/tools/python27' 05:03:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:31 INFO - Installing pip.................done. 05:03:31 INFO - Return code: 0 05:03:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:03:31 INFO - Reading from file tmpfile_stdout 05:03:31 INFO - Output received: 05:03:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:03:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:03:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:31 INFO - 'HOME': '/Users/cltbld', 05:03:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:31 INFO - 'LOGNAME': 'cltbld', 05:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:31 INFO - 'MOZ_NO_REMOTE': '1', 05:03:31 INFO - 'NO_EM_RESTART': '1', 05:03:31 INFO - 'PAGER': '/bin/cat', 05:03:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:31 INFO - 'PWD': '/builds/slave/test', 05:03:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:31 INFO - 'SHELL': '/bin/bash', 05:03:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:31 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:31 INFO - 'USER': 'cltbld', 05:03:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:31 INFO - 'XPC_FLAGS': '0x0', 05:03:31 INFO - 'XPC_SERVICE_NAME': '0', 05:03:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:03:32 INFO - Cleaning up... 05:03:32 INFO - Return code: 0 05:03:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:03:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:32 INFO - 'HOME': '/Users/cltbld', 05:03:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:32 INFO - 'LOGNAME': 'cltbld', 05:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:32 INFO - 'MOZ_NO_REMOTE': '1', 05:03:32 INFO - 'NO_EM_RESTART': '1', 05:03:32 INFO - 'PAGER': '/bin/cat', 05:03:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:32 INFO - 'PWD': '/builds/slave/test', 05:03:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:32 INFO - 'SHELL': '/bin/bash', 05:03:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:32 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:32 INFO - 'USER': 'cltbld', 05:03:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:32 INFO - 'XPC_FLAGS': '0x0', 05:03:32 INFO - 'XPC_SERVICE_NAME': '0', 05:03:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:32 INFO - Downloading/unpacking psutil>=3.1.1 05:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:36 INFO - Installing collected packages: psutil 05:03:36 INFO - Running setup.py install for psutil 05:03:36 INFO - building 'psutil._psutil_osx' extension 05:03:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:03:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:03:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:03:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:03:36 INFO - building 'psutil._psutil_posix' extension 05:03:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:03:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:03:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:03:37 INFO - ^ 05:03:37 INFO - 1 warning generated. 05:03:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:03:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:37 INFO - Successfully installed psutil 05:03:37 INFO - Cleaning up... 05:03:37 INFO - Return code: 0 05:03:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:37 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 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:03:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:37 INFO - 'HOME': '/Users/cltbld', 05:03:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:37 INFO - 'LOGNAME': 'cltbld', 05:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:37 INFO - 'MOZ_NO_REMOTE': '1', 05:03:37 INFO - 'NO_EM_RESTART': '1', 05:03:37 INFO - 'PAGER': '/bin/cat', 05:03:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:37 INFO - 'PWD': '/builds/slave/test', 05:03:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:37 INFO - 'SHELL': '/bin/bash', 05:03:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:37 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:37 INFO - 'USER': 'cltbld', 05:03:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:37 INFO - 'XPC_FLAGS': '0x0', 05:03:37 INFO - 'XPC_SERVICE_NAME': '0', 05:03:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:40 INFO - Installing collected packages: mozsystemmonitor 05:03:40 INFO - Running setup.py install for mozsystemmonitor 05:03:40 INFO - Successfully installed mozsystemmonitor 05:03:40 INFO - Cleaning up... 05:03:40 INFO - Return code: 0 05:03:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:40 INFO - 'HOME': '/Users/cltbld', 05:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:40 INFO - 'LOGNAME': 'cltbld', 05:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:40 INFO - 'MOZ_NO_REMOTE': '1', 05:03:40 INFO - 'NO_EM_RESTART': '1', 05:03:40 INFO - 'PAGER': '/bin/cat', 05:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:40 INFO - 'PWD': '/builds/slave/test', 05:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:40 INFO - 'SHELL': '/bin/bash', 05:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:40 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:40 INFO - 'USER': 'cltbld', 05:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:40 INFO - 'XPC_FLAGS': '0x0', 05:03:40 INFO - 'XPC_SERVICE_NAME': '0', 05:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:44 INFO - warning: no files found matching '*.txt' 05:03:44 INFO - no previously-included directories found matching 'build' 05:03:44 INFO - no previously-included directories found matching 'dist' 05:03:44 INFO - no previously-included directories found matching '.git*' 05:03:44 INFO - Installing collected packages: jsonschema, functools32 05:03:44 INFO - Running setup.py install for functools32 05:03:44 INFO - warning: no files found matching '*.txt' 05:03:44 INFO - no previously-included directories found matching 'build' 05:03:44 INFO - no previously-included directories found matching 'dist' 05:03:44 INFO - no previously-included directories found matching '.git*' 05:03:44 INFO - Successfully installed jsonschema functools32 05:03:44 INFO - Cleaning up... 05:03:44 INFO - Return code: 0 05:03:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:44 INFO - 'HOME': '/Users/cltbld', 05:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:44 INFO - 'LOGNAME': 'cltbld', 05:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:44 INFO - 'MOZ_NO_REMOTE': '1', 05:03:44 INFO - 'NO_EM_RESTART': '1', 05:03:44 INFO - 'PAGER': '/bin/cat', 05:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:44 INFO - 'PWD': '/builds/slave/test', 05:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:44 INFO - 'SHELL': '/bin/bash', 05:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:44 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:44 INFO - 'USER': 'cltbld', 05:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:44 INFO - 'XPC_FLAGS': '0x0', 05:03:44 INFO - 'XPC_SERVICE_NAME': '0', 05:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:03:44 INFO - Cleaning up... 05:03:44 INFO - Return code: 0 05:03:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:44 INFO - 'HOME': '/Users/cltbld', 05:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:44 INFO - 'LOGNAME': 'cltbld', 05:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:44 INFO - 'MOZ_NO_REMOTE': '1', 05:03:44 INFO - 'NO_EM_RESTART': '1', 05:03:44 INFO - 'PAGER': '/bin/cat', 05:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:44 INFO - 'PWD': '/builds/slave/test', 05:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:44 INFO - 'SHELL': '/bin/bash', 05:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:44 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:44 INFO - 'USER': 'cltbld', 05:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:44 INFO - 'XPC_FLAGS': '0x0', 05:03:44 INFO - 'XPC_SERVICE_NAME': '0', 05:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - Downloading docopt-0.6.1.tar.gz 05:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:48 INFO - Running setup.py install for blobuploader 05:03:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:48 INFO - Running setup.py install for requests 05:03:49 INFO - Running setup.py install for docopt 05:03:49 INFO - Successfully installed blobuploader requests docopt 05:03:49 INFO - Cleaning up... 05:03:49 INFO - Return code: 0 05:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 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 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:49 INFO - 'HOME': '/Users/cltbld', 05:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:49 INFO - 'LOGNAME': 'cltbld', 05:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:49 INFO - 'MOZ_NO_REMOTE': '1', 05:03:49 INFO - 'NO_EM_RESTART': '1', 05:03:49 INFO - 'PAGER': '/bin/cat', 05:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:49 INFO - 'PWD': '/builds/slave/test', 05:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:49 INFO - 'SHELL': '/bin/bash', 05:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:49 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:49 INFO - 'USER': 'cltbld', 05:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:49 INFO - 'XPC_FLAGS': '0x0', 05:03:49 INFO - 'XPC_SERVICE_NAME': '0', 05:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:49 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-PopEDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-H4C4oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-pLldeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-my8ND0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-wRWTvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NwSrTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ik7uZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-TjMBGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-6SRMJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NVldMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:50 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-HMPZl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-alTpsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-I05TfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-iIw1bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-nxOXUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-dqx2IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:51 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-WHBWvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:51 INFO - Running setup.py install for manifestparser 05:03:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozcrash 05:03:51 INFO - Running setup.py install for mozdebug 05:03:52 INFO - Running setup.py install for mozdevice 05:03:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozfile 05:03:52 INFO - Running setup.py install for mozhttpd 05:03:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozinfo 05:03:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozInstall 05:03:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozleak 05:03:52 INFO - Running setup.py install for mozlog 05:03:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Running setup.py install for moznetwork 05:03:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Running setup.py install for mozprocess 05:03:53 INFO - Running setup.py install for mozprofile 05:03:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Running setup.py install for mozrunner 05:03:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Running setup.py install for mozscreenshot 05:03:53 INFO - Running setup.py install for moztest 05:03:54 INFO - Running setup.py install for mozversion 05:03:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:54 INFO - Cleaning up... 05:03:54 INFO - Return code: 0 05:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:54 INFO - 'HOME': '/Users/cltbld', 05:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:54 INFO - 'LOGNAME': 'cltbld', 05:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:54 INFO - 'MOZ_NO_REMOTE': '1', 05:03:54 INFO - 'NO_EM_RESTART': '1', 05:03:54 INFO - 'PAGER': '/bin/cat', 05:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:54 INFO - 'PWD': '/builds/slave/test', 05:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:54 INFO - 'SHELL': '/bin/bash', 05:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:54 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:54 INFO - 'USER': 'cltbld', 05:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:54 INFO - 'XPC_FLAGS': '0x0', 05:03:54 INFO - 'XPC_SERVICE_NAME': '0', 05:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-0XkuAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-y1LqoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-yF964x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-dVs8i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:54 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-IsBtI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-6jSbiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-03Buk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-oiv9UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-YlzWOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-07lhBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-cSV9zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-MxbWTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-_BWQji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:55 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-_IGYeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-E9nVrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-JQGZdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:56 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-oqKKOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:58 INFO - Downloading blessings-1.6.tar.gz 05:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:59 INFO - Installing collected packages: blessings 05:03:59 INFO - Running setup.py install for blessings 05:03:59 INFO - Successfully installed blessings 05:03:59 INFO - Cleaning up... 05:03:59 INFO - Return code: 0 05:03:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:59 INFO - Reading from file tmpfile_stdout 05:03:59 INFO - Current package versions: 05:03:59 INFO - blessings == 1.6 05:03:59 INFO - blobuploader == 1.2.4 05:03:59 INFO - docopt == 0.6.1 05:03:59 INFO - functools32 == 3.2.3-2 05:03:59 INFO - jsonschema == 2.5.1 05:03:59 INFO - manifestparser == 1.1 05:03:59 INFO - mozInstall == 1.12 05:03:59 INFO - mozcrash == 1.0 05:03:59 INFO - mozdebug == 0.1 05:03:59 INFO - mozdevice == 0.49 05:03:59 INFO - mozfile == 1.2 05:03:59 INFO - mozhttpd == 0.7 05:03:59 INFO - mozinfo == 0.9 05:03:59 INFO - mozleak == 0.1 05:03:59 INFO - mozlog == 3.4 05:03:59 INFO - moznetwork == 0.27 05:03:59 INFO - mozprocess == 0.25 05:03:59 INFO - mozprofile == 0.28 05:03:59 INFO - mozrunner == 6.13 05:03:59 INFO - mozscreenshot == 0.1 05:03:59 INFO - mozsystemmonitor == 0.3 05:03:59 INFO - moztest == 0.8 05:03:59 INFO - mozversion == 1.4 05:03:59 INFO - psutil == 3.1.1 05:03:59 INFO - requests == 1.2.3 05:03:59 INFO - wsgiref == 0.1.2 05:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:59 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 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:59 INFO - 'HOME': '/Users/cltbld', 05:03:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:59 INFO - 'LOGNAME': 'cltbld', 05:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:59 INFO - 'MOZ_NO_REMOTE': '1', 05:03:59 INFO - 'NO_EM_RESTART': '1', 05:03:59 INFO - 'PAGER': '/bin/cat', 05:03:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:59 INFO - 'PWD': '/builds/slave/test', 05:03:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:59 INFO - 'SHELL': '/bin/bash', 05:03:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:59 INFO - 'USER': 'cltbld', 05:03:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:59 INFO - 'XPC_FLAGS': '0x0', 05:03:59 INFO - 'XPC_SERVICE_NAME': '0', 05:03:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:03:59 INFO - Cleaning up... 05:03:59 INFO - Return code: 0 05:03:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022b1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022b4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a1cf6dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, '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.wkda09udCh/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.D6zjfqh5ck/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:03:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:03:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:59 INFO - 'HOME': '/Users/cltbld', 05:03:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:59 INFO - 'LOGNAME': 'cltbld', 05:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:59 INFO - 'MOZ_NO_REMOTE': '1', 05:03:59 INFO - 'NO_EM_RESTART': '1', 05:03:59 INFO - 'PAGER': '/bin/cat', 05:03:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:59 INFO - 'PWD': '/builds/slave/test', 05:03:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:59 INFO - 'SHELL': '/bin/bash', 05:03:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:03:59 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:03:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:59 INFO - 'USER': 'cltbld', 05:03:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:59 INFO - 'XPC_FLAGS': '0x0', 05:03:59 INFO - 'XPC_SERVICE_NAME': '0', 05:03:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:04:00 INFO - Cleaning up... 05:04:00 INFO - Return code: 0 05:04:00 INFO - Running post-action listener: _resource_record_post_action 05:04:00 INFO - Running post-action listener: _start_resource_monitoring 05:04:00 INFO - Starting resource monitoring. 05:04:00 INFO - [mozharness: 2017-04-01 12:04:00.166447Z] Finished create-virtualenv step (success) 05:04:00 INFO - [mozharness: 2017-04-01 12:04:00.167461Z] Running install step. 05:04:00 INFO - Running pre-action listener: _resource_record_pre_action 05:04:00 INFO - Running main action method: install 05:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:00 INFO - Reading from file tmpfile_stdout 05:04:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:00 INFO - Reading from file tmpfile_stdout 05:04:00 INFO - Output received: 05:04:00 INFO - Usage: mozinstall [options] installer 05:04:00 INFO - Options: 05:04:00 INFO - -h, --help show this help message and exit 05:04:00 INFO - -d DEST, --destination=DEST 05:04:00 INFO - Directory to install application into. [default: 05:04:00 INFO - "/builds/slave/test"] 05:04:00 INFO - --app=APP Application being installed. [default: firefox] 05:04:00 INFO - mkdir: /builds/slave/test/build/application 05:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:04:21 INFO - Reading from file tmpfile_stdout 05:04:21 INFO - Output received: 05:04:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:04:21 INFO - Running post-action listener: _resource_record_post_action 05:04:21 INFO - [mozharness: 2017-04-01 12:04:21.002201Z] Finished install step (success) 05:04:21 INFO - [mozharness: 2017-04-01 12:04:21.002336Z] Running run-tests step. 05:04:21 INFO - Running pre-action listener: _resource_record_pre_action 05:04:21 INFO - Running main action method: run_tests 05:04:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:21 INFO - 2017-04-01 05:04:21.017 screenresolution[2080:20933] starting screenresolution argv=screenresolution get 05:04:21 INFO - 2017-04-01 05:04:21.019 screenresolution[2080:20933] Display 0: 1600x1200x32@60 05:04:21 INFO - 2017-04-01 05:04:21.025 screenresolution[2081:20936] starting screenresolution argv=screenresolution list 05:04:21 INFO - Available Modes on Display 0 05:04:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:21 INFO - Intel Iris: 05:04:21 INFO - Chipset Model: Intel Iris 05:04:21 INFO - Type: GPU 05:04:21 INFO - Bus: Built-In 05:04:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:21 INFO - Vendor: Intel (0x8086) 05:04:21 INFO - Device ID: 0x0a2e 05:04:21 INFO - Revision ID: 0x0009 05:04:21 INFO - Displays: 05:04:21 INFO - Display: 05:04:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:21 INFO - Display Serial Number: 1600x1200 60 05:04:21 INFO - Main Display: Yes 05:04:21 INFO - Mirror: Off 05:04:21 INFO - Online: Yes 05:04:21 INFO - Rotation: Supported 05:04:21 INFO - Return code: 0 05:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:21 INFO - Python 2.7.3 05:04:21 INFO - Return code: 0 05:04:21 INFO - grabbing minidump binary from tooltool 05:04: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')]} 05:04:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10208fd30>, '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 0x101fb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102084be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:04:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:04:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:04:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:21 INFO - Return code: 0 05:04:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:04:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:21 INFO - ENV: RUST_BACKTRACE is now 1 05:04:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:04:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:04:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wkda09udCh/Render', 05:04:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:21 INFO - 'HOME': '/Users/cltbld', 05:04:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:21 INFO - 'LOGNAME': 'cltbld', 05:04:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:21 INFO - 'MOZ_NO_REMOTE': '1', 05:04:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:21 INFO - 'NO_EM_RESTART': '1', 05:04:21 INFO - 'PAGER': '/bin/cat', 05:04:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:21 INFO - 'PWD': '/builds/slave/test', 05:04:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:21 INFO - 'RUST_BACKTRACE': '1', 05:04:21 INFO - 'SHELL': '/bin/bash', 05:04:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D6zjfqh5ck/Listeners', 05:04:21 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 05:04:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:21 INFO - 'USER': 'cltbld', 05:04:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:21 INFO - 'XPC_FLAGS': '0x0', 05:04:21 INFO - 'XPC_SERVICE_NAME': '0', 05:04:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:04:21 INFO - mozversion application_buildid: 20170401040823 05:04:21 INFO - mozversion application_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 05:04:21 INFO - mozversion application_display_name: Nightly 05:04:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:21 INFO - mozversion application_name: Firefox 05:04:21 INFO - mozversion application_remotingname: firefox 05:04:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:04:21 INFO - mozversion application_vendor: Mozilla 05:04:21 INFO - mozversion application_version: 55.0a1 05:04:21 INFO - mozversion platform_buildid: 20170401040823 05:04:21 INFO - mozversion platform_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 05:04:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:04:21 INFO - mozversion platform_version: 55.0a1 05:04:21 INFO - using testdate: 1491048261 05:04:21 INFO - actual date: 1491048261 05:04:21 INFO - starting webserver on 'localhost:49488' 05:04:21 INFO - SUITE-START | Running 2 tests 05:04:21 INFO - TEST-START | dromaeo_css 05:04:21 INFO - operating with platform_type : mac_ 05:04:21 INFO - Initialising browser for dromaeo_css test... 05:04:21 INFO - TEST-INFO | started process 2091 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp4SVjY7/profile http://localhost:49488/getInfo.html) 05:04:24 INFO - PID 2091 | __metrics Screen width/height:1600/1200 05:04:24 INFO - PID 2091 | colorDepth:24 05:04:24 INFO - PID 2091 | Browser inner width/height: 1024/689 05:04:24 INFO - PID 2091 | __metrics 05:04:24 INFO - PID 2091 | 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:04:24 INFO - PID 2091 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:25 INFO - TEST-INFO | 2091: exit 0 05:04:25 INFO - Browser initialized. 05:04:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:25 INFO - TEST-INFO | started process 2093 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp4SVjY7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:37 INFO - PID 2093 | RSS: Main: 232779776 05:04:37 INFO - PID 2093 | 05:07:42 INFO - PID 2093 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49488/tests/dromaeo/cssquery-ext.html) 05:07:45 INFO - PID 2093 | RSS: Main: 499585024 05:07:45 INFO - PID 2093 | 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | A coding exception was thrown and uncaught in a Task. 05:09:26 INFO - PID 2093 | 05:09:26 ERROR - PID 2093 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:26 INFO - PID 2093 | Full stack: 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | A coding exception was thrown and uncaught in a Task. 05:09:26 INFO - PID 2093 | 05:09:26 ERROR - PID 2093 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:26 INFO - PID 2093 | Full stack: 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | A coding exception was thrown and uncaught in a Task. 05:09:26 INFO - PID 2093 | 05:09:26 ERROR - PID 2093 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:26 INFO - PID 2093 | Full stack: 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | ************************* 05:09:26 INFO - PID 2093 | A coding exception was thrown and uncaught in a Task. 05:09:26 INFO - PID 2093 | 05:09:26 ERROR - PID 2093 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:26 INFO - PID 2093 | Full stack: 05:09:26 INFO - PID 2093 | ************************* 05:10:48 INFO - PID 2093 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-ext.html (next: http://localhost:49488/tests/dromaeo/cssquery-jquery.html) 05:10:49 INFO - PID 2093 | RSS: Main: 365494272 05:10:49 INFO - PID 2093 | 05:13:51 INFO - PID 2093 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49488/tests/dromaeo/cssquery-mootools.html) 05:13:52 INFO - PID 2093 | RSS: Main: 336637952 05:13:52 INFO - PID 2093 | 05:16:54 INFO - PID 2093 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49488/tests/dromaeo/cssquery-prototype.html) 05:16:55 INFO - PID 2093 | RSS: Main: 330096640 05:16:55 INFO - PID 2093 | 05:19:59 INFO - PID 2093 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49488/tests/dromaeo/cssquery-yui.html) 05:19:59 INFO - PID 2093 | RSS: Main: 340041728 05:19:59 INFO - PID 2093 | 05:23:02 INFO - PID 2093 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-yui.html (next: http://localhost:49488/tests/dromaeo/cssquery-dojo.html) 05:23:03 INFO - PID 2093 | RSS: Main: 456585216 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | __start_tp_report 05:23:03 INFO - PID 2093 | _x_x_mozilla_page_load 05:23:03 INFO - PID 2093 | _x_x_mozilla_page_load_details 05:23:03 INFO - PID 2093 | |i|pagename|runs| 05:23:03 INFO - PID 2093 | |0;dojo.html;3495.300939812038;3503.5095086687884;3533.116720819795;3533.7526373153883;3576.8926932192044;5351.25082488451;6174.475169610583;6189.53578481614;6219.067139929001;6238.500919926406;5822.854428639286;6066.272047354312;6143.5118776895315;6215.62706237626;6248.656323902183;5342.866428339284;5353.116735738598;5396.730163491809;5400.78396864125;5475.589330800186;4991.650584459071;5268.236105764662;5342.786288548473;5417.133258678612;5419.376771671269;5376.623636345457;5377.5429088527135;5378.327709036371;5378.704171270579;5385.138377859524;5310.92033619496;5347.25138480613;5360.946390536123;5368.731563421813;5378.2470454136455;5278.287431196778;5327.9733601331745;5334.653247538898;5339.786408543654;5347.812826551091;6114.829235621335;6116;6117.410478740911;6125.877482450371;6137.2942111657285;6368.968155159241;6396.264429590564;6405.6797160141805;6414.61512309263;6417.679116044179;6430.549861509696;6450.387213214737;6452.193475815523;6467.288598254188;6610.669466526654;5240.816571420059;6303.527235457267;6344.04839274108;6359.586626869239;6361.8727625448155;6570.671466426755;6643.60138391698;6864.931350686529;6872.140982377203;6889.724411023603;6379.968100159563;6409.583377080475;6425.678716064178;6458.418742313214;6475.740970361227;6627.569208001464;6644.235912869985;6655.101561289261;6669.799906002828;6682.599044057372;6561.1470508833545;6575.44108750752;6576.868462630816;6580.638064906476;6602.966985165043;6165.013597824327;6275.843103922439;6341.239051313872;6343.936560634427;6359.20509936258;5205.609579281569;5224.05966925957;5231.607629427732;5240.947590524046;5242.082635538765;3928.508936382952;4641.350210970467;4703.576678098988;4717.669763116617;4729.243321068681;6338.429541341301;6351.777687780906;6355.936440635534;6356.809295721136;6370.458511026522;6589.901151482732;6648.235452922976;6672.2994085621285;6672.2994085621285;6676.666166691646;6112.1387513176505;6186.226721659793;6190.226221722285;6248.937510624835;6329.746810127635;5835.533157347402;5836.503897168704;5841.153032810219;5850.736716847752;5889.587728858939;6832.965835170792;6887.345702158287;6902.723891044302;6908.965455172692;6914.9308506914285;6343.111964324906;6413.1021656969;6432.839179020562;6639.867202655823;6660.300668429745;6671.966640166768;6672.366125218096;6675.7997260082275;6676.799696009128;6681.231658359351;6365.14070600463;6375.362463753588;6387.265464471459;6394.584352017104;6407.583507072025;6577.80266592003;6635.568688035262;6670.166229221348;6674.065630811788;6674.998750187317;6312.810615681537;6414.775482858077;6431.710573024318;6435.420812126931;6449.580777249464;6267.467265282502;6363.713632886439;6442.484601231984;6443.806685799434;6449.258335291313;6279.623222606659;6296.527760418078;6308.179936608211;6308.621482711052;6312.873742525216;6266.091416744455;6348.174737284308;6350.7777227796805;6358.809235722936;6362.491000720024;6293.496520278458;6362.3319551448285;6364.172657554674;6372.980323148274;6376.39424254695 05:23:03 INFO - PID 2093 | |1;ext.html;707.6992278281731;806.5241507510567;1129.2546919033434;1148.9827652585213;1151.9827202591957;36410.81794591027;37017.814910925445;37217.627823721756;37301.067473313145;37386.06534836624;38897.8330650081;39160;39193.02017449565;39307.41038884412;39335.213295734065;5904.586678932476;6009.338972712998;8427.83144337113;8576.356773242002;8581.613827377783;8292.37807164462;8472.576371181416;8488.23605875471;8499.937507811523;8508.659653613848;8487.702930397438;8563.529005904673;8575.013873404576;8583.313334933222;8592.957035214815;8465.703700370488;8550.871736923982;8562.315014798864;8562.486250824908;8591.613377397969;7072.646367681596;8536.8719469208;8547.35894807892;8547.957260213721;8554.82890342196;37040.81479592585;37174.62825371766;37197.25605487875;37214.88355349344;37356;2988.940221195564;3004.143819011593;3011.1869795155403;3015.7587393008507;3031.8484075796123;26694.866525667443;26724.33189170267;26783.25585107451;26969.595456068175;27147.86426067857;2731.7677997370247;2752.6146339512484;2765.6542932133484;2790.3024243939017;2796.4546913351905;320155.3992230047;322248.38875805703;322586.9025062125;322805;323419;39366.40950385747;40045.39931901024;40122.59570915004;49621.25568116481;49845.50154498409;41882.790586046875;41982.160356792694;41993.58006419958;42003;49669.503304966485;13826.446942122404;14098.365573549216;14130.010899236955;14137.78793318101;14170;10012.349197302152;11493.942530287295;11512.481938312796;11518.251313664585;11558;9496.90503094974;10676;11882.108841836896;12075.45660445282;12084.637460876187;4724.858254252378;4864.6594738368685;5145.871353216199;5203.427622961472;5216.365735303647;953.5565961827783;956.2445667922402;971.3977334052933;976.7948730766476;1023.1610079734695;21804.563908721735;23332.53334933292;23384.766152338598;23540.882295588413;23565.882170589037;1049.1344640671477;1073.7369344510646;1086.5056399338282;1101.2676570080966;1108.4180805077237;9606.855897161548;11928.522859085539;12064.879351206375;12095.939520302518;12106.334151621746;447976;448517;448793;449690;449799.7510012429;51868.74065629723;51900;52022.73988630108;52028.73985630123;52036.73981630067;1443.1196969848384;1488.761798112297;1501.0543357684808;1512.0927443533792;1522.6041229280245;23477.647835282827;23482.88258558696;23508.177213797437;23556.8822155895;23558.882205588863;38060.955123590604;38264.85205443841;38266.808665956494;38282;38299.85100446991;439490;441390;441922;441925.7903710461;441931;25695.614565781903;26106;31407.52888706717;31645;32258.516122258654;31514.842425787723;31621.20946976344;40349.1930161401;41620.791896040326;41946.1610767789;23545.529089417774;27860.488290981564;27949.441011179257;28247.2938176539;29592.556111658774;26556.070537531094;28517.857410712815;29293.707062929097;29519.55720664235;29586.408271834873;32989;33418.164545886546;33949;34190.31619367549;34388;29039.709602904546;29183.70816291895;29948;29969.400611988076;30218.54672179963;21745.565088698455;23086.769132309135;23337.066517339117;23518.64722029137;23771.762282377647 05:23:03 INFO - PID 2093 | |2;jquery.html;421.3357660457921;426.2412905029049;428.84347213267165;432.37090034000533;451.6432018705223;17326.393576224833;21859.72104184373;22215.44461388466;23105.30684079476;23365.76634233657;22492;22670.88664556679;23225.767742322612;23825.689587072706;24109.39726506834;5229.581633469314;5991.760329586822;6202.9689851550675;6228.408301211378;6240.719167637467;3680.392735198689;3878.2437424702193;3885.1452680410266;5976.940230597704;6262.530310226728;3860.478835357233;3867.38121900496;3872.457855900176;3874.9925019494995;5949.464548190662;6063.484603808682;6079.6960151992225;6169.691515424211;6212.316645169028;6218.782342618032;5027.899442011176;5091.23631455281;5416.404195538487;5464.836054918359;5470.56235501159;26328.73671263301;26657.866710666516;26904.192874213608;27583;27736;2009.9598008039757;2051.4050925231663;2061.7628972668185;2076.356329537848;2153.569286142778;16738.83261167385;16780.328786848513;17060;17363.65272694539;17528.386506472212;1853.4161739052156;1881.9811801882079;1883.3784850999136;1888.3485197606803;1897.7627796525435;136113.3194334032;143489.56510434867;144094.27952860272;163126.18436907858;170102.44846327315;10087.7478063049;12520.561780337644;12628.936855315664;12685.809712854314;12819.871801282054;16706.331746730237;16730.16349182536;16754.99470031802;16755.078470684228;16765.497035088723;8218.753437396888;8561.015483219386;8772.78068048304;9098.499582522893;9264.11990860867;7003.478747650842;8668.306535477146;8725.694600689072;8929.10708929102;8932.508712020772;7788.883166752503;7883.211678832071;7939.920600794034;7948.801279967932;7958.164392738795;1973.7828838827718;2108.81020708137;2129.6911947767485;2139.1871088986086;2299.275728145629;865.1132589096227;882.8896387951506;885.3890815337396;914.9908500915038;924.3160061554536;19925.10337034837;20051.398458046282;21441.571168576542;21652.675209871864;21723.022463989157;913.4199783137756;934.7287688743304;967.4678926590348;970.2383628851318;973.2894986659778;9706;9966.152877005536;11075.05862001739;11088.944555277334;11099.944500277446;702704;705618;706976;711941;724013;152649;157501;160771.39228607563;163156;163331;1094.2887123369874;1123.2867129372744;1149.827525871126;1150.6778102131416;1152.6023521884936;12971.675708107372;18085.909570452062;18618.813811861706;18867.433976980712;19107.80892191116;60737.088943666764;63590;64615.67692161509;65014;65512;85318.57340713257;86417;86995.56502217449;87269;88834;7623.69505219785;8427.367947403847;8525.786855328419;8553.101924298107;8790.164934331227;10805.621803236849;13662.453501860213;13699.794503082263;14083.732464078283;14327.57017289483;11734.589289374831;11812.291262524275;12036.578719744766;12046.578369757017;12080.697982550506;10369.84445233307;10944.945275273572;10960.013598776148;10969.890301096886;11400.429978501208;9729.805403891742;11763.470643820878;11812.940935295268;11944.462499187384;12130.33283169434;8079.474834135763;8220.780389294738;8592.742217733477;8598.82802343962;9131.406458580172;11431.714207144887;11702.239354441934;12125.454354553889;12148.149629526202;12190.451429685863 05:23:03 INFO - PID 2093 | |3;mootools.html;1386.5355106039474;1455.672473693419;1460.0874453466583;1477.6896851661152;1478.5416520878534;10267.127294179994;10684.091852192563;10696.358218506895;10703.250772445932;10713.464326783649;10446.425446600433;10448.582056717722;10760.354378737282;10768.946155269212;10778.73053173671;2401.6877805885256;2444.523317953;2446.217210492643;2446.2905757330354;2448.571499987504;2324.407276144581;2410.457647029422;2417.516496700658;2421.140495124232;2427.0655797517993;2043.9795602043937;2351.3651314145254;2410.939726506843;2416.4200591858003;2440.4996975620043;2309.7690230976937;2377.560151371993;2381.047580967618;2388.605880029793;2393.3418309964727;2373.56089123511;2378.678878351435;2391.175044609607;2395.796357309631;2402.8678422686744;10633.308834925783;10836.349819010884;10838.891611083867;10853.914608539162;10874.075703565206;6102.755889764404;6342.365763423667;6364.427201551883;6371.108044873721;6372.745090196387;3983.223271462066;3994.3409337459284;4025.5169379674626;4038.5961403859674;4068.6338229559483;1137.4199158429178;1171.9882801171964;1177.2289150606366;1195.1932445599186;1206.6319772469394;13407.865921340759;13807.930960345235;13828.723425531432;14583.416663333453;14745.926270368687;4393.846215382447;4773.307870358779;4895.632827537949;4933.358663373739;5352.063388906926;11175.764847030627;11190.496427660775;11200.383978881076;11211.943940280247;11219.270747401393;6237.313895471494;6243.219597550306;6244.406781355855;6250.593711408835;6251.74993000284;5555.333359996826;5777.913331300034;5809.09958956354;5873.3245676746865;5874.618149820248;4066;4168.624823765876;4186.727862688916;4227.387028880795;4251.404803327537;1250.2873362183468;1252.323745177594;1254.6549698832894;1270.84749830021;1274.7004453953314;721.7077083781077;729.3508777188307;749.8612756640039;752.6951584608242;782.0537150048391;5458.317710286215;5597.720113994284;5664.85837854057;5687.943120568824;5700.828975130753;535.6464733276019;560.9607327487118;594.2334388638694;596.1028651878895;597.4772074434869;3585.659362360572;3645.927081458356;3786.67813235878;3789.3368660484307;3816.4084566892175;12980.740385192243;13638;13650.453981840814;13658.52195173184;13670.316484175752;12927.741445171045;13169.53906613264;13548.254845983369;13570.117942333716;13585;7160.892586611205;8503.65985360591;9973.650922217688;10037.096661300518;10093.899061009295;6427.517936154713;6614.140161778938;6632;6691.330866913269;6743.629100399525;10639.468026598794;11786.941065294961;12100.515979360727;12176.964957978671;12338.012958963442;12227.388630568257;12266.202696824677;12316.753664926471;12450.937745311216;12454;6894.689738961859;7966.3626909848235;8009.8398032040195;8080.111187769223;8095.959520202597;9683.886353069205;9728.17310528613;9818.607255709692;9819.9018009819;9845.310828241954;8231.34149268045;8447.915520844714;8502.064772875103;8536.530490823065;8630.266427353745;8214.876776848472;8233.46482478637;8262.545559994258;8482.957585212034;8516.105808889977;6054.455099041107;7485.5508669480005;7755.961220193863;7862.371010319046;7870.449068565145;4885.560299573055;5751.568632352507;5843.1235314703135;5985.25184351956;6006.699665016644;4830.613550915848;5983.341832398346;5993.640381577119;6054.3642917493025;6115.388461153849 05:23:03 INFO - PID 2093 | |4;prototype.html;311.9079871437926;389.375053039871;393.69095260220735;393.8916797880584;399.8860324807427;4938.975305123474;5972.19375384323;5981.641101533905;5990.1913241712355;6009.2788865336115;4518.638508919287;5744.770209191627;5904.261967254093;5916.852078698024;5949.851253718659;4102.8255024836735;4128.504579450455;4468.575485328896;4540.296254080623;4543.954560454403;4421.115776844628;4505.459344878619;4526.773661316937;4534.659900507459;4551.863444096666;3683.410654295313;3742.9438558421643;3853.626134337519;4487.483939346968;4515.864524064284;4029.758214507124;4443.46678398591;4461.263891457906;4473.150101480708;4504.932426013613;3942.7831469269177;3974.721769476138;3980.24375368679;3982.422548730418;3988.102676897704;4711.597085486393;5186.818461353872;5784.71076446176;5812.418758124154;5819.127130930395;4839.249916262985;5131.281620573122;5147.819826306099;5157.510036546522;5165.793368265265;6251.937480625181;6276.529260305495;6289.213848268966;6289.37106289372;6296.9370306296805;3570;4040.616141466556;4226.492820861486;4240.766757828318;4246.341817018367;5542.258975191729;6092.08618707193;6368.1154495757555;6490.740370385226;6505.934940650627;4142.834286628561;4301.78491075445;4306.7940976526625;4326.978365108154;4344.782760861945;4359.346098085249;4392.253316936129;4393.253146965024;4399.472063352354;4411.713238639478;4721.291806229093;4783.521647835189;5145.331106956071;5179.689218646893;5219.712915789592;5259.895421961354;5417.729113544386;6247.938839754105;6276.525016621091;6296;1173;1295.1581472043247;1458.5332693537966;1486.5317425011087;1489.2777003153462;887.3877024852831;978.6770365779275;979.1481411172325;988.0958922585753;1006.3509036671306;5019.548240658358;5198.972400763705;5600.35595906476;5692.861427714473;6006.579539432198;6228;6476.6114033158165;6481.384268494486;6489.67551622417;6496.285408605049;4623.352730617717;5704.258446402024;5915.881682366328;5924.555658325643;5953.22608060958;3396.626371099177;3399.079520071152;3411.368896754059;3417.8974630761118;3418.1454636340914;6102.931986902275;6154.691990503561;6505.837354066186;6767.221769496571;6809.591424514446;5585.664860108406;5594.104943209067;6639.236487803868;6672.0325552794575;6677.76627818024;6321.557490975588;6719.160104986877;6729.764458243938;6755.392014718601;6768.390844823989;6399.616023038632;6465.903011454926;6477.643729594729;6488.156539650005;6505.837354066186;5908.852278693067;5963;6312.526560508072;6416.17688217183;6426.228852537725;5031.748172793983;5963.70181490915;6198.535109866688;6256.718447669775;6713.556585333981;3768.3593789056476;4276.91446171081;4299.656027517729;4301.268784306738;4326.545712700121;6274.692075296204;6338.239411270677;6484.967575162094;6522.934770652422;6536.182977127859;5735.8566035849435;5770.653760774367;6201.976673848945;6238.132357938108;6264;5222.9216561750845;6254.061890716247;6261.812145635638;6263.4362907338555;6361.360035585365;5771.394003629726;6102.328743838263;6107.877842443215;6178.62928224308;6204.410580994799;6124.755009799558;6271.184745982993;6279.560430769802;6286.402791734778;6290.182276304051;4535.727856328631;5903.192440875697;6112.144299798121;6112.235970503687;6135.233095863017 05:23:03 INFO - PID 2093 | |5;yui.html;726.4224941171768;732.7801659502152;736.547023580498;749.7975546602414;759.6923246085336;15622.76565851513;16371.427000055;16409.34362625495;16409.507714768562;16644.750328745078;17957.91021044896;18256.81743182568;18273.177707003182;18276.817231827677;18311.633767324678;963.0369630369648;973.9513024348789;986.0287616697548;986.5511192407438;987.6148302162162;1004.8593196952432;1005.0753306957616;1005.8541511480831;1006;1007.5214273220236;1006.9395836249848;1023.355286169712;1051.4322265976364;1052.8157572424834;1067.0503252105632;1008.2690049713935;1039.3088596083596;1042.4162469017374;1043.4156872151543;1044.1281529922485;751.1324420294568;767.5394763142126;771.996140019302;772.3357912195507;772.9690812367498;12304.938475307566;16198.02811831282;16738.81962427135;16896.40862569804;17456;15073.147194739158;15140.318685659062;15282.465113721077;15285.61785955349;16328.83671163297;11391;11624;11725.472353744102;11773.41132943358;12056.819147712791;2915.877819352733;2999.1902186409548;3015.7888947773663;3029.5455681647927;3067.2485241115846;118792.40603796925;120469;121348;123361.38319308436;125974.99999999908;11622.70943226426;11628.244164129474;11677.708057298465;11840.70398240051;11879.22785018971;25513.489730205292;26127.608085878728;26134.86932565325;26191.083312083985;26204.60693089605;6928.757493487704;7989.720359787496;8159.83680326402;8163.755087347389;8325.916740832636;3888.6305800948867;3990.4812374391145;4007.338789099766;4078.3270760324212;4080.7143499955314;3108.362785628941;4152.1695660867945;4258.212230737262;4266.850660226877;4278.379634952977;784.8704963680929;794.6265255329986;805.7703554486943;817.3787921179946;827.8923739913893;542.9782808687609;574.8476653686777;585.8330375842864;593.7921727395463;593.9940600593939;9578.521073946275;10102.657154930335;10302.227332950059;10338.689839304832;10547.472626368652;528.6959998001165;546.6064433607796;581.3635708642498;589.9380565040694;596.8179705189872;4657.208274593328;4824.059308434821;4827.253224224844;4833.564979151823;4846.927296090562;106045;106867;107856;109145.45427272812;111162.88837111687;70256.64871675712;95036;95459;98492;99742;62658;83897;85282.14717852866;86535;86538.56730716306;9511.116857542229;9667.517400237673;9669.922817773457;9686.632407402702;9687.85677606554;41148.971275718344;41540;41804.1639167221;41988.95027624334;42204.366934495396;49942.25086623631;53741.73129134329;54595.72702136464;54757;55271;11706.35615041181;11750.29498230109;11867.397901283217;12005.459754310903;12332.876671233173;12520.74958500843;12827.294498802656;12907.419166137734;13212.075154739076;13271;13395.330233488481;14038.470138685492;14177.574672759834;14189.432422703389;14436.133831970115;14013.089149205269;14276.928615356857;14277.42890284377;14458.710825783215;14762.966592338433;13820.585382438543;13906.791398129239;13995.650108747363;14482.275886205436;14570;10239;10409.271351005356;10515.737106572396;10557.894421055691;10980.670579882617;8494.447860889022;9694.46680432583;10528.894711052792;11176.944115279372;11711.121665874924 05:23:03 INFO - PID 2093 | __end_tp_report 05:23:03 INFO - PID 2093 | __start_cc_report 05:23:03 INFO - PID 2093 | _x_x_mozilla_cycle_collect,3304 05:23:03 INFO - PID 2093 | __end_cc_report 05:23:03 INFO - PID 2093 | __startTimestamp1491049383065__endTimestamp 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | ------- Summary: start ------- 05:23:03 INFO - PID 2093 | Number of tests: 6 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | [#0] dojo.html Cycles:165 Average:6060.41 Median:6344.05 stddev:714.73 (11.3%) stddev-sans-first:688.01 05:23:03 INFO - PID 2093 | Values: 3495.3 3503.5 3533.1 3533.8 3576.9 5351.3 6174.5 6189.5 6219.1 6238.5 5822.9 6066.3 6143.5 6215.6 6248.7 5342.9 5353.1 5396.7 5400.8 5475.6 4991.7 5268.2 5342.8 5417.1 5419.4 5376.6 5377.5 5378.3 5378.7 5385.1 5310.9 5347.3 5360.9 5368.7 5378.2 5278.3 5328.0 5334.7 5339.8 5347.8 6114.8 6116.0 6117.4 6125.9 6137.3 6369.0 6396.3 6405.7 6414.6 6417.7 6430.5 6450.4 6452.2 6467.3 6610.7 5240.8 6303.5 6344.0 6359.6 6361.9 6570.7 6643.6 6864.9 6872.1 6889.7 6380.0 6409.6 6425.7 6458.4 6475.7 6627.6 6644.2 6655.1 6669.8 6682.6 6561.1 6575.4 6576.9 6580.6 6603.0 6165.0 6275.8 6341.2 6343.9 6359.2 5205.6 5224.1 5231.6 5240.9 5242.1 3928.5 4641.4 4703.6 4717.7 4729.2 6338.4 6351.8 6355.9 6356.8 6370.5 6589.9 6648.2 6672.3 6672.3 6676.7 6112.1 6186.2 6190.2 6248.9 6329.7 5835.5 5836.5 5841.2 5850.7 5889.6 6833.0 6887.3 6902.7 6909.0 6914.9 6343.1 6413.1 6432.8 6639.9 6660.3 6672.0 6672.4 6675.8 6676.8 6681.2 6365.1 6375.4 6387.3 6394.6 6407.6 6577.8 6635.6 6670.2 6674.1 6675.0 6312.8 6414.8 6431.7 6435.4 6449.6 6267.5 6363.7 6442.5 6443.8 6449.3 6279.6 6296.5 6308.2 6308.6 6312.9 6266.1 6348.2 6350.8 6358.8 6362.5 6293.5 6362.3 6364.2 6373.0 6376.4 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | [#1] ext.html Cycles:180 Average:52535.18 Median:33683.58 stddev:108615.19 (322.5%) stddev-sans-first:108850.18 05:23:03 INFO - PID 2093 | Values: 707.7 806.5 1129.3 1149.0 1152.0 36410.8 37017.8 37217.6 37301.1 37386.1 38897.8 39160.0 39193.0 39307.4 39335.2 5904.6 6009.3 8427.8 8576.4 8581.6 8292.4 8472.6 8488.2 8499.9 8508.7 8487.7 8563.5 8575.0 8583.3 8593.0 8465.7 8550.9 8562.3 8562.5 8591.6 7072.6 8536.9 8547.4 8548.0 8554.8 37040.8 37174.6 37197.3 37214.9 37356.0 2988.9 3004.1 3011.2 3015.8 3031.8 26694.9 26724.3 26783.3 26969.6 27147.9 2731.8 2752.6 2765.7 2790.3 2796.5 320155.4 322248.4 322586.9 322805.0 323419.0 39366.4 40045.4 40122.6 49621.3 49845.5 41882.8 41982.2 41993.6 42003.0 49669.5 13826.4 14098.4 14130.0 14137.8 14170.0 10012.3 11493.9 11512.5 11518.3 11558.0 9496.9 10676.0 11882.1 12075.5 12084.6 4724.9 4864.7 5145.9 5203.4 5216.4 953.6 956.2 971.4 976.8 1023.2 21804.6 23332.5 23384.8 23540.9 23565.9 1049.1 1073.7 1086.5 1101.3 1108.4 9606.9 11928.5 12064.9 12095.9 12106.3 447976.0 448517.0 448793.0 449690.0 449799.8 51868.7 51900.0 52022.7 52028.7 52036.7 1443.1 1488.8 1501.1 1512.1 1522.6 23477.6 23482.9 23508.2 23556.9 23558.9 38061.0 38264.9 38266.8 38282.0 38299.9 439490.0 441390.0 441922.0 441925.8 441931.0 25695.6 26106.0 31407.5 31645.0 32258.5 31514.8 31621.2 40349.2 41620.8 41946.2 23545.5 27860.5 27949.4 28247.3 29592.6 26556.1 28517.9 29293.7 29519.6 29586.4 32989.0 33418.2 33949.0 34190.3 34388.0 29039.7 29183.7 29948.0 29969.4 30218.5 21745.6 23086.8 23337.1 23518.6 23771.8 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | [#2] jquery.html Cycles:180 Average:41013.56 Median:23967.54 stddev:119203.80 (497.4%) stddev-sans-first:119499.23 05:23:03 INFO - PID 2093 | Values: 421.3 426.2 428.8 432.4 451.6 17326.4 21859.7 22215.4 23105.3 23365.8 22492.0 22670.9 23225.8 23825.7 24109.4 5229.6 5991.8 6203.0 6228.4 6240.7 3680.4 3878.2 3885.1 5976.9 6262.5 3860.5 3867.4 3872.5 3875.0 5949.5 6063.5 6079.7 6169.7 6212.3 6218.8 5027.9 5091.2 5416.4 5464.8 5470.6 26328.7 26657.9 26904.2 27583.0 27736.0 2010.0 2051.4 2061.8 2076.4 2153.6 16738.8 16780.3 17060.0 17363.7 17528.4 1853.4 1882.0 1883.4 1888.3 1897.8 136113.3 143489.6 144094.3 163126.2 170102.4 10087.7 12520.6 12628.9 12685.8 12819.9 16706.3 16730.2 16755.0 16755.1 16765.5 8218.8 8561.0 8772.8 9098.5 9264.1 7003.5 8668.3 8725.7 8929.1 8932.5 7788.9 7883.2 7939.9 7948.8 7958.2 1973.8 2108.8 2129.7 2139.2 2299.3 865.1 882.9 885.4 915.0 924.3 19925.1 20051.4 21441.6 21652.7 21723.0 913.4 934.7 967.5 970.2 973.3 9706.0 9966.2 11075.1 11088.9 11099.9 702704.0 705618.0 706976.0 711941.0 724013.0 152649.0 157501.0 160771.4 163156.0 163331.0 1094.3 1123.3 1149.8 1150.7 1152.6 12971.7 18085.9 18618.8 18867.4 19107.8 60737.1 63590.0 64615.7 65014.0 65512.0 85318.6 86417.0 86995.6 87269.0 88834.0 7623.7 8427.4 8525.8 8553.1 8790.2 10805.6 13662.5 13699.8 14083.7 14327.6 11734.6 11812.3 12036.6 12046.6 12080.7 10369.8 10944.9 10960.0 10969.9 11400.4 9729.8 11763.5 11812.9 11944.5 12130.3 8079.5 8220.8 8592.7 8598.8 9131.4 11431.7 11702.2 12125.5 12148.1 12190.5 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | [#3] mootools.html Cycles:180 Average:6537.03 Median:3802.87 stddev:4026.14 (105.9%) stddev-sans-first:4018.83 05:23:03 INFO - PID 2093 | Values: 1386.5 1455.7 1460.1 1477.7 1478.5 10267.1 10684.1 10696.4 10703.3 10713.5 10446.4 10448.6 10760.4 10768.9 10778.7 2401.7 2444.5 2446.2 2446.3 2448.6 2324.4 2410.5 2417.5 2421.1 2427.1 2044.0 2351.4 2410.9 2416.4 2440.5 2309.8 2377.6 2381.0 2388.6 2393.3 2373.6 2378.7 2391.2 2395.8 2402.9 10633.3 10836.3 10838.9 10853.9 10874.1 6102.8 6342.4 6364.4 6371.1 6372.7 3983.2 3994.3 4025.5 4038.6 4068.6 1137.4 1172.0 1177.2 1195.2 1206.6 13407.9 13807.9 13828.7 14583.4 14745.9 4393.8 4773.3 4895.6 4933.4 5352.1 11175.8 11190.5 11200.4 11211.9 11219.3 6237.3 6243.2 6244.4 6250.6 6251.7 5555.3 5777.9 5809.1 5873.3 5874.6 4066.0 4168.6 4186.7 4227.4 4251.4 1250.3 1252.3 1254.7 1270.8 1274.7 721.7 729.4 749.9 752.7 782.1 5458.3 5597.7 5664.9 5687.9 5700.8 535.6 561.0 594.2 596.1 597.5 3585.7 3645.9 3786.7 3789.3 3816.4 12980.7 13638.0 13650.5 13658.5 13670.3 12927.7 13169.5 13548.3 13570.1 13585.0 7160.9 8503.7 9973.7 10037.1 10093.9 6427.5 6614.1 6632.0 6691.3 6743.6 10639.5 11786.9 12100.5 12177.0 12338.0 12227.4 12266.2 12316.8 12450.9 12454.0 6894.7 7966.4 8009.8 8080.1 8096.0 9683.9 9728.2 9818.6 9819.9 9845.3 8231.3 8447.9 8502.1 8536.5 8630.3 8214.9 8233.5 8262.5 8483.0 8516.1 6054.5 7485.6 7756.0 7862.4 7870.4 4885.6 5751.6 5843.1 5985.3 6006.7 4830.6 5983.3 5993.6 6054.4 6115.4 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | [#4] prototype.html Cycles:180 Average:5053.68 Median:5757.71 stddev:1569.95 (27.3%) stddev-sans-first:1533.48 05:23:03 INFO - PID 2093 | Values: 311.9 389.4 393.7 393.9 399.9 4939.0 5972.2 5981.6 5990.2 6009.3 4518.6 5744.8 5904.3 5916.9 5949.9 4102.8 4128.5 4468.6 4540.3 4544.0 4421.1 4505.5 4526.8 4534.7 4551.9 3683.4 3742.9 3853.6 4487.5 4515.9 4029.8 4443.5 4461.3 4473.2 4504.9 3942.8 3974.7 3980.2 3982.4 3988.1 4711.6 5186.8 5784.7 5812.4 5819.1 4839.2 5131.3 5147.8 5157.5 5165.8 6251.9 6276.5 6289.2 6289.4 6296.9 3570.0 4040.6 4226.5 4240.8 4246.3 5542.3 6092.1 6368.1 6490.7 6505.9 4142.8 4301.8 4306.8 4327.0 4344.8 4359.3 4392.3 4393.3 4399.5 4411.7 4721.3 4783.5 5145.3 5179.7 5219.7 5259.9 5417.7 6247.9 6276.5 6296.0 1173.0 1295.2 1458.5 1486.5 1489.3 887.4 978.7 979.1 988.1 1006.4 5019.5 5199.0 5600.4 5692.9 6006.6 6228.0 6476.6 6481.4 6489.7 6496.3 4623.4 5704.3 5915.9 5924.6 5953.2 3396.6 3399.1 3411.4 3417.9 3418.1 6102.9 6154.7 6505.8 6767.2 6809.6 5585.7 5594.1 6639.2 6672.0 6677.8 6321.6 6719.2 6729.8 6755.4 6768.4 6399.6 6465.9 6477.6 6488.2 6505.8 5908.9 5963.0 6312.5 6416.2 6426.2 5031.7 5963.7 6198.5 6256.7 6713.6 3768.4 4276.9 4299.7 4301.3 4326.5 6274.7 6338.2 6485.0 6522.9 6536.2 5735.9 5770.7 6202.0 6238.1 6264.0 5222.9 6254.1 6261.8 6263.4 6361.4 5771.4 6102.3 6107.9 6178.6 6204.4 6124.8 6271.2 6279.6 6286.4 6290.2 4535.7 5903.2 6112.1 6112.2 6135.2 05:23:03 INFO - PID 2093 | 05:23:03 INFO - PID 2093 | [#5] yui.html Cycles:180 Average:20919.18 Median:18294.23 stddev:30894.61 (168.9%) stddev-sans-first:30944.07 05:23:03 INFO - PID 2093 | Values: 726.4 732.8 736.5 749.8 759.7 15622.8 16371.4 16409.3 16409.5 16644.8 17957.9 18256.8 18273.2 18276.8 18311.6 963.0 974.0 986.0 986.6 987.6 1004.9 1005.1 1005.9 1006.0 1007.5 1006.9 1023.4 1051.4 1052.8 1067.1 1008.3 1039.3 1042.4 1043.4 1044.1 751.1 767.5 772.0 772.3 773.0 12304.9 16198.0 16738.8 16896.4 17456.0 15073.1 15140.3 15282.5 15285.6 16328.8 11391.0 11624.0 11725.5 11773.4 12056.8 2915.9 2999.2 3015.8 3029.5 3067.2 118792.4 120469.0 121348.0 123361.4 125975.0 11622.7 11628.2 11677.7 11840.7 11879.2 25513.5 26127.6 26134.9 26191.1 26204.6 6928.8 7989.7 8159.8 8163.8 8325.9 3888.6 3990.5 4007.3 4078.3 4080.7 3108.4 4152.2 4258.2 4266.9 4278.4 784.9 794.6 805.8 817.4 827.9 543.0 574.8 585.8 593.8 594.0 9578.5 10102.7 10302.2 10338.7 10547.5 528.7 546.6 581.4 589.9 596.8 4657.2 4824.1 4827.3 4833.6 4846.9 106045.0 106867.0 107856.0 109145.5 111162.9 70256.6 95036.0 95459.0 98492.0 99742.0 62658.0 83897.0 85282.1 86535.0 86538.6 9511.1 9667.5 9669.9 9686.6 9687.9 41149.0 41540.0 41804.2 41989.0 42204.4 49942.3 53741.7 54595.7 54757.0 55271.0 11706.4 11750.3 11867.4 12005.5 12332.9 12520.7 12827.3 12907.4 13212.1 13271.0 13395.3 14038.5 14177.6 14189.4 14436.1 14013.1 14276.9 14277.4 14458.7 14763.0 13820.6 13906.8 13995.7 14482.3 14570.0 10239.0 10409.3 10515.7 10557.9 10980.7 8494.4 9694.5 10528.9 11176.9 11711.1 05:23:03 INFO - PID 2093 | -------- Summary: end -------- 05:23:03 INFO - PID 2093 | 05:23:03 INFO - TEST-INFO | 2093: exit 0 05:23:03 INFO - TEST-OK | dromaeo_css | took 1122173ms 05:23:03 INFO - TEST-START | kraken 05:23:03 INFO - operating with platform_type : mac_ 05:23:03 INFO - Initialising browser for kraken test... 05:23:03 INFO - TEST-INFO | started process 2099 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpKUsM66/profile http://localhost:49488/getInfo.html) 05:23:06 INFO - PID 2099 | __metrics Screen width/height:1600/1200 05:23:06 INFO - PID 2099 | colorDepth:24 05:23:06 INFO - PID 2099 | Browser inner width/height: 1024/689 05:23:06 INFO - PID 2099 | __metrics 05:23:06 INFO - PID 2099 | 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:23:06 INFO - PID 2099 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:07 INFO - TEST-INFO | 2099: exit 0 05:23:07 INFO - Browser initialized. 05:23:07 INFO - Running cycle 1/1 for kraken test... 05:23:07 INFO - TEST-INFO | started process 2100 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpKUsM66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:19 INFO - PID 2100 | RSS: Main: 234164224 05:23:19 INFO - PID 2100 | 05:23:22 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:23 INFO - PID 2100 | RSS: Main: 286576640 05:23:23 INFO - PID 2100 | 05:23:26 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-dft) 05:23:26 INFO - PID 2100 | RSS: Main: 286572544 05:23:26 INFO - PID 2100 | 05:23:30 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-fft) 05:23:31 INFO - PID 2100 | RSS: Main: 379236352 05:23:31 INFO - PID 2100 | 05:23:33 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator) 05:23:34 INFO - PID 2100 | RSS: Main: 284585984 05:23:34 INFO - PID 2100 | 05:23:36 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:37 INFO - PID 2100 | RSS: Main: 286806016 05:23:37 INFO - PID 2100 | 05:23:40 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:40 INFO - PID 2100 | RSS: Main: 328900608 05:23:40 INFO - PID 2100 | 05:23:44 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:44 INFO - PID 2100 | RSS: Main: 337321984 05:23:44 INFO - PID 2100 | 05:23:47 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial) 05:23:48 INFO - PID 2100 | RSS: Main: 344809472 05:23:48 INFO - PID 2100 | 05:23:50 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:50 INFO - PID 2100 | RSS: Main: 305008640 05:23:50 INFO - PID 2100 | 05:23:52 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:53 INFO - PID 2100 | RSS: Main: 307339264 05:23:53 INFO - PID 2100 | 05:23:55 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:56 INFO - PID 2100 | RSS: Main: 309399552 05:23:56 INFO - PID 2100 | 05:23:59 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:00 INFO - PID 2100 | RSS: Main: 325521408 05:24:00 INFO - PID 2100 | 05:24:03 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:04 INFO - PID 2100 | RSS: Main: 320098304 05:24:04 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49488/tests/kraken/driver.html?testName=ai-astar) 05:24:06 INFO - PID 2100 | RSS: Main: 382771200 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | __start_tp_report 05:24:06 INFO - PID 2100 | _x_x_mozilla_page_load 05:24:06 INFO - PID 2100 | _x_x_mozilla_page_load_details 05:24:06 INFO - PID 2100 | |i|pagename|runs| 05:24:06 INFO - PID 2100 | |0;ai-astar;112;123;122;123;124;122;123;124;131;181 05:24:06 INFO - PID 2100 | |1;audio-beat-detection;159;120;120;184;156;157;119;124;188;118 05:24:06 INFO - PID 2100 | |2;audio-dft;217;222;210;216;214;218;215;211;263;263 05:24:06 INFO - PID 2100 | |3;audio-fft;84;66;68;101;70;66;61;67;82;66 05:24:06 INFO - PID 2100 | |4;audio-oscillator;98;78;126;113;109;74;95;105;68;107 05:24:06 INFO - PID 2100 | |5;imaging-gaussian-blur;94;93;94;92;93;93;93;95;117;78 05:24:06 INFO - PID 2100 | |6;imaging-darkroom;101;101;99;101;101;109;158;102;101;102 05:24:06 INFO - PID 2100 | |7;imaging-desaturate;103;103;105;102;101;101;104;103;104;102 05:24:06 INFO - PID 2100 | |8;json-parse-financial;53;50;51;51;51;51;51;53;53;51 05:24:06 INFO - PID 2100 | |9;json-stringify-tinderbox;58;66;68;77;71;68;64;64;64;66 05:24:06 INFO - PID 2100 | |10;stanford-crypto-aes;93;92;91;92;92;90;91;88;94;91 05:24:06 INFO - PID 2100 | |11;stanford-crypto-ccm;149;182;176;148;152;156;170;172;256;197 05:24:06 INFO - PID 2100 | |12;stanford-crypto-pbkdf2;205;201;204;204;203;208;206;203;203;201 05:24:06 INFO - PID 2100 | |13;stanford-crypto-sha256-iterative;70;76;73;73;76;89;108;69;80;114 05:24:06 INFO - PID 2100 | __end_tp_report 05:24:06 INFO - PID 2100 | __start_cc_report 05:24:06 INFO - PID 2100 | _x_x_mozilla_cycle_collect,2185 05:24:06 INFO - PID 2100 | __end_cc_report 05:24:06 INFO - PID 2100 | __startTimestamp1491049446539__endTimestamp 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | ------- Summary: start ------- 05:24:06 INFO - PID 2100 | Number of tests: 14 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#0] ai-astar Cycles:10 Average:128.50 Median:123.50 stddev:19.00 (15.4%) stddev-sans-first:19.20 05:24:06 INFO - PID 2100 | Values: 112.0 123.0 122.0 123.0 124.0 122.0 123.0 124.0 131.0 181.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:156.50 stddev:27.74 (17.7%) stddev-sans-first:28.92 05:24:06 INFO - PID 2100 | Values: 159.0 120.0 120.0 184.0 156.0 157.0 119.0 124.0 188.0 118.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#2] audio-dft Cycles:10 Average:224.90 Median:217.50 stddev:20.37 (9.4%) stddev-sans-first:21.40 05:24:06 INFO - PID 2100 | Values: 217.0 222.0 210.0 216.0 214.0 218.0 215.0 211.0 263.0 263.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#3] audio-fft Cycles:10 Average:73.10 Median:67.50 stddev:12.23 (18.1%) stddev-sans-first:12.32 05:24:06 INFO - PID 2100 | Values: 84.0 66.0 68.0 101.0 70.0 66.0 61.0 67.0 82.0 66.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:71.00 stddev:18.68 (26.3%) stddev-sans-first:19.81 05:24:06 INFO - PID 2100 | Values: 98.0 78.0 126.0 113.0 109.0 74.0 95.0 105.0 68.0 107.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:93.00 stddev:9.39 (10.1%) stddev-sans-first:9.96 05:24:06 INFO - PID 2100 | Values: 94.0 93.0 94.0 92.0 93.0 93.0 93.0 95.0 117.0 78.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:102.00 stddev:17.94 (17.6%) stddev-sans-first:18.87 05:24:06 INFO - PID 2100 | Values: 101.0 101.0 99.0 101.0 101.0 109.0 158.0 102.0 101.0 102.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:103.00 stddev:1.32 (1.3%) stddev-sans-first:1.39 05:24:06 INFO - PID 2100 | Values: 103.0 103.0 105.0 102.0 101.0 101.0 104.0 103.0 104.0 102.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.08 (2.1%) stddev-sans-first:1.00 05:24:06 INFO - PID 2100 | Values: 53.0 50.0 51.0 51.0 51.0 51.0 51.0 53.0 53.0 51.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:5.02 (7.5%) stddev-sans-first:4.25 05:24:06 INFO - PID 2100 | Values: 58.0 66.0 68.0 77.0 71.0 68.0 64.0 64.0 64.0 66.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:92.00 stddev:1.65 (1.8%) stddev-sans-first:1.64 05:24:06 INFO - PID 2100 | Values: 93.0 92.0 91.0 92.0 92.0 90.0 91.0 88.0 94.0 91.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#11] stanford-crypto-ccm Cycles:10 Average:175.80 Median:174.00 stddev:32.35 (18.6%) stddev-sans-first:32.82 05:24:06 INFO - PID 2100 | Values: 149.0 182.0 176.0 148.0 152.0 156.0 170.0 172.0 256.0 197.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.80 Median:204.00 stddev:2.15 (1.1%) stddev-sans-first:2.24 05:24:06 INFO - PID 2100 | Values: 205.0 201.0 204.0 204.0 203.0 208.0 206.0 203.0 203.0 201.0 05:24:06 INFO - PID 2100 | 05:24:06 INFO - PID 2100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.80 Median:74.50 stddev:15.96 (21.4%) stddev-sans-first:16.25 05:24:06 INFO - PID 2100 | Values: 70.0 76.0 73.0 73.0 76.0 89.0 108.0 69.0 80.0 114.0 05:24:06 INFO - PID 2100 | -------- Summary: end -------- 05:24:06 INFO - PID 2100 | 05:24:07 INFO - TEST-INFO | 2100: exit 0 05:24:07 INFO - TEST-OK | kraken | took 63776ms 05:24:07 INFO - SUITE-END | took 1185s 05:24:07 INFO - Completed test suite (00:19:46) 05:24:07 INFO - javascript benchmark 05:24:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7531.533922844908, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3495.300939812038, 3503.5095086687884, 3533.116720819795, 3533.7526373153883, 3576.8926932192044, 5351.25082488451, 6174.475169610583, 6189.53578481614, 6219.067139929001, 6238.500919926406, 5822.854428639286, 6066.272047354312, 6143.5118776895315, 6215.62706237626, 6248.656323902183, 5342.866428339284, 5353.116735738598, 5396.730163491809, 5400.78396864125, 5475.589330800186, 4991.650584459071, 5268.236105764662, 5342.786288548473, 5417.133258678612, 5419.376771671269, 5376.623636345457, 5377.5429088527135, 5378.327709036371, 5378.704171270579, 5385.138377859524, 5310.92033619496, 5347.25138480613, 5360.946390536123, 5368.731563421813, 5378.2470454136455, 5278.287431196778, 5327.9733601331745, 5334.653247538898, 5339.786408543654, 5347.812826551091, 6114.829235621335, 6116.0, 6117.410478740911, 6125.877482450371, 6137.2942111657285, 6368.968155159241, 6396.264429590564, 6405.6797160141805, 6414.61512309263, 6417.679116044179, 6430.549861509696, 6450.387213214737, 6452.193475815523, 6467.288598254188, 6610.669466526654, 5240.816571420059, 6303.527235457267, 6344.04839274108, 6359.586626869239, 6361.8727625448155, 6570.671466426755, 6643.60138391698, 6864.931350686529, 6872.140982377203, 6889.724411023603, 6379.968100159563, 6409.583377080475, 6425.678716064178, 6458.418742313214, 6475.740970361227, 6627.569208001464, 6644.235912869985, 6655.101561289261, 6669.799906002828, 6682.599044057372, 6561.1470508833545, 6575.44108750752, 6576.868462630816, 6580.638064906476, 6602.966985165043, 6165.013597824327, 6275.843103922439, 6341.239051313872, 6343.936560634427, 6359.20509936258, 5205.609579281569, 5224.05966925957, 5231.607629427732, 5240.947590524046, 5242.082635538765, 3928.508936382952, 4641.350210970467, 4703.576678098988, 4717.669763116617, 4729.243321068681, 6338.429541341301, 6351.777687780906, 6355.936440635534, 6356.809295721136, 6370.458511026522, 6589.901151482732, 6648.235452922976, 6672.2994085621285, 6672.2994085621285, 6676.666166691646, 6112.1387513176505, 6186.226721659793, 6190.226221722285, 6248.937510624835, 6329.746810127635, 5835.533157347402, 5836.503897168704, 5841.153032810219, 5850.736716847752, 5889.587728858939, 6832.965835170792, 6887.345702158287, 6902.723891044302, 6908.965455172692, 6914.9308506914285, 6343.111964324906, 6413.1021656969, 6432.839179020562, 6639.867202655823, 6660.300668429745, 6671.966640166768, 6672.366125218096, 6675.7997260082275, 6676.799696009128, 6681.231658359351, 6365.14070600463, 6375.362463753588, 6387.265464471459, 6394.584352017104, 6407.583507072025, 6577.80266592003, 6635.568688035262, 6670.166229221348, 6674.065630811788, 6674.998750187317, 6312.810615681537, 6414.775482858077, 6431.710573024318, 6435.420812126931, 6449.580777249464, 6267.467265282502, 6363.713632886439, 6442.484601231984, 6443.806685799434, 6449.258335291313, 6279.623222606659, 6296.527760418078, 6308.179936608211, 6308.621482711052, 6312.873742525216, 6266.091416744455, 6348.174737284308, 6350.7777227796805, 6358.809235722936, 6362.491000720024, 6293.496520278458, 6362.3319551448285, 6364.172657554674, 6372.980323148274, 6376.39424254695], "value": 6012.140230568309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.6992278281731, 806.5241507510567, 1129.2546919033434, 1148.9827652585213, 1151.9827202591957, 36410.81794591027, 37017.814910925445, 37217.627823721756, 37301.067473313145, 37386.06534836624, 38897.8330650081, 39160.0, 39193.02017449565, 39307.41038884412, 39335.213295734065, 5904.586678932476, 6009.338972712998, 8427.83144337113, 8576.356773242002, 8581.613827377783, 8292.37807164462, 8472.576371181416, 8488.23605875471, 8499.937507811523, 8508.659653613848, 8487.702930397438, 8563.529005904673, 8575.013873404576, 8583.313334933222, 8592.957035214815, 8465.703700370488, 8550.871736923982, 8562.315014798864, 8562.486250824908, 8591.613377397969, 7072.646367681596, 8536.8719469208, 8547.35894807892, 8547.957260213721, 8554.82890342196, 37040.81479592585, 37174.62825371766, 37197.25605487875, 37214.88355349344, 37356.0, 2988.940221195564, 3004.143819011593, 3011.1869795155403, 3015.7587393008507, 3031.8484075796123, 26694.866525667443, 26724.33189170267, 26783.25585107451, 26969.595456068175, 27147.86426067857, 2731.7677997370247, 2752.6146339512484, 2765.6542932133484, 2790.3024243939017, 2796.4546913351905, 320155.3992230047, 322248.38875805703, 322586.9025062125, 322805.0, 323419.0, 39366.40950385747, 40045.39931901024, 40122.59570915004, 49621.25568116481, 49845.50154498409, 41882.790586046875, 41982.160356792694, 41993.58006419958, 42003.0, 49669.503304966485, 13826.446942122404, 14098.365573549216, 14130.010899236955, 14137.78793318101, 14170.0, 10012.349197302152, 11493.942530287295, 11512.481938312796, 11518.251313664585, 11558.0, 9496.90503094974, 10676.0, 11882.108841836896, 12075.45660445282, 12084.637460876187, 4724.858254252378, 4864.6594738368685, 5145.871353216199, 5203.427622961472, 5216.365735303647, 953.5565961827783, 956.2445667922402, 971.3977334052933, 976.7948730766476, 1023.1610079734695, 21804.563908721735, 23332.53334933292, 23384.766152338598, 23540.882295588413, 23565.882170589037, 1049.1344640671477, 1073.7369344510646, 1086.5056399338282, 1101.2676570080966, 1108.4180805077237, 9606.855897161548, 11928.522859085539, 12064.879351206375, 12095.939520302518, 12106.334151621746, 447976.0, 448517.0, 448793.0, 449690.0, 449799.7510012429, 51868.74065629723, 51900.0, 52022.73988630108, 52028.73985630123, 52036.73981630067, 1443.1196969848384, 1488.761798112297, 1501.0543357684808, 1512.0927443533792, 1522.6041229280245, 23477.647835282827, 23482.88258558696, 23508.177213797437, 23556.8822155895, 23558.882205588863, 38060.955123590604, 38264.85205443841, 38266.808665956494, 38282.0, 38299.85100446991, 439490.0, 441390.0, 441922.0, 441925.7903710461, 441931.0, 25695.614565781903, 26106.0, 31407.52888706717, 31645.0, 32258.516122258654, 31514.842425787723, 31621.20946976344, 40349.1930161401, 41620.791896040326, 41946.1610767789, 23545.529089417774, 27860.488290981564, 27949.441011179257, 28247.2938176539, 29592.556111658774, 26556.070537531094, 28517.857410712815, 29293.707062929097, 29519.55720664235, 29586.408271834873, 32989.0, 33418.164545886546, 33949.0, 34190.31619367549, 34388.0, 29039.709602904546, 29183.70816291895, 29948.0, 29969.400611988076, 30218.54672179963, 21745.565088698455, 23086.769132309135, 23337.066517339117, 23518.64722029137, 23771.762282377647], "value": 16999.77363122568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.3357660457921, 426.2412905029049, 428.84347213267165, 432.37090034000533, 451.6432018705223, 17326.393576224833, 21859.72104184373, 22215.44461388466, 23105.30684079476, 23365.76634233657, 22492.0, 22670.88664556679, 23225.767742322612, 23825.689587072706, 24109.39726506834, 5229.581633469314, 5991.760329586822, 6202.9689851550675, 6228.408301211378, 6240.719167637467, 3680.392735198689, 3878.2437424702193, 3885.1452680410266, 5976.940230597704, 6262.530310226728, 3860.478835357233, 3867.38121900496, 3872.457855900176, 3874.9925019494995, 5949.464548190662, 6063.484603808682, 6079.6960151992225, 6169.691515424211, 6212.316645169028, 6218.782342618032, 5027.899442011176, 5091.23631455281, 5416.404195538487, 5464.836054918359, 5470.56235501159, 26328.73671263301, 26657.866710666516, 26904.192874213608, 27583.0, 27736.0, 2009.9598008039757, 2051.4050925231663, 2061.7628972668185, 2076.356329537848, 2153.569286142778, 16738.83261167385, 16780.328786848513, 17060.0, 17363.65272694539, 17528.386506472212, 1853.4161739052156, 1881.9811801882079, 1883.3784850999136, 1888.3485197606803, 1897.7627796525435, 136113.3194334032, 143489.56510434867, 144094.27952860272, 163126.18436907858, 170102.44846327315, 10087.7478063049, 12520.561780337644, 12628.936855315664, 12685.809712854314, 12819.871801282054, 16706.331746730237, 16730.16349182536, 16754.99470031802, 16755.078470684228, 16765.497035088723, 8218.753437396888, 8561.015483219386, 8772.78068048304, 9098.499582522893, 9264.11990860867, 7003.478747650842, 8668.306535477146, 8725.694600689072, 8929.10708929102, 8932.508712020772, 7788.883166752503, 7883.211678832071, 7939.920600794034, 7948.801279967932, 7958.164392738795, 1973.7828838827718, 2108.81020708137, 2129.6911947767485, 2139.1871088986086, 2299.275728145629, 865.1132589096227, 882.8896387951506, 885.3890815337396, 914.9908500915038, 924.3160061554536, 19925.10337034837, 20051.398458046282, 21441.571168576542, 21652.675209871864, 21723.022463989157, 913.4199783137756, 934.7287688743304, 967.4678926590348, 970.2383628851318, 973.2894986659778, 9706.0, 9966.152877005536, 11075.05862001739, 11088.944555277334, 11099.944500277446, 702704.0, 705618.0, 706976.0, 711941.0, 724013.0, 152649.0, 157501.0, 160771.39228607563, 163156.0, 163331.0, 1094.2887123369874, 1123.2867129372744, 1149.827525871126, 1150.6778102131416, 1152.6023521884936, 12971.675708107372, 18085.909570452062, 18618.813811861706, 18867.433976980712, 19107.80892191116, 60737.088943666764, 63590.0, 64615.67692161509, 65014.0, 65512.0, 85318.57340713257, 86417.0, 86995.56502217449, 87269.0, 88834.0, 7623.69505219785, 8427.367947403847, 8525.786855328419, 8553.101924298107, 8790.164934331227, 10805.621803236849, 13662.453501860213, 13699.794503082263, 14083.732464078283, 14327.57017289483, 11734.589289374831, 11812.291262524275, 12036.578719744766, 12046.578369757017, 12080.697982550506, 10369.84445233307, 10944.945275273572, 10960.013598776148, 10969.890301096886, 11400.429978501208, 9729.805403891742, 11763.470643820878, 11812.940935295268, 11944.462499187384, 12130.33283169434, 8079.474834135763, 8220.780389294738, 8592.742217733477, 8598.82802343962, 9131.406458580172, 11431.714207144887, 11702.239354441934, 12125.454354553889, 12148.149629526202, 12190.451429685863], "value": 10245.982894374783, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.5355106039474, 1455.672473693419, 1460.0874453466583, 1477.6896851661152, 1478.5416520878534, 10267.127294179994, 10684.091852192563, 10696.358218506895, 10703.250772445932, 10713.464326783649, 10446.425446600433, 10448.582056717722, 10760.354378737282, 10768.946155269212, 10778.73053173671, 2401.6877805885256, 2444.523317953, 2446.217210492643, 2446.2905757330354, 2448.571499987504, 2324.407276144581, 2410.457647029422, 2417.516496700658, 2421.140495124232, 2427.0655797517993, 2043.9795602043937, 2351.3651314145254, 2410.939726506843, 2416.4200591858003, 2440.4996975620043, 2309.7690230976937, 2377.560151371993, 2381.047580967618, 2388.605880029793, 2393.3418309964727, 2373.56089123511, 2378.678878351435, 2391.175044609607, 2395.796357309631, 2402.8678422686744, 10633.308834925783, 10836.349819010884, 10838.891611083867, 10853.914608539162, 10874.075703565206, 6102.755889764404, 6342.365763423667, 6364.427201551883, 6371.108044873721, 6372.745090196387, 3983.223271462066, 3994.3409337459284, 4025.5169379674626, 4038.5961403859674, 4068.6338229559483, 1137.4199158429178, 1171.9882801171964, 1177.2289150606366, 1195.1932445599186, 1206.6319772469394, 13407.865921340759, 13807.930960345235, 13828.723425531432, 14583.416663333453, 14745.926270368687, 4393.846215382447, 4773.307870358779, 4895.632827537949, 4933.358663373739, 5352.063388906926, 11175.764847030627, 11190.496427660775, 11200.383978881076, 11211.943940280247, 11219.270747401393, 6237.313895471494, 6243.219597550306, 6244.406781355855, 6250.593711408835, 6251.74993000284, 5555.333359996826, 5777.913331300034, 5809.09958956354, 5873.3245676746865, 5874.618149820248, 4066.0, 4168.624823765876, 4186.727862688916, 4227.387028880795, 4251.404803327537, 1250.2873362183468, 1252.323745177594, 1254.6549698832894, 1270.84749830021, 1274.7004453953314, 721.7077083781077, 729.3508777188307, 749.8612756640039, 752.6951584608242, 782.0537150048391, 5458.317710286215, 5597.720113994284, 5664.85837854057, 5687.943120568824, 5700.828975130753, 535.6464733276019, 560.9607327487118, 594.2334388638694, 596.1028651878895, 597.4772074434869, 3585.659362360572, 3645.927081458356, 3786.67813235878, 3789.3368660484307, 3816.4084566892175, 12980.740385192243, 13638.0, 13650.453981840814, 13658.52195173184, 13670.316484175752, 12927.741445171045, 13169.53906613264, 13548.254845983369, 13570.117942333716, 13585.0, 7160.892586611205, 8503.65985360591, 9973.650922217688, 10037.096661300518, 10093.899061009295, 6427.517936154713, 6614.140161778938, 6632.0, 6691.330866913269, 6743.629100399525, 10639.468026598794, 11786.941065294961, 12100.515979360727, 12176.964957978671, 12338.012958963442, 12227.388630568257, 12266.202696824677, 12316.753664926471, 12450.937745311216, 12454.0, 6894.689738961859, 7966.3626909848235, 8009.8398032040195, 8080.111187769223, 8095.959520202597, 9683.886353069205, 9728.17310528613, 9818.607255709692, 9819.9018009819, 9845.310828241954, 8231.34149268045, 8447.915520844714, 8502.064772875103, 8536.530490823065, 8630.266427353745, 8214.876776848472, 8233.46482478637, 8262.545559994258, 8482.957585212034, 8516.105808889977, 6054.455099041107, 7485.5508669480005, 7755.961220193863, 7862.371010319046, 7870.449068565145, 4885.560299573055, 5751.568632352507, 5843.1235314703135, 5985.25184351956, 6006.699665016644, 4830.613550915848, 5983.341832398346, 5993.640381577119, 6054.3642917493025, 6115.388461153849], "value": 4966.031091361586, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9079871437926, 389.375053039871, 393.69095260220735, 393.8916797880584, 399.8860324807427, 4938.975305123474, 5972.19375384323, 5981.641101533905, 5990.1913241712355, 6009.2788865336115, 4518.638508919287, 5744.770209191627, 5904.261967254093, 5916.852078698024, 5949.851253718659, 4102.8255024836735, 4128.504579450455, 4468.575485328896, 4540.296254080623, 4543.954560454403, 4421.115776844628, 4505.459344878619, 4526.773661316937, 4534.659900507459, 4551.863444096666, 3683.410654295313, 3742.9438558421643, 3853.626134337519, 4487.483939346968, 4515.864524064284, 4029.758214507124, 4443.46678398591, 4461.263891457906, 4473.150101480708, 4504.932426013613, 3942.7831469269177, 3974.721769476138, 3980.24375368679, 3982.422548730418, 3988.102676897704, 4711.597085486393, 5186.818461353872, 5784.71076446176, 5812.418758124154, 5819.127130930395, 4839.249916262985, 5131.281620573122, 5147.819826306099, 5157.510036546522, 5165.793368265265, 6251.937480625181, 6276.529260305495, 6289.213848268966, 6289.37106289372, 6296.9370306296805, 3570.0, 4040.616141466556, 4226.492820861486, 4240.766757828318, 4246.341817018367, 5542.258975191729, 6092.08618707193, 6368.1154495757555, 6490.740370385226, 6505.934940650627, 4142.834286628561, 4301.78491075445, 4306.7940976526625, 4326.978365108154, 4344.782760861945, 4359.346098085249, 4392.253316936129, 4393.253146965024, 4399.472063352354, 4411.713238639478, 4721.291806229093, 4783.521647835189, 5145.331106956071, 5179.689218646893, 5219.712915789592, 5259.895421961354, 5417.729113544386, 6247.938839754105, 6276.525016621091, 6296.0, 1173.0, 1295.1581472043247, 1458.5332693537966, 1486.5317425011087, 1489.2777003153462, 887.3877024852831, 978.6770365779275, 979.1481411172325, 988.0958922585753, 1006.3509036671306, 5019.548240658358, 5198.972400763705, 5600.35595906476, 5692.861427714473, 6006.579539432198, 6228.0, 6476.6114033158165, 6481.384268494486, 6489.67551622417, 6496.285408605049, 4623.352730617717, 5704.258446402024, 5915.881682366328, 5924.555658325643, 5953.22608060958, 3396.626371099177, 3399.079520071152, 3411.368896754059, 3417.8974630761118, 3418.1454636340914, 6102.931986902275, 6154.691990503561, 6505.837354066186, 6767.221769496571, 6809.591424514446, 5585.664860108406, 5594.104943209067, 6639.236487803868, 6672.0325552794575, 6677.76627818024, 6321.557490975588, 6719.160104986877, 6729.764458243938, 6755.392014718601, 6768.390844823989, 6399.616023038632, 6465.903011454926, 6477.643729594729, 6488.156539650005, 6505.837354066186, 5908.852278693067, 5963.0, 6312.526560508072, 6416.17688217183, 6426.228852537725, 5031.748172793983, 5963.70181490915, 6198.535109866688, 6256.718447669775, 6713.556585333981, 3768.3593789056476, 4276.91446171081, 4299.656027517729, 4301.268784306738, 4326.545712700121, 6274.692075296204, 6338.239411270677, 6484.967575162094, 6522.934770652422, 6536.182977127859, 5735.8566035849435, 5770.653760774367, 6201.976673848945, 6238.132357938108, 6264.0, 5222.9216561750845, 6254.061890716247, 6261.812145635638, 6263.4362907338555, 6361.360035585365, 5771.394003629726, 6102.328743838263, 6107.877842443215, 6178.62928224308, 6204.410580994799, 6124.755009799558, 6271.184745982993, 6279.560430769802, 6286.402791734778, 6290.182276304051, 4535.727856328631, 5903.192440875697, 6112.144299798121, 6112.235970503687, 6135.233095863017], "value": 4560.85798755296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.4224941171768, 732.7801659502152, 736.547023580498, 749.7975546602414, 759.6923246085336, 15622.76565851513, 16371.427000055, 16409.34362625495, 16409.507714768562, 16644.750328745078, 17957.91021044896, 18256.81743182568, 18273.177707003182, 18276.817231827677, 18311.633767324678, 963.0369630369648, 973.9513024348789, 986.0287616697548, 986.5511192407438, 987.6148302162162, 1004.8593196952432, 1005.0753306957616, 1005.8541511480831, 1006.0, 1007.5214273220236, 1006.9395836249848, 1023.355286169712, 1051.4322265976364, 1052.8157572424834, 1067.0503252105632, 1008.2690049713935, 1039.3088596083596, 1042.4162469017374, 1043.4156872151543, 1044.1281529922485, 751.1324420294568, 767.5394763142126, 771.996140019302, 772.3357912195507, 772.9690812367498, 12304.938475307566, 16198.02811831282, 16738.81962427135, 16896.40862569804, 17456.0, 15073.147194739158, 15140.318685659062, 15282.465113721077, 15285.61785955349, 16328.83671163297, 11391.0, 11624.0, 11725.472353744102, 11773.41132943358, 12056.819147712791, 2915.877819352733, 2999.1902186409548, 3015.7888947773663, 3029.5455681647927, 3067.2485241115846, 118792.40603796925, 120469.0, 121348.0, 123361.38319308436, 125974.99999999908, 11622.70943226426, 11628.244164129474, 11677.708057298465, 11840.70398240051, 11879.22785018971, 25513.489730205292, 26127.608085878728, 26134.86932565325, 26191.083312083985, 26204.60693089605, 6928.757493487704, 7989.720359787496, 8159.83680326402, 8163.755087347389, 8325.916740832636, 3888.6305800948867, 3990.4812374391145, 4007.338789099766, 4078.3270760324212, 4080.7143499955314, 3108.362785628941, 4152.1695660867945, 4258.212230737262, 4266.850660226877, 4278.379634952977, 784.8704963680929, 794.6265255329986, 805.7703554486943, 817.3787921179946, 827.8923739913893, 542.9782808687609, 574.8476653686777, 585.8330375842864, 593.7921727395463, 593.9940600593939, 9578.521073946275, 10102.657154930335, 10302.227332950059, 10338.689839304832, 10547.472626368652, 528.6959998001165, 546.6064433607796, 581.3635708642498, 589.9380565040694, 596.8179705189872, 4657.208274593328, 4824.059308434821, 4827.253224224844, 4833.564979151823, 4846.927296090562, 106045.0, 106867.0, 107856.0, 109145.45427272812, 111162.88837111687, 70256.64871675712, 95036.0, 95459.0, 98492.0, 99742.0, 62658.0, 83897.0, 85282.14717852866, 86535.0, 86538.56730716306, 9511.116857542229, 9667.517400237673, 9669.922817773457, 9686.632407402702, 9687.85677606554, 41148.971275718344, 41540.0, 41804.1639167221, 41988.95027624334, 42204.366934495396, 49942.25086623631, 53741.73129134329, 54595.72702136464, 54757.0, 55271.0, 11706.35615041181, 11750.29498230109, 11867.397901283217, 12005.459754310903, 12332.876671233173, 12520.74958500843, 12827.294498802656, 12907.419166137734, 13212.075154739076, 13271.0, 13395.330233488481, 14038.470138685492, 14177.574672759834, 14189.432422703389, 14436.133831970115, 14013.089149205269, 14276.928615356857, 14277.42890284377, 14458.710825783215, 14762.966592338433, 13820.585382438543, 13906.791398129239, 13995.650108747363, 14482.275886205436, 14570.0, 10239.0, 10409.271351005356, 10515.737106572396, 10557.894421055691, 10980.670579882617, 8494.447860889022, 9694.46680432583, 10528.894711052792, 11176.944115279372, 11711.121665874924], "value": 7694.589783415037, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1644.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 122.0, 123.0, 124.0, 122.0, 123.0, 124.0, 131.0, 181.0], "value": 128.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 120.0, 120.0, 184.0, 156.0, 157.0, 119.0, 124.0, 188.0, 118.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 222.0, 210.0, 216.0, 214.0, 218.0, 215.0, 211.0, 263.0, 263.0], "value": 224.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 66.0, 68.0, 101.0, 70.0, 66.0, 61.0, 67.0, 82.0, 66.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 78.0, 126.0, 113.0, 109.0, 74.0, 95.0, 105.0, 68.0, 107.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 95.0, 117.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 99.0, 101.0, 101.0, 109.0, 158.0, 102.0, 101.0, 102.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 105.0, 102.0, 101.0, 101.0, 104.0, 103.0, 104.0, 102.0], "value": 102.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 53.0, 53.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 66.0, 68.0, 77.0, 71.0, 68.0, 64.0, 64.0, 64.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 91.0, 92.0, 92.0, 90.0, 91.0, 88.0, 94.0, 91.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 182.0, 176.0, 148.0, 152.0, 156.0, 170.0, 172.0, 256.0, 197.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 201.0, 204.0, 204.0, 203.0, 208.0, 206.0, 203.0, 203.0, 201.0], "value": 203.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 73.0, 73.0, 76.0, 89.0, 108.0, 69.0, 80.0, 114.0], "value": 82.8, "unit": "score"}]}]} 05:24:07 INFO - Return code: 0 05:24:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:07 ERROR - # TBPL SUCCESS # 05:24:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:24:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:24:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:24:07 INFO - 2017-04-01 05:24:07.805 screenresolution[2104:23170] starting screenresolution argv=screenresolution get 05:24:07 INFO - 2017-04-01 05:24:07.808 screenresolution[2104:23170] Display 0: 1600x1200x32@60 05:24:07 INFO - 2017-04-01 05:24:07.815 screenresolution[2105:23173] starting screenresolution argv=screenresolution list 05:24:07 INFO - Available Modes on Display 0 05:24:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:24:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:24:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:24:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:24:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:24:08 INFO - Intel Iris: 05:24:08 INFO - Chipset Model: Intel Iris 05:24:08 INFO - Type: GPU 05:24:08 INFO - Bus: Built-In 05:24:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:24:08 INFO - Vendor: Intel (0x8086) 05:24:08 INFO - Device ID: 0x0a2e 05:24:08 INFO - Revision ID: 0x0009 05:24:08 INFO - Displays: 05:24:08 INFO - Display: 05:24:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:24:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:24:08 INFO - Display Serial Number: 1600x1200 60 05:24:08 INFO - Main Display: Yes 05:24:08 INFO - Mirror: Off 05:24:08 INFO - Online: Yes 05:24:08 INFO - Rotation: Supported 05:24:08 INFO - Return code: 0 05:24:08 INFO - Running post-action listener: _resource_record_post_action 05:24:08 INFO - [mozharness: 2017-04-01 12:24:08.062043Z] Finished run-tests step (success) 05:24:08 INFO - Running post-run listener: _resource_record_post_run 05:24:08 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 1241088; Write bytes: 519097344; Read time: 13; Write time: 1605 05:24:08 INFO - TinderboxPrint: CPU usage
53.5% 05:24:08 INFO - TinderboxPrint: I/O read bytes / time
1,241,088 / 13 05:24:08 INFO - TinderboxPrint: I/O write bytes / time
519,097,344 / 1,605 05:24:08 INFO - TinderboxPrint: CPU idle
2,246.1 (46.5%) 05:24:08 INFO - TinderboxPrint: CPU system
967.0 (20.0%) 05:24:08 INFO - TinderboxPrint: CPU user
1,616.6 (33.5%) 05:24:08 INFO - TinderboxPrint: Swap in / out
212,688,896 / 0 05:24:08 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203901440; Write bytes: 206604288; Read time: 15656; Write time: 466 05:24:08 INFO - run-tests - Wall time: 1187s; CPU: 53.0%; Read bytes: 1241088; Write bytes: 302547968; Read time: 13; Write time: 1104 05:24:08 INFO - Running post-run listener: _upload_blobber_files 05:24:08 INFO - Blob upload gear active. 05:24:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:08 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:24:08 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:24:08 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:24:08 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:09 INFO - (blobuploader) - INFO - Done attempting. 05:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:10 INFO - (blobuploader) - INFO - Done attempting. 05:24:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:24:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:24:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:11 INFO - (blobuploader) - INFO - Done attempting. 05:24:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:14 INFO - (blobuploader) - INFO - Done attempting. 05:24:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:14 INFO - Return code: 0 05:24:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f59218ab1003bd4b6652bc38b997b82d6aa7bbbb43bc371d99731995fe802e5f526443332ce02360fbd6deeb90d08ba5b1bda45d0b9605417769e2427fd892b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec276bfd96b79764713e97e6d4ee159a85801a680be83e2468100a3a81cda200f86f74521fbba085e3bab9446c33c1b55fd3e71314ba730ee39a7eaa289d5ad8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/750d176947029fd7d7f87665f80565a5cd7690cf7b722540d5d5506e936c6be1a879f6c1f8b24e4765c17d9b19a344e68f7a7ce562fb618de3866b33bdf6dcda", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ffb269c21b0c76851eb8bb7b9a6ac89903a5b7c767006e3c7a5edeeeeb74b25c148103822922940279dfff5db3e797de392113d34b0e9f154473a3e27893b1b"} 05:24:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:14 INFO - Contents: 05:24:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f59218ab1003bd4b6652bc38b997b82d6aa7bbbb43bc371d99731995fe802e5f526443332ce02360fbd6deeb90d08ba5b1bda45d0b9605417769e2427fd892b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec276bfd96b79764713e97e6d4ee159a85801a680be83e2468100a3a81cda200f86f74521fbba085e3bab9446c33c1b55fd3e71314ba730ee39a7eaa289d5ad8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/750d176947029fd7d7f87665f80565a5cd7690cf7b722540d5d5506e936c6be1a879f6c1f8b24e4765c17d9b19a344e68f7a7ce562fb618de3866b33bdf6dcda", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ffb269c21b0c76851eb8bb7b9a6ac89903a5b7c767006e3c7a5edeeeeb74b25c148103822922940279dfff5db3e797de392113d34b0e9f154473a3e27893b1b"} 05:24:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:14 INFO - Copying logs to upload dir... 05:24:14 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.533473 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-01 05:24:14.117307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:14.122808) ========= 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.wkda09udCh/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.D6zjfqh5ck/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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/f59218ab1003bd4b6652bc38b997b82d6aa7bbbb43bc371d99731995fe802e5f526443332ce02360fbd6deeb90d08ba5b1bda45d0b9605417769e2427fd892b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec276bfd96b79764713e97e6d4ee159a85801a680be83e2468100a3a81cda200f86f74521fbba085e3bab9446c33c1b55fd3e71314ba730ee39a7eaa289d5ad8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/750d176947029fd7d7f87665f80565a5cd7690cf7b722540d5d5506e936c6be1a879f6c1f8b24e4765c17d9b19a344e68f7a7ce562fb618de3866b33bdf6dcda", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ffb269c21b0c76851eb8bb7b9a6ac89903a5b7c767006e3c7a5edeeeeb74b25c148103822922940279dfff5db3e797de392113d34b0e9f154473a3e27893b1b"} build_url:https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/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/f59218ab1003bd4b6652bc38b997b82d6aa7bbbb43bc371d99731995fe802e5f526443332ce02360fbd6deeb90d08ba5b1bda45d0b9605417769e2427fd892b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec276bfd96b79764713e97e6d4ee159a85801a680be83e2468100a3a81cda200f86f74521fbba085e3bab9446c33c1b55fd3e71314ba730ee39a7eaa289d5ad8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/750d176947029fd7d7f87665f80565a5cd7690cf7b722540d5d5506e936c6be1a879f6c1f8b24e4765c17d9b19a344e68f7a7ce562fb618de3866b33bdf6dcda", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ffb269c21b0c76851eb8bb7b9a6ac89903a5b7c767006e3c7a5edeeeeb74b25c148103822922940279dfff5db3e797de392113d34b0e9f154473a3e27893b1b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:14.158856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:14.159245) ========= 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.wkda09udCh/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.D6zjfqh5ck/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005270 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:14.211434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:24:14.212153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:24:14.212952) ========= ========= Total master_lag: 0.19 =========