builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0311 starttime: 1491826119.95 results: success (0) buildid: 20170410030221 builduid: 095bc7be1faf49689ab66bd5d04df180 revision: 731639fccc709a4dd95fed7e9dda88efb2227906 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:39.948766) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:39.949318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:39.949694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:39.977736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:39.978379) ========= 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.9L8TWfbRfJ/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.762tMWg5DA/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-10 05:08:40-- 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% 19.0M=0.001s 2017-04-10 05:08:40 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172382 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:40.177453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:40.177839) ========= 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.9L8TWfbRfJ/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.762tMWg5DA/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.028138 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:40.228004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 05:08:40.228404) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 731639fccc709a4dd95fed7e9dda88efb2227906 --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 731639fccc709a4dd95fed7e9dda88efb2227906 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9L8TWfbRfJ/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.762tMWg5DA/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-10 05:08:40,332 truncating revision to first 12 chars 2017-04-10 05:08:40,333 Setting DEBUG logging. 2017-04-10 05:08:40,333 attempt 1/10 2017-04-10 05:08:40,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/731639fccc70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 05:08:41,398 unpacking tar archive at: mozilla-central-731639fccc70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.362420 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 05:08:41.616551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:41.616933) ========= script_repo_revision: 731639fccc709a4dd95fed7e9dda88efb2227906 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:41.617416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:41.617761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 05:08:41.638901) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-10 05:08:41.639557) ========= /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.9L8TWfbRfJ/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.762tMWg5DA/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:08:41 INFO - MultiFileLogger online at 20170410 05:08:41 in /builds/slave/test 05:08:41 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:08:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:41 INFO - {'append_to_log': False, 05:08:41 INFO - 'base_work_dir': '/builds/slave/test', 05:08:41 INFO - 'blob_upload_branch': 'Firefox', 05:08:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:41 INFO - 'branch': 'Firefox', 05:08:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:41 INFO - 'config_files': ('talos/mac_config.py',), 05:08:41 INFO - 'default_actions': ('clobber', 05:08:41 INFO - 'read-buildbot-config', 05:08:41 INFO - 'download-and-extract', 05:08:41 INFO - 'populate-webroot', 05:08:41 INFO - 'create-virtualenv', 05:08:41 INFO - 'install', 05:08:41 INFO - 'run-tests'), 05:08:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:41 INFO - 'download_minidump_stackwalk': True, 05:08:41 INFO - 'download_symbols': 'ondemand', 05:08:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:41 INFO - 'gecko_profile': False, 05:08:41 INFO - 'gecko_profile_interval': 0, 05:08:41 INFO - 'installer_path': 'installer.exe', 05:08:41 INFO - 'log_level': 'info', 05:08:41 INFO - 'log_name': 'talos', 05:08:41 INFO - 'log_to_console': True, 05:08:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:41 INFO - 'opt_config_files': (), 05:08:41 INFO - 'pip_index': False, 05:08:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:41 INFO - 'cmd': ('bash', 05:08:41 INFO - '-c', 05:08:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:41 INFO - 'enabled': True, 05:08:41 INFO - 'halt_on_failure': False, 05:08:41 INFO - 'name': 'check_screen_resolution'},), 05:08:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:41 INFO - 'cmd': ('bash', 05:08:41 INFO - '-c', 05:08:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:41 INFO - 'enabled': True, 05:08:41 INFO - 'halt_on_failure': False, 05:08:41 INFO - 'name': 'check_screen_resolution'},), 05:08:41 INFO - 'run_cmd_checks_enabled': True, 05:08:41 INFO - 'suite': 'dromaeojs', 05:08:41 INFO - 'system_bits': '32', 05:08:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:41 INFO - 'title': 't-yosemite-r7-0311', 05:08:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:41 INFO - 'use_talos_json': True, 05:08:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:41 INFO - 'work_dir': 'build'} 05:08:41 INFO - [mozharness: 2017-04-10 12:08:41.853207Z] Running clobber step. 05:08:41 INFO - Running pre-action listener: _resource_record_pre_action 05:08:41 INFO - Running main action method: clobber 05:08:41 INFO - rmtree: /builds/slave/test/build 05:08:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:44 INFO - Running post-action listener: _resource_record_post_action 05:08:44 INFO - [mozharness: 2017-04-10 12:08:44.210789Z] Finished clobber step (success) 05:08:44 INFO - [mozharness: 2017-04-10 12:08:44.210919Z] Running read-buildbot-config step. 05:08:44 INFO - Running pre-action listener: _resource_record_pre_action 05:08:44 INFO - Running main action method: read_buildbot_config 05:08:44 INFO - Using buildbot properties: 05:08:44 INFO - { 05:08:44 INFO - "project": "", 05:08:44 INFO - "product": "firefox", 05:08:44 INFO - "script_repo_revision": "production", 05:08:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:08:44 INFO - "repository": "", 05:08:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:08:44 INFO - "buildid": "20170410030221", 05:08:44 INFO - "stage_platform": "macosx64", 05:08:44 INFO - "basedir": "/builds/slave/test", 05:08:44 INFO - "nightly_build": "True", 05:08:44 INFO - "buildnumber": 1, 05:08:44 INFO - "slavename": "t-yosemite-r7-0311", 05:08:44 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:08:44 INFO - "platform": "yosemite_r7", 05:08:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:08:44 INFO - "branch": "mozilla-central", 05:08:44 INFO - "repo_path": "mozilla-central", 05:08:44 INFO - "revision": "731639fccc709a4dd95fed7e9dda88efb2227906", 05:08:44 INFO - "pgo_build": "False", 05:08:44 INFO - "builduid": "095bc7be1faf49689ab66bd5d04df180", 05:08:44 INFO - "slavebuilddir": "test" 05:08:44 INFO - } 05:08:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:08:44 INFO - Running post-action listener: _resource_record_post_action 05:08:44 INFO - [mozharness: 2017-04-10 12:08:44.214306Z] Finished read-buildbot-config step (success) 05:08:44 INFO - [mozharness: 2017-04-10 12:08:44.214420Z] Running download-and-extract step. 05:08:44 INFO - Running pre-action listener: _resource_record_pre_action 05:08:44 INFO - Running main action method: download_and_extract 05:08:44 INFO - mkdir: /builds/slave/test/build/tests 05:08: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:08:44 INFO - trying https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:08:44 INFO - Downloading https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/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:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/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:08:45 INFO - Downloaded 1325 bytes. 05:08:45 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:08:45 INFO - Using the following test package requirements: 05:08:45 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:08:45 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:08:45 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:45 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:08:45 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'jsshell-mac.zip'], 05:08:45 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:08:45 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:08:45 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:08:45 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:08:45 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:08:45 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:08:45 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:08:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:45 INFO - Fetch https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:08:46 INFO - Expected file size: 52581042 05:08:46 INFO - Obtained file size: 52581042 05:09:03 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:09:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:09:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:03 INFO - Fetch https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:09:05 INFO - Expected file size: 52581042 05:09:05 INFO - Obtained file size: 52581042 05:09:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:09:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:09:20 INFO - Fetch https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:09:21 INFO - Expected file size: 14405596 05:09:21 INFO - Obtained file size: 14405596 05:09: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:09:21 INFO - trying https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:09:21 INFO - Downloading https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/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:09:23 INFO - Downloaded 71028739 bytes. 05:09:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:09:23 INFO - mkdir: /builds/slave/test/properties 05:09:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:23 INFO - Contents: 05:09:23 INFO - build_url:https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:09:24 INFO - Running post-action listener: _resource_record_post_action 05:09:24 INFO - Running post-action listener: set_extra_try_arguments 05:09:24 INFO - [mozharness: 2017-04-10 12:09:24.402341Z] Finished download-and-extract step (success) 05:09:24 INFO - [mozharness: 2017-04-10 12:09:24.402470Z] Running populate-webroot step. 05:09:24 INFO - Running pre-action listener: _resource_record_pre_action 05:09:24 INFO - Running main action method: populate_webroot 05:09:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:24 INFO - '--tppagecycles', 05:09:24 INFO - '7'], 05:09:24 INFO - 'tests': ['tsvgm']}}, 05:09:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['damp', 'tps']}, 05:09:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'tests': ['damp', 'tps']}, 05:09:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['dromaeo_dom']}, 05:09:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['basic_compositor_video']}, 05:09:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:09:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['a11yr', 05:09:24 INFO - 'ts_paint', 05:09:24 INFO - 'tpaint', 05:09:24 INFO - 'sessionrestore', 05:09:24 INFO - 'sessionrestore_no_auto_restore', 05:09:24 INFO - 'tabpaint']}, 05:09:24 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:24 INFO - 'ts_paint', 05:09:24 INFO - 'tpaint', 05:09:24 INFO - 'sessionrestore', 05:09:24 INFO - 'sessionrestore_no_auto_restore', 05:09:24 INFO - 'tabpaint']}, 05:09:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:24 INFO - 'ts_paint', 05:09:24 INFO - 'tpaint', 05:09:24 INFO - 'sessionrestore', 05:09:24 INFO - 'sessionrestore_no_auto_restore', 05:09:24 INFO - 'tabpaint']}, 05:09:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:24 INFO - 'ts_paint', 05:09:24 INFO - 'tpaint', 05:09:24 INFO - 'sessionrestore', 05:09:24 INFO - 'sessionrestore_no_auto_restore', 05:09:24 INFO - 'tabpaint']}, 05:09:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['a11yr', 05:09:24 INFO - 'ts_paint', 05:09:24 INFO - 'tpaint', 05:09:24 INFO - 'sessionrestore', 05:09:24 INFO - 'sessionrestore_no_auto_restore', 05:09:24 INFO - 'tabpaint']}, 05:09:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['a11yr', 05:09:24 INFO - 'ts_paint', 05:09:24 INFO - 'tpaint', 05:09:24 INFO - 'sessionrestore', 05:09:24 INFO - 'sessionrestore_no_auto_restore', 05:09:24 INFO - 'tabpaint']}, 05:09:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['tsvgx', 05:09:24 INFO - 'tsvgr_opacity', 05:09:24 INFO - 'tart', 05:09:24 INFO - 'tscrollx', 05:09:24 INFO - 'cart', 05:09:24 INFO - 'tsvg_static']}, 05:09:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:24 INFO - 'tsvgr_opacity', 05:09:24 INFO - 'tart', 05:09:24 INFO - 'tscrollx', 05:09:24 INFO - 'cart', 05:09:24 INFO - 'tsvg_static']}, 05:09:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'talos_options': ['--disable-e10s'], 05:09:24 INFO - 'tests': ['tp5o']}, 05:09:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:09:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'talos_options': ['--disable-e10s', 05:09:24 INFO - '--xperf_path', 05:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:24 INFO - 'tests': ['tp5n']}, 05:09:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:09:24 INFO - 'talos_options': ['--xperf_path', 05:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:24 INFO - 'tests': ['tp5n']}}, 05:09:24 INFO - 'talos.zip': {'path': '', 05:09:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:24 INFO - Running post-action listener: _resource_record_post_action 05:09:24 INFO - [mozharness: 2017-04-10 12:09:24.421116Z] Finished populate-webroot step (success) 05:09:24 INFO - [mozharness: 2017-04-10 12:09:24.421254Z] Running create-virtualenv step. 05:09:24 INFO - Running pre-action listener: _resource_record_pre_action 05:09:24 INFO - Running main action method: create_virtualenv 05:09:24 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:24 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:09:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:24 INFO - Using real prefix '/tools/python27' 05:09:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:28 INFO - Installing pip.................done. 05:09:28 INFO - Return code: 0 05:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:09:28 INFO - Reading from file tmpfile_stdout 05:09:28 INFO - Output received: 05:09:28 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:09:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:28 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:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 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:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:28 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:09:28 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:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:28 INFO - 'HOME': '/Users/cltbld', 05:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:28 INFO - 'LOGNAME': 'cltbld', 05:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:28 INFO - 'MOZ_NO_REMOTE': '1', 05:09:28 INFO - 'NO_EM_RESTART': '1', 05:09:28 INFO - 'PAGER': '/bin/cat', 05:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:28 INFO - 'PWD': '/builds/slave/test', 05:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:28 INFO - 'SHELL': '/bin/bash', 05:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:28 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:28 INFO - 'USER': 'cltbld', 05:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:28 INFO - 'XPC_FLAGS': '0x0', 05:09:28 INFO - 'XPC_SERVICE_NAME': '0', 05:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:28 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:09:28 INFO - Cleaning up... 05:09:28 INFO - Return code: 0 05:09:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:28 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:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 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:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:28 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:28 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:09:28 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:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:28 INFO - 'HOME': '/Users/cltbld', 05:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:28 INFO - 'LOGNAME': 'cltbld', 05:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:28 INFO - 'MOZ_NO_REMOTE': '1', 05:09:28 INFO - 'NO_EM_RESTART': '1', 05:09:28 INFO - 'PAGER': '/bin/cat', 05:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:28 INFO - 'PWD': '/builds/slave/test', 05:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:28 INFO - 'SHELL': '/bin/bash', 05:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:28 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:28 INFO - 'USER': 'cltbld', 05:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:28 INFO - 'XPC_FLAGS': '0x0', 05:09:28 INFO - 'XPC_SERVICE_NAME': '0', 05:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:29 INFO - Downloading/unpacking psutil>=3.1.1 05:09:29 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:09:29 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:09:29 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:09:29 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:09:29 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:09:29 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:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:32 INFO - Installing collected packages: psutil 05:09:32 INFO - Running setup.py install for psutil 05:09:32 INFO - building 'psutil._psutil_osx' extension 05:09:32 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:09:33 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:09:33 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:09:33 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:09:33 INFO - building 'psutil._psutil_posix' extension 05:09:33 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:09:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:33 INFO - ^ 05:09:33 INFO - 1 warning generated. 05:09:33 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:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:33 INFO - Successfully installed psutil 05:09:33 INFO - Cleaning up... 05:09:33 INFO - Return code: 0 05:09:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09:33 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:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 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:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:33 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:09:33 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:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:33 INFO - 'HOME': '/Users/cltbld', 05:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:33 INFO - 'LOGNAME': 'cltbld', 05:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:33 INFO - 'MOZ_NO_REMOTE': '1', 05:09:33 INFO - 'NO_EM_RESTART': '1', 05:09:33 INFO - 'PAGER': '/bin/cat', 05:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:33 INFO - 'PWD': '/builds/slave/test', 05:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:33 INFO - 'SHELL': '/bin/bash', 05:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:33 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:33 INFO - 'USER': 'cltbld', 05:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:33 INFO - 'XPC_FLAGS': '0x0', 05:09:33 INFO - 'XPC_SERVICE_NAME': '0', 05:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:36 INFO - Installing collected packages: mozsystemmonitor 05:09:36 INFO - Running setup.py install for mozsystemmonitor 05:09:36 INFO - Successfully installed mozsystemmonitor 05:09:36 INFO - Cleaning up... 05:09:37 INFO - Return code: 0 05:09:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09: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:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', '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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:09: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 jsonschema==2.5.1 05:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:37 INFO - 'HOME': '/Users/cltbld', 05:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:37 INFO - 'LOGNAME': 'cltbld', 05:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:37 INFO - 'MOZ_NO_REMOTE': '1', 05:09:37 INFO - 'NO_EM_RESTART': '1', 05:09:37 INFO - 'PAGER': '/bin/cat', 05:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:37 INFO - 'PWD': '/builds/slave/test', 05:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:37 INFO - 'SHELL': '/bin/bash', 05:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:37 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:37 INFO - 'USER': 'cltbld', 05:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:37 INFO - 'XPC_FLAGS': '0x0', 05:09:37 INFO - 'XPC_SERVICE_NAME': '0', 05:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:09: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:09: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:09: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:09: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:09: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:09: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:09:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09: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:09: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:09: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:09: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:09: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:09: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:09:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:41 INFO - warning: no files found matching '*.txt' 05:09:41 INFO - no previously-included directories found matching 'build' 05:09:41 INFO - no previously-included directories found matching 'dist' 05:09:41 INFO - no previously-included directories found matching '.git*' 05:09:41 INFO - Installing collected packages: jsonschema, functools32 05:09:41 INFO - Running setup.py install for functools32 05:09:41 INFO - warning: no files found matching '*.txt' 05:09:41 INFO - no previously-included directories found matching 'build' 05:09:41 INFO - no previously-included directories found matching 'dist' 05:09:41 INFO - no previously-included directories found matching '.git*' 05:09:41 INFO - Successfully installed jsonschema functools32 05:09:41 INFO - Cleaning up... 05:09:41 INFO - Return code: 0 05:09:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:41 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:41 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:09:41 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:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:41 INFO - 'HOME': '/Users/cltbld', 05:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:41 INFO - 'LOGNAME': 'cltbld', 05:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:41 INFO - 'MOZ_NO_REMOTE': '1', 05:09:41 INFO - 'NO_EM_RESTART': '1', 05:09:41 INFO - 'PAGER': '/bin/cat', 05:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:41 INFO - 'PWD': '/builds/slave/test', 05:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:41 INFO - 'SHELL': '/bin/bash', 05:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:41 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:41 INFO - 'USER': 'cltbld', 05:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:41 INFO - 'XPC_FLAGS': '0x0', 05:09:41 INFO - 'XPC_SERVICE_NAME': '0', 05:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:09:41 INFO - Cleaning up... 05:09:41 INFO - Return code: 0 05:09:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:41 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:41 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:09:41 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:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:41 INFO - 'HOME': '/Users/cltbld', 05:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:41 INFO - 'LOGNAME': 'cltbld', 05:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:41 INFO - 'MOZ_NO_REMOTE': '1', 05:09:41 INFO - 'NO_EM_RESTART': '1', 05:09:41 INFO - 'PAGER': '/bin/cat', 05:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:41 INFO - 'PWD': '/builds/slave/test', 05:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:41 INFO - 'SHELL': '/bin/bash', 05:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:41 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:41 INFO - 'USER': 'cltbld', 05:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:41 INFO - 'XPC_FLAGS': '0x0', 05:09:41 INFO - 'XPC_SERVICE_NAME': '0', 05:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:42 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:09:42 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:09:42 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:09:42 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:09:42 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:09:42 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:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09: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:09: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:09: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:09: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:09: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:09: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:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:46 INFO - Downloading docopt-0.6.1.tar.gz 05:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:46 INFO - Running setup.py install for blobuploader 05:09:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:46 INFO - Running setup.py install for requests 05:09:46 INFO - Running setup.py install for docopt 05:09:47 INFO - Successfully installed blobuploader requests docopt 05:09:47 INFO - Cleaning up... 05:09:47 INFO - Return code: 0 05:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:47 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:47 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:09:47 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:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:47 INFO - 'HOME': '/Users/cltbld', 05:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:47 INFO - 'LOGNAME': 'cltbld', 05:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:47 INFO - 'MOZ_NO_REMOTE': '1', 05:09:47 INFO - 'NO_EM_RESTART': '1', 05:09:47 INFO - 'PAGER': '/bin/cat', 05:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:47 INFO - 'PWD': '/builds/slave/test', 05:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:47 INFO - 'SHELL': '/bin/bash', 05:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:47 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:47 INFO - 'USER': 'cltbld', 05:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:47 INFO - 'XPC_FLAGS': '0x0', 05:09:47 INFO - 'XPC_SERVICE_NAME': '0', 05:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Aj53JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-QAUQxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Bra_5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-dsiSso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-fXnPxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-QY9KKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:47 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-2pWKt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-VzF_JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-3E8Xlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-S1QU61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-fTru0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-wbXW23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-tE0ggz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-QrhC0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-L80Ho3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:48 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-TZplA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:49 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-33FXy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:49 INFO - Running setup.py install for manifestparser 05:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:49 INFO - Running setup.py install for mozcrash 05:09:49 INFO - Running setup.py install for mozdebug 05:09:49 INFO - Running setup.py install for mozdevice 05:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:49 INFO - Running setup.py install for mozfile 05:09:49 INFO - Running setup.py install for mozhttpd 05:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:49 INFO - Running setup.py install for mozinfo 05:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozInstall 05:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozleak 05:09:50 INFO - Running setup.py install for mozlog 05:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for moznetwork 05:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozprocess 05:09:50 INFO - Running setup.py install for mozprofile 05:09:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Running setup.py install for mozrunner 05:09:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Running setup.py install for mozscreenshot 05:09:51 INFO - Running setup.py install for moztest 05:09:51 INFO - Running setup.py install for mozversion 05:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:51 INFO - Cleaning up... 05:09:51 INFO - Return code: 0 05:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:51 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:51 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:09:51 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:09:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:51 INFO - 'HOME': '/Users/cltbld', 05:09:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:51 INFO - 'LOGNAME': 'cltbld', 05:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:51 INFO - 'MOZ_NO_REMOTE': '1', 05:09:51 INFO - 'NO_EM_RESTART': '1', 05:09:51 INFO - 'PAGER': '/bin/cat', 05:09:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:51 INFO - 'PWD': '/builds/slave/test', 05:09:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:51 INFO - 'SHELL': '/bin/bash', 05:09:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:51 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:51 INFO - 'USER': 'cltbld', 05:09:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:51 INFO - 'XPC_FLAGS': '0x0', 05:09:51 INFO - 'XPC_SERVICE_NAME': '0', 05:09:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-2etFwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-TOIqSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-PpZZTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-dONxSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-RlWAnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-7qEY6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-CH2O6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-tpylsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-MjZiaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-78BJ2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:52 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:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:52 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-OWrL3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-M4Ue9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-4Q8ga7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ktrabJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ABqBuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ApO5mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:53 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:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:53 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-mCNhOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:53 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:09:53 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:09:53 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:09:53 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:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:56 INFO - Downloading blessings-1.6.tar.gz 05:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:56 INFO - Installing collected packages: blessings 05:09:56 INFO - Running setup.py install for blessings 05:09:56 INFO - Successfully installed blessings 05:09:56 INFO - Cleaning up... 05:09:56 INFO - Return code: 0 05:09:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:57 INFO - Reading from file tmpfile_stdout 05:09:57 INFO - Current package versions: 05:09:57 INFO - blessings == 1.6 05:09:57 INFO - blobuploader == 1.2.4 05:09:57 INFO - docopt == 0.6.1 05:09:57 INFO - functools32 == 3.2.3-2 05:09:57 INFO - jsonschema == 2.5.1 05:09:57 INFO - manifestparser == 1.1 05:09:57 INFO - mozInstall == 1.12 05:09:57 INFO - mozcrash == 1.0 05:09:57 INFO - mozdebug == 0.1 05:09:57 INFO - mozdevice == 0.50 05:09:57 INFO - mozfile == 1.2 05:09:57 INFO - mozhttpd == 0.7 05:09:57 INFO - mozinfo == 0.9 05:09:57 INFO - mozleak == 0.1 05:09:57 INFO - mozlog == 3.4 05:09:57 INFO - moznetwork == 0.27 05:09:57 INFO - mozprocess == 0.25 05:09:57 INFO - mozprofile == 0.28 05:09:57 INFO - mozrunner == 6.13 05:09:57 INFO - mozscreenshot == 0.1 05:09:57 INFO - mozsystemmonitor == 0.3 05:09:57 INFO - moztest == 0.8 05:09:57 INFO - mozversion == 1.4 05:09:57 INFO - psutil == 3.1.1 05:09:57 INFO - requests == 1.2.3 05:09:57 INFO - wsgiref == 0.1.2 05:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:57 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 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:57 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:09:57 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:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:57 INFO - 'HOME': '/Users/cltbld', 05:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:57 INFO - 'LOGNAME': 'cltbld', 05:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:57 INFO - 'MOZ_NO_REMOTE': '1', 05:09:57 INFO - 'NO_EM_RESTART': '1', 05:09:57 INFO - 'PAGER': '/bin/cat', 05:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:57 INFO - 'PWD': '/builds/slave/test', 05:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:57 INFO - 'SHELL': '/bin/bash', 05:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:57 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:57 INFO - 'USER': 'cltbld', 05:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:57 INFO - 'XPC_FLAGS': '0x0', 05:09:57 INFO - 'XPC_SERVICE_NAME': '0', 05:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 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:09:57 INFO - Cleaning up... 05:09:57 INFO - Return code: 0 05:09:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a546b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a549768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee84751f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, '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.9L8TWfbRfJ/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.762tMWg5DA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:57 INFO - 'HOME': '/Users/cltbld', 05:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:57 INFO - 'LOGNAME': 'cltbld', 05:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:57 INFO - 'MOZ_NO_REMOTE': '1', 05:09:57 INFO - 'NO_EM_RESTART': '1', 05:09:57 INFO - 'PAGER': '/bin/cat', 05:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:57 INFO - 'PWD': '/builds/slave/test', 05:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:57 INFO - 'SHELL': '/bin/bash', 05:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:09:57 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:57 INFO - 'USER': 'cltbld', 05:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:57 INFO - 'XPC_FLAGS': '0x0', 05:09:57 INFO - 'XPC_SERVICE_NAME': '0', 05:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:57 INFO - Cleaning up... 05:09:57 INFO - Return code: 0 05:09:57 INFO - Running post-action listener: _resource_record_post_action 05:09:57 INFO - Running post-action listener: _start_resource_monitoring 05:09:57 INFO - Starting resource monitoring. 05:09:57 INFO - [mozharness: 2017-04-10 12:09:57.585023Z] Finished create-virtualenv step (success) 05:09:57 INFO - [mozharness: 2017-04-10 12:09:57.586030Z] Running install step. 05:09:57 INFO - Running pre-action listener: _resource_record_pre_action 05:09:57 INFO - Running main action method: install 05:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:57 INFO - Reading from file tmpfile_stdout 05:09:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:57 INFO - Reading from file tmpfile_stdout 05:09:57 INFO - Output received: 05:09:57 INFO - Usage: mozinstall [options] installer 05:09:57 INFO - Options: 05:09:57 INFO - -h, --help show this help message and exit 05:09:57 INFO - -d DEST, --destination=DEST 05:09:57 INFO - Directory to install application into. [default: 05:09:57 INFO - "/builds/slave/test"] 05:09:57 INFO - --app=APP Application being installed. [default: firefox] 05:09:57 INFO - mkdir: /builds/slave/test/build/application 05:09:57 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:09:57 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:10:17 INFO - Reading from file tmpfile_stdout 05:10:17 INFO - Output received: 05:10:17 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:10:17 INFO - Running post-action listener: _resource_record_post_action 05:10:17 INFO - [mozharness: 2017-04-10 12:10:17.684251Z] Finished install step (success) 05:10:17 INFO - [mozharness: 2017-04-10 12:10:17.684388Z] Running run-tests step. 05:10:17 INFO - Running pre-action listener: _resource_record_pre_action 05:10:17 INFO - Running main action method: run_tests 05:10:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:17 INFO - 2017-04-10 05:10:17.698 screenresolution[1621:7340] starting screenresolution argv=screenresolution get 05:10:17 INFO - 2017-04-10 05:10:17.700 screenresolution[1621:7340] Display 0: 1600x1200x32@60 05:10:17 INFO - 2017-04-10 05:10:17.705 screenresolution[1622:7343] starting screenresolution argv=screenresolution list 05:10:17 INFO - Available Modes on Display 0 05:10:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:17 INFO - Intel Iris: 05:10:17 INFO - Chipset Model: Intel Iris 05:10:17 INFO - Type: GPU 05:10:17 INFO - Bus: Built-In 05:10:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:17 INFO - Vendor: Intel (0x8086) 05:10:17 INFO - Device ID: 0x0a2e 05:10:17 INFO - Revision ID: 0x0009 05:10:17 INFO - Displays: 05:10:17 INFO - Display: 05:10:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:17 INFO - Display Serial Number: 1600x1200 60 05:10:17 INFO - Main Display: Yes 05:10:17 INFO - Mirror: Off 05:10:17 INFO - Online: Yes 05:10:17 INFO - Rotation: Supported 05:10:17 INFO - Return code: 0 05:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:17 INFO - Python 2.7.3 05:10:17 INFO - Return code: 0 05:10:17 INFO - grabbing minidump binary from tooltool 05:10:17 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:10:17 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 0x10a324d30>, '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 0x10a24bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a319be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:17 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:10:17 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:10:17 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:10:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:18 INFO - Return code: 0 05:10:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:10:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:18 INFO - ENV: RUST_BACKTRACE is now 1 05:10:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:10:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --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:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9L8TWfbRfJ/Render', 05:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:18 INFO - 'HOME': '/Users/cltbld', 05:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:18 INFO - 'LOGNAME': 'cltbld', 05:10:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:18 INFO - 'MOZ_NO_REMOTE': '1', 05:10:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:18 INFO - 'NO_EM_RESTART': '1', 05:10:18 INFO - 'PAGER': '/bin/cat', 05:10:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:18 INFO - 'PWD': '/builds/slave/test', 05:10:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:18 INFO - 'RUST_BACKTRACE': '1', 05:10:18 INFO - 'SHELL': '/bin/bash', 05:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.762tMWg5DA/Listeners', 05:10:18 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 05:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:18 INFO - 'USER': 'cltbld', 05:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:18 INFO - 'XPC_FLAGS': '0x0', 05:10:18 INFO - 'XPC_SERVICE_NAME': '0', 05:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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:10:18 INFO - mozversion application_buildid: 20170410030221 05:10:18 INFO - mozversion application_changeset: 731639fccc709a4dd95fed7e9dda88efb2227906 05:10:18 INFO - mozversion application_display_name: Nightly 05:10:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:18 INFO - mozversion application_name: Firefox 05:10:18 INFO - mozversion application_remotingname: firefox 05:10:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:10:18 INFO - mozversion application_vendor: Mozilla 05:10:18 INFO - mozversion application_version: 55.0a1 05:10:18 INFO - mozversion platform_buildid: 20170410030221 05:10:18 INFO - mozversion platform_changeset: 731639fccc709a4dd95fed7e9dda88efb2227906 05:10:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:10:18 INFO - mozversion platform_version: 55.0a1 05:10:18 INFO - using testdate: 1491826218 05:10:18 INFO - actual date: 1491826218 05:10:18 INFO - starting webserver on 'localhost:49240' 05:10:18 INFO - SUITE-START | Running 2 tests 05:10:18 INFO - TEST-START | dromaeo_css 05:10:18 INFO - operating with platform_type : mac_ 05:10:18 INFO - Initialising browser for dromaeo_css test... 05:10:18 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpVJw6fH/profile http://localhost:49240/getInfo.html) 05:10:21 INFO - PID 1632 | __metrics Screen width/height:1600/1200 05:10:21 INFO - PID 1632 | colorDepth:24 05:10:21 INFO - PID 1632 | Browser inner width/height: 1024/689 05:10:21 INFO - PID 1632 | __metrics 05:10:21 INFO - PID 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:10:21 INFO - PID 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:22 INFO - TEST-INFO | 1632: exit 0 05:10:22 INFO - Browser initialized. 05:10:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:22 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpVJw6fH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:34 INFO - PID 1635 | RSS: Main: 238190592 05:10:34 INFO - PID 1635 | 05:13:39 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 05:13:41 INFO - PID 1635 | RSS: Main: 405143552 05:13:41 INFO - PID 1635 | 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:15:23 INFO - PID 1635 | 05:15:23 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:15:23 INFO - PID 1635 | Full stack: 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:15:23 INFO - PID 1635 | 05:15:23 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:15:23 INFO - PID 1635 | Full stack: 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:15:23 INFO - PID 1635 | 05:15:23 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:15:23 INFO - PID 1635 | Full stack: 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | ************************* 05:15:23 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:15:23 INFO - PID 1635 | 05:15:23 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:15:23 INFO - PID 1635 | Full stack: 05:15:23 INFO - PID 1635 | ************************* 05:16:43 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 05:16:44 INFO - PID 1635 | RSS: Main: 369659904 05:16:44 INFO - PID 1635 | 05:19:46 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 05:19:47 INFO - PID 1635 | RSS: Main: 333373440 05:19:47 INFO - PID 1635 | 05:22:49 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:22:50 INFO - PID 1635 | RSS: Main: 360378368 05:22:50 INFO - PID 1635 | 05:25:54 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:25:54 INFO - PID 1635 | RSS: Main: 334004224 05:25:54 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:28:57 INFO - PID 1635 | RSS: Main: 377339904 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | __start_tp_report 05:28:57 INFO - PID 1635 | _x_x_mozilla_page_load 05:28:57 INFO - PID 1635 | _x_x_mozilla_page_load_details 05:28:57 INFO - PID 1635 | |i|pagename|runs| 05:28:57 INFO - PID 1635 | |0;dojo.html;2917.3144311086894;3450.3271861986923;3464.566929133858;3473.7742046766957;3513.1392808761857;5859.619124756899;6014.278286605602;6065.878682426354;6067.2112625358695;6079.696015199239;5334.333208348957;6044.516438684906;6049.092636104587;6166.475849552793;6177.258728952521;5218.817341393052;5299.152135658295;5332.120200166968;5342.893142137155;5350.170723537858;5370.758315875795;5382.165764306539;5437.184422336642;5450.155225939986;5482.588805839578;4310.633596144332;4896.706197628136;5278.47215278473;5301.946980530184;5340.62615616907;5321.1752178412025;5338.145896656516;5362.249285100089;5363.275957745694;5436.075867102602;5252.6323157379;5281.260623512673;5282.947170528284;5328.973355133238;5376.811811586615;4848.830290939835;5913.349531551526;6016.729247183887;6114.908276375858;6152.8769424611255;6413.486921046305;6508;6509.544331896769;6516.446102081329;6533.052707357454;6565.901511477332;6576.145101136822;6579.769708060243;6592.967035164794;6595.94464885616;6029.276486821522;6157.138000679908;6209.9379006210265;6212.974859148235;6222.160008398853;6331.398517140864;6588.374104460068;6589.439897608661;6631.834204144839;6710.932890671031;6230.875382492325;6296.370362963667;6307.180066591313;6324.2410910691015;6401.967990160019;6502.349765023459;6565.967170164118;6567.802965911031;6586.440152586988;6589.571677840925;6010;6480.125183100221;6499.512536559777;6513.967430162914;6514.869702605922;6227.6263424193785;6307.211598550181;6505.219373675094;6515.967420162869;6521.706523206372;5200.635955483155;5227.947720522746;5248.107821670325;5258.07983602868;5277.419483856773;4596.563326483979;4607.792649330788;4628.861134165913;4635.490096089427;4674.742889141062;5926.436988486087;6205.844853878599;6212.565120441525;6216.2540495139965;6218.751249949952;6423.871522569616;6444.7744328948265;6445.2265728112925;6445.51658625605;6453.612783233021;6083.026715725551;6104.428839602234;6211.534134939898;6211.875762484725;6237.532185086136;5742.7415766290615;5755.654660720286;5763.827085187451;5764.827055188351;5791.362950075489;6687.164104486939;6731.663416829237;6735.865282694319;6736.797896063126;6740.29226931175;5720.3707592165665;6296.433321000949;6382.32985536512;6382.6170429774365;6442.420182183626;6769.255381908085;6769.4922880785125;6783.3555812197765;6797.456203503609;6818;5588.692621905834;6480.287168411377;6507.609543427409;6518.348165183444;6556.147700798866;5425.511703946506;6328.240611126695;6399.840003999937;6629.237637671729;6647.102641143384;4682.92292772671;6199;6274.6548939808745;6380.3619638035825;6393.1369265148605;6245.843853903507;6273.3099359071375;6319.778807741707;6320.273168585488;6323.936760632335;6203.131561581292;6230.7819226326865;6250.062490626442;6257.186565746424;6268.247810262797;6184.288806787097;6250.937490625036;6371.916774148499;6383.808485745435;6386.297507274289;6155.384461553809;6215;6255.124282600531;6262.718177682106;6270.028145637433 05:28:57 INFO - PID 1635 | |1;ext.html;750.8911207874859;797.9800504987375;820.1306614988112;1128.3511980611152;1150.5167829511604;27266.727332726667;36330.818345908265;37339;37349.25301493972;37376.626233737654;38765.41851872224;39139.41290880632;39161.608383916224;39185.21629567407;39192.21615567687;6175.320714721377;8558.614862331178;8734.737957861274;8742.825143497126;8750.03749587545;6248.46888014517;7871.921280787176;8263.917360826375;8503.65985360588;8673.479591224515;8753.080926502722;8806.64773409063;8809.95595022024;8822.161894620032;8830.514321712304;8730.083341249172;8763.912360876373;8784.38509304349;8811.295096392338;8812.295016398673;8526.701565445243;8561.828763424697;8585.484870907765;8589.226969572768;8594.398392112555;36693.44959825605;36848.81575592105;36849.81575092107;36867.81566092152;36888.07779805527;3575.2670702506184;3615.403458429356;3617.656322649344;3618.6743193112748;3621.167131559756;30106.54840177399;30242.69757302421;30309.545356819664;30350.392992140034;30362.93729719449;3113.9377212455624;3159.8894038708536;3175.9206019849457;3177.4439473092348;3194.952075718866;262210;268673;269345;269692.65153674304;269941;48490.54528364155;48517.5148248513;48531.5146848527;48560.757196213795;48573.5142648569;49872;49903.75048124736;49924.75037624789;50018.24972625414;50030.49969500258;14026.85973140276;14142.080764750259;14171.433142674177;14175;14189.574312770634;10005.449700266556;11582.594609188638;11586.594469193538;11594.362310073027;11607.85254727878;10681.519331630096;10769.353838769699;10772.299800512941;10773.730656733487;10787.244892857425;5111.156659151198;5325.760340784674;5336.839894803162;5344.225087362389;5345.65253258537;980.6420656460483;1010.934289271195;1014.1734486393566;1055.8996895294936;1058.6718117383637;22938.770612293665;23982.7601723984;24001.039958401467;24162.275131746075;24290.878545607513;1040.6211769405568;1047.2355180718118;1114.7101753543975;1146.2893006335958;1154.96535103947;11630;12309.076819238413;12311.50753969849;12335.198212116184;12335.753284934251;344926;345726.2713686466;345779;345851;346220;52420;52498.21252681213;52511.47488525066;52611.736941315816;52640.473595264324;1309.4500309869877;1475.2800749780338;1483.4659522571865;1521.7032678627784;1526.4962562354397;23507.88246058759;23579.29262122139;23639.29082127539;23683.1710890118;23750.88124559366;36816.63183368132;36949.81525092357;37004;37005.25989480249;37050.444243335834;309093.9090609155;309894;309920;310302;310886;33263;33765.83117084399;34246.48630270498;34320.48519272163;34379;37484.43773343456;38011.42982855315;38017;44213;44954;28371.941013934123;29121.70878291275;29599.304180912688;30621.23446913756;31763.68236317607;30123.54814677738;30890.374318183207;31206.531902021034;31209.90765323203;31226.531602026444;29202.561961571017;36620.45069323909;36842.8157859209;36911.63088369082;36917.077073073386;29760.702392975792;30243;30669.693303066684;30992.296786858442;31838;22778.886105569367;23500.41248968721;23781.524369512168;24172.63741043921;24224.273271801874 05:28:57 INFO - PID 1635 | |2;jquery.html;426.6394896312615;429.0582172132169;438.67099675243566;441.6797821579355;457.7185031205809;20384.87883166427;21713.56572868542;22306.776932230674;22556.774432255672;22567;22239;23118.959646815892;23478.882605586947;23816.999999999956;24222.87888560559;6125.908111378333;6153.784617538398;6369.394907483782;6376.936230637681;6377.202849643794;6323.083152942821;6438.5171112166545;6442.549021568492;6445.51658625605;6450.322716114811;6168.259808822948;6260.874782504347;6361.077643741678;6382.521310901678;6392;6267.310595834455;6286.528510361695;6344;6349.428551430347;6349.841253968664;5505.6696598203835;5668.121441176624;5738.254026976467;5746.626469279525;5748.396418376052;28140.296492587644;28341.43317133646;28368.85815570909;28435.715642843512;28550.571741423897;2182.1707751054496;2225.4547635829163;2231.698720672721;2233.3188377544843;2233.62028455163;16914.49256522294;17724.91137544317;18266.817331826645;18304.17631206599;18565.44303670892;1962.7252184694155;2041.13251867957;2177.891105444737;2184.6722991551237;2186.365953873375;153479;157235;158734.41265587427;162359;163790;12377.752444951051;12417.62747117588;12584.874151258553;12702.42839072244;12916.289604071866;17043.488695339158;17087.829121708623;17101.743473847902;17106.743398849027;17232.138393080295;7881.960590197013;7961.203879612109;8922.840030795955;9022.548872556346;9218.21645160169;8598.527081010605;8607.78480537979;8630.697925572575;8834.425762325429;8838.381313308008;6680.459356541041;7524.984127142875;7831.804204894923;7892.60536973149;7908.327792137733;2174.6520556710852;2175.869447833135;2176.4667656424276;2183.7379514458366;2323.790858822714;927.8979312275644;953.537534295866;978.256525040974;993.3493561717087;998.2612866478753;20748.896255518626;21553.67669484959;21559;21561.784382156293;21598.78401215968;967.4485543240426;967.5259123029806;975.6048800235916;1002.8896821349646;1005.6731562242301;10860;11045.889541104487;11073.169512286611;11101.611443599435;11150.888491115147;713340;724671;725107;748149;754201;104051.54864039624;154181;156609;159380;162273;1123.1688550472754;1164.0978241862456;1176.2178151529308;1176.7528818947947;1178.911581631381;20991.685124723448;21979.670304945757;22260.77739222587;22284.554308914056;22308;60540;60848;61583.6920815393;61846.38153618406;62123.06815397863;80806;81418;83740.58129709556;85745;86478.135218647;7976.641051152828;8730.039695633603;9028.232600229054;9092.22716069115;9245.121713437213;14159.292035398395;14194.006419550946;14271.357788899732;14658.267086645837;14684.926575367055;10123.898761012295;11005.559777608805;11252.887471125185;11834.881651183377;11965.700857478632;11060.949209825054;11099.667009989713;11167.162462815159;11563.58086479095;11844.644660660195;9989.950050249703;11913.821292680443;12172.39138043112;12178.147529672839;12422.565210217961;8746.69386571467;8942.821143577223;8965.551722413722;9004.729858104267;9229.307801915018;11047.558097676003;11530.1928864982;11696.35670038156;11719.88280117222;12134.75730485403 05:28:57 INFO - PID 1635 | |3;mootools.html;1267.6133779197344;1361.5438827992634;1454.425501926739;1475.1444162385817;1478.4899209772625;10570.154387648989;11653.941730291337;11668.766624667502;11678.649640510788;11720.706982325424;11432.485538150782;11887.346195959219;11890.048796096313;11929.7614047719;11937.462814173361;2539.1366935242013;2576.6521519594894;2580.225932220336;2582.9612555811677;2583.7287084856102;2106.062802053087;2146.37755051035;2421.588329983907;2511.8116141289383;2554.604036374365;2171.619966505863;2433.793127584149;2536.5561026820324;2540.5173017126685;2545.2237067694346;2456.914008009711;2479.764422379871;2482.565551028563;2490.452100537897;2494.276659768665;2466.0628960994886;2471.1351027140536;2472.1223965492172;2480.91316803911;2481.268025932336;11794.823077653842;12096.213746106476;12104.697382565419;12107.213031152947;12119.33343666098;6626.900596491057;6895.862082758316;6896.034555162281;6906.551074180162;6920.30796920309;4096.651784598283;4324.956750432487;4434.246178149722;4487.708298960557;4494.9775251123865;1102.7979502342484;1264.5574049082838;1275.8086287056924;1301.6615679923289;1307.8430588329365;16792.91603541987;16882.662346752997;16895.070771107585;16897.577560561083;16903.915480422642;4171.249175148502;5301.363836339664;5354;5506.339239291311;5698.515626171822;12448.564300249447;12466.252024878355;12474.563390281297;12480.625581232578;12485.563005294953;6648.700808463631;6681.064650948871;6682.131322927989;6688.832779180462;6696.7656132035145;6026.12412683752;6114.847128821815;6178.907316390258;6209.472194863487;6225.408586184305;3691.8707845225827;4202.684798640114;4324.1567894260315;4334.869953901388;4390.275604525217;1267.1256832785348;1267.2649863079391;1271.3643178410794;1290.4193113099143;1291.4511332683571;626.9184261929174;760.22836820626;786.6184900323339;795.8885755994165;798.9600519974094;6316.747330106744;6738.225104112992;7030.367266945999;7064.752733654297;7097;927.7819712367589;936.4942930817418;940.849464085743;940.9247260219166;947.668316089377;3586.372384832644;3907.667848232932;4237.618614324726;4274.722143060753;4327.459067616548;14971.326290316962;15571.143587102819;15577.532674019798;15606.531804045897;15607.297671604805;13689.110207836458;15358.462453814287;15360.23198840076;15362.53912382608;15371.769423458658;10401.53193106312;10651.60338923736;10673;10683.83974240387;10691.62579309736;6517.250516190698;6816.693248803716;7254.45591580623;7283.490155689051;7349.4487913407775;13705;13770.586882393543;13877.306134693426;14122;14153;14230.217338046094;14233.50182743599;14360.640983975067;14556.708865822413;14584.416623334948;9559.761005974628;9873.703788886345;9875.728582426225;9882.258830587878;9901.05939935705;10918;10927.562897484011;10976.176786740867;11038.337699738042;11056.115510758958;9251.398659087137;9287.582058807506;9306.395084319498;9326.160645541662;9470.857937131086;9138.268938485038;9234.676786312446;9261.907380926104;9265.768355791159;9269.212116970133;8299.751007469786;8496.787580310542;8500.31997440191;8502.44734092282;8511.74464766058;4908.730019848943;5185.714785686823;5979.222701048836;6130.386961303834;6263.718132684131;6084.239470066242;6104.816855494342;6194.845128871814;6307.43233109004;6432.00303952888 05:28:57 INFO - PID 1635 | |4;prototype.html;390.83704266637704;394.2017414735161;403.79406502683634;419.2620987062771;420.0129695216242;4911.6669581948645;5260.89478210436;5837.24115864937;6046.516278697699;6087.7260523276445;4855.7086574805535;5086.720230387327;5882.205977144739;5887.735051922674;5965.46310832025;3630.6187850275737;4385.166818304528;4389.3196554534015;4410.845620403286;4411.933820992687;4198.139381426816;4371.846985355497;4403.581659742319;4412.338149277602;4418.690691651585;4334.479862416514;4345.283028300327;4362.149380870732;4370.562943705636;4394.231009573328;3755.6244375562223;3787.659110680052;4353.891152721208;4365.428445759524;4381.9561804381865;3799.2401519695895;3809.3524100902637;3810.256999884996;3815.1225218199693;3820.694344452465;5564.638298510584;5852.56105792063;5854.853628659275;5874.882502349929;5886.1164427383255;5038.00238857879;5187.455317191716;5250.18622113573;5290.365156181244;5305.575553955674;5571.554275657938;6019.194241727508;6303.621782693007;6350.761601487712;6378.840528986766;4323.524412314643;4329.264025115738;4332.718373305725;4338.783060846945;4338.783060846977;6164.445199931983;6362.791069696789;6443.162388889415;6566.37619426149;6779.52551316129;3823.445600387928;4366.257736184856;4395.7362558246605;4405.911881762347;4409.735415875058;4447.999200179934;4452.554744525586;4457.375967364572;4468.843590474317;4491.236489796743;3993.0815912340327;4810.927836082462;4986.301917731521;5251.8161864335325;5291.894162116736;6320.209973753281;6404.925635694893;6409.615423074631;6423.325550817191;6463.612183269019;1510.3203558398545;1524.7268530776703;1528.7171873203492;1529.4493982166412;1532.3487517804888;966.2270183852889;1007.9546420411099;1012.9290949633603;1014.6347314966606;1023.948802559869;5315.405378386468;6028.306744724413;6066.848328791815;6078.206928955969;6116.541259405562;5716.114002329646;6042.555743226407;6218.22272215973;6609.504287178481;6622.2715501294815;5387.326584176978;5807.593468457252;6094.481969032682;6157.260019291372;6181.536384771161;2633.736626337389;3469.7918124912585;3471.2016236265295;3476.3568739783223;3481.442969124928;5693.629914055656;6758.459323254128;6772.966135169391;6791.219009813836;6808.6255255960405;6708.496862735315;6708.798736037927;6719.529632925648;6749.527533072638;6757.256701762803;5877.823665290048;6421.51838612106;6476.514261430411;6678.465722742266;6689.665516724047;5983.44812430388;6115.541334400027;6498.447631951148;6509.967450162719;6611.371919667624;5349.705766182898;5868.413158684098;6127.785527506516;6346.555741098079;6373.139626150411;5110.259012443101;5845.707714614167;6701.430378417889;6761.357671021246;6798.626075565693;4136.689748268952;4231.942014496376;4828.985912958318;4832.710037397767;4843.539863712942;4987.451380348231;5831.650100993954;6261.495401839118;6588.6046837188005;6629.370209830058;6290.2766181889665;6326.525510586633;6342.8731425370315;6350.555461117678;6369.299377068612;5550.583706221969;6097.817065488042;6121.357257488078;6365.96817015912;6390.456811171102;5805.3614102447855;6156.353582873734;6179.598326108789;6182.598131121463;6268.247810262797;5751;6339.144215530844;6347.809565713036;6356.2054743157105;6358.618482891041;5846.795362162304;5872.533535915011;5922.911156332744;6136.8772624548155;6213.627182369072 05:28:57 INFO - PID 1635 | |5;yui.html;706.392502447895;843.4517563583672;868.3660927522908;875.2385424680529;875.7197696737043;13574.3212839358;17836.73244901326;17915.820841791578;18510.352137675185;18511;17117.22972466239;17124.743128853046;17492.737608935844;17565.473035808915;17576.560585985324;963.7494251494592;991.2961797124015;992.791513782103;993.2798720927306;999.2455695949548;669.8358902069;689.3554526517722;973.5570315506463;1007.1791489935715;1024.4263212600968;1071.6463567022863;1072.1583556907829;1072.9195310351715;1074.8172810622214;1077.3697387028599;1063.473580577619;1067.2635881241918;1067.9893201067969;1068.0761141612527;1069.4385447639972;660.9537332386735;800.3677095094868;802.1377019703842;802.8033131882668;803.2248879830933;16225.756613650805;16321.83678163215;16494.75257871133;16938.576535586708;17244.137793110294;16804.74792878108;16934.915325423295;17354;17371.131443427905;17451.825481745145;13848.723025539533;13953.023288369819;14107.78838317426;14262.429502819874;14302.64243393913;3417.829108544563;3439.2777516721517;3442;3447.465642825366;3448.3448144852396;112754;115659;116248.41875790567;116316;117112.41443792726;11196.552137914556;11361.318320900607;12231.143819932518;12314.076444266715;12333.260004399765;17513.036782976804;20253.886036268148;25521.234362969142;25532.48935021289;25676.101336453135;8714.259287960595;9042.773930651654;9053.818923621491;9054.185123338799;9083.772905677411;4627.745473998895;4765.69023013503;4836.46798852126;4876.024795041006;4880.048390563877;3719.4420836874683;4287.164003019381;4413.801378937956;4415.51429342772;4418.4918734345965;934.5700977550267;974.0697633759743;977.7702239973601;978.8189185000798;979.1139019187505;575.5999580291657;576.2163457697528;590.2739630254725;590.740074367277;608.4675908579992;10493.422861742678;11354;11698.181127321006;11875.524979000744;12046.879531204751;654.3227759269229;654.754467074847;656.7373050779727;668.759246671198;685.6914388525084;5372.355317361941;5543.113101903676;5561.721913904288;5649.802256920988;6157.322694503601;94312;99314.5034274824;102653;103158;103458;76414.47171056547;82984.58507707543;87455;94090;96532.0346796537;53443;79469.41061178745;82229.58885205536;82685.58657206796;83313.16686833055;10009.599616015277;10505.737356566147;11989.34058626784;12295.75408491843;12399.628011159679;40393;40650.78047658575;40969;41280;41876;71799.4610565904;72875;74035.259647405;74587;74728.13179670552;16355.672886542441;16529;16582;16643.084630345445;16644.833551664327;17894;18477.353292634692;18513.629727405645;18515.537111572317;18548.44354669362;16355.427560035341;16371.345146194019;16798.160091995105;16892.66214675675;16938.661226775643;16346.427875024317;16360.754588681417;16404.17979101064;16620.83379166241;16675.66648667044;13490.460381584626;16206.027638341737;16372.590685232488;16437.26032328524;16551.586210344838;11237.60668376603;11386;11801.17391782567;11980.460879260629;12430.192037517532;12700.555480558136;13833.930830345784;13923.930380348034;13935.651608709457;13947.4421023162 05:28:57 INFO - PID 1635 | __end_tp_report 05:28:57 INFO - PID 1635 | __start_cc_report 05:28:57 INFO - PID 1635 | _x_x_mozilla_cycle_collect,1742 05:28:57 INFO - PID 1635 | __end_cc_report 05:28:57 INFO - PID 1635 | __startTimestamp1491827337383__endTimestamp 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | ------- Summary: start ------- 05:28:57 INFO - PID 1635 | Number of tests: 6 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5967.60 Median:6218.75 stddev:725.21 (11.7%) stddev-sans-first:686.82 05:28:57 INFO - PID 1635 | Values: 2917.3 3450.3 3464.6 3473.8 3513.1 5859.6 6014.3 6065.9 6067.2 6079.7 5334.3 6044.5 6049.1 6166.5 6177.3 5218.8 5299.2 5332.1 5342.9 5350.2 5370.8 5382.2 5437.2 5450.2 5482.6 4310.6 4896.7 5278.5 5301.9 5340.6 5321.2 5338.1 5362.2 5363.3 5436.1 5252.6 5281.3 5282.9 5329.0 5376.8 4848.8 5913.3 6016.7 6114.9 6152.9 6413.5 6508.0 6509.5 6516.4 6533.1 6565.9 6576.1 6579.8 6593.0 6595.9 6029.3 6157.1 6209.9 6213.0 6222.2 6331.4 6588.4 6589.4 6631.8 6710.9 6230.9 6296.4 6307.2 6324.2 6402.0 6502.3 6566.0 6567.8 6586.4 6589.6 6010.0 6480.1 6499.5 6514.0 6514.9 6227.6 6307.2 6505.2 6516.0 6521.7 5200.6 5227.9 5248.1 5258.1 5277.4 4596.6 4607.8 4628.9 4635.5 4674.7 5926.4 6205.8 6212.6 6216.3 6218.8 6423.9 6444.8 6445.2 6445.5 6453.6 6083.0 6104.4 6211.5 6211.9 6237.5 5742.7 5755.7 5763.8 5764.8 5791.4 6687.2 6731.7 6735.9 6736.8 6740.3 5720.4 6296.4 6382.3 6382.6 6442.4 6769.3 6769.5 6783.4 6797.5 6818.0 5588.7 6480.3 6507.6 6518.3 6556.1 5425.5 6328.2 6399.8 6629.2 6647.1 4682.9 6199.0 6274.7 6380.4 6393.1 6245.8 6273.3 6319.8 6320.3 6323.9 6203.1 6230.8 6250.1 6257.2 6268.2 6184.3 6250.9 6371.9 6383.8 6386.3 6155.4 6215.0 6255.1 6262.7 6270.0 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:45354.52 Median:34283.49 stddev:81359.29 (237.3%) stddev-sans-first:81518.60 05:28:57 INFO - PID 1635 | Values: 750.9 798.0 820.1 1128.4 1150.5 27266.7 36330.8 37339.0 37349.3 37376.6 38765.4 39139.4 39161.6 39185.2 39192.2 6175.3 8558.6 8734.7 8742.8 8750.0 6248.5 7871.9 8263.9 8503.7 8673.5 8753.1 8806.6 8810.0 8822.2 8830.5 8730.1 8763.9 8784.4 8811.3 8812.3 8526.7 8561.8 8585.5 8589.2 8594.4 36693.4 36848.8 36849.8 36867.8 36888.1 3575.3 3615.4 3617.7 3618.7 3621.2 30106.5 30242.7 30309.5 30350.4 30362.9 3113.9 3159.9 3175.9 3177.4 3195.0 262210.0 268673.0 269345.0 269692.7 269941.0 48490.5 48517.5 48531.5 48560.8 48573.5 49872.0 49903.8 49924.8 50018.2 50030.5 14026.9 14142.1 14171.4 14175.0 14189.6 10005.4 11582.6 11586.6 11594.4 11607.9 10681.5 10769.4 10772.3 10773.7 10787.2 5111.2 5325.8 5336.8 5344.2 5345.7 980.6 1010.9 1014.2 1055.9 1058.7 22938.8 23982.8 24001.0 24162.3 24290.9 1040.6 1047.2 1114.7 1146.3 1155.0 11630.0 12309.1 12311.5 12335.2 12335.8 344926.0 345726.3 345779.0 345851.0 346220.0 52420.0 52498.2 52511.5 52611.7 52640.5 1309.5 1475.3 1483.5 1521.7 1526.5 23507.9 23579.3 23639.3 23683.2 23750.9 36816.6 36949.8 37004.0 37005.3 37050.4 309093.9 309894.0 309920.0 310302.0 310886.0 33263.0 33765.8 34246.5 34320.5 34379.0 37484.4 38011.4 38017.0 44213.0 44954.0 28371.9 29121.7 29599.3 30621.2 31763.7 30123.5 30890.4 31206.5 31209.9 31226.5 29202.6 36620.5 36842.8 36911.6 36917.1 29760.7 30243.0 30669.7 30992.3 31838.0 22778.9 23500.4 23781.5 24172.6 24224.3 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:41788.41 Median:22842.98 stddev:122594.87 (536.7%) stddev-sans-first:122899.44 05:28:57 INFO - PID 1635 | Values: 426.6 429.1 438.7 441.7 457.7 20384.9 21713.6 22306.8 22556.8 22567.0 22239.0 23119.0 23478.9 23817.0 24222.9 6125.9 6153.8 6369.4 6376.9 6377.2 6323.1 6438.5 6442.5 6445.5 6450.3 6168.3 6260.9 6361.1 6382.5 6392.0 6267.3 6286.5 6344.0 6349.4 6349.8 5505.7 5668.1 5738.3 5746.6 5748.4 28140.3 28341.4 28368.9 28435.7 28550.6 2182.2 2225.5 2231.7 2233.3 2233.6 16914.5 17724.9 18266.8 18304.2 18565.4 1962.7 2041.1 2177.9 2184.7 2186.4 153479.0 157235.0 158734.4 162359.0 163790.0 12377.8 12417.6 12584.9 12702.4 12916.3 17043.5 17087.8 17101.7 17106.7 17232.1 7882.0 7961.2 8922.8 9022.5 9218.2 8598.5 8607.8 8630.7 8834.4 8838.4 6680.5 7525.0 7831.8 7892.6 7908.3 2174.7 2175.9 2176.5 2183.7 2323.8 927.9 953.5 978.3 993.3 998.3 20748.9 21553.7 21559.0 21561.8 21598.8 967.4 967.5 975.6 1002.9 1005.7 10860.0 11045.9 11073.2 11101.6 11150.9 713340.0 724671.0 725107.0 748149.0 754201.0 104051.5 154181.0 156609.0 159380.0 162273.0 1123.2 1164.1 1176.2 1176.8 1178.9 20991.7 21979.7 22260.8 22284.6 22308.0 60540.0 60848.0 61583.7 61846.4 62123.1 80806.0 81418.0 83740.6 85745.0 86478.1 7976.6 8730.0 9028.2 9092.2 9245.1 14159.3 14194.0 14271.4 14658.3 14684.9 10123.9 11005.6 11252.9 11834.9 11965.7 11060.9 11099.7 11167.2 11563.6 11844.6 9990.0 11913.8 12172.4 12178.1 12422.6 8746.7 8942.8 8965.6 9004.7 9229.3 11047.6 11530.2 11696.4 11719.9 12134.8 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7310.96 Median:2565.63 stddev:4692.11 (182.9%) stddev-sans-first:4683.30 05:28:57 INFO - PID 1635 | Values: 1267.6 1361.5 1454.4 1475.1 1478.5 10570.2 11653.9 11668.8 11678.6 11720.7 11432.5 11887.3 11890.0 11929.8 11937.5 2539.1 2576.7 2580.2 2583.0 2583.7 2106.1 2146.4 2421.6 2511.8 2554.6 2171.6 2433.8 2536.6 2540.5 2545.2 2456.9 2479.8 2482.6 2490.5 2494.3 2466.1 2471.1 2472.1 2480.9 2481.3 11794.8 12096.2 12104.7 12107.2 12119.3 6626.9 6895.9 6896.0 6906.6 6920.3 4096.7 4325.0 4434.2 4487.7 4495.0 1102.8 1264.6 1275.8 1301.7 1307.8 16792.9 16882.7 16895.1 16897.6 16903.9 4171.2 5301.4 5354.0 5506.3 5698.5 12448.6 12466.3 12474.6 12480.6 12485.6 6648.7 6681.1 6682.1 6688.8 6696.8 6026.1 6114.8 6178.9 6209.5 6225.4 3691.9 4202.7 4324.2 4334.9 4390.3 1267.1 1267.3 1271.4 1290.4 1291.5 626.9 760.2 786.6 795.9 799.0 6316.7 6738.2 7030.4 7064.8 7097.0 927.8 936.5 940.8 940.9 947.7 3586.4 3907.7 4237.6 4274.7 4327.5 14971.3 15571.1 15577.5 15606.5 15607.3 13689.1 15358.5 15360.2 15362.5 15371.8 10401.5 10651.6 10673.0 10683.8 10691.6 6517.3 6816.7 7254.5 7283.5 7349.4 13705.0 13770.6 13877.3 14122.0 14153.0 14230.2 14233.5 14360.6 14556.7 14584.4 9559.8 9873.7 9875.7 9882.3 9901.1 10918.0 10927.6 10976.2 11038.3 11056.1 9251.4 9287.6 9306.4 9326.2 9470.9 9138.3 9234.7 9261.9 9265.8 9269.2 8299.8 8496.8 8500.3 8502.4 8511.7 4908.7 5185.7 5979.2 6130.4 6263.7 6084.2 6104.8 6194.8 6307.4 6432.0 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5114.04 Median:5819.62 stddev:1580.02 (27.1%) stddev-sans-first:1544.17 05:28:57 INFO - PID 1635 | Values: 390.8 394.2 403.8 419.3 420.0 4911.7 5260.9 5837.2 6046.5 6087.7 4855.7 5086.7 5882.2 5887.7 5965.5 3630.6 4385.2 4389.3 4410.8 4411.9 4198.1 4371.8 4403.6 4412.3 4418.7 4334.5 4345.3 4362.1 4370.6 4394.2 3755.6 3787.7 4353.9 4365.4 4382.0 3799.2 3809.4 3810.3 3815.1 3820.7 5564.6 5852.6 5854.9 5874.9 5886.1 5038.0 5187.5 5250.2 5290.4 5305.6 5571.6 6019.2 6303.6 6350.8 6378.8 4323.5 4329.3 4332.7 4338.8 4338.8 6164.4 6362.8 6443.2 6566.4 6779.5 3823.4 4366.3 4395.7 4405.9 4409.7 4448.0 4452.6 4457.4 4468.8 4491.2 3993.1 4810.9 4986.3 5251.8 5291.9 6320.2 6404.9 6409.6 6423.3 6463.6 1510.3 1524.7 1528.7 1529.4 1532.3 966.2 1008.0 1012.9 1014.6 1023.9 5315.4 6028.3 6066.8 6078.2 6116.5 5716.1 6042.6 6218.2 6609.5 6622.3 5387.3 5807.6 6094.5 6157.3 6181.5 2633.7 3469.8 3471.2 3476.4 3481.4 5693.6 6758.5 6773.0 6791.2 6808.6 6708.5 6708.8 6719.5 6749.5 6757.3 5877.8 6421.5 6476.5 6678.5 6689.7 5983.4 6115.5 6498.4 6510.0 6611.4 5349.7 5868.4 6127.8 6346.6 6373.1 5110.3 5845.7 6701.4 6761.4 6798.6 4136.7 4231.9 4829.0 4832.7 4843.5 4987.5 5831.7 6261.5 6588.6 6629.4 6290.3 6326.5 6342.9 6350.6 6369.3 5550.6 6097.8 6121.4 6366.0 6390.5 5805.4 6156.4 6179.6 6182.6 6268.2 5751.0 6339.1 6347.8 6356.2 6358.6 5846.8 5872.5 5922.9 6136.9 6213.6 05:28:57 INFO - PID 1635 | 05:28:57 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21643.13 Median:18493.85 stddev:29718.16 (160.7%) stddev-sans-first:29759.95 05:28:57 INFO - PID 1635 | Values: 706.4 843.5 868.4 875.2 875.7 13574.3 17836.7 17915.8 18510.4 18511.0 17117.2 17124.7 17492.7 17565.5 17576.6 963.7 991.3 992.8 993.3 999.2 669.8 689.4 973.6 1007.2 1024.4 1071.6 1072.2 1072.9 1074.8 1077.4 1063.5 1067.3 1068.0 1068.1 1069.4 661.0 800.4 802.1 802.8 803.2 16225.8 16321.8 16494.8 16938.6 17244.1 16804.7 16934.9 17354.0 17371.1 17451.8 13848.7 13953.0 14107.8 14262.4 14302.6 3417.8 3439.3 3442.0 3447.5 3448.3 112754.0 115659.0 116248.4 116316.0 117112.4 11196.6 11361.3 12231.1 12314.1 12333.3 17513.0 20253.9 25521.2 25532.5 25676.1 8714.3 9042.8 9053.8 9054.2 9083.8 4627.7 4765.7 4836.5 4876.0 4880.0 3719.4 4287.2 4413.8 4415.5 4418.5 934.6 974.1 977.8 978.8 979.1 575.6 576.2 590.3 590.7 608.5 10493.4 11354.0 11698.2 11875.5 12046.9 654.3 654.8 656.7 668.8 685.7 5372.4 5543.1 5561.7 5649.8 6157.3 94312.0 99314.5 102653.0 103158.0 103458.0 76414.5 82984.6 87455.0 94090.0 96532.0 53443.0 79469.4 82229.6 82685.6 83313.2 10009.6 10505.7 11989.3 12295.8 12399.6 40393.0 40650.8 40969.0 41280.0 41876.0 71799.5 72875.0 74035.3 74587.0 74728.1 16355.7 16529.0 16582.0 16643.1 16644.8 17894.0 18477.4 18513.6 18515.5 18548.4 16355.4 16371.3 16798.2 16892.7 16938.7 16346.4 16360.8 16404.2 16620.8 16675.7 13490.5 16206.0 16372.6 16437.3 16551.6 11237.6 11386.0 11801.2 11980.5 12430.2 12700.6 13833.9 13923.9 13935.7 13947.4 05:28:57 INFO - PID 1635 | -------- Summary: end -------- 05:28:57 INFO - PID 1635 | 05:28:58 INFO - TEST-INFO | 1635: exit 0 05:28:58 INFO - TEST-OK | dromaeo_css | took 1119796ms 05:28:58 INFO - TEST-START | kraken 05:28:58 INFO - operating with platform_type : mac_ 05:28:58 INFO - Initialising browser for kraken test... 05:28:58 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpcGJ7ej/profile http://localhost:49240/getInfo.html) 05:29:00 INFO - PID 1645 | __metrics Screen width/height:1600/1200 05:29:00 INFO - PID 1645 | colorDepth:24 05:29:00 INFO - PID 1645 | Browser inner width/height: 1024/689 05:29:00 INFO - PID 1645 | __metrics 05:29:00 INFO - PID 1645 | 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:29:00 INFO - PID 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:01 INFO - TEST-INFO | 1645: exit 0 05:29:01 INFO - Browser initialized. 05:29:01 INFO - Running cycle 1/1 for kraken test... 05:29:01 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpcGJ7ej/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:14 INFO - PID 1647 | RSS: Main: 238628864 05:29:14 INFO - PID 1647 | 05:29:17 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:18 INFO - PID 1647 | RSS: Main: 291876864 05:29:18 INFO - PID 1647 | 05:29:20 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 05:29:21 INFO - PID 1647 | RSS: Main: 292229120 05:29:21 INFO - PID 1647 | 05:29:25 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 05:29:25 INFO - PID 1647 | RSS: Main: 387407872 05:29:25 INFO - PID 1647 | 05:29:27 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 05:29:28 INFO - PID 1647 | RSS: Main: 290713600 05:29:28 INFO - PID 1647 | 05:29:30 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:31 INFO - PID 1647 | RSS: Main: 292290560 05:29:31 INFO - PID 1647 | 05:29:34 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:34 INFO - PID 1647 | RSS: Main: 333746176 05:29:34 INFO - PID 1647 | 05:29:38 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:38 INFO - PID 1647 | RSS: Main: 343928832 05:29:38 INFO - PID 1647 | 05:29:42 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 05:29:42 INFO - PID 1647 | RSS: Main: 345194496 05:29:42 INFO - PID 1647 | 05:29:44 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:44 INFO - PID 1647 | RSS: Main: 310681600 05:29:44 INFO - PID 1647 | 05:29:46 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:47 INFO - PID 1647 | RSS: Main: 313372672 05:29:47 INFO - PID 1647 | 05:29:49 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:50 INFO - PID 1647 | RSS: Main: 315891712 05:29:50 INFO - PID 1647 | 05:29:53 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:54 INFO - PID 1647 | RSS: Main: 333668352 05:29:54 INFO - PID 1647 | 05:29:57 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:58 INFO - PID 1647 | RSS: Main: 314281984 05:29:58 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 05:30:00 INFO - PID 1647 | RSS: Main: 380051456 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | __start_tp_report 05:30:00 INFO - PID 1647 | _x_x_mozilla_page_load 05:30:00 INFO - PID 1647 | _x_x_mozilla_page_load_details 05:30:00 INFO - PID 1647 | |i|pagename|runs| 05:30:00 INFO - PID 1647 | |0;ai-astar;109;122;121;123;123;122;126;175;104;175 05:30:00 INFO - PID 1647 | |1;audio-beat-detection;152;113;117;162;116;117;113;116;145;147 05:30:00 INFO - PID 1647 | |2;audio-dft;207;217;209;208;207;208;209;209;211;214 05:30:00 INFO - PID 1647 | |3;audio-fft;82;70;89;128;59;81;89;91;114;60 05:30:00 INFO - PID 1647 | |4;audio-oscillator;95;79;95;76;77;74;91;73;74;91 05:30:00 INFO - PID 1647 | |5;imaging-gaussian-blur;90;104;91;91;91;91;92;91;91;92 05:30:00 INFO - PID 1647 | |6;imaging-darkroom;99;101;100;101;100;101;100;100;98;99 05:30:00 INFO - PID 1647 | |7;imaging-desaturate;101;101;123;163;111;152;112;100;102;100 05:30:00 INFO - PID 1647 | |8;json-parse-financial;53;50;51;50;51;53;51;50;51;52 05:30:00 INFO - PID 1647 | |9;json-stringify-tinderbox;59;68;69;71;67;63;65;65;64;65 05:30:00 INFO - PID 1647 | |10;stanford-crypto-aes;94;92;90;91;89;92;93;88;90;105 05:30:00 INFO - PID 1647 | |11;stanford-crypto-ccm;173;169;142;142;159;168;162;150;198;196 05:30:00 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;227;262;234;260;263;211;197;208;231;219 05:30:00 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;75;74;75;73;73;73;74;73;72;74 05:30:00 INFO - PID 1647 | __end_tp_report 05:30:00 INFO - PID 1647 | __start_cc_report 05:30:00 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2169 05:30:00 INFO - PID 1647 | __end_cc_report 05:30:00 INFO - PID 1647 | __startTimestamp1491827400703__endTimestamp 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | ------- Summary: start ------- 05:30:00 INFO - PID 1647 | Number of tests: 14 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:130.00 Median:123.00 stddev:24.70 (20.1%) stddev-sans-first:25.00 05:30:00 INFO - PID 1647 | Values: 109.0 122.0 121.0 123.0 123.0 122.0 126.0 175.0 104.0 175.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:131.00 stddev:19.23 (14.7%) stddev-sans-first:18.65 05:30:00 INFO - PID 1647 | Values: 152.0 113.0 117.0 162.0 116.0 117.0 113.0 116.0 145.0 147.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:209.90 Median:209.00 stddev:3.25 (1.6%) stddev-sans-first:3.27 05:30:00 INFO - PID 1647 | Values: 207.0 217.0 209.0 208.0 207.0 208.0 209.0 209.0 211.0 214.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:86.30 Median:81.50 stddev:21.84 (26.8%) stddev-sans-first:23.11 05:30:00 INFO - PID 1647 | Values: 82.0 70.0 89.0 128.0 59.0 81.0 89.0 91.0 114.0 60.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:85.00 stddev:9.29 (10.9%) stddev-sans-first:8.68 05:30:00 INFO - PID 1647 | Values: 95.0 79.0 95.0 76.0 77.0 74.0 91.0 73.0 74.0 91.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:91.00 stddev:4.12 (4.5%) stddev-sans-first:4.27 05:30:00 INFO - PID 1647 | Values: 90.0 104.0 91.0 91.0 91.0 91.0 92.0 91.0 91.0 92.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:101.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 05:30:00 INFO - PID 1647 | Values: 99.0 101.0 100.0 101.0 100.0 101.0 100.0 100.0 98.0 99.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:116.50 Median:111.50 stddev:22.97 (20.6%) stddev-sans-first:23.67 05:30:00 INFO - PID 1647 | Values: 101.0 101.0 123.0 163.0 111.0 152.0 112.0 100.0 102.0 100.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.14 (2.2%) stddev-sans-first:1.00 05:30:00 INFO - PID 1647 | Values: 53.0 50.0 51.0 50.0 51.0 53.0 51.0 50.0 51.0 52.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:3.37 (5.1%) stddev-sans-first:2.60 05:30:00 INFO - PID 1647 | Values: 59.0 68.0 69.0 71.0 67.0 63.0 65.0 65.0 64.0 65.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:91.50 stddev:4.79 (5.2%) stddev-sans-first:5.04 05:30:00 INFO - PID 1647 | Values: 94.0 92.0 90.0 91.0 89.0 92.0 93.0 88.0 90.0 105.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:165.90 Median:168.50 stddev:19.60 (11.6%) stddev-sans-first:20.62 05:30:00 INFO - PID 1647 | Values: 173.0 169.0 142.0 142.0 159.0 168.0 162.0 150.0 198.0 196.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:231.20 Median:232.50 stddev:23.76 (10.2%) stddev-sans-first:25.15 05:30:00 INFO - PID 1647 | Values: 227.0 262.0 234.0 260.0 263.0 211.0 197.0 208.0 231.0 219.0 05:30:00 INFO - PID 1647 | 05:30:00 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:0.88 05:30:00 INFO - PID 1647 | Values: 75.0 74.0 75.0 73.0 73.0 73.0 74.0 73.0 72.0 74.0 05:30:00 INFO - PID 1647 | -------- Summary: end -------- 05:30:00 INFO - PID 1647 | 05:30:01 INFO - TEST-INFO | 1647: exit 0 05:30:01 INFO - TEST-OK | kraken | took 63698ms 05:30:01 INFO - SUITE-END | took 1183s 05:30:01 INFO - Completed test suite (00:19:43) 05:30:01 INFO - javascript benchmark 05:30:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7844.451064335803, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2917.3144311086894, 3450.3271861986923, 3464.566929133858, 3473.7742046766957, 3513.1392808761857, 5859.619124756899, 6014.278286605602, 6065.878682426354, 6067.2112625358695, 6079.696015199239, 5334.333208348957, 6044.516438684906, 6049.092636104587, 6166.475849552793, 6177.258728952521, 5218.817341393052, 5299.152135658295, 5332.120200166968, 5342.893142137155, 5350.170723537858, 5370.758315875795, 5382.165764306539, 5437.184422336642, 5450.155225939986, 5482.588805839578, 4310.633596144332, 4896.706197628136, 5278.47215278473, 5301.946980530184, 5340.62615616907, 5321.1752178412025, 5338.145896656516, 5362.249285100089, 5363.275957745694, 5436.075867102602, 5252.6323157379, 5281.260623512673, 5282.947170528284, 5328.973355133238, 5376.811811586615, 4848.830290939835, 5913.349531551526, 6016.729247183887, 6114.908276375858, 6152.8769424611255, 6413.486921046305, 6508.0, 6509.544331896769, 6516.446102081329, 6533.052707357454, 6565.901511477332, 6576.145101136822, 6579.769708060243, 6592.967035164794, 6595.94464885616, 6029.276486821522, 6157.138000679908, 6209.9379006210265, 6212.974859148235, 6222.160008398853, 6331.398517140864, 6588.374104460068, 6589.439897608661, 6631.834204144839, 6710.932890671031, 6230.875382492325, 6296.370362963667, 6307.180066591313, 6324.2410910691015, 6401.967990160019, 6502.349765023459, 6565.967170164118, 6567.802965911031, 6586.440152586988, 6589.571677840925, 6010.0, 6480.125183100221, 6499.512536559777, 6513.967430162914, 6514.869702605922, 6227.6263424193785, 6307.211598550181, 6505.219373675094, 6515.967420162869, 6521.706523206372, 5200.635955483155, 5227.947720522746, 5248.107821670325, 5258.07983602868, 5277.419483856773, 4596.563326483979, 4607.792649330788, 4628.861134165913, 4635.490096089427, 4674.742889141062, 5926.436988486087, 6205.844853878599, 6212.565120441525, 6216.2540495139965, 6218.751249949952, 6423.871522569616, 6444.7744328948265, 6445.2265728112925, 6445.51658625605, 6453.612783233021, 6083.026715725551, 6104.428839602234, 6211.534134939898, 6211.875762484725, 6237.532185086136, 5742.7415766290615, 5755.654660720286, 5763.827085187451, 5764.827055188351, 5791.362950075489, 6687.164104486939, 6731.663416829237, 6735.865282694319, 6736.797896063126, 6740.29226931175, 5720.3707592165665, 6296.433321000949, 6382.32985536512, 6382.6170429774365, 6442.420182183626, 6769.255381908085, 6769.4922880785125, 6783.3555812197765, 6797.456203503609, 6818.0, 5588.692621905834, 6480.287168411377, 6507.609543427409, 6518.348165183444, 6556.147700798866, 5425.511703946506, 6328.240611126695, 6399.840003999937, 6629.237637671729, 6647.102641143384, 4682.92292772671, 6199.0, 6274.6548939808745, 6380.3619638035825, 6393.1369265148605, 6245.843853903507, 6273.3099359071375, 6319.778807741707, 6320.273168585488, 6323.936760632335, 6203.131561581292, 6230.7819226326865, 6250.062490626442, 6257.186565746424, 6268.247810262797, 6184.288806787097, 6250.937490625036, 6371.916774148499, 6383.808485745435, 6386.297507274289, 6155.384461553809, 6215.0, 6255.124282600531, 6262.718177682106, 6270.028145637433], "value": 5919.390195572041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.8911207874859, 797.9800504987375, 820.1306614988112, 1128.3511980611152, 1150.5167829511604, 27266.727332726667, 36330.818345908265, 37339.0, 37349.25301493972, 37376.626233737654, 38765.41851872224, 39139.41290880632, 39161.608383916224, 39185.21629567407, 39192.21615567687, 6175.320714721377, 8558.614862331178, 8734.737957861274, 8742.825143497126, 8750.03749587545, 6248.46888014517, 7871.921280787176, 8263.917360826375, 8503.65985360588, 8673.479591224515, 8753.080926502722, 8806.64773409063, 8809.95595022024, 8822.161894620032, 8830.514321712304, 8730.083341249172, 8763.912360876373, 8784.38509304349, 8811.295096392338, 8812.295016398673, 8526.701565445243, 8561.828763424697, 8585.484870907765, 8589.226969572768, 8594.398392112555, 36693.44959825605, 36848.81575592105, 36849.81575092107, 36867.81566092152, 36888.07779805527, 3575.2670702506184, 3615.403458429356, 3617.656322649344, 3618.6743193112748, 3621.167131559756, 30106.54840177399, 30242.69757302421, 30309.545356819664, 30350.392992140034, 30362.93729719449, 3113.9377212455624, 3159.8894038708536, 3175.9206019849457, 3177.4439473092348, 3194.952075718866, 262210.0, 268673.0, 269345.0, 269692.65153674304, 269941.0, 48490.54528364155, 48517.5148248513, 48531.5146848527, 48560.757196213795, 48573.5142648569, 49872.0, 49903.75048124736, 49924.75037624789, 50018.24972625414, 50030.49969500258, 14026.85973140276, 14142.080764750259, 14171.433142674177, 14175.0, 14189.574312770634, 10005.449700266556, 11582.594609188638, 11586.594469193538, 11594.362310073027, 11607.85254727878, 10681.519331630096, 10769.353838769699, 10772.299800512941, 10773.730656733487, 10787.244892857425, 5111.156659151198, 5325.760340784674, 5336.839894803162, 5344.225087362389, 5345.65253258537, 980.6420656460483, 1010.934289271195, 1014.1734486393566, 1055.8996895294936, 1058.6718117383637, 22938.770612293665, 23982.7601723984, 24001.039958401467, 24162.275131746075, 24290.878545607513, 1040.6211769405568, 1047.2355180718118, 1114.7101753543975, 1146.2893006335958, 1154.96535103947, 11630.0, 12309.076819238413, 12311.50753969849, 12335.198212116184, 12335.753284934251, 344926.0, 345726.2713686466, 345779.0, 345851.0, 346220.0, 52420.0, 52498.21252681213, 52511.47488525066, 52611.736941315816, 52640.473595264324, 1309.4500309869877, 1475.2800749780338, 1483.4659522571865, 1521.7032678627784, 1526.4962562354397, 23507.88246058759, 23579.29262122139, 23639.29082127539, 23683.1710890118, 23750.88124559366, 36816.63183368132, 36949.81525092357, 37004.0, 37005.25989480249, 37050.444243335834, 309093.9090609155, 309894.0, 309920.0, 310302.0, 310886.0, 33263.0, 33765.83117084399, 34246.48630270498, 34320.48519272163, 34379.0, 37484.43773343456, 38011.42982855315, 38017.0, 44213.0, 44954.0, 28371.941013934123, 29121.70878291275, 29599.304180912688, 30621.23446913756, 31763.68236317607, 30123.54814677738, 30890.374318183207, 31206.531902021034, 31209.90765323203, 31226.531602026444, 29202.561961571017, 36620.45069323909, 36842.8157859209, 36911.63088369082, 36917.077073073386, 29760.702392975792, 30243.0, 30669.693303066684, 30992.296786858442, 31838.0, 22778.886105569367, 23500.41248968721, 23781.524369512168, 24172.63741043921, 24224.273271801874], "value": 17227.562461905494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.6394896312615, 429.0582172132169, 438.67099675243566, 441.6797821579355, 457.7185031205809, 20384.87883166427, 21713.56572868542, 22306.776932230674, 22556.774432255672, 22567.0, 22239.0, 23118.959646815892, 23478.882605586947, 23816.999999999956, 24222.87888560559, 6125.908111378333, 6153.784617538398, 6369.394907483782, 6376.936230637681, 6377.202849643794, 6323.083152942821, 6438.5171112166545, 6442.549021568492, 6445.51658625605, 6450.322716114811, 6168.259808822948, 6260.874782504347, 6361.077643741678, 6382.521310901678, 6392.0, 6267.310595834455, 6286.528510361695, 6344.0, 6349.428551430347, 6349.841253968664, 5505.6696598203835, 5668.121441176624, 5738.254026976467, 5746.626469279525, 5748.396418376052, 28140.296492587644, 28341.43317133646, 28368.85815570909, 28435.715642843512, 28550.571741423897, 2182.1707751054496, 2225.4547635829163, 2231.698720672721, 2233.3188377544843, 2233.62028455163, 16914.49256522294, 17724.91137544317, 18266.817331826645, 18304.17631206599, 18565.44303670892, 1962.7252184694155, 2041.13251867957, 2177.891105444737, 2184.6722991551237, 2186.365953873375, 153479.0, 157235.0, 158734.41265587427, 162359.0, 163790.0, 12377.752444951051, 12417.62747117588, 12584.874151258553, 12702.42839072244, 12916.289604071866, 17043.488695339158, 17087.829121708623, 17101.743473847902, 17106.743398849027, 17232.138393080295, 7881.960590197013, 7961.203879612109, 8922.840030795955, 9022.548872556346, 9218.21645160169, 8598.527081010605, 8607.78480537979, 8630.697925572575, 8834.425762325429, 8838.381313308008, 6680.459356541041, 7524.984127142875, 7831.804204894923, 7892.60536973149, 7908.327792137733, 2174.6520556710852, 2175.869447833135, 2176.4667656424276, 2183.7379514458366, 2323.790858822714, 927.8979312275644, 953.537534295866, 978.256525040974, 993.3493561717087, 998.2612866478753, 20748.896255518626, 21553.67669484959, 21559.0, 21561.784382156293, 21598.78401215968, 967.4485543240426, 967.5259123029806, 975.6048800235916, 1002.8896821349646, 1005.6731562242301, 10860.0, 11045.889541104487, 11073.169512286611, 11101.611443599435, 11150.888491115147, 713340.0, 724671.0, 725107.0, 748149.0, 754201.0, 104051.54864039624, 154181.0, 156609.0, 159380.0, 162273.0, 1123.1688550472754, 1164.0978241862456, 1176.2178151529308, 1176.7528818947947, 1178.911581631381, 20991.685124723448, 21979.670304945757, 22260.77739222587, 22284.554308914056, 22308.0, 60540.0, 60848.0, 61583.6920815393, 61846.38153618406, 62123.06815397863, 80806.0, 81418.0, 83740.58129709556, 85745.0, 86478.135218647, 7976.641051152828, 8730.039695633603, 9028.232600229054, 9092.22716069115, 9245.121713437213, 14159.292035398395, 14194.006419550946, 14271.357788899732, 14658.267086645837, 14684.926575367055, 10123.898761012295, 11005.559777608805, 11252.887471125185, 11834.881651183377, 11965.700857478632, 11060.949209825054, 11099.667009989713, 11167.162462815159, 11563.58086479095, 11844.644660660195, 9989.950050249703, 11913.821292680443, 12172.39138043112, 12178.147529672839, 12422.565210217961, 8746.69386571467, 8942.821143577223, 8965.551722413722, 9004.729858104267, 9229.307801915018, 11047.558097676003, 11530.1928864982, 11696.35670038156, 11719.88280117222, 12134.75730485403], "value": 10747.596259590347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.6133779197344, 1361.5438827992634, 1454.425501926739, 1475.1444162385817, 1478.4899209772625, 10570.154387648989, 11653.941730291337, 11668.766624667502, 11678.649640510788, 11720.706982325424, 11432.485538150782, 11887.346195959219, 11890.048796096313, 11929.7614047719, 11937.462814173361, 2539.1366935242013, 2576.6521519594894, 2580.225932220336, 2582.9612555811677, 2583.7287084856102, 2106.062802053087, 2146.37755051035, 2421.588329983907, 2511.8116141289383, 2554.604036374365, 2171.619966505863, 2433.793127584149, 2536.5561026820324, 2540.5173017126685, 2545.2237067694346, 2456.914008009711, 2479.764422379871, 2482.565551028563, 2490.452100537897, 2494.276659768665, 2466.0628960994886, 2471.1351027140536, 2472.1223965492172, 2480.91316803911, 2481.268025932336, 11794.823077653842, 12096.213746106476, 12104.697382565419, 12107.213031152947, 12119.33343666098, 6626.900596491057, 6895.862082758316, 6896.034555162281, 6906.551074180162, 6920.30796920309, 4096.651784598283, 4324.956750432487, 4434.246178149722, 4487.708298960557, 4494.9775251123865, 1102.7979502342484, 1264.5574049082838, 1275.8086287056924, 1301.6615679923289, 1307.8430588329365, 16792.91603541987, 16882.662346752997, 16895.070771107585, 16897.577560561083, 16903.915480422642, 4171.249175148502, 5301.363836339664, 5354.0, 5506.339239291311, 5698.515626171822, 12448.564300249447, 12466.252024878355, 12474.563390281297, 12480.625581232578, 12485.563005294953, 6648.700808463631, 6681.064650948871, 6682.131322927989, 6688.832779180462, 6696.7656132035145, 6026.12412683752, 6114.847128821815, 6178.907316390258, 6209.472194863487, 6225.408586184305, 3691.8707845225827, 4202.684798640114, 4324.1567894260315, 4334.869953901388, 4390.275604525217, 1267.1256832785348, 1267.2649863079391, 1271.3643178410794, 1290.4193113099143, 1291.4511332683571, 626.9184261929174, 760.22836820626, 786.6184900323339, 795.8885755994165, 798.9600519974094, 6316.747330106744, 6738.225104112992, 7030.367266945999, 7064.752733654297, 7097.0, 927.7819712367589, 936.4942930817418, 940.849464085743, 940.9247260219166, 947.668316089377, 3586.372384832644, 3907.667848232932, 4237.618614324726, 4274.722143060753, 4327.459067616548, 14971.326290316962, 15571.143587102819, 15577.532674019798, 15606.531804045897, 15607.297671604805, 13689.110207836458, 15358.462453814287, 15360.23198840076, 15362.53912382608, 15371.769423458658, 10401.53193106312, 10651.60338923736, 10673.0, 10683.83974240387, 10691.62579309736, 6517.250516190698, 6816.693248803716, 7254.45591580623, 7283.490155689051, 7349.4487913407775, 13705.0, 13770.586882393543, 13877.306134693426, 14122.0, 14153.0, 14230.217338046094, 14233.50182743599, 14360.640983975067, 14556.708865822413, 14584.416623334948, 9559.761005974628, 9873.703788886345, 9875.728582426225, 9882.258830587878, 9901.05939935705, 10918.0, 10927.562897484011, 10976.176786740867, 11038.337699738042, 11056.115510758958, 9251.398659087137, 9287.582058807506, 9306.395084319498, 9326.160645541662, 9470.857937131086, 9138.268938485038, 9234.676786312446, 9261.907380926104, 9265.768355791159, 9269.212116970133, 8299.751007469786, 8496.787580310542, 8500.31997440191, 8502.44734092282, 8511.74464766058, 4908.730019848943, 5185.714785686823, 5979.222701048836, 6130.386961303834, 6263.718132684131, 6084.239470066242, 6104.816855494342, 6194.845128871814, 6307.43233109004, 6432.00303952888], "value": 5466.11300583915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.83704266637704, 394.2017414735161, 403.79406502683634, 419.2620987062771, 420.0129695216242, 4911.6669581948645, 5260.89478210436, 5837.24115864937, 6046.516278697699, 6087.7260523276445, 4855.7086574805535, 5086.720230387327, 5882.205977144739, 5887.735051922674, 5965.46310832025, 3630.6187850275737, 4385.166818304528, 4389.3196554534015, 4410.845620403286, 4411.933820992687, 4198.139381426816, 4371.846985355497, 4403.581659742319, 4412.338149277602, 4418.690691651585, 4334.479862416514, 4345.283028300327, 4362.149380870732, 4370.562943705636, 4394.231009573328, 3755.6244375562223, 3787.659110680052, 4353.891152721208, 4365.428445759524, 4381.9561804381865, 3799.2401519695895, 3809.3524100902637, 3810.256999884996, 3815.1225218199693, 3820.694344452465, 5564.638298510584, 5852.56105792063, 5854.853628659275, 5874.882502349929, 5886.1164427383255, 5038.00238857879, 5187.455317191716, 5250.18622113573, 5290.365156181244, 5305.575553955674, 5571.554275657938, 6019.194241727508, 6303.621782693007, 6350.761601487712, 6378.840528986766, 4323.524412314643, 4329.264025115738, 4332.718373305725, 4338.783060846945, 4338.783060846977, 6164.445199931983, 6362.791069696789, 6443.162388889415, 6566.37619426149, 6779.52551316129, 3823.445600387928, 4366.257736184856, 4395.7362558246605, 4405.911881762347, 4409.735415875058, 4447.999200179934, 4452.554744525586, 4457.375967364572, 4468.843590474317, 4491.236489796743, 3993.0815912340327, 4810.927836082462, 4986.301917731521, 5251.8161864335325, 5291.894162116736, 6320.209973753281, 6404.925635694893, 6409.615423074631, 6423.325550817191, 6463.612183269019, 1510.3203558398545, 1524.7268530776703, 1528.7171873203492, 1529.4493982166412, 1532.3487517804888, 966.2270183852889, 1007.9546420411099, 1012.9290949633603, 1014.6347314966606, 1023.948802559869, 5315.405378386468, 6028.306744724413, 6066.848328791815, 6078.206928955969, 6116.541259405562, 5716.114002329646, 6042.555743226407, 6218.22272215973, 6609.504287178481, 6622.2715501294815, 5387.326584176978, 5807.593468457252, 6094.481969032682, 6157.260019291372, 6181.536384771161, 2633.736626337389, 3469.7918124912585, 3471.2016236265295, 3476.3568739783223, 3481.442969124928, 5693.629914055656, 6758.459323254128, 6772.966135169391, 6791.219009813836, 6808.6255255960405, 6708.496862735315, 6708.798736037927, 6719.529632925648, 6749.527533072638, 6757.256701762803, 5877.823665290048, 6421.51838612106, 6476.514261430411, 6678.465722742266, 6689.665516724047, 5983.44812430388, 6115.541334400027, 6498.447631951148, 6509.967450162719, 6611.371919667624, 5349.705766182898, 5868.413158684098, 6127.785527506516, 6346.555741098079, 6373.139626150411, 5110.259012443101, 5845.707714614167, 6701.430378417889, 6761.357671021246, 6798.626075565693, 4136.689748268952, 4231.942014496376, 4828.985912958318, 4832.710037397767, 4843.539863712942, 4987.451380348231, 5831.650100993954, 6261.495401839118, 6588.6046837188005, 6629.370209830058, 6290.2766181889665, 6326.525510586633, 6342.8731425370315, 6350.555461117678, 6369.299377068612, 5550.583706221969, 6097.817065488042, 6121.357257488078, 6365.96817015912, 6390.456811171102, 5805.3614102447855, 6156.353582873734, 6179.598326108789, 6182.598131121463, 6268.247810262797, 5751.0, 6339.144215530844, 6347.809565713036, 6356.2054743157105, 6358.618482891041, 5846.795362162304, 5872.533535915011, 5922.911156332744, 6136.8772624548155, 6213.627182369072], "value": 4630.3653644106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.392502447895, 843.4517563583672, 868.3660927522908, 875.2385424680529, 875.7197696737043, 13574.3212839358, 17836.73244901326, 17915.820841791578, 18510.352137675185, 18511.0, 17117.22972466239, 17124.743128853046, 17492.737608935844, 17565.473035808915, 17576.560585985324, 963.7494251494592, 991.2961797124015, 992.791513782103, 993.2798720927306, 999.2455695949548, 669.8358902069, 689.3554526517722, 973.5570315506463, 1007.1791489935715, 1024.4263212600968, 1071.6463567022863, 1072.1583556907829, 1072.9195310351715, 1074.8172810622214, 1077.3697387028599, 1063.473580577619, 1067.2635881241918, 1067.9893201067969, 1068.0761141612527, 1069.4385447639972, 660.9537332386735, 800.3677095094868, 802.1377019703842, 802.8033131882668, 803.2248879830933, 16225.756613650805, 16321.83678163215, 16494.75257871133, 16938.576535586708, 17244.137793110294, 16804.74792878108, 16934.915325423295, 17354.0, 17371.131443427905, 17451.825481745145, 13848.723025539533, 13953.023288369819, 14107.78838317426, 14262.429502819874, 14302.64243393913, 3417.829108544563, 3439.2777516721517, 3442.0, 3447.465642825366, 3448.3448144852396, 112754.0, 115659.0, 116248.41875790567, 116316.0, 117112.41443792726, 11196.552137914556, 11361.318320900607, 12231.143819932518, 12314.076444266715, 12333.260004399765, 17513.036782976804, 20253.886036268148, 25521.234362969142, 25532.48935021289, 25676.101336453135, 8714.259287960595, 9042.773930651654, 9053.818923621491, 9054.185123338799, 9083.772905677411, 4627.745473998895, 4765.69023013503, 4836.46798852126, 4876.024795041006, 4880.048390563877, 3719.4420836874683, 4287.164003019381, 4413.801378937956, 4415.51429342772, 4418.4918734345965, 934.5700977550267, 974.0697633759743, 977.7702239973601, 978.8189185000798, 979.1139019187505, 575.5999580291657, 576.2163457697528, 590.2739630254725, 590.740074367277, 608.4675908579992, 10493.422861742678, 11354.0, 11698.181127321006, 11875.524979000744, 12046.879531204751, 654.3227759269229, 654.754467074847, 656.7373050779727, 668.759246671198, 685.6914388525084, 5372.355317361941, 5543.113101903676, 5561.721913904288, 5649.802256920988, 6157.322694503601, 94312.0, 99314.5034274824, 102653.0, 103158.0, 103458.0, 76414.47171056547, 82984.58507707543, 87455.0, 94090.0, 96532.0346796537, 53443.0, 79469.41061178745, 82229.58885205536, 82685.58657206796, 83313.16686833055, 10009.599616015277, 10505.737356566147, 11989.34058626784, 12295.75408491843, 12399.628011159679, 40393.0, 40650.78047658575, 40969.0, 41280.0, 41876.0, 71799.4610565904, 72875.0, 74035.259647405, 74587.0, 74728.13179670552, 16355.672886542441, 16529.0, 16582.0, 16643.084630345445, 16644.833551664327, 17894.0, 18477.353292634692, 18513.629727405645, 18515.537111572317, 18548.44354669362, 16355.427560035341, 16371.345146194019, 16798.160091995105, 16892.66214675675, 16938.661226775643, 16346.427875024317, 16360.754588681417, 16404.17979101064, 16620.83379166241, 16675.66648667044, 13490.460381584626, 16206.027638341737, 16372.590685232488, 16437.26032328524, 16551.586210344838, 11237.60668376603, 11386.0, 11801.17391782567, 11980.460879260629, 12430.192037517532, 12700.555480558136, 13833.930830345784, 13923.930380348034, 13935.651608709457, 13947.4421023162], "value": 8399.19349770333, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1627.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 122.0, 121.0, 123.0, 123.0, 122.0, 126.0, 175.0, 104.0, 175.0], "value": 130.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 113.0, 117.0, 162.0, 116.0, 117.0, 113.0, 116.0, 145.0, 147.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 217.0, 209.0, 208.0, 207.0, 208.0, 209.0, 209.0, 211.0, 214.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 89.0, 128.0, 59.0, 81.0, 89.0, 91.0, 114.0, 60.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 79.0, 95.0, 76.0, 77.0, 74.0, 91.0, 73.0, 74.0, 91.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 104.0, 91.0, 91.0, 91.0, 91.0, 92.0, 91.0, 91.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 100.0, 101.0, 100.0, 101.0, 100.0, 100.0, 98.0, 99.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 123.0, 163.0, 111.0, 152.0, 112.0, 100.0, 102.0, 100.0], "value": 116.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 50.0, 51.0, 53.0, 51.0, 50.0, 51.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 68.0, 69.0, 71.0, 67.0, 63.0, 65.0, 65.0, 64.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 90.0, 91.0, 89.0, 92.0, 93.0, 88.0, 90.0, 105.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 142.0, 142.0, 159.0, 168.0, 162.0, 150.0, 198.0, 196.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [227.0, 262.0, 234.0, 260.0, 263.0, 211.0, 197.0, 208.0, 231.0, 219.0], "value": 231.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 73.0, 73.0, 73.0, 74.0, 73.0, 72.0, 74.0], "value": 73.6, "unit": "score"}]}]} 05:30:01 INFO - Return code: 0 05:30:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:30:02 ERROR - # TBPL SUCCESS # 05:30:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:02 INFO - 2017-04-10 05:30:02.027 screenresolution[1652:9761] starting screenresolution argv=screenresolution get 05:30:02 INFO - 2017-04-10 05:30:02.030 screenresolution[1652:9761] Display 0: 1600x1200x32@60 05:30:02 INFO - 2017-04-10 05:30:02.036 screenresolution[1653:9764] starting screenresolution argv=screenresolution list 05:30:02 INFO - Available Modes on Display 0 05:30:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:02 INFO - Intel Iris: 05:30:02 INFO - Chipset Model: Intel Iris 05:30:02 INFO - Type: GPU 05:30:02 INFO - Bus: Built-In 05:30:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:30:02 INFO - Vendor: Intel (0x8086) 05:30:02 INFO - Device ID: 0x0a2e 05:30:02 INFO - Revision ID: 0x0009 05:30:02 INFO - Displays: 05:30:02 INFO - Display: 05:30:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:02 INFO - Display Serial Number: 1600x1200 60 05:30:02 INFO - Main Display: Yes 05:30:02 INFO - Mirror: Off 05:30:02 INFO - Online: Yes 05:30:02 INFO - Rotation: Supported 05:30:02 INFO - Return code: 0 05:30:02 INFO - Running post-action listener: _resource_record_post_action 05:30:02 INFO - [mozharness: 2017-04-10 12:30:02.284851Z] Finished run-tests step (success) 05:30:02 INFO - Running post-run listener: _resource_record_post_run 05:30:02 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 38433792; Write bytes: 519615488; Read time: 248; Write time: 1576 05:30:02 INFO - TinderboxPrint: CPU usage
53.4% 05:30:02 INFO - TinderboxPrint: I/O read bytes / time
38,433,792 / 248 05:30:02 INFO - TinderboxPrint: I/O write bytes / time
519,615,488 / 1,576 05:30:02 INFO - TinderboxPrint: CPU idle
2,243.4 (46.6%) 05:30:02 INFO - TinderboxPrint: CPU system
958.4 (19.9%) 05:30:02 INFO - TinderboxPrint: CPU user
1,615.9 (33.5%) 05:30:02 INFO - TinderboxPrint: Swap in / out
245,583,872 / 0 05:30:02 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208812544; Write bytes: 210921472; Read time: 15953; Write time: 451 05:30:02 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 34649088; Write bytes: 307170304; Read time: 221; Write time: 1120 05:30:02 INFO - Running post-run listener: _upload_blobber_files 05:30:02 INFO - Blob upload gear active. 05:30:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:30:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:04 INFO - (blobuploader) - INFO - Done attempting. 05:30:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:30:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:05 INFO - (blobuploader) - INFO - Done attempting. 05:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:06 INFO - (blobuploader) - INFO - Done attempting. 05:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:30:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:08 INFO - (blobuploader) - INFO - Done attempting. 05:30:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:30:08 INFO - Return code: 0 05:30:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:30:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:30:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a008570e7cb48f70afafa58038c3e4881b5e5b3aef24ea3b27576a8045b7324f3f66fa149b971d1e29a45d71e2f8e436a90ee4e4708e8bcbebbec4f39d5f5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa32370d4d3422a931f2c1a2c4d3e57efbc896b55da4cf8a51fd27b2545f416b19d62de7c18a8bac83535f03af352449b8cc93b723a0a3f6385f67ee6598eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c798fc870dc41ff435293710c4785a8b87c874f89d21a1a630a5743229dfa59cfcfc6bfd93feb9034b372d803120bcc6ea6614d5e0510153262153659957884", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/765b807033e1d7df9d8f1844d81dc65e9a9b70676bc016097be3417cc1672fe59b9e9b8b1fec9151cdcd5701aa286b9cba0d67912f75610633d534c3811cfb2a"} 05:30:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:30:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:30:08 INFO - Contents: 05:30:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a008570e7cb48f70afafa58038c3e4881b5e5b3aef24ea3b27576a8045b7324f3f66fa149b971d1e29a45d71e2f8e436a90ee4e4708e8bcbebbec4f39d5f5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa32370d4d3422a931f2c1a2c4d3e57efbc896b55da4cf8a51fd27b2545f416b19d62de7c18a8bac83535f03af352449b8cc93b723a0a3f6385f67ee6598eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c798fc870dc41ff435293710c4785a8b87c874f89d21a1a630a5743229dfa59cfcfc6bfd93feb9034b372d803120bcc6ea6614d5e0510153262153659957884", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/765b807033e1d7df9d8f1844d81dc65e9a9b70676bc016097be3417cc1672fe59b9e9b8b1fec9151cdcd5701aa286b9cba0d67912f75610633d534c3811cfb2a"} 05:30:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:30:08 INFO - Copying logs to upload dir... 05:30:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:30:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.597239 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-10 05:30:08.285639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 05:30:08.289313) ========= 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.9L8TWfbRfJ/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.762tMWg5DA/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/14a008570e7cb48f70afafa58038c3e4881b5e5b3aef24ea3b27576a8045b7324f3f66fa149b971d1e29a45d71e2f8e436a90ee4e4708e8bcbebbec4f39d5f5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa32370d4d3422a931f2c1a2c4d3e57efbc896b55da4cf8a51fd27b2545f416b19d62de7c18a8bac83535f03af352449b8cc93b723a0a3f6385f67ee6598eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c798fc870dc41ff435293710c4785a8b87c874f89d21a1a630a5743229dfa59cfcfc6bfd93feb9034b372d803120bcc6ea6614d5e0510153262153659957884", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/765b807033e1d7df9d8f1844d81dc65e9a9b70676bc016097be3417cc1672fe59b9e9b8b1fec9151cdcd5701aa286b9cba0d67912f75610633d534c3811cfb2a"} build_url:https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/bpfKz_AbSeS6zjkm3GuZ_g/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/14a008570e7cb48f70afafa58038c3e4881b5e5b3aef24ea3b27576a8045b7324f3f66fa149b971d1e29a45d71e2f8e436a90ee4e4708e8bcbebbec4f39d5f5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa32370d4d3422a931f2c1a2c4d3e57efbc896b55da4cf8a51fd27b2545f416b19d62de7c18a8bac83535f03af352449b8cc93b723a0a3f6385f67ee6598eb0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c798fc870dc41ff435293710c4785a8b87c874f89d21a1a630a5743229dfa59cfcfc6bfd93feb9034b372d803120bcc6ea6614d5e0510153262153659957884", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/765b807033e1d7df9d8f1844d81dc65e9a9b70676bc016097be3417cc1672fe59b9e9b8b1fec9151cdcd5701aa286b9cba0d67912f75610633d534c3811cfb2a"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 05:30:08.404701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 05:30:08.408029) ========= 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.9L8TWfbRfJ/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.762tMWg5DA/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.005380 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 05:30:08.439301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 05:30:08.439571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 05:30:08.439860) ========= ========= Total master_lag: 0.25 =========