builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0281 starttime: 1491867077.8 results: success (0) buildid: 20170410145521 builduid: adc4d7a7385e4dd9aa39a36e9a2f76ad revision: d7b81b700d7571cd4c5486a1152477fe99e0643d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:17.798212) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:17.798629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:17.799046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:17.827991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 16:31:17.828317) ========= 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.Whxn3agyyx/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.S2FtAcpfng/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:31:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.1M=0.001s 2017-04-10 16:31:18 (11.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.056003 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 16:31:18.908907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:18.909287) ========= 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.Whxn3agyyx/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.S2FtAcpfng/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.037683 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:18.969254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:18.969709) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d7b81b700d7571cd4c5486a1152477fe99e0643d --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 d7b81b700d7571cd4c5486a1152477fe99e0643d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Whxn3agyyx/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.S2FtAcpfng/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:31:19,054 truncating revision to first 12 chars 2017-04-10 16:31:19,054 Setting DEBUG logging. 2017-04-10 16:31:19,054 attempt 1/10 2017-04-10 16:31:19,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d7b81b700d75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 16:31:19,400 unpacking tar archive at: mozilla-central-d7b81b700d75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:19.621738) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:19.622106) ========= script_repo_revision: d7b81b700d7571cd4c5486a1152477fe99e0643d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:19.622486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:19.622752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 16:31:19.643486) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-10 16:31:19.644362) ========= /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.Whxn3agyyx/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.S2FtAcpfng/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:31:19 INFO - MultiFileLogger online at 20170410 16:31:19 in /builds/slave/test 16:31:19 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 16:31:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:19 INFO - {'append_to_log': False, 16:31:19 INFO - 'base_work_dir': '/builds/slave/test', 16:31:19 INFO - 'blob_upload_branch': 'Firefox', 16:31:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:19 INFO - 'branch': 'Firefox', 16:31:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:19 INFO - 'config_files': ('talos/mac_config.py',), 16:31:19 INFO - 'default_actions': ('clobber', 16:31:19 INFO - 'read-buildbot-config', 16:31:19 INFO - 'download-and-extract', 16:31:19 INFO - 'populate-webroot', 16:31:19 INFO - 'create-virtualenv', 16:31:19 INFO - 'install', 16:31:19 INFO - 'run-tests'), 16:31:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:19 INFO - 'download_minidump_stackwalk': True, 16:31:19 INFO - 'download_symbols': 'ondemand', 16:31:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:19 INFO - 'gecko_profile': False, 16:31:19 INFO - 'gecko_profile_interval': 0, 16:31:19 INFO - 'installer_path': 'installer.exe', 16:31:19 INFO - 'log_level': 'info', 16:31:19 INFO - 'log_name': 'talos', 16:31:19 INFO - 'log_to_console': True, 16:31:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:31:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:31:19 INFO - 'opt_config_files': (), 16:31:19 INFO - 'pip_index': False, 16:31:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:19 INFO - 'cmd': ('bash', 16:31:19 INFO - '-c', 16:31:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:19 INFO - 'enabled': True, 16:31:19 INFO - 'halt_on_failure': False, 16:31:19 INFO - 'name': 'check_screen_resolution'},), 16:31:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:19 INFO - 'cmd': ('bash', 16:31:19 INFO - '-c', 16:31:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:19 INFO - 'enabled': True, 16:31:19 INFO - 'halt_on_failure': False, 16:31:19 INFO - 'name': 'check_screen_resolution'},), 16:31:19 INFO - 'run_cmd_checks_enabled': True, 16:31:19 INFO - 'suite': 'dromaeojs', 16:31:19 INFO - 'system_bits': '32', 16:31:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:19 INFO - 'title': 't-yosemite-r7-0281', 16:31:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:19 INFO - 'use_talos_json': True, 16:31:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:19 INFO - 'work_dir': 'build'} 16:31:19 INFO - [mozharness: 2017-04-10 23:31:19.839374Z] Running clobber step. 16:31:19 INFO - Running pre-action listener: _resource_record_pre_action 16:31:19 INFO - Running main action method: clobber 16:31:19 INFO - rmtree: /builds/slave/test/build 16:31:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:22 INFO - Running post-action listener: _resource_record_post_action 16:31:22 INFO - [mozharness: 2017-04-10 23:31:22.384613Z] Finished clobber step (success) 16:31:22 INFO - [mozharness: 2017-04-10 23:31:22.384745Z] Running read-buildbot-config step. 16:31:22 INFO - Running pre-action listener: _resource_record_pre_action 16:31:22 INFO - Running main action method: read_buildbot_config 16:31:22 INFO - Using buildbot properties: 16:31:22 INFO - { 16:31:22 INFO - "project": "", 16:31:22 INFO - "product": "firefox", 16:31:22 INFO - "script_repo_revision": "production", 16:31:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:31:22 INFO - "repository": "", 16:31:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:31:22 INFO - "buildid": "20170410145521", 16:31:22 INFO - "pgo_build": "False", 16:31:22 INFO - "basedir": "/builds/slave/test", 16:31:22 INFO - "buildnumber": 73, 16:31:22 INFO - "slavename": "t-yosemite-r7-0281", 16:31:22 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:31:22 INFO - "platform": "yosemite_r7", 16:31:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:31:22 INFO - "branch": "mozilla-central", 16:31:22 INFO - "repo_path": "mozilla-central", 16:31:22 INFO - "revision": "d7b81b700d7571cd4c5486a1152477fe99e0643d", 16:31:22 INFO - "stage_platform": "macosx64", 16:31:22 INFO - "builduid": "adc4d7a7385e4dd9aa39a36e9a2f76ad", 16:31:22 INFO - "slavebuilddir": "test" 16:31:22 INFO - } 16:31:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:31:22 INFO - Running post-action listener: _resource_record_post_action 16:31:22 INFO - [mozharness: 2017-04-10 23:31:22.387891Z] Finished read-buildbot-config step (success) 16:31:22 INFO - [mozharness: 2017-04-10 23:31:22.387983Z] Running download-and-extract step. 16:31:22 INFO - Running pre-action listener: _resource_record_pre_action 16:31:22 INFO - Running main action method: download_and_extract 16:31:22 INFO - mkdir: /builds/slave/test/build/tests 16:31:22 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')]} 16:31:22 INFO - trying https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/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 16:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/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 16:31:23 INFO - Downloaded 1325 bytes. 16:31:23 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:31:23 INFO - Using the following test package requirements: 16:31:23 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:31:23 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:31:23 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:31:23 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:31:23 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'jsshell-mac.zip'], 16:31:23 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:31:23 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:31:23 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:31:23 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:31:23 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:31:23 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:31:23 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:31:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:31:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:31:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:31:23 INFO - Fetch https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:31:25 INFO - Expected file size: 52580640 16:31:25 INFO - Obtained file size: 52580640 16:31:41 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 16:31:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:31:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:31:41 INFO - Fetch https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:31:42 INFO - Expected file size: 52580640 16:31:42 INFO - Obtained file size: 52580640 16:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:31:59 INFO - Expected file size: 14405596 16:31:59 INFO - Obtained file size: 14405596 16:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:00 INFO - trying https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:32:00 INFO - Downloading https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/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 16:32:02 INFO - Downloaded 70958806 bytes. 16:32:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:32:02 INFO - mkdir: /builds/slave/test/properties 16:32:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:02 INFO - Contents: 16:32:02 INFO - build_url:https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:32:02 INFO - Running post-action listener: _resource_record_post_action 16:32:02 INFO - Running post-action listener: set_extra_try_arguments 16:32:02 INFO - [mozharness: 2017-04-10 23:32:02.759580Z] Finished download-and-extract step (success) 16:32:02 INFO - [mozharness: 2017-04-10 23:32:02.759726Z] Running populate-webroot step. 16:32:02 INFO - Running pre-action listener: _resource_record_pre_action 16:32:02 INFO - Running main action method: populate_webroot 16:32:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:02 INFO - '--tppagecycles', 16:32:02 INFO - '7'], 16:32:02 INFO - 'tests': ['tsvgm']}}, 16:32:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['damp', 'tps']}, 16:32:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'tests': ['damp', 'tps']}, 16:32:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['dromaeo_dom']}, 16:32:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['basic_compositor_video']}, 16:32:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:32:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['a11yr', 16:32:02 INFO - 'ts_paint', 16:32:02 INFO - 'tpaint', 16:32:02 INFO - 'sessionrestore', 16:32:02 INFO - 'sessionrestore_no_auto_restore', 16:32:02 INFO - 'tabpaint']}, 16:32:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tsvgx', 16:32:02 INFO - 'tsvgr_opacity', 16:32:02 INFO - 'tart', 16:32:02 INFO - 'tscrollx', 16:32:02 INFO - 'cart', 16:32:02 INFO - 'tsvg_static']}, 16:32:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:02 INFO - 'tsvgr_opacity', 16:32:02 INFO - 'tart', 16:32:02 INFO - 'tscrollx', 16:32:02 INFO - 'cart', 16:32:02 INFO - 'tsvg_static']}, 16:32:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s'], 16:32:02 INFO - 'tests': ['tp5o']}, 16:32:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:32:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--disable-e10s', 16:32:02 INFO - '--xperf_path', 16:32:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:02 INFO - 'tests': ['tp5n']}, 16:32:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:32:02 INFO - 'talos_options': ['--xperf_path', 16:32:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:02 INFO - 'tests': ['tp5n']}}, 16:32:02 INFO - 'talos.zip': {'path': '', 16:32:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:02 INFO - Running post-action listener: _resource_record_post_action 16:32:02 INFO - [mozharness: 2017-04-10 23:32:02.778040Z] Finished populate-webroot step (success) 16:32:02 INFO - [mozharness: 2017-04-10 23:32:02.778149Z] Running create-virtualenv step. 16:32:02 INFO - Running pre-action listener: _resource_record_pre_action 16:32:02 INFO - Running main action method: create_virtualenv 16:32:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:02 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 16:32:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:02 INFO - Using real prefix '/tools/python27' 16:32:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:06 INFO - Installing pip.................done. 16:32:06 INFO - Return code: 0 16:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:32:06 INFO - Reading from file tmpfile_stdout 16:32:06 INFO - Output received: 16:32:06 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) 16:32:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:07 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:07 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 16:32:07 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 16:32:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:07 INFO - 'HOME': '/Users/cltbld', 16:32:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:07 INFO - 'LOGNAME': 'cltbld', 16:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:07 INFO - 'MOZ_NO_REMOTE': '1', 16:32:07 INFO - 'NO_EM_RESTART': '1', 16:32:07 INFO - 'PAGER': '/bin/cat', 16:32:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:07 INFO - 'PWD': '/builds/slave/test', 16:32:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:07 INFO - 'SHELL': '/bin/bash', 16:32:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:07 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:07 INFO - 'USER': 'cltbld', 16:32:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:07 INFO - 'XPC_FLAGS': '0x0', 16:32:07 INFO - 'XPC_SERVICE_NAME': '0', 16:32:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:07 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 16:32:07 INFO - Cleaning up... 16:32:07 INFO - Return code: 0 16:32:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32:07 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')]} 16:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:07 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')]} 16:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:07 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:07 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 16:32:07 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 16:32:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:07 INFO - 'HOME': '/Users/cltbld', 16:32:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:07 INFO - 'LOGNAME': 'cltbld', 16:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:07 INFO - 'MOZ_NO_REMOTE': '1', 16:32:07 INFO - 'NO_EM_RESTART': '1', 16:32:07 INFO - 'PAGER': '/bin/cat', 16:32:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:07 INFO - 'PWD': '/builds/slave/test', 16:32:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:07 INFO - 'SHELL': '/bin/bash', 16:32:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:07 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:07 INFO - 'USER': 'cltbld', 16:32:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:07 INFO - 'XPC_FLAGS': '0x0', 16:32:07 INFO - 'XPC_SERVICE_NAME': '0', 16:32:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:07 INFO - Downloading/unpacking psutil>=3.1.1 16:32:07 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 16:32:07 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 16:32:07 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 16:32:07 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 16:32:07 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 16:32:07 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 16:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:11 INFO - Installing collected packages: psutil 16:32:11 INFO - Running setup.py install for psutil 16:32:11 INFO - building 'psutil._psutil_osx' extension 16:32:11 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 16:32:11 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 16:32:11 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 16:32:11 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 16:32:11 INFO - building 'psutil._psutil_posix' extension 16:32:11 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 16:32:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:32:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:32:11 INFO - ^ 16:32:12 INFO - 1 warning generated. 16:32:12 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 16:32:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:12 INFO - Successfully installed psutil 16:32:12 INFO - Cleaning up... 16:32:12 INFO - Return code: 0 16:32:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:12 INFO - 'HOME': '/Users/cltbld', 16:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:12 INFO - 'LOGNAME': 'cltbld', 16:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:12 INFO - 'MOZ_NO_REMOTE': '1', 16:32:12 INFO - 'NO_EM_RESTART': '1', 16:32:12 INFO - 'PAGER': '/bin/cat', 16:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:12 INFO - 'PWD': '/builds/slave/test', 16:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:12 INFO - 'SHELL': '/bin/bash', 16:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:12 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:12 INFO - 'USER': 'cltbld', 16:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:12 INFO - 'XPC_FLAGS': '0x0', 16:32:12 INFO - 'XPC_SERVICE_NAME': '0', 16:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:15 INFO - Installing collected packages: mozsystemmonitor 16:32:15 INFO - Running setup.py install for mozsystemmonitor 16:32:15 INFO - Successfully installed mozsystemmonitor 16:32:15 INFO - Cleaning up... 16:32:15 INFO - Return code: 0 16:32:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:15 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')]} 16:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:15 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')]} 16:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:16 INFO - 'HOME': '/Users/cltbld', 16:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:16 INFO - 'LOGNAME': 'cltbld', 16:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:16 INFO - 'MOZ_NO_REMOTE': '1', 16:32:16 INFO - 'NO_EM_RESTART': '1', 16:32:16 INFO - 'PAGER': '/bin/cat', 16:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:16 INFO - 'PWD': '/builds/slave/test', 16:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:16 INFO - 'SHELL': '/bin/bash', 16:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:16 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:16 INFO - 'USER': 'cltbld', 16:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:16 INFO - 'XPC_FLAGS': '0x0', 16:32:16 INFO - 'XPC_SERVICE_NAME': '0', 16:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:20 INFO - warning: no files found matching '*.txt' 16:32:20 INFO - no previously-included directories found matching 'build' 16:32:20 INFO - no previously-included directories found matching 'dist' 16:32:20 INFO - no previously-included directories found matching '.git*' 16:32:20 INFO - Installing collected packages: jsonschema, functools32 16:32:20 INFO - Running setup.py install for functools32 16:32:20 INFO - warning: no files found matching '*.txt' 16:32:20 INFO - no previously-included directories found matching 'build' 16:32:20 INFO - no previously-included directories found matching 'dist' 16:32:20 INFO - no previously-included directories found matching '.git*' 16:32:20 INFO - Successfully installed jsonschema functools32 16:32:20 INFO - Cleaning up... 16:32:20 INFO - Return code: 0 16:32:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:32:20 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')]} 16:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 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')]} 16:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:20 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 16:32:20 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 16:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:20 INFO - 'HOME': '/Users/cltbld', 16:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:20 INFO - 'LOGNAME': 'cltbld', 16:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:20 INFO - 'MOZ_NO_REMOTE': '1', 16:32:20 INFO - 'NO_EM_RESTART': '1', 16:32:20 INFO - 'PAGER': '/bin/cat', 16:32:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:20 INFO - 'PWD': '/builds/slave/test', 16:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:20 INFO - 'SHELL': '/bin/bash', 16:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:20 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:20 INFO - 'USER': 'cltbld', 16:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:20 INFO - 'XPC_FLAGS': '0x0', 16:32:20 INFO - 'XPC_SERVICE_NAME': '0', 16:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:20 INFO - Cleaning up... 16:32:20 INFO - Return code: 0 16:32:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:20 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')]} 16:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 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')]} 16:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:20 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 16:32:20 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 16:32:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:20 INFO - 'HOME': '/Users/cltbld', 16:32:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:20 INFO - 'LOGNAME': 'cltbld', 16:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:20 INFO - 'MOZ_NO_REMOTE': '1', 16:32:20 INFO - 'NO_EM_RESTART': '1', 16:32:20 INFO - 'PAGER': '/bin/cat', 16:32:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:20 INFO - 'PWD': '/builds/slave/test', 16:32:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:20 INFO - 'SHELL': '/bin/bash', 16:32:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:20 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:20 INFO - 'USER': 'cltbld', 16:32:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:20 INFO - 'XPC_FLAGS': '0x0', 16:32:20 INFO - 'XPC_SERVICE_NAME': '0', 16:32:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32:23 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 16:32:23 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 16:32:23 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 16:32:23 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 16:32:23 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 16:32:23 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 16:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:24 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 16:32:24 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 16:32:24 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 16:32:24 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 16:32:24 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 16:32:24 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 16:32:24 INFO - Downloading docopt-0.6.1.tar.gz 16:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:24 INFO - Running setup.py install for blobuploader 16:32:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:25 INFO - Running setup.py install for requests 16:32:25 INFO - Running setup.py install for docopt 16:32:25 INFO - Successfully installed blobuploader requests docopt 16:32:25 INFO - Cleaning up... 16:32:25 INFO - Return code: 0 16:32:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:25 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:25 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 16:32:25 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 16:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:25 INFO - 'HOME': '/Users/cltbld', 16:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:25 INFO - 'LOGNAME': 'cltbld', 16:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:25 INFO - 'MOZ_NO_REMOTE': '1', 16:32:25 INFO - 'NO_EM_RESTART': '1', 16:32:25 INFO - 'PAGER': '/bin/cat', 16:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:25 INFO - 'PWD': '/builds/slave/test', 16:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:25 INFO - 'SHELL': '/bin/bash', 16:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:25 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:25 INFO - 'USER': 'cltbld', 16:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:25 INFO - 'XPC_FLAGS': '0x0', 16:32:25 INFO - 'XPC_SERVICE_NAME': '0', 16:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-JgPsD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-xzbkOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Ty7HQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-LsLhML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-akTGgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-wfZ_f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-0LDVGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-mNqLcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:26 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-MxAqUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-5shxhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ceKOE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-Ux08Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ZbBLNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-wdMrPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-H15i0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-UkSvrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:27 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-7nwDRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:27 INFO - Running setup.py install for manifestparser 16:32:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:27 INFO - Running setup.py install for mozcrash 16:32:28 INFO - Running setup.py install for mozdebug 16:32:28 INFO - Running setup.py install for mozdevice 16:32:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Running setup.py install for mozfile 16:32:28 INFO - Running setup.py install for mozhttpd 16:32:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Running setup.py install for mozinfo 16:32:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Running setup.py install for mozInstall 16:32:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:28 INFO - Running setup.py install for mozleak 16:32:29 INFO - Running setup.py install for mozlog 16:32:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:29 INFO - Running setup.py install for moznetwork 16:32:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:29 INFO - Running setup.py install for mozprocess 16:32:29 INFO - Running setup.py install for mozprofile 16:32:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:29 INFO - Running setup.py install for mozrunner 16:32:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:29 INFO - Running setup.py install for mozscreenshot 16:32:30 INFO - Running setup.py install for moztest 16:32:30 INFO - Running setup.py install for mozversion 16:32:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:30 INFO - Cleaning up... 16:32:30 INFO - Return code: 0 16:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:30 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')]} 16:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:30 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')]} 16:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:30 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:30 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 16:32:30 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 16:32:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:30 INFO - 'HOME': '/Users/cltbld', 16:32:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:30 INFO - 'LOGNAME': 'cltbld', 16:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:30 INFO - 'MOZ_NO_REMOTE': '1', 16:32:30 INFO - 'NO_EM_RESTART': '1', 16:32:30 INFO - 'PAGER': '/bin/cat', 16:32:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:30 INFO - 'PWD': '/builds/slave/test', 16:32:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:30 INFO - 'SHELL': '/bin/bash', 16:32:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:30 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:30 INFO - 'USER': 'cltbld', 16:32:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:30 INFO - 'XPC_FLAGS': '0x0', 16:32:30 INFO - 'XPC_SERVICE_NAME': '0', 16:32:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:30 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-jnvrYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:30 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)) 16:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:30 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-ksgX96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:30 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)) 16:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:30 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-A5xcv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:30 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)) 16:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:30 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-IBvuIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-V7lh_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zsJCu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-j5uLlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-qWLv7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-qA2kSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-chOHs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-OmKFNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-zru0sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:31 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)) 16:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:31 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-lYGZmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:32 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)) 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-13jgXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:32 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)) 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-yiyT1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:32 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)) 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-CcjZio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:32 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)) 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:32 INFO - Running setup.py (path:/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/pip-g56Fqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:32 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)) 16:32:32 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)) 16:32:32 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)) 16:32:32 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)) 16:32:32 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)) 16:32:32 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)) 16:32:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:35 INFO - Downloading blessings-1.6.tar.gz 16:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:35 INFO - Installing collected packages: blessings 16:32:35 INFO - Running setup.py install for blessings 16:32:35 INFO - Successfully installed blessings 16:32:35 INFO - Cleaning up... 16:32:35 INFO - Return code: 0 16:32:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:35 INFO - Reading from file tmpfile_stdout 16:32:35 INFO - Current package versions: 16:32:35 INFO - blessings == 1.6 16:32:35 INFO - blobuploader == 1.2.4 16:32:35 INFO - docopt == 0.6.1 16:32:35 INFO - functools32 == 3.2.3-2 16:32:35 INFO - jsonschema == 2.5.1 16:32:35 INFO - manifestparser == 1.1 16:32:35 INFO - mozInstall == 1.12 16:32:35 INFO - mozcrash == 1.0 16:32:35 INFO - mozdebug == 0.1 16:32:35 INFO - mozdevice == 0.50 16:32:35 INFO - mozfile == 1.2 16:32:35 INFO - mozhttpd == 0.7 16:32:35 INFO - mozinfo == 0.9 16:32:35 INFO - mozleak == 0.1 16:32:35 INFO - mozlog == 3.4 16:32:35 INFO - moznetwork == 0.27 16:32:35 INFO - mozprocess == 0.25 16:32:35 INFO - mozprofile == 0.28 16:32:35 INFO - mozrunner == 6.13 16:32:35 INFO - mozscreenshot == 0.1 16:32:35 INFO - mozsystemmonitor == 0.3 16:32:35 INFO - moztest == 0.8 16:32:35 INFO - mozversion == 1.4 16:32:35 INFO - psutil == 3.1.1 16:32:35 INFO - requests == 1.2.3 16:32:35 INFO - wsgiref == 0.1.2 16:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:35 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')]} 16:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:35 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')]} 16:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:35 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:35 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 16:32:35 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 16:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:35 INFO - 'HOME': '/Users/cltbld', 16:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:35 INFO - 'LOGNAME': 'cltbld', 16:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:35 INFO - 'MOZ_NO_REMOTE': '1', 16:32:35 INFO - 'NO_EM_RESTART': '1', 16:32:35 INFO - 'PAGER': '/bin/cat', 16:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:35 INFO - 'PWD': '/builds/slave/test', 16:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:35 INFO - 'SHELL': '/bin/bash', 16:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:35 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:35 INFO - 'USER': 'cltbld', 16:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:35 INFO - 'XPC_FLAGS': '0x0', 16:32:35 INFO - 'XPC_SERVICE_NAME': '0', 16:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 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)) 16:32:35 INFO - Cleaning up... 16:32:35 INFO - Return code: 0 16:32:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:35 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')]} 16:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:35 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')]} 16:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:35 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 0x1089fab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089fd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc342d68500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, '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.Whxn3agyyx/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.S2FtAcpfng/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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 16:32:35 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 16:32:35 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 16:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:35 INFO - 'HOME': '/Users/cltbld', 16:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:35 INFO - 'LOGNAME': 'cltbld', 16:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:35 INFO - 'MOZ_NO_REMOTE': '1', 16:32:35 INFO - 'NO_EM_RESTART': '1', 16:32:35 INFO - 'PAGER': '/bin/cat', 16:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:35 INFO - 'PWD': '/builds/slave/test', 16:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:35 INFO - 'SHELL': '/bin/bash', 16:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:35 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:35 INFO - 'USER': 'cltbld', 16:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:35 INFO - 'XPC_FLAGS': '0x0', 16:32:35 INFO - 'XPC_SERVICE_NAME': '0', 16:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:36 INFO - Cleaning up... 16:32:36 INFO - Return code: 0 16:32:36 INFO - Running post-action listener: _resource_record_post_action 16:32:36 INFO - Running post-action listener: _start_resource_monitoring 16:32:36 INFO - Starting resource monitoring. 16:32:36 INFO - [mozharness: 2017-04-10 23:32:36.234679Z] Finished create-virtualenv step (success) 16:32:36 INFO - [mozharness: 2017-04-10 23:32:36.235689Z] Running install step. 16:32:36 INFO - Running pre-action listener: _resource_record_pre_action 16:32:36 INFO - Running main action method: install 16:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:36 INFO - Reading from file tmpfile_stdout 16:32:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:36 INFO - Reading from file tmpfile_stdout 16:32:36 INFO - Output received: 16:32:36 INFO - Usage: mozinstall [options] installer 16:32:36 INFO - Options: 16:32:36 INFO - -h, --help show this help message and exit 16:32:36 INFO - -d DEST, --destination=DEST 16:32:36 INFO - Directory to install application into. [default: 16:32:36 INFO - "/builds/slave/test"] 16:32:36 INFO - --app=APP Application being installed. [default: firefox] 16:32:36 INFO - mkdir: /builds/slave/test/build/application 16:32:36 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'] 16:32:36 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 16:32:56 INFO - Reading from file tmpfile_stdout 16:32:56 INFO - Output received: 16:32:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:32:56 INFO - Running post-action listener: _resource_record_post_action 16:32:56 INFO - [mozharness: 2017-04-10 23:32:56.118856Z] Finished install step (success) 16:32:56 INFO - [mozharness: 2017-04-10 23:32:56.118984Z] Running run-tests step. 16:32:56 INFO - Running pre-action listener: _resource_record_pre_action 16:32:56 INFO - Running main action method: run_tests 16:32:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:56 INFO - 2017-04-10 16:32:56.133 screenresolution[1623:7393] starting screenresolution argv=screenresolution get 16:32:56 INFO - 2017-04-10 16:32:56.136 screenresolution[1623:7393] Display 0: 1600x1200x32@60 16:32:56 INFO - 2017-04-10 16:32:56.142 screenresolution[1624:7396] starting screenresolution argv=screenresolution list 16:32:56 INFO - Available Modes on Display 0 16:32:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:56 INFO - Intel Iris: 16:32:56 INFO - Chipset Model: Intel Iris 16:32:56 INFO - Type: GPU 16:32:56 INFO - Bus: Built-In 16:32:56 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:56 INFO - Vendor: Intel (0x8086) 16:32:56 INFO - Device ID: 0x0a2e 16:32:56 INFO - Revision ID: 0x0009 16:32:56 INFO - Displays: 16:32:56 INFO - Display: 16:32:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:56 INFO - Display Serial Number: 1600x1200 60 16:32:56 INFO - Main Display: Yes 16:32:56 INFO - Mirror: Off 16:32:56 INFO - Online: Yes 16:32:56 INFO - Rotation: Supported 16:32:56 INFO - Return code: 0 16:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:56 INFO - Python 2.7.3 16:32:56 INFO - Return code: 0 16:32:56 INFO - grabbing minidump binary from tooltool 16:32:56 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')]} 16:32:56 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 0x1087d8d30>, '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 0x1086ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087cdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:56 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 16:32:56 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 16:32:56 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 16:32:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:56 INFO - Return code: 0 16:32:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:32:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:56 INFO - ENV: RUST_BACKTRACE is now 1 16:32:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:32:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 16:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0281 --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 16:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Whxn3agyyx/Render', 16:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:56 INFO - 'HOME': '/Users/cltbld', 16:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:56 INFO - 'LOGNAME': 'cltbld', 16:32:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:56 INFO - 'MOZ_NO_REMOTE': '1', 16:32:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:56 INFO - 'NO_EM_RESTART': '1', 16:32:56 INFO - 'PAGER': '/bin/cat', 16:32:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:56 INFO - 'PWD': '/builds/slave/test', 16:32:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:56 INFO - 'RUST_BACKTRACE': '1', 16:32:56 INFO - 'SHELL': '/bin/bash', 16:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S2FtAcpfng/Listeners', 16:32:56 INFO - 'TMPDIR': '/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/', 16:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:56 INFO - 'USER': 'cltbld', 16:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:56 INFO - 'XPC_FLAGS': '0x0', 16:32:56 INFO - 'XPC_SERVICE_NAME': '0', 16:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0281', '--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 16:32:56 INFO - mozversion application_buildid: 20170410145521 16:32:56 INFO - mozversion application_changeset: d7b81b700d7571cd4c5486a1152477fe99e0643d 16:32:56 INFO - mozversion application_display_name: Nightly 16:32:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:56 INFO - mozversion application_name: Firefox 16:32:56 INFO - mozversion application_remotingname: firefox 16:32:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:32:56 INFO - mozversion application_vendor: Mozilla 16:32:56 INFO - mozversion application_version: 55.0a1 16:32:56 INFO - mozversion platform_buildid: 20170410145521 16:32:56 INFO - mozversion platform_changeset: d7b81b700d7571cd4c5486a1152477fe99e0643d 16:32:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:32:56 INFO - mozversion platform_version: 55.0a1 16:32:56 INFO - using testdate: 1491867176 16:32:56 INFO - actual date: 1491867176 16:32:56 INFO - starting webserver on 'localhost:49236' 16:32:56 INFO - SUITE-START | Running 2 tests 16:32:56 INFO - TEST-START | dromaeo_css 16:32:56 INFO - operating with platform_type : mac_ 16:32:56 INFO - Initialising browser for dromaeo_css test... 16:32:56 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmplLK0B3/profile http://localhost:49236/getInfo.html) 16:32:59 INFO - PID 1634 | __metrics Screen width/height:1600/1200 16:32:59 INFO - PID 1634 | colorDepth:24 16:32:59 INFO - PID 1634 | Browser inner width/height: 1024/689 16:32:59 INFO - PID 1634 | __metrics 16:32:59 INFO - PID 1634 | 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" 16:32:59 INFO - PID 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:00 INFO - TEST-INFO | 1634: exit 0 16:33:00 INFO - Browser initialized. 16:33:00 INFO - Running cycle 1/1 for dromaeo_css test... 16:33:00 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmplLK0B3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:12 INFO - PID 1636 | RSS: Main: 238448640 16:33:12 INFO - PID 1636 | 16:36:18 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 16:36:20 INFO - PID 1636 | RSS: Main: 368226304 16:36:20 INFO - PID 1636 | 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:38:02 INFO - PID 1636 | 16:38:02 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:02 INFO - PID 1636 | Full stack: 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:38:02 INFO - PID 1636 | 16:38:02 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:02 INFO - PID 1636 | Full stack: 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:38:02 INFO - PID 1636 | 16:38:02 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:02 INFO - PID 1636 | Full stack: 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | ************************* 16:38:02 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:38:02 INFO - PID 1636 | 16:38:02 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:02 INFO - PID 1636 | Full stack: 16:38:02 INFO - PID 1636 | ************************* 16:39:23 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 16:39:23 INFO - PID 1636 | RSS: Main: 369864704 16:39:23 INFO - PID 1636 | 16:42:26 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 16:42:26 INFO - PID 1636 | RSS: Main: 335671296 16:42:26 INFO - PID 1636 | 16:45:29 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 16:45:29 INFO - PID 1636 | RSS: Main: 355479552 16:45:29 INFO - PID 1636 | 16:48:33 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 16:48:34 INFO - PID 1636 | RSS: Main: 330784768 16:48:34 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 16:51:36 INFO - PID 1636 | RSS: Main: 374218752 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | __start_tp_report 16:51:36 INFO - PID 1636 | _x_x_mozilla_page_load 16:51:36 INFO - PID 1636 | _x_x_mozilla_page_load_details 16:51:36 INFO - PID 1636 | |i|pagename|runs| 16:51:36 INFO - PID 1636 | |0;dojo.html;3016.5927599774027;3482.669146431088;3497.8950631481034;3510.473428985652;3550.4319308910563;5073.644844860862;5831.825045248649;6137.87724245516;6140.508759299257;6150.7539698412065;6086.7565297388055;6102.786402475915;6105.793350785075;6132.141360525212;6149.877002459959;5181.0933086709865;5273.630845840793;5301.7084060376665;5312.521873031426;5319.468053194688;5377.542908852753;5387.4073851876265;5427.050266203399;5432.592555558349;5469.808556700516;5235.293235413209;5247.842564723064;5288.65623734456;5308.840734777963;5337.546308563777;5306.92039619406;5343.599230057761;5361.624686271963;5368.973155134199;5422.457754224585;5251.343582052244;5283.524482796567;5302.019126461617;5319.414864364917;5382.91925621116;5993.700314984233;6049.48579370754;6053.606515576474;6076.939230607682;6127.5404344674325;6324.924762790337;6325.652089135096;6330.3669633036325;6330.905036424458;6352.618842869442;6533.24867640218;6603.108580341641;6623.602583844985;6640.037194606755;6640.966795165993;6151.384861513902;6212.223472065992;6240.594361366497;6260.092286618415;6280.5603607747935;6740.561863478858;6750.561213521106;6763.256041835394;6769.72921083161;6775.322467753185;6230.158928544589;6374.9681251594375;6444.258910225384;6452.677366131768;6452.935470645233;6599.274079851212;6600.1089852869245;6614.404703576702;6629.403353698191;6635.535512514078;6522.119513865662;6540.4767618590395;6541.542092053605;6545;6557;6257.499400047986;6321.65230912295;6436.517261205428;6510.707018184193;6535.836604084936;5261.815836445706;5266.21006848968;5269.71016594091;5274.393444753902;5296.841094767163;4673.813047478063;4675.298705194248;4679.438467383868;4696.694714843524;4727.976360118178;6048.243969503812;6093.6039157454625;6132.6933653317155;6148.9692551536955;6195.31851496335;6546.378094081055;6572.408483236436;6586.604803711697;6591.670416479157;6591.670416479157;6167.784127555514;6168.444839964335;6179.907301390483;6183.96908015466;6186.845328866724;5633.8309850704545;5751.4536119068625;5796.275465566804;5810.94189058104;5829.4170582942215;6553.672316384257;6667.299933506912;6729.327067293231;6731.697073631601;6735.259121496533;6320.178376810985;6364.809055728336;6596.142501474777;6615.735370585123;6632.734690612321;6525.119108920235;6562;6662.133922590032;6705.6647167642395;6712.731490740316;6531.248906375828;6551.344865513411;6554.901676474761;6555.934440655532;6556.377144171296;6325.810225693236;6374.713137908712;6526.118973938457;6549.083128362128;6589.868202635825;6391.776287829904;6432.581882177644;6451.225852897683;6451.967740161269;6454.354564543508;6417.197850268716;6420.7431702731365;6422.6467544285515;6427.903581446376;6434;5688.54491640676;6176.413240742122;6212.9068063979985;6271.560990730605;6372.299047104722;6359.7456101755415;6385.10608514799;6386.850366933996;6387.648679322682;6387.968060159669;6201.286852012076;6271.122042914087;6282.748690052346;6285.5600107992;6287 16:51:36 INFO - PID 1636 | |1;ext.html;797.6968751874289;819.524675688101;1073.6134991403098;1148.167578505583;1149.2759561476269;35647;36577.53689852409;36599.08502287441;36672.44991325126;36696.44955325666;38376.61623383765;38744.418833717515;38810;38875;38926.61073389265;6098.57309988301;8467.237948584627;8618.827623447527;8622.13778622139;8629.870551941725;6165;8315.542645154514;8502.872456913152;8505.61724722389;8508.659653613848;8522.488650680947;8536.658533658647;8575.785605359853;8580.485170889735;8585.098564650716;8473.195046470575;8548.529830859301;8552.444091134119;8561.315094792402;8564.914350856505;8368.3305335573;8425.452345597516;8435.662573497053;8440.155984401572;8444.57777111142;36246.818765906;36534.903952881454;36638.81680591607;36736.08159796;36784.26431471355;3588.551431071116;3625.619309972468;3631.418972964313;3631.636836316374;3633.7638053526434;30135.397292054255;30255.94104206364;30257.697423025707;30300.696993030007;30420.54369184464;3149.10250578584;3176.3647270545753;3194.2014496375905;3197.2326641605846;3220.2915358621067;252681.99999999817;257980.13029804567;258182;258547;258587.9999999981;37667.62332376641;38269.42595861064;46883.29675054877;47067.293990590166;47193;39334.60665393309;39361.40957885634;39397;39399.40900886489;39535.60464395377;13231.27228002469;13319;13422.993275504181;13424.798628020588;13480.325983700972;10866.185036122322;10885.67342979696;10900.07349375312;10901.34591924487;10901.672949811518;12071.215371000857;12113.636590902288;12139;12142.514299428101;12238.388080595934;4655.51117132703;5490.505854473116;5496.065668836308;5496.972515137399;5498.862528436821;1013.7921726046143;1021.7598864266891;1027.2655051637964;1052.7052425320921;1053.5733028123623;22474.438139046328;23592.528149436916;23757;23873.045078197025;23886.88056559706;1072.5280876414354;1116.9556464705527;1147.363213416545;1148.936808475542;1158.1834806461425;11566.843315668366;11833.467493962793;12150.696232594255;12166;12245.632631021084;319531;320082;321055;321203;321633;51687.96624067498;51878;51937.740311298956;51940.740296298274;51969.74015129976;1453.345994302568;1481.903676261061;1522.0867479512203;1525.9465918692792;1541.1985767401113;23220.767792322535;23341.41646458852;23394.94722737447;23471;23562.646560301266;37018.25963480769;37036.44445333268;37045;37102.44346334861;37160;289704;290754;290911;290990;291070;28585.42829143364;29171.270718232216;30293.788248470697;33508.994730158134;33623.15942101467;41682.79158604187;42336.364954526325;42466.15067698567;42466.513672021334;42749.786251068545;27720;27724.86137569299;29074.7092529072;29758.25604359908;29891.252718682208;28921.421571568873;29061.418771624027;29568;29973.55039674363;30212.5468117974;35462.29075418529;35507.11232219215;35545;35634.58577455979;35721.285574288886;28171.295717606405;28203.43593128167;29391.412171756874;30236.54645180368;30327.848360758057;21890.452738681022;22752.544949101255;23252.883735581214;23264.302070937898;23528.882355588114 16:51:36 INFO - PID 1636 | |2;jquery.html;388.068635275339;414.2998332817538;431.79921336578485;436.2540056503379;456.9840055598055;16218.513444596667;21040.158393664253;21938;22531.986060627292;22783.886080569573;22437;23035.884820575873;23197;23205.651915221242;23382.415439613975;6040.728167232463;6078.118672792453;6293.874122517547;6303.968480157616;6410.391012853772;3732.2535492901393;6294.181756371665;6317.715702793363;6355.555111142199;6358;3920.4707364505853;4000.8599699010542;6325.240971083454;6333.461655759243;6339.556231063827;5908.291005079375;6312.526560507958;6315.5894866833505;6347.714352854109;6352.364763523657;5439.184122381635;5479.75341109651;5513.807016754395;5523.392426833045;5529.115341545374;26718.866405668043;27473.17580472589;28257;28435.573466398022;28593.71406285931;2254.875981820999;2304.216566367443;2305.7578954209735;2307.1348244408346;2312.629979203336;16577.585560361087;17182;17740.556486087822;17937.730934036;17956.92258464483;1855.1837191635636;2110.6306396380724;2182.650775875852;2186.420598541388;2218.8335874809454;134827.6517234825;143061;144070;144428.27785861003;145426.272868635;11113.555457781598;11577.6526704199;11628.53485860556;12048.578299759467;12128.272303661808;14571.198584077765;14665;15076.623084422758;15114.697706046038;15129.243537823066;8604.182602652863;8649.394542381973;8650;8695.391322607356;8848.318819424418;8090.352771778244;8124.309433698202;8288.336933045463;8312.293455056388;8316;6482.416582507502;7569.924300757032;7592.202818704067;7663.233676632292;7666.501677390952;1780.9821901781077;2080.2927004818434;2087.53030568124;2089.279198676454;2210.0386331945656;929.8884133903974;945.8885809174193;946.3091942881734;956.4930586789013;982.6315131825565;18657.720134197996;20291.18835246603;20605;20687;20705.68941465879;933.2254228989922;993.1161266472845;1006.7332156978407;1016.3292227130058;1026.235454586338;10230.953809238183;10661.84007239892;10757.085647719874;10796.460176991119;10796.622118225825;619952;630052;634833;638160;638734;140295.77633789272;142356;145407;145915;147125;1199.4962115911337;1217.792975194219;1242.9192102513307;1243.8569564500017;1247.7442124364484;16029.55733983947;17438.738418923473;17765;17895.552611184823;17925.551861203574;56591.43408565861;58086.4191358081;58125.12812307734;58900.41099588949;59238.703806482416;82312.58843705982;82637;84042.73935890844;84355.73466397886;85303;8142.796430089295;8156.551389673625;8580.828383432421;8669.529184182478;8695.869561956702;12635.494580216688;13232.206067635972;13509.527166549124;13603.251821149932;13961.301934903417;11498.712532186762;11714.70713232176;11767.293962362286;11856.822147667619;11986.820197696867;10661;10698;10775.892241077489;10801.351918884891;10976.451177441255;11246.381449020382;11385.146114041314;11750.059995200534;11884.405779711153;11913.583024594098;8453.36599755033;8530.74407767768;8752.29981601483;8757.47455152693;8958.552072396224;11530;11585.189036767682;11868.465919033491;11904;11927 16:51:36 INFO - PID 1636 | |3;mootools.html;1262.8168915507251;1445.4940770730245;1470.4779803169872;1475.7269905067562;1480.3042569992099;11528.365939873303;12061.879381206185;12094.516219351237;12097.516099356026;12112.152149349527;11673.533058677644;11686.415679216048;12115.454804533794;12123.757524849498;12146.757064858697;2484.142970675114;2528.6586310847983;2531.8227724059325;2532.012515119105;2533.0627667762956;2463.4334103156284;2469.839460435066;2539.5428822811887;2540.9745902541017;2553.323369307135;2298.4368829636765;2400.5558971590312;2401.9759802402014;2402.5194961007783;2503.7871780898645;2494.9251522454356;2495.5258500884775;2520.949581008388;2524.507720994407;2527.406059575989;2505.9475020491436;2510.8367956082798;2514.6856642919633;2515.207709571479;2517.6727025486753;11663.94168029163;11980.34108124053;11986.280823150551;12004.939975300067;12008.279503229747;6495.4803615710625;6755.966220168917;6756.054152418666;6757.729690812362;6762.492813039042;3629;4015.277250094982;4357.934630980538;4388.429504164438;4406.471223453206;1222.3338280637074;1232.445399570188;1239.3988915376035;1316.9670758231025;1317.7298653775954;15347.07917524941;15897.28462219203;15901.602459938364;16111.516654500267;16232.431864884673;4673.976630116827;5549.694766787785;5871.001929671966;5881.264841894763;5893.823185304448;12400.81398779019;12414.131010829336;12416.565420210249;12421.813672794915;12436.937815310866;5733.254676891977;5990.041593345131;5992.280926288786;6630;6648.16897887764;5384;5394.190871369326;5622.57830662702;5972.954732921721;6188.195534580475;4269.103488267437;4348.195583816941;4376.12477504494;4418.33724941255;4433.534478879671;1285.607889593683;1287.3241548187277;1291.4511332683571;1306.9215847049209;1307.875751803577;803.2890891560894;806.2018601584389;821.8315245374683;827.9337652987747;856.8928883889514;4908.607311415079;5514.310711161105;6135.355787642234;6135.509159267248;6379.266384365765;596.3946594206883;610.2493932463095;620.1565870416231;625.7059182184366;629.8236493781749;3795.7912314822397;3931.7051221158526;3981.5023122109737;4002.7598344099447;4010.6590939770444;14406.927965360106;15058.774118388234;15086.094834309977;15096.56582624649;15137.621559460882;13740.282464691914;14648;14935.850641493664;15033.699326013419;15053.698926021418;10745.40900250478;10807.40559269232;10835.18736094796;10846.18653600983;11180.38507882058;7006.789796306119;7022.08712867324;7156.391706704989;7211.242819504087;7276.490645654753;13603.93198034043;13827.723445531234;13830.515931942333;14213.50252741149;14238.145711257357;14089.647758805702;14184.929075354557;14228.928855355656;14270.500532481314;14335.211563364115;9417.645588602849;9505.572249248939;9569.330146889652;9695.22438204956;9700.175485083846;10855;10954.726131846768;10987.011168994828;10988.230823842254;10988.560457581607;9123.817523649623;9335.206507446672;9387.543700634284;9429.811403772022;9537.23702103844;9082.318826088202;9118.133777291147;9150.359474836963;9177.357584968988;9227.723168304961;8165.2243036911395;8313.168683131638;8344.624491897757;8353.624086915981;8359.164083591835;5940.930632486021;5984.97007514977;6132.846678833065;6160.229971253593;6231.376862313732;6043.7884674036195;6124.969375153096;6283.937160628335;6294.905576416449;6327.96836015817 16:51:36 INFO - PID 1636 | |4;prototype.html;334.6185348702478;346.2123668653812;412.97993954931326;419.51545964411076;420.7790909772371;4995.7502124893745;5303.363596368432;5813.866296072268;5828.533717302616;5885.234919460475;4479.798409071592;4682.391289132416;5633.746481408336;5739.253896993396;5787.971060144704;3635.218428037971;3877.243937432202;4288.571142885718;4314.1803057419065;4328.177646247203;3821.9871733990376;4317.114991426765;4325.070109926365;4351.65098819367;4391.429114215148;3549.8580056797696;4287.5069367022725;4314.913701725964;4333.5233124356455;4334.566543345672;4280.9143817123795;4291.24903141952;4300.419443375167;4309.2027974824605;4319.416878721364;3179.998300535347;3723.207594304272;3736;3739.121306492972;3782.5082739244;5410.188471729232;5470.17947307903;5581.776728930838;5646.938867313442;5662.433756624346;4713.764311784397;5053.393592768891;5089.821856235051;5113.360829896263;5203.297554830126;6185.257769067695;6238.220222472191;6238.844028899269;6238.946453372782;6249.218847644044;4024.9195016099807;4238.512571054337;4244.151169766028;4255.6169944705125;4269.957300426987;4967.155583550805;5088.974555127238;6155.076738489218;6235.9376406235815;6487.870242595121;3286.4741641337273;3659.6523330284112;3899.7075219358094;4139.523954745183;4170.47869016373;4007.4189242559664;4029.871635941941;4344;4353.586409291112;4372.519022907478;4821.228603423436;4954.5540901319055;5029.812031766193;5052.444231134572;5061.5950723942;5330.946690533045;5492.505674489315;5608.270924779834;6138.78514252008;6161.322254551996;1251.4118364368733;1467.9045862018934;1473.911565306085;1477.4533422633478;1484.3617244584716;931.4762147840196;980.2696990741942;992.3252188511881;995.7958618483193;1001.4992503748126;5785.82642520725;5787.797427090031;5800.419958004166;5803.216565763652;5803.245578074823;6363.172787537683;6363.5545511813725;6368.490520758328;6369.5222858285815;6391.616503009835;5143.639945203875;5473.370562385297;5795.290389335072;5801.984652685763;5973.253343332083;2744.6157537944705;2926.6488021437563;3187.856546455415;3372.7183670205163;3375.0549846043145;6186.845328866814;6209.9068513972325;6485.6108633482145;6503;6528.967355163194;5817.476427121579;6562.376574225441;6646.833829154213;6656;6661.733530658817;5543.722813859372;5789.073748200268;6312.842178945563;6571.3100124488155;6738.966305168443;6333.588316759396;6374.330695276929;6460.967695161494;6478.740850365933;6525.314841941527;6339.302676705466;6356.4279214870885;6372.330905255067;6385.201849768779;6414.696431337958;5093.612747522856;6060.848478788065;6424.389682980296;6487.870242595216;6529;3641.834612923839;3744.7378683491893;4253.894322310476;4268.743875367488;4301.849435269751;5779.901818654443;6111.54163437735;6220.813375598739;6321.367863213642;6445;5127.564157046693;5400.324959380077;6164.260288765377;6166.722497487534;6242.625442473466;4954.1330267202375;6139.9914042119935;6170;6190.907136392868;6206.896551724138;5149.035420619879;5947.405259474018;6011.308699499614;6058.757649694139;6110.26676798787;5644.689542075061;6157.876842463036;6184.257889053342;6196.81409557714;6395.360463953567;5861.267341582302;5893.711196268819;5909.320428150818;6021.096835474538;6037.69811509414 16:51:36 INFO - PID 1636 | |5;yui.html;711.533945265851;779.6179871862789;844.2275318083954;864.8616221404576;885.3404213860675;13152.145110567806;17165.313387464503;17894.463166105004;17897.373591924286;17925.014124223162;16877.156142192904;17004;17061.061641609736;17095.145242737875;17097.82902170981;990.4898977026837;1020.2908978260112;1027.7687520307945;1046.2571574182339;1047.7433028907928;682.1507223506741;706.6396137969621;981.3523074770653;1032.091759251861;1034.3948789957883;1070.5022164693416;1080.2330345454698;1083.6423980086593;1085.5169449594932;1088.4938503595827;1064.9520771565299;1065.445968096593;1065.504540388719;1066.402814423925;1071.5820829876354;800.5156880087521;801.6152246921511;803.1526739290047;803.3492870774633;804.6097642643314;16748.24632891523;17025.148742562822;17313.653726925517;17387.391441299493;17509.7373539397;16546;16769.916150419293;17013.979161250365;17032.91483542587;17450.556922030926;12696.1747486414;12921.547745828851;13111.409986550629;13289.601311960656;13298.73402531944;3518;3539.823008849547;3540.0087975366937;3540.061883600848;3549.165946002687;93024.06975930222;109675;111333.88666113316;111364.44317778359;111649;11236;11549;13696.452141914211;13981.231032293119;14092.365843537065;19538.511537211685;24573;24762.876185619316;25415.491690166094;25421.237362879143;8837.734867953972;8861.512616806138;9049.819003620023;9049.909500905038;9062.275017998545;4797.664163508591;4948.826791062295;4953.18272485036;4958.578520825698;4964.578010869044;4234.9364759528635;4266.402703621434;4328.740275583412;4376;4381.211381951216;948.6537413843897;961.4759955824093;966.9653470786332;969.4280374579032;969.7575606098476;646.0954663471178;652.3769799841141;664.1366223908996;672.4754691340762;694.5763084518439;9745.56144973478;11638.41807909601;11671.35807530594;11791.88208117908;12146.878531214576;657.1194599237045;664.2991643815724;664.6377724140356;670.4234358451728;689.6276010954128;5341.332333458317;5483.7806487740045;5493.23094766733;5502.284702988586;5618.522425593788;95748.08503829884;96555;100375;100637.98724025479;100840.49579752055;76172;78301.21698783053;84543.30913381698;84678.57660711781;85787.14212857916;64048.03927941085;67863.66068169726;68747.65626171937;70884.29115708776;71820.28179718241;11698.649040528799;12072.094592905743;12088.939555302168;12096.939515302367;12157.69605759863;30382.17706937591;36141.915742527766;36402.27195456023;36479.08802279858;37305.81347093247;44622.77688611536;44682;44982.650520484436;45489.54510454853;45703;15567;15585;15718.68562628718;15896.682066358839;16089.47150020746;14925.179115148338;17772.200250988994;18044.097795110454;18105.275788968822;18142.818571814114;16213.432529861399;16918.407855724992;17115.22981465812;17210.225539850988;17263.82736172622;16317.18414079315;16371.754423683893;16608.335666573686;17070.74393884068;17216.225269862636;16028.599285017968;16646.16769161513;16756.413525526546;16988;17015.91492042532;9929.801403971736;11443.198976071595;11904.285742855456;12017.759644807229;12069.818952715892;12916.870831291566;12976.45920670774;13239.338033098114;13729.45082196701;13741.450341986209 16:51:36 INFO - PID 1636 | __end_tp_report 16:51:36 INFO - PID 1636 | __start_cc_report 16:51:36 INFO - PID 1636 | _x_x_mozilla_cycle_collect,2060 16:51:36 INFO - PID 1636 | __end_cc_report 16:51:36 INFO - PID 1636 | __startTimestamp1491868296918__endTimestamp 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | ------- Summary: start ------- 16:51:36 INFO - PID 1636 | Number of tests: 6 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6033.31 Median:6280.56 stddev:706.06 (11.2%) stddev-sans-first:667.38 16:51:36 INFO - PID 1636 | Values: 3016.6 3482.7 3497.9 3510.5 3550.4 5073.6 5831.8 6137.9 6140.5 6150.8 6086.8 6102.8 6105.8 6132.1 6149.9 5181.1 5273.6 5301.7 5312.5 5319.5 5377.5 5387.4 5427.1 5432.6 5469.8 5235.3 5247.8 5288.7 5308.8 5337.5 5306.9 5343.6 5361.6 5369.0 5422.5 5251.3 5283.5 5302.0 5319.4 5382.9 5993.7 6049.5 6053.6 6076.9 6127.5 6324.9 6325.7 6330.4 6330.9 6352.6 6533.2 6603.1 6623.6 6640.0 6641.0 6151.4 6212.2 6240.6 6260.1 6280.6 6740.6 6750.6 6763.3 6769.7 6775.3 6230.2 6375.0 6444.3 6452.7 6452.9 6599.3 6600.1 6614.4 6629.4 6635.5 6522.1 6540.5 6541.5 6545.0 6557.0 6257.5 6321.7 6436.5 6510.7 6535.8 5261.8 5266.2 5269.7 5274.4 5296.8 4673.8 4675.3 4679.4 4696.7 4728.0 6048.2 6093.6 6132.7 6149.0 6195.3 6546.4 6572.4 6586.6 6591.7 6591.7 6167.8 6168.4 6179.9 6184.0 6186.8 5633.8 5751.5 5796.3 5810.9 5829.4 6553.7 6667.3 6729.3 6731.7 6735.3 6320.2 6364.8 6596.1 6615.7 6632.7 6525.1 6562.0 6662.1 6705.7 6712.7 6531.2 6551.3 6554.9 6555.9 6556.4 6325.8 6374.7 6526.1 6549.1 6589.9 6391.8 6432.6 6451.2 6452.0 6454.4 6417.2 6420.7 6422.6 6427.9 6434.0 5688.5 6176.4 6212.9 6271.6 6372.3 6359.7 6385.1 6386.9 6387.6 6388.0 6201.3 6271.1 6282.7 6285.6 6287.0 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:43213.06 Median:161639.62 stddev:76241.50 (47.2%) stddev-sans-first:76388.87 16:51:36 INFO - PID 1636 | Values: 797.7 819.5 1073.6 1148.2 1149.3 35647.0 36577.5 36599.1 36672.4 36696.4 38376.6 38744.4 38810.0 38875.0 38926.6 6098.6 8467.2 8618.8 8622.1 8629.9 6165.0 8315.5 8502.9 8505.6 8508.7 8522.5 8536.7 8575.8 8580.5 8585.1 8473.2 8548.5 8552.4 8561.3 8564.9 8368.3 8425.5 8435.7 8440.2 8444.6 36246.8 36534.9 36638.8 36736.1 36784.3 3588.6 3625.6 3631.4 3631.6 3633.8 30135.4 30255.9 30257.7 30300.7 30420.5 3149.1 3176.4 3194.2 3197.2 3220.3 252682.0 257980.1 258182.0 258547.0 258588.0 37667.6 38269.4 46883.3 47067.3 47193.0 39334.6 39361.4 39397.0 39399.4 39535.6 13231.3 13319.0 13423.0 13424.8 13480.3 10866.2 10885.7 10900.1 10901.3 10901.7 12071.2 12113.6 12139.0 12142.5 12238.4 4655.5 5490.5 5496.1 5497.0 5498.9 1013.8 1021.8 1027.3 1052.7 1053.6 22474.4 23592.5 23757.0 23873.0 23886.9 1072.5 1117.0 1147.4 1148.9 1158.2 11566.8 11833.5 12150.7 12166.0 12245.6 319531.0 320082.0 321055.0 321203.0 321633.0 51688.0 51878.0 51937.7 51940.7 51969.7 1453.3 1481.9 1522.1 1525.9 1541.2 23220.8 23341.4 23394.9 23471.0 23562.6 37018.3 37036.4 37045.0 37102.4 37160.0 289704.0 290754.0 290911.0 290990.0 291070.0 28585.4 29171.3 30293.8 33509.0 33623.2 41682.8 42336.4 42466.2 42466.5 42749.8 27720.0 27724.9 29074.7 29758.3 29891.3 28921.4 29061.4 29568.0 29973.6 30212.5 35462.3 35507.1 35545.0 35634.6 35721.3 28171.3 28203.4 29391.4 30236.5 30327.8 21890.5 22752.5 23252.9 23264.3 23528.9 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:37917.94 Median:12670.05 stddev:106246.72 (838.6%) stddev-sans-first:106507.40 16:51:36 INFO - PID 1636 | Values: 388.1 414.3 431.8 436.3 457.0 16218.5 21040.2 21938.0 22532.0 22783.9 22437.0 23035.9 23197.0 23205.7 23382.4 6040.7 6078.1 6293.9 6304.0 6410.4 3732.3 6294.2 6317.7 6355.6 6358.0 3920.5 4000.9 6325.2 6333.5 6339.6 5908.3 6312.5 6315.6 6347.7 6352.4 5439.2 5479.8 5513.8 5523.4 5529.1 26718.9 27473.2 28257.0 28435.6 28593.7 2254.9 2304.2 2305.8 2307.1 2312.6 16577.6 17182.0 17740.6 17937.7 17956.9 1855.2 2110.6 2182.7 2186.4 2218.8 134827.7 143061.0 144070.0 144428.3 145426.3 11113.6 11577.7 11628.5 12048.6 12128.3 14571.2 14665.0 15076.6 15114.7 15129.2 8604.2 8649.4 8650.0 8695.4 8848.3 8090.4 8124.3 8288.3 8312.3 8316.0 6482.4 7569.9 7592.2 7663.2 7666.5 1781.0 2080.3 2087.5 2089.3 2210.0 929.9 945.9 946.3 956.5 982.6 18657.7 20291.2 20605.0 20687.0 20705.7 933.2 993.1 1006.7 1016.3 1026.2 10231.0 10661.8 10757.1 10796.5 10796.6 619952.0 630052.0 634833.0 638160.0 638734.0 140295.8 142356.0 145407.0 145915.0 147125.0 1199.5 1217.8 1242.9 1243.9 1247.7 16029.6 17438.7 17765.0 17895.6 17925.6 56591.4 58086.4 58125.1 58900.4 59238.7 82312.6 82637.0 84042.7 84355.7 85303.0 8142.8 8156.6 8580.8 8669.5 8695.9 12635.5 13232.2 13509.5 13603.3 13961.3 11498.7 11714.7 11767.3 11856.8 11986.8 10661.0 10698.0 10775.9 10801.4 10976.5 11246.4 11385.1 11750.1 11884.4 11913.6 8453.4 8530.7 8752.3 8757.5 8958.6 11530.0 11585.2 11868.5 11904.0 11927.0 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7222.83 Median:2532.54 stddev:4614.93 (182.2%) stddev-sans-first:4606.14 16:51:36 INFO - PID 1636 | Values: 1262.8 1445.5 1470.5 1475.7 1480.3 11528.4 12061.9 12094.5 12097.5 12112.2 11673.5 11686.4 12115.5 12123.8 12146.8 2484.1 2528.7 2531.8 2532.0 2533.1 2463.4 2469.8 2539.5 2541.0 2553.3 2298.4 2400.6 2402.0 2402.5 2503.8 2494.9 2495.5 2520.9 2524.5 2527.4 2505.9 2510.8 2514.7 2515.2 2517.7 11663.9 11980.3 11986.3 12004.9 12008.3 6495.5 6756.0 6756.1 6757.7 6762.5 3629.0 4015.3 4357.9 4388.4 4406.5 1222.3 1232.4 1239.4 1317.0 1317.7 15347.1 15897.3 15901.6 16111.5 16232.4 4674.0 5549.7 5871.0 5881.3 5893.8 12400.8 12414.1 12416.6 12421.8 12436.9 5733.3 5990.0 5992.3 6630.0 6648.2 5384.0 5394.2 5622.6 5973.0 6188.2 4269.1 4348.2 4376.1 4418.3 4433.5 1285.6 1287.3 1291.5 1306.9 1307.9 803.3 806.2 821.8 827.9 856.9 4908.6 5514.3 6135.4 6135.5 6379.3 596.4 610.2 620.2 625.7 629.8 3795.8 3931.7 3981.5 4002.8 4010.7 14406.9 15058.8 15086.1 15096.6 15137.6 13740.3 14648.0 14935.9 15033.7 15053.7 10745.4 10807.4 10835.2 10846.2 11180.4 7006.8 7022.1 7156.4 7211.2 7276.5 13603.9 13827.7 13830.5 14213.5 14238.1 14089.6 14184.9 14228.9 14270.5 14335.2 9417.6 9505.6 9569.3 9695.2 9700.2 10855.0 10954.7 10987.0 10988.2 10988.6 9123.8 9335.2 9387.5 9429.8 9537.2 9082.3 9118.1 9150.4 9177.4 9227.7 8165.2 8313.2 8344.6 8353.6 8359.2 5940.9 5985.0 6132.8 6160.2 6231.4 6043.8 6125.0 6283.9 6294.9 6328.0 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:4956.48 Median:5621.01 stddev:1562.54 (27.8%) stddev-sans-first:1527.93 16:51:36 INFO - PID 1636 | Values: 334.6 346.2 413.0 419.5 420.8 4995.8 5303.4 5813.9 5828.5 5885.2 4479.8 4682.4 5633.7 5739.3 5788.0 3635.2 3877.2 4288.6 4314.2 4328.2 3822.0 4317.1 4325.1 4351.7 4391.4 3549.9 4287.5 4314.9 4333.5 4334.6 4280.9 4291.2 4300.4 4309.2 4319.4 3180.0 3723.2 3736.0 3739.1 3782.5 5410.2 5470.2 5581.8 5646.9 5662.4 4713.8 5053.4 5089.8 5113.4 5203.3 6185.3 6238.2 6238.8 6238.9 6249.2 4024.9 4238.5 4244.2 4255.6 4270.0 4967.2 5089.0 6155.1 6235.9 6487.9 3286.5 3659.7 3899.7 4139.5 4170.5 4007.4 4029.9 4344.0 4353.6 4372.5 4821.2 4954.6 5029.8 5052.4 5061.6 5330.9 5492.5 5608.3 6138.8 6161.3 1251.4 1467.9 1473.9 1477.5 1484.4 931.5 980.3 992.3 995.8 1001.5 5785.8 5787.8 5800.4 5803.2 5803.2 6363.2 6363.6 6368.5 6369.5 6391.6 5143.6 5473.4 5795.3 5802.0 5973.3 2744.6 2926.6 3187.9 3372.7 3375.1 6186.8 6209.9 6485.6 6503.0 6529.0 5817.5 6562.4 6646.8 6656.0 6661.7 5543.7 5789.1 6312.8 6571.3 6739.0 6333.6 6374.3 6461.0 6478.7 6525.3 6339.3 6356.4 6372.3 6385.2 6414.7 5093.6 6060.8 6424.4 6487.9 6529.0 3641.8 3744.7 4253.9 4268.7 4301.8 5779.9 6111.5 6220.8 6321.4 6445.0 5127.6 5400.3 6164.3 6166.7 6242.6 4954.1 6140.0 6170.0 6190.9 6206.9 5149.0 5947.4 6011.3 6058.8 6110.3 5644.7 6157.9 6184.3 6196.8 6395.4 5861.3 5893.7 5909.3 6021.1 6037.7 16:51:36 INFO - PID 1636 | 16:51:36 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:20058.64 Median:17895.92 stddev:26868.74 (150.1%) stddev-sans-first:26904.83 16:51:36 INFO - PID 1636 | Values: 711.5 779.6 844.2 864.9 885.3 13152.1 17165.3 17894.5 17897.4 17925.0 16877.2 17004.0 17061.1 17095.1 17097.8 990.5 1020.3 1027.8 1046.3 1047.7 682.2 706.6 981.4 1032.1 1034.4 1070.5 1080.2 1083.6 1085.5 1088.5 1065.0 1065.4 1065.5 1066.4 1071.6 800.5 801.6 803.2 803.3 804.6 16748.2 17025.1 17313.7 17387.4 17509.7 16546.0 16769.9 17014.0 17032.9 17450.6 12696.2 12921.5 13111.4 13289.6 13298.7 3518.0 3539.8 3540.0 3540.1 3549.2 93024.1 109675.0 111333.9 111364.4 111649.0 11236.0 11549.0 13696.5 13981.2 14092.4 19538.5 24573.0 24762.9 25415.5 25421.2 8837.7 8861.5 9049.8 9049.9 9062.3 4797.7 4948.8 4953.2 4958.6 4964.6 4234.9 4266.4 4328.7 4376.0 4381.2 948.7 961.5 967.0 969.4 969.8 646.1 652.4 664.1 672.5 694.6 9745.6 11638.4 11671.4 11791.9 12146.9 657.1 664.3 664.6 670.4 689.6 5341.3 5483.8 5493.2 5502.3 5618.5 95748.1 96555.0 100375.0 100638.0 100840.5 76172.0 78301.2 84543.3 84678.6 85787.1 64048.0 67863.7 68747.7 70884.3 71820.3 11698.6 12072.1 12088.9 12096.9 12157.7 30382.2 36141.9 36402.3 36479.1 37305.8 44622.8 44682.0 44982.7 45489.5 45703.0 15567.0 15585.0 15718.7 15896.7 16089.5 14925.2 17772.2 18044.1 18105.3 18142.8 16213.4 16918.4 17115.2 17210.2 17263.8 16317.2 16371.8 16608.3 17070.7 17216.2 16028.6 16646.2 16756.4 16988.0 17015.9 9929.8 11443.2 11904.3 12017.8 12069.8 12916.9 12976.5 13239.3 13729.5 13741.5 16:51:36 INFO - PID 1636 | -------- Summary: end -------- 16:51:36 INFO - PID 1636 | 16:51:37 INFO - TEST-INFO | 1636: exit 0 16:51:37 INFO - TEST-OK | dromaeo_css | took 1120902ms 16:51:37 INFO - TEST-START | kraken 16:51:37 INFO - operating with platform_type : mac_ 16:51:37 INFO - Initialising browser for kraken test... 16:51:37 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpt45tDA/profile http://localhost:49236/getInfo.html) 16:51:40 INFO - PID 1646 | __metrics Screen width/height:1600/1200 16:51:40 INFO - PID 1646 | colorDepth:24 16:51:40 INFO - PID 1646 | Browser inner width/height: 1024/689 16:51:40 INFO - PID 1646 | __metrics 16:51:40 INFO - PID 1646 | 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" 16:51:40 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:41 INFO - TEST-INFO | 1646: exit 0 16:51:41 INFO - Browser initialized. 16:51:41 INFO - Running cycle 1/1 for kraken test... 16:51:41 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/T/tmpt45tDA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:53 INFO - PID 1647 | RSS: Main: 231686144 16:51:53 INFO - PID 1647 | 16:51:56 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:57 INFO - PID 1647 | RSS: Main: 291962880 16:51:57 INFO - PID 1647 | 16:52:00 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 16:52:01 INFO - PID 1647 | RSS: Main: 294322176 16:52:01 INFO - PID 1647 | 16:52:04 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 16:52:05 INFO - PID 1647 | RSS: Main: 387473408 16:52:05 INFO - PID 1647 | 16:52:07 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 16:52:08 INFO - PID 1647 | RSS: Main: 291532800 16:52:08 INFO - PID 1647 | 16:52:10 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:11 INFO - PID 1647 | RSS: Main: 293376000 16:52:11 INFO - PID 1647 | 16:52:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:14 INFO - PID 1647 | RSS: Main: 335802368 16:52:14 INFO - PID 1647 | 16:52:17 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:18 INFO - PID 1647 | RSS: Main: 344236032 16:52:18 INFO - PID 1647 | 16:52:21 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 16:52:22 INFO - PID 1647 | RSS: Main: 350019584 16:52:22 INFO - PID 1647 | 16:52:24 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:24 INFO - PID 1647 | RSS: Main: 310341632 16:52:24 INFO - PID 1647 | 16:52:26 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:27 INFO - PID 1647 | RSS: Main: 313208832 16:52:27 INFO - PID 1647 | 16:52:29 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:30 INFO - PID 1647 | RSS: Main: 316080128 16:52:30 INFO - PID 1647 | 16:52:33 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:34 INFO - PID 1647 | RSS: Main: 331575296 16:52:34 INFO - PID 1647 | 16:52:37 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:37 INFO - PID 1647 | RSS: Main: 325779456 16:52:37 INFO - PID 1647 | 16:52:39 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 16:52:40 INFO - PID 1647 | RSS: Main: 388177920 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | __start_tp_report 16:52:40 INFO - PID 1647 | _x_x_mozilla_page_load 16:52:40 INFO - PID 1647 | _x_x_mozilla_page_load_details 16:52:40 INFO - PID 1647 | |i|pagename|runs| 16:52:40 INFO - PID 1647 | |0;ai-astar;109;122;121;121;122;122;122;123;124;122 16:52:40 INFO - PID 1647 | |1;audio-beat-detection;159;120;119;164;130;115;147;150;178;140 16:52:40 INFO - PID 1647 | |2;audio-dft;212;209;215;255;207;207;212;209;210;208 16:52:40 INFO - PID 1647 | |3;audio-fft;80;82;82;129;94;82;63;60;83;59 16:52:40 INFO - PID 1647 | |4;audio-oscillator;95;74;96;77;83;105;128;73;75;87 16:52:40 INFO - PID 1647 | |5;imaging-gaussian-blur;92;91;91;90;91;92;92;92;90;91 16:52:40 INFO - PID 1647 | |6;imaging-darkroom;100;101;100;101;99;100;99;101;100;119 16:52:40 INFO - PID 1647 | |7;imaging-desaturate;101;103;120;162;101;101;100;99;102;101 16:52:40 INFO - PID 1647 | |8;json-parse-financial;52;50;50;50;51;50;53;49;52;53 16:52:40 INFO - PID 1647 | |9;json-stringify-tinderbox;62;68;65;75;70;67;64;64;64;64 16:52:40 INFO - PID 1647 | |10;stanford-crypto-aes;93;91;93;90;91;89;92;90;89;86 16:52:40 INFO - PID 1647 | |11;stanford-crypto-ccm;154;164;154;153;147;149;153;148;198;170 16:52:40 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;196;203;200;202;200;200;201;199;198;200 16:52:40 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;72;74;74;71;71;73;71;102;107;96 16:52:40 INFO - PID 1647 | __end_tp_report 16:52:40 INFO - PID 1647 | __start_cc_report 16:52:40 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2289 16:52:40 INFO - PID 1647 | __end_cc_report 16:52:40 INFO - PID 1647 | __startTimestamp1491868360143__endTimestamp 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | ------- Summary: start ------- 16:52:40 INFO - PID 1647 | Number of tests: 14 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:120.80 Median:122.00 stddev:4.24 (3.5%) stddev-sans-first:0.93 16:52:40 INFO - PID 1647 | Values: 109.0 122.0 121.0 121.0 122.0 122.0 122.0 123.0 124.0 122.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:21.21 (14.3%) stddev-sans-first:21.60 16:52:40 INFO - PID 1647 | Values: 159.0 120.0 119.0 164.0 130.0 115.0 147.0 150.0 178.0 140.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:214.40 Median:211.00 stddev:14.49 (6.9%) stddev-sans-first:15.34 16:52:40 INFO - PID 1647 | Values: 212.0 209.0 215.0 255.0 207.0 207.0 212.0 209.0 210.0 208.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:81.40 Median:82.00 stddev:20.35 (24.8%) stddev-sans-first:21.58 16:52:40 INFO - PID 1647 | Values: 80.0 82.0 82.0 129.0 94.0 82.0 63.0 60.0 83.0 59.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:80.00 stddev:17.39 (21.7%) stddev-sans-first:18.32 16:52:40 INFO - PID 1647 | Values: 95.0 74.0 96.0 77.0 83.0 105.0 128.0 73.0 75.0 87.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:91.50 stddev:0.79 (0.9%) stddev-sans-first:0.78 16:52:40 INFO - PID 1647 | Values: 92.0 91.0 91.0 90.0 91.0 92.0 92.0 92.0 90.0 91.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:101.00 stddev:6.02 (6.0%) stddev-sans-first:6.34 16:52:40 INFO - PID 1647 | Values: 100.0 101.0 100.0 101.0 99.0 100.0 99.0 101.0 100.0 119.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:102.50 stddev:19.58 (19.1%) stddev-sans-first:20.56 16:52:40 INFO - PID 1647 | Values: 101.0 103.0 120.0 162.0 101.0 101.0 100.0 99.0 102.0 101.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:1.41 (2.7%) stddev-sans-first:1.45 16:52:40 INFO - PID 1647 | Values: 52.0 50.0 50.0 50.0 51.0 50.0 53.0 49.0 52.0 53.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:3.86 (5.8%) stddev-sans-first:3.77 16:52:40 INFO - PID 1647 | Values: 62.0 68.0 65.0 75.0 70.0 67.0 64.0 64.0 64.0 64.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:91.00 stddev:2.12 (2.3%) stddev-sans-first:2.03 16:52:40 INFO - PID 1647 | Values: 93.0 91.0 93.0 90.0 91.0 89.0 92.0 90.0 89.0 86.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:154.00 stddev:15.47 (10.0%) stddev-sans-first:16.30 16:52:40 INFO - PID 1647 | Values: 154.0 164.0 154.0 153.0 147.0 149.0 153.0 148.0 198.0 170.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.90 Median:200.00 stddev:1.97 (1.0%) stddev-sans-first:1.50 16:52:40 INFO - PID 1647 | Values: 196.0 203.0 200.0 202.0 200.0 200.0 201.0 199.0 198.0 200.0 16:52:40 INFO - PID 1647 | 16:52:40 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.10 Median:72.50 stddev:14.47 (20.0%) stddev-sans-first:14.97 16:52:40 INFO - PID 1647 | Values: 72.0 74.0 74.0 71.0 71.0 73.0 71.0 102.0 107.0 96.0 16:52:40 INFO - PID 1647 | -------- Summary: end -------- 16:52:40 INFO - PID 1647 | 16:52:41 INFO - TEST-INFO | 1647: exit 0 16:52:41 INFO - TEST-OK | kraken | took 63614ms 16:52:41 INFO - SUITE-END | took 1184s 16:52:41 INFO - Completed test suite (00:19:44) 16:52:41 INFO - javascript benchmark 16:52:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7691.792800986513, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.5927599774027, 3482.669146431088, 3497.8950631481034, 3510.473428985652, 3550.4319308910563, 5073.644844860862, 5831.825045248649, 6137.87724245516, 6140.508759299257, 6150.7539698412065, 6086.7565297388055, 6102.786402475915, 6105.793350785075, 6132.141360525212, 6149.877002459959, 5181.0933086709865, 5273.630845840793, 5301.7084060376665, 5312.521873031426, 5319.468053194688, 5377.542908852753, 5387.4073851876265, 5427.050266203399, 5432.592555558349, 5469.808556700516, 5235.293235413209, 5247.842564723064, 5288.65623734456, 5308.840734777963, 5337.546308563777, 5306.92039619406, 5343.599230057761, 5361.624686271963, 5368.973155134199, 5422.457754224585, 5251.343582052244, 5283.524482796567, 5302.019126461617, 5319.414864364917, 5382.91925621116, 5993.700314984233, 6049.48579370754, 6053.606515576474, 6076.939230607682, 6127.5404344674325, 6324.924762790337, 6325.652089135096, 6330.3669633036325, 6330.905036424458, 6352.618842869442, 6533.24867640218, 6603.108580341641, 6623.602583844985, 6640.037194606755, 6640.966795165993, 6151.384861513902, 6212.223472065992, 6240.594361366497, 6260.092286618415, 6280.5603607747935, 6740.561863478858, 6750.561213521106, 6763.256041835394, 6769.72921083161, 6775.322467753185, 6230.158928544589, 6374.9681251594375, 6444.258910225384, 6452.677366131768, 6452.935470645233, 6599.274079851212, 6600.1089852869245, 6614.404703576702, 6629.403353698191, 6635.535512514078, 6522.119513865662, 6540.4767618590395, 6541.542092053605, 6545.0, 6557.0, 6257.499400047986, 6321.65230912295, 6436.517261205428, 6510.707018184193, 6535.836604084936, 5261.815836445706, 5266.21006848968, 5269.71016594091, 5274.393444753902, 5296.841094767163, 4673.813047478063, 4675.298705194248, 4679.438467383868, 4696.694714843524, 4727.976360118178, 6048.243969503812, 6093.6039157454625, 6132.6933653317155, 6148.9692551536955, 6195.31851496335, 6546.378094081055, 6572.408483236436, 6586.604803711697, 6591.670416479157, 6591.670416479157, 6167.784127555514, 6168.444839964335, 6179.907301390483, 6183.96908015466, 6186.845328866724, 5633.8309850704545, 5751.4536119068625, 5796.275465566804, 5810.94189058104, 5829.4170582942215, 6553.672316384257, 6667.299933506912, 6729.327067293231, 6731.697073631601, 6735.259121496533, 6320.178376810985, 6364.809055728336, 6596.142501474777, 6615.735370585123, 6632.734690612321, 6525.119108920235, 6562.0, 6662.133922590032, 6705.6647167642395, 6712.731490740316, 6531.248906375828, 6551.344865513411, 6554.901676474761, 6555.934440655532, 6556.377144171296, 6325.810225693236, 6374.713137908712, 6526.118973938457, 6549.083128362128, 6589.868202635825, 6391.776287829904, 6432.581882177644, 6451.225852897683, 6451.967740161269, 6454.354564543508, 6417.197850268716, 6420.7431702731365, 6422.6467544285515, 6427.903581446376, 6434.0, 5688.54491640676, 6176.413240742122, 6212.9068063979985, 6271.560990730605, 6372.299047104722, 6359.7456101755415, 6385.10608514799, 6386.850366933996, 6387.648679322682, 6387.968060159669, 6201.286852012076, 6271.122042914087, 6282.748690052346, 6285.5600107992, 6287.0], "value": 5984.894263060783, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.6968751874289, 819.524675688101, 1073.6134991403098, 1148.167578505583, 1149.2759561476269, 35647.0, 36577.53689852409, 36599.08502287441, 36672.44991325126, 36696.44955325666, 38376.61623383765, 38744.418833717515, 38810.0, 38875.0, 38926.61073389265, 6098.57309988301, 8467.237948584627, 8618.827623447527, 8622.13778622139, 8629.870551941725, 6165.0, 8315.542645154514, 8502.872456913152, 8505.61724722389, 8508.659653613848, 8522.488650680947, 8536.658533658647, 8575.785605359853, 8580.485170889735, 8585.098564650716, 8473.195046470575, 8548.529830859301, 8552.444091134119, 8561.315094792402, 8564.914350856505, 8368.3305335573, 8425.452345597516, 8435.662573497053, 8440.155984401572, 8444.57777111142, 36246.818765906, 36534.903952881454, 36638.81680591607, 36736.08159796, 36784.26431471355, 3588.551431071116, 3625.619309972468, 3631.418972964313, 3631.636836316374, 3633.7638053526434, 30135.397292054255, 30255.94104206364, 30257.697423025707, 30300.696993030007, 30420.54369184464, 3149.10250578584, 3176.3647270545753, 3194.2014496375905, 3197.2326641605846, 3220.2915358621067, 252681.99999999817, 257980.13029804567, 258182.0, 258547.0, 258587.9999999981, 37667.62332376641, 38269.42595861064, 46883.29675054877, 47067.293990590166, 47193.0, 39334.60665393309, 39361.40957885634, 39397.0, 39399.40900886489, 39535.60464395377, 13231.27228002469, 13319.0, 13422.993275504181, 13424.798628020588, 13480.325983700972, 10866.185036122322, 10885.67342979696, 10900.07349375312, 10901.34591924487, 10901.672949811518, 12071.215371000857, 12113.636590902288, 12139.0, 12142.514299428101, 12238.388080595934, 4655.51117132703, 5490.505854473116, 5496.065668836308, 5496.972515137399, 5498.862528436821, 1013.7921726046143, 1021.7598864266891, 1027.2655051637964, 1052.7052425320921, 1053.5733028123623, 22474.438139046328, 23592.528149436916, 23757.0, 23873.045078197025, 23886.88056559706, 1072.5280876414354, 1116.9556464705527, 1147.363213416545, 1148.936808475542, 1158.1834806461425, 11566.843315668366, 11833.467493962793, 12150.696232594255, 12166.0, 12245.632631021084, 319531.0, 320082.0, 321055.0, 321203.0, 321633.0, 51687.96624067498, 51878.0, 51937.740311298956, 51940.740296298274, 51969.74015129976, 1453.345994302568, 1481.903676261061, 1522.0867479512203, 1525.9465918692792, 1541.1985767401113, 23220.767792322535, 23341.41646458852, 23394.94722737447, 23471.0, 23562.646560301266, 37018.25963480769, 37036.44445333268, 37045.0, 37102.44346334861, 37160.0, 289704.0, 290754.0, 290911.0, 290990.0, 291070.0, 28585.42829143364, 29171.270718232216, 30293.788248470697, 33508.994730158134, 33623.15942101467, 41682.79158604187, 42336.364954526325, 42466.15067698567, 42466.513672021334, 42749.786251068545, 27720.0, 27724.86137569299, 29074.7092529072, 29758.25604359908, 29891.252718682208, 28921.421571568873, 29061.418771624027, 29568.0, 29973.55039674363, 30212.5468117974, 35462.29075418529, 35507.11232219215, 35545.0, 35634.58577455979, 35721.285574288886, 28171.295717606405, 28203.43593128167, 29391.412171756874, 30236.54645180368, 30327.848360758057, 21890.452738681022, 22752.544949101255, 23252.883735581214, 23264.302070937898, 23528.882355588114], "value": 16917.194366563934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.068635275339, 414.2998332817538, 431.79921336578485, 436.2540056503379, 456.9840055598055, 16218.513444596667, 21040.158393664253, 21938.0, 22531.986060627292, 22783.886080569573, 22437.0, 23035.884820575873, 23197.0, 23205.651915221242, 23382.415439613975, 6040.728167232463, 6078.118672792453, 6293.874122517547, 6303.968480157616, 6410.391012853772, 3732.2535492901393, 6294.181756371665, 6317.715702793363, 6355.555111142199, 6358.0, 3920.4707364505853, 4000.8599699010542, 6325.240971083454, 6333.461655759243, 6339.556231063827, 5908.291005079375, 6312.526560507958, 6315.5894866833505, 6347.714352854109, 6352.364763523657, 5439.184122381635, 5479.75341109651, 5513.807016754395, 5523.392426833045, 5529.115341545374, 26718.866405668043, 27473.17580472589, 28257.0, 28435.573466398022, 28593.71406285931, 2254.875981820999, 2304.216566367443, 2305.7578954209735, 2307.1348244408346, 2312.629979203336, 16577.585560361087, 17182.0, 17740.556486087822, 17937.730934036, 17956.92258464483, 1855.1837191635636, 2110.6306396380724, 2182.650775875852, 2186.420598541388, 2218.8335874809454, 134827.6517234825, 143061.0, 144070.0, 144428.27785861003, 145426.272868635, 11113.555457781598, 11577.6526704199, 11628.53485860556, 12048.578299759467, 12128.272303661808, 14571.198584077765, 14665.0, 15076.623084422758, 15114.697706046038, 15129.243537823066, 8604.182602652863, 8649.394542381973, 8650.0, 8695.391322607356, 8848.318819424418, 8090.352771778244, 8124.309433698202, 8288.336933045463, 8312.293455056388, 8316.0, 6482.416582507502, 7569.924300757032, 7592.202818704067, 7663.233676632292, 7666.501677390952, 1780.9821901781077, 2080.2927004818434, 2087.53030568124, 2089.279198676454, 2210.0386331945656, 929.8884133903974, 945.8885809174193, 946.3091942881734, 956.4930586789013, 982.6315131825565, 18657.720134197996, 20291.18835246603, 20605.0, 20687.0, 20705.68941465879, 933.2254228989922, 993.1161266472845, 1006.7332156978407, 1016.3292227130058, 1026.235454586338, 10230.953809238183, 10661.84007239892, 10757.085647719874, 10796.460176991119, 10796.622118225825, 619952.0, 630052.0, 634833.0, 638160.0, 638734.0, 140295.77633789272, 142356.0, 145407.0, 145915.0, 147125.0, 1199.4962115911337, 1217.792975194219, 1242.9192102513307, 1243.8569564500017, 1247.7442124364484, 16029.55733983947, 17438.738418923473, 17765.0, 17895.552611184823, 17925.551861203574, 56591.43408565861, 58086.4191358081, 58125.12812307734, 58900.41099588949, 59238.703806482416, 82312.58843705982, 82637.0, 84042.73935890844, 84355.73466397886, 85303.0, 8142.796430089295, 8156.551389673625, 8580.828383432421, 8669.529184182478, 8695.869561956702, 12635.494580216688, 13232.206067635972, 13509.527166549124, 13603.251821149932, 13961.301934903417, 11498.712532186762, 11714.70713232176, 11767.293962362286, 11856.822147667619, 11986.820197696867, 10661.0, 10698.0, 10775.892241077489, 10801.351918884891, 10976.451177441255, 11246.381449020382, 11385.146114041314, 11750.059995200534, 11884.405779711153, 11913.583024594098, 8453.36599755033, 8530.74407767768, 8752.29981601483, 8757.47455152693, 8958.552072396224, 11530.0, 11585.189036767682, 11868.465919033491, 11904.0, 11927.0], "value": 10300.49552848374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.8168915507251, 1445.4940770730245, 1470.4779803169872, 1475.7269905067562, 1480.3042569992099, 11528.365939873303, 12061.879381206185, 12094.516219351237, 12097.516099356026, 12112.152149349527, 11673.533058677644, 11686.415679216048, 12115.454804533794, 12123.757524849498, 12146.757064858697, 2484.142970675114, 2528.6586310847983, 2531.8227724059325, 2532.012515119105, 2533.0627667762956, 2463.4334103156284, 2469.839460435066, 2539.5428822811887, 2540.9745902541017, 2553.323369307135, 2298.4368829636765, 2400.5558971590312, 2401.9759802402014, 2402.5194961007783, 2503.7871780898645, 2494.9251522454356, 2495.5258500884775, 2520.949581008388, 2524.507720994407, 2527.406059575989, 2505.9475020491436, 2510.8367956082798, 2514.6856642919633, 2515.207709571479, 2517.6727025486753, 11663.94168029163, 11980.34108124053, 11986.280823150551, 12004.939975300067, 12008.279503229747, 6495.4803615710625, 6755.966220168917, 6756.054152418666, 6757.729690812362, 6762.492813039042, 3629.0, 4015.277250094982, 4357.934630980538, 4388.429504164438, 4406.471223453206, 1222.3338280637074, 1232.445399570188, 1239.3988915376035, 1316.9670758231025, 1317.7298653775954, 15347.07917524941, 15897.28462219203, 15901.602459938364, 16111.516654500267, 16232.431864884673, 4673.976630116827, 5549.694766787785, 5871.001929671966, 5881.264841894763, 5893.823185304448, 12400.81398779019, 12414.131010829336, 12416.565420210249, 12421.813672794915, 12436.937815310866, 5733.254676891977, 5990.041593345131, 5992.280926288786, 6630.0, 6648.16897887764, 5384.0, 5394.190871369326, 5622.57830662702, 5972.954732921721, 6188.195534580475, 4269.103488267437, 4348.195583816941, 4376.12477504494, 4418.33724941255, 4433.534478879671, 1285.607889593683, 1287.3241548187277, 1291.4511332683571, 1306.9215847049209, 1307.875751803577, 803.2890891560894, 806.2018601584389, 821.8315245374683, 827.9337652987747, 856.8928883889514, 4908.607311415079, 5514.310711161105, 6135.355787642234, 6135.509159267248, 6379.266384365765, 596.3946594206883, 610.2493932463095, 620.1565870416231, 625.7059182184366, 629.8236493781749, 3795.7912314822397, 3931.7051221158526, 3981.5023122109737, 4002.7598344099447, 4010.6590939770444, 14406.927965360106, 15058.774118388234, 15086.094834309977, 15096.56582624649, 15137.621559460882, 13740.282464691914, 14648.0, 14935.850641493664, 15033.699326013419, 15053.698926021418, 10745.40900250478, 10807.40559269232, 10835.18736094796, 10846.18653600983, 11180.38507882058, 7006.789796306119, 7022.08712867324, 7156.391706704989, 7211.242819504087, 7276.490645654753, 13603.93198034043, 13827.723445531234, 13830.515931942333, 14213.50252741149, 14238.145711257357, 14089.647758805702, 14184.929075354557, 14228.928855355656, 14270.500532481314, 14335.211563364115, 9417.645588602849, 9505.572249248939, 9569.330146889652, 9695.22438204956, 9700.175485083846, 10855.0, 10954.726131846768, 10987.011168994828, 10988.230823842254, 10988.560457581607, 9123.817523649623, 9335.206507446672, 9387.543700634284, 9429.811403772022, 9537.23702103844, 9082.318826088202, 9118.133777291147, 9150.359474836963, 9177.357584968988, 9227.723168304961, 8165.2243036911395, 8313.168683131638, 8344.624491897757, 8353.624086915981, 8359.164083591835, 5940.930632486021, 5984.97007514977, 6132.846678833065, 6160.229971253593, 6231.376862313732, 6043.7884674036195, 6124.969375153096, 6283.937160628335, 6294.905576416449, 6327.96836015817], "value": 5380.243675213885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.6185348702478, 346.2123668653812, 412.97993954931326, 419.51545964411076, 420.7790909772371, 4995.7502124893745, 5303.363596368432, 5813.866296072268, 5828.533717302616, 5885.234919460475, 4479.798409071592, 4682.391289132416, 5633.746481408336, 5739.253896993396, 5787.971060144704, 3635.218428037971, 3877.243937432202, 4288.571142885718, 4314.1803057419065, 4328.177646247203, 3821.9871733990376, 4317.114991426765, 4325.070109926365, 4351.65098819367, 4391.429114215148, 3549.8580056797696, 4287.5069367022725, 4314.913701725964, 4333.5233124356455, 4334.566543345672, 4280.9143817123795, 4291.24903141952, 4300.419443375167, 4309.2027974824605, 4319.416878721364, 3179.998300535347, 3723.207594304272, 3736.0, 3739.121306492972, 3782.5082739244, 5410.188471729232, 5470.17947307903, 5581.776728930838, 5646.938867313442, 5662.433756624346, 4713.764311784397, 5053.393592768891, 5089.821856235051, 5113.360829896263, 5203.297554830126, 6185.257769067695, 6238.220222472191, 6238.844028899269, 6238.946453372782, 6249.218847644044, 4024.9195016099807, 4238.512571054337, 4244.151169766028, 4255.6169944705125, 4269.957300426987, 4967.155583550805, 5088.974555127238, 6155.076738489218, 6235.9376406235815, 6487.870242595121, 3286.4741641337273, 3659.6523330284112, 3899.7075219358094, 4139.523954745183, 4170.47869016373, 4007.4189242559664, 4029.871635941941, 4344.0, 4353.586409291112, 4372.519022907478, 4821.228603423436, 4954.5540901319055, 5029.812031766193, 5052.444231134572, 5061.5950723942, 5330.946690533045, 5492.505674489315, 5608.270924779834, 6138.78514252008, 6161.322254551996, 1251.4118364368733, 1467.9045862018934, 1473.911565306085, 1477.4533422633478, 1484.3617244584716, 931.4762147840196, 980.2696990741942, 992.3252188511881, 995.7958618483193, 1001.4992503748126, 5785.82642520725, 5787.797427090031, 5800.419958004166, 5803.216565763652, 5803.245578074823, 6363.172787537683, 6363.5545511813725, 6368.490520758328, 6369.5222858285815, 6391.616503009835, 5143.639945203875, 5473.370562385297, 5795.290389335072, 5801.984652685763, 5973.253343332083, 2744.6157537944705, 2926.6488021437563, 3187.856546455415, 3372.7183670205163, 3375.0549846043145, 6186.845328866814, 6209.9068513972325, 6485.6108633482145, 6503.0, 6528.967355163194, 5817.476427121579, 6562.376574225441, 6646.833829154213, 6656.0, 6661.733530658817, 5543.722813859372, 5789.073748200268, 6312.842178945563, 6571.3100124488155, 6738.966305168443, 6333.588316759396, 6374.330695276929, 6460.967695161494, 6478.740850365933, 6525.314841941527, 6339.302676705466, 6356.4279214870885, 6372.330905255067, 6385.201849768779, 6414.696431337958, 5093.612747522856, 6060.848478788065, 6424.389682980296, 6487.870242595216, 6529.0, 3641.834612923839, 3744.7378683491893, 4253.894322310476, 4268.743875367488, 4301.849435269751, 5779.901818654443, 6111.54163437735, 6220.813375598739, 6321.367863213642, 6445.0, 5127.564157046693, 5400.324959380077, 6164.260288765377, 6166.722497487534, 6242.625442473466, 4954.1330267202375, 6139.9914042119935, 6170.0, 6190.907136392868, 6206.896551724138, 5149.035420619879, 5947.405259474018, 6011.308699499614, 6058.757649694139, 6110.26676798787, 5644.689542075061, 6157.876842463036, 6184.257889053342, 6196.81409557714, 6395.360463953567, 5861.267341582302, 5893.711196268819, 5909.320428150818, 6021.096835474538, 6037.69811509414], "value": 4475.896415644916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.533945265851, 779.6179871862789, 844.2275318083954, 864.8616221404576, 885.3404213860675, 13152.145110567806, 17165.313387464503, 17894.463166105004, 17897.373591924286, 17925.014124223162, 16877.156142192904, 17004.0, 17061.061641609736, 17095.145242737875, 17097.82902170981, 990.4898977026837, 1020.2908978260112, 1027.7687520307945, 1046.2571574182339, 1047.7433028907928, 682.1507223506741, 706.6396137969621, 981.3523074770653, 1032.091759251861, 1034.3948789957883, 1070.5022164693416, 1080.2330345454698, 1083.6423980086593, 1085.5169449594932, 1088.4938503595827, 1064.9520771565299, 1065.445968096593, 1065.504540388719, 1066.402814423925, 1071.5820829876354, 800.5156880087521, 801.6152246921511, 803.1526739290047, 803.3492870774633, 804.6097642643314, 16748.24632891523, 17025.148742562822, 17313.653726925517, 17387.391441299493, 17509.7373539397, 16546.0, 16769.916150419293, 17013.979161250365, 17032.91483542587, 17450.556922030926, 12696.1747486414, 12921.547745828851, 13111.409986550629, 13289.601311960656, 13298.73402531944, 3518.0, 3539.823008849547, 3540.0087975366937, 3540.061883600848, 3549.165946002687, 93024.06975930222, 109675.0, 111333.88666113316, 111364.44317778359, 111649.0, 11236.0, 11549.0, 13696.452141914211, 13981.231032293119, 14092.365843537065, 19538.511537211685, 24573.0, 24762.876185619316, 25415.491690166094, 25421.237362879143, 8837.734867953972, 8861.512616806138, 9049.819003620023, 9049.909500905038, 9062.275017998545, 4797.664163508591, 4948.826791062295, 4953.18272485036, 4958.578520825698, 4964.578010869044, 4234.9364759528635, 4266.402703621434, 4328.740275583412, 4376.0, 4381.211381951216, 948.6537413843897, 961.4759955824093, 966.9653470786332, 969.4280374579032, 969.7575606098476, 646.0954663471178, 652.3769799841141, 664.1366223908996, 672.4754691340762, 694.5763084518439, 9745.56144973478, 11638.41807909601, 11671.35807530594, 11791.88208117908, 12146.878531214576, 657.1194599237045, 664.2991643815724, 664.6377724140356, 670.4234358451728, 689.6276010954128, 5341.332333458317, 5483.7806487740045, 5493.23094766733, 5502.284702988586, 5618.522425593788, 95748.08503829884, 96555.0, 100375.0, 100637.98724025479, 100840.49579752055, 76172.0, 78301.21698783053, 84543.30913381698, 84678.57660711781, 85787.14212857916, 64048.03927941085, 67863.66068169726, 68747.65626171937, 70884.29115708776, 71820.28179718241, 11698.649040528799, 12072.094592905743, 12088.939555302168, 12096.939515302367, 12157.69605759863, 30382.17706937591, 36141.915742527766, 36402.27195456023, 36479.08802279858, 37305.81347093247, 44622.77688611536, 44682.0, 44982.650520484436, 45489.54510454853, 45703.0, 15567.0, 15585.0, 15718.68562628718, 15896.682066358839, 16089.47150020746, 14925.179115148338, 17772.200250988994, 18044.097795110454, 18105.275788968822, 18142.818571814114, 16213.432529861399, 16918.407855724992, 17115.22981465812, 17210.225539850988, 17263.82736172622, 16317.18414079315, 16371.754423683893, 16608.335666573686, 17070.74393884068, 17216.225269862636, 16028.599285017968, 16646.16769161513, 16756.413525526546, 16988.0, 17015.91492042532, 9929.801403971736, 11443.198976071595, 11904.285742855456, 12017.759644807229, 12069.818952715892, 12916.870831291566, 12976.45920670774, 13239.338033098114, 13729.45082196701, 13741.450341986209], "value": 8245.338871696353, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 122.0, 121.0, 121.0, 122.0, 122.0, 122.0, 123.0, 124.0, 122.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 120.0, 119.0, 164.0, 130.0, 115.0, 147.0, 150.0, 178.0, 140.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 209.0, 215.0, 255.0, 207.0, 207.0, 212.0, 209.0, 210.0, 208.0], "value": 214.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 82.0, 129.0, 94.0, 82.0, 63.0, 60.0, 83.0, 59.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 74.0, 96.0, 77.0, 83.0, 105.0, 128.0, 73.0, 75.0, 87.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 90.0, 91.0, 92.0, 92.0, 92.0, 90.0, 91.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 100.0, 101.0, 99.0, 100.0, 99.0, 101.0, 100.0, 119.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 120.0, 162.0, 101.0, 101.0, 100.0, 99.0, 102.0, 101.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 50.0, 51.0, 50.0, 53.0, 49.0, 52.0, 53.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 65.0, 75.0, 70.0, 67.0, 64.0, 64.0, 64.0, 64.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 93.0, 90.0, 91.0, 89.0, 92.0, 90.0, 89.0, 86.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 164.0, 154.0, 153.0, 147.0, 149.0, 153.0, 148.0, 198.0, 170.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 203.0, 200.0, 202.0, 200.0, 200.0, 201.0, 199.0, 198.0, 200.0], "value": 199.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 74.0, 71.0, 71.0, 73.0, 71.0, 102.0, 107.0, 96.0], "value": 81.1, "unit": "score"}]}]} 16:52:41 INFO - Return code: 0 16:52:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:41 ERROR - # TBPL SUCCESS # 16:52:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:52:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:52:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:52:41 INFO - 2017-04-10 16:52:41.449 screenresolution[1651:9973] starting screenresolution argv=screenresolution get 16:52:41 INFO - 2017-04-10 16:52:41.453 screenresolution[1651:9973] Display 0: 1600x1200x32@60 16:52:41 INFO - 2017-04-10 16:52:41.459 screenresolution[1652:9976] starting screenresolution argv=screenresolution list 16:52:41 INFO - Available Modes on Display 0 16:52:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:52:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:52:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:52:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:52:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:52:41 INFO - Intel Iris: 16:52:41 INFO - Chipset Model: Intel Iris 16:52:41 INFO - Type: GPU 16:52:41 INFO - Bus: Built-In 16:52:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:52:41 INFO - Vendor: Intel (0x8086) 16:52:41 INFO - Device ID: 0x0a2e 16:52:41 INFO - Revision ID: 0x0009 16:52:41 INFO - Displays: 16:52:41 INFO - Display: 16:52:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:52:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:52:41 INFO - Display Serial Number: 1600x1200 60 16:52:41 INFO - Main Display: Yes 16:52:41 INFO - Mirror: Off 16:52:41 INFO - Online: Yes 16:52:41 INFO - Rotation: Supported 16:52:41 INFO - Return code: 0 16:52:41 INFO - Running post-action listener: _resource_record_post_action 16:52:41 INFO - [mozharness: 2017-04-10 23:52:41.705069Z] Finished run-tests step (success) 16:52:41 INFO - Running post-run listener: _resource_record_post_run 16:52:41 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 38183936; Write bytes: 515869184; Read time: 246; Write time: 1595 16:52:41 INFO - TinderboxPrint: CPU usage
53.6% 16:52:41 INFO - TinderboxPrint: I/O read bytes / time
38,183,936 / 246 16:52:41 INFO - TinderboxPrint: I/O write bytes / time
515,869,184 / 1,595 16:52:41 INFO - TinderboxPrint: CPU idle
2,234.4 (46.4%) 16:52:41 INFO - TinderboxPrint: CPU system
963.8 (20.0%) 16:52:41 INFO - TinderboxPrint: CPU user
1,619.4 (33.6%) 16:52:41 INFO - TinderboxPrint: Swap in / out
245,583,872 / 0 16:52:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196375040; Write bytes: 194693120; Read time: 15009; Write time: 410 16:52:41 INFO - run-tests - Wall time: 1186s; CPU: 54.0%; Read bytes: 37217280; Write bytes: 304329216; Read time: 231; Write time: 1134 16:52:42 INFO - Running post-run listener: _upload_blobber_files 16:52:42 INFO - Blob upload gear active. 16:52:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:42 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 16:52:42 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'] 16:52:42 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 16:52:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:43 INFO - (blobuploader) - INFO - Done attempting. 16:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:44 INFO - (blobuploader) - INFO - Done attempting. 16:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:45 INFO - (blobuploader) - INFO - Done attempting. 16:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:48 INFO - (blobuploader) - INFO - Done attempting. 16:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:48 INFO - Return code: 0 16:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c260f902ba7b250b0d1a0edbb76ed426d5743851202f4942cf397a9f7b951e255ff025fee7963d8339d31d29b2455caef6561900ddfb13e73d66b7544eba9381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab3946b7191cc1c767c209259640a46b5cc8134478eddd6248953dbb945a66f210c9d0c3b9ee0729e9e425ea2c12f41dfb6d7217dcbda9551f93e3bcf2e4c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90449a22cd73a3c6fc0af17b80137db87f2aa76ab0a8c7811c44de7288120c003dbc44b77c640605f6c7f05bdc436b2755aaac5092944e167e8d5c8311d91415", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe7a481443ff3a55407e472b0a927d7a4f3114d688cb3efefc235429ea89ce80091b61a518070db2524223de04270af93d7d94ad59053fef0b4632b4cbc151f"} 16:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:48 INFO - Contents: 16:52:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c260f902ba7b250b0d1a0edbb76ed426d5743851202f4942cf397a9f7b951e255ff025fee7963d8339d31d29b2455caef6561900ddfb13e73d66b7544eba9381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab3946b7191cc1c767c209259640a46b5cc8134478eddd6248953dbb945a66f210c9d0c3b9ee0729e9e425ea2c12f41dfb6d7217dcbda9551f93e3bcf2e4c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90449a22cd73a3c6fc0af17b80137db87f2aa76ab0a8c7811c44de7288120c003dbc44b77c640605f6c7f05bdc436b2755aaac5092944e167e8d5c8311d91415", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe7a481443ff3a55407e472b0a927d7a4f3114d688cb3efefc235429ea89ce80091b61a518070db2524223de04270af93d7d94ad59053fef0b4632b4cbc151f"} 16:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:48 INFO - Copying logs to upload dir... 16:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.852816 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-10 16:52:48.539050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 16:52:48.542315) ========= 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.Whxn3agyyx/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.S2FtAcpfng/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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/c260f902ba7b250b0d1a0edbb76ed426d5743851202f4942cf397a9f7b951e255ff025fee7963d8339d31d29b2455caef6561900ddfb13e73d66b7544eba9381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab3946b7191cc1c767c209259640a46b5cc8134478eddd6248953dbb945a66f210c9d0c3b9ee0729e9e425ea2c12f41dfb6d7217dcbda9551f93e3bcf2e4c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90449a22cd73a3c6fc0af17b80137db87f2aa76ab0a8c7811c44de7288120c003dbc44b77c640605f6c7f05bdc436b2755aaac5092944e167e8d5c8311d91415", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe7a481443ff3a55407e472b0a927d7a4f3114d688cb3efefc235429ea89ce80091b61a518070db2524223de04270af93d7d94ad59053fef0b4632b4cbc151f"} build_url:https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011793 build_url: 'https://queue.taskcluster.net/v1/task/STrsARLCQwOQ6hQmiKr2Hw/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/c260f902ba7b250b0d1a0edbb76ed426d5743851202f4942cf397a9f7b951e255ff025fee7963d8339d31d29b2455caef6561900ddfb13e73d66b7544eba9381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab3946b7191cc1c767c209259640a46b5cc8134478eddd6248953dbb945a66f210c9d0c3b9ee0729e9e425ea2c12f41dfb6d7217dcbda9551f93e3bcf2e4c43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90449a22cd73a3c6fc0af17b80137db87f2aa76ab0a8c7811c44de7288120c003dbc44b77c640605f6c7f05bdc436b2755aaac5092944e167e8d5c8311d91415", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe7a481443ff3a55407e472b0a927d7a4f3114d688cb3efefc235429ea89ce80091b61a518070db2524223de04270af93d7d94ad59053fef0b4632b4cbc151f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 16:52:48.584881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 16:52:48.585242) ========= 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.Whxn3agyyx/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.S2FtAcpfng/Listeners TMPDIR=/var/folders/xm/n27ws1sd1t3406fsw7fnw23r00000w/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.005275 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 16:52:48.636707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 16:52:48.637459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 16:52:48.638294) ========= ========= Total master_lag: 0.19 =========