builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0285 starttime: 1493309640.1 results: success (0) buildid: 20170427075325 builduid: 4326fa405f174f2bb53eff975e5c6d95 revision: abe5868346c7abb5b0bdf76f29bc3d9f839461f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.101089) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.101538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.101811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.128952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.129275) ========= 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.Dqt23XVri9/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.SoWOBIABsd/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-27 09:14:00-- 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% 18.7M=0.001s 2017-04-27 09:14:00 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142204 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.539384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.539696) ========= 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.Dqt23XVri9/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.SoWOBIABsd/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.026891 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:00.589503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 09:14:00.589850) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev abe5868346c7abb5b0bdf76f29bc3d9f839461f5 --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 abe5868346c7abb5b0bdf76f29bc3d9f839461f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dqt23XVri9/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.SoWOBIABsd/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-27 09:14:00,695 truncating revision to first 12 chars 2017-04-27 09:14:00,695 Setting DEBUG logging. 2017-04-27 09:14:00,695 attempt 1/10 2017-04-27 09:14:00,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/abe5868346c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 09:14:02,039 unpacking tar archive at: mozilla-central-abe5868346c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.622977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 09:14:02.237435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:02.237966) ========= script_repo_revision: abe5868346c7abb5b0bdf76f29bc3d9f839461f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:02.238639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:02.239078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 09:14:02.259732) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-27 09:14:02.260102) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Dqt23XVri9/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.SoWOBIABsd/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:14:02 INFO - MultiFileLogger online at 20170427 09:14:02 in /builds/slave/test 09:14:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:02 INFO - {'append_to_log': False, 09:14:02 INFO - 'base_work_dir': '/builds/slave/test', 09:14:02 INFO - 'blob_upload_branch': 'Firefox', 09:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:02 INFO - 'branch': 'Firefox', 09:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:02 INFO - 'config_files': ('talos/mac_config.py',), 09:14:02 INFO - 'default_actions': ('clobber', 09:14:02 INFO - 'read-buildbot-config', 09:14:02 INFO - 'download-and-extract', 09:14:02 INFO - 'populate-webroot', 09:14:02 INFO - 'create-virtualenv', 09:14:02 INFO - 'install', 09:14:02 INFO - 'run-tests'), 09:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:02 INFO - 'download_minidump_stackwalk': True, 09:14:02 INFO - 'download_symbols': 'ondemand', 09:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:02 INFO - 'gecko_profile': False, 09:14:02 INFO - 'gecko_profile_interval': 0, 09:14:02 INFO - 'installer_path': 'installer.exe', 09:14:02 INFO - 'log_level': 'info', 09:14:02 INFO - 'log_name': 'talos', 09:14:02 INFO - 'log_to_console': True, 09:14:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:14:02 INFO - 'opt_config_files': (), 09:14:02 INFO - 'pip_index': False, 09:14:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:02 INFO - 'cmd': ('bash', 09:14:02 INFO - '-c', 09:14:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:02 INFO - 'enabled': True, 09:14:02 INFO - 'halt_on_failure': False, 09:14:02 INFO - 'name': 'check_screen_resolution'},), 09:14:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:14:02 INFO - 'cmd': ('bash', 09:14:02 INFO - '-c', 09:14:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:14:02 INFO - 'enabled': True, 09:14:02 INFO - 'halt_on_failure': False, 09:14:02 INFO - 'name': 'check_screen_resolution'},), 09:14:02 INFO - 'run_cmd_checks_enabled': True, 09:14:02 INFO - 'suite': 'dromaeojs-e10s', 09:14:02 INFO - 'system_bits': '32', 09:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:02 INFO - 'title': 't-yosemite-r7-0285', 09:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:02 INFO - 'use_talos_json': True, 09:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:02 INFO - 'work_dir': 'build'} 09:14:02 INFO - [mozharness: 2017-04-27 16:14:02.472494Z] Running clobber step. 09:14:02 INFO - Running pre-action listener: _resource_record_pre_action 09:14:02 INFO - Running main action method: clobber 09:14:02 INFO - rmtree: /builds/slave/test/build 09:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:04 INFO - Running post-action listener: _resource_record_post_action 09:14:04 INFO - [mozharness: 2017-04-27 16:14:04.805947Z] Finished clobber step (success) 09:14:04 INFO - [mozharness: 2017-04-27 16:14:04.806093Z] Running read-buildbot-config step. 09:14:04 INFO - Running pre-action listener: _resource_record_pre_action 09:14:04 INFO - Running main action method: read_buildbot_config 09:14:04 INFO - Using buildbot properties: 09:14:04 INFO - { 09:14:04 INFO - "project": "", 09:14:04 INFO - "product": "firefox", 09:14:04 INFO - "script_repo_revision": "production", 09:14:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:14:04 INFO - "repository": "", 09:14:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:14:04 INFO - "buildid": "20170427075325", 09:14:04 INFO - "pgo_build": "False", 09:14:04 INFO - "basedir": "/builds/slave/test", 09:14:04 INFO - "buildnumber": 51, 09:14:04 INFO - "slavename": "t-yosemite-r7-0285", 09:14:04 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:14:04 INFO - "platform": "yosemite_r7", 09:14:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:14:04 INFO - "branch": "mozilla-central", 09:14:04 INFO - "repo_path": "mozilla-central", 09:14:04 INFO - "revision": "abe5868346c7abb5b0bdf76f29bc3d9f839461f5", 09:14:04 INFO - "stage_platform": "macosx64", 09:14:04 INFO - "builduid": "4326fa405f174f2bb53eff975e5c6d95", 09:14:04 INFO - "slavebuilddir": "test" 09:14:04 INFO - } 09:14:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:14:04 INFO - Running post-action listener: _resource_record_post_action 09:14:04 INFO - [mozharness: 2017-04-27 16:14:04.809852Z] Finished read-buildbot-config step (success) 09:14:04 INFO - [mozharness: 2017-04-27 16:14:04.810008Z] Running download-and-extract step. 09:14:04 INFO - Running pre-action listener: _resource_record_pre_action 09:14:04 INFO - Running main action method: download_and_extract 09:14:04 INFO - mkdir: /builds/slave/test/build/tests 09:14:04 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')]} 09:14:04 INFO - trying https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:14:04 INFO - Downloading https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/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 09:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/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 09:14:05 INFO - Downloaded 1325 bytes. 09:14:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:14:05 INFO - Using the following test package requirements: 09:14:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:14:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:14:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:14:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:14:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'jsshell-mac.zip'], 09:14:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:14:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:14:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:14:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:14:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:14:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:14:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:14:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:14:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:14:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:14:05 INFO - Fetch https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:14:07 INFO - Content-Length response header: 52528456 09:14:07 INFO - Bytes received: 52528456 09:14:24 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 09:14:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:14:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:14:24 INFO - Fetch https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:14:26 INFO - Content-Length response header: 52528456 09:14:26 INFO - Bytes received: 52528456 09:14:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:14:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:14:41 INFO - Fetch https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:14:43 INFO - Content-Length response header: 14408809 09:14:43 INFO - Bytes received: 14408809 09:14:43 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')]} 09:14:43 INFO - trying https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:14:43 INFO - Downloading https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/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 09:14:45 INFO - Downloaded 71191289 bytes. 09:14:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:14:45 INFO - mkdir: /builds/slave/test/properties 09:14:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:45 INFO - Contents: 09:14:45 INFO - build_url:https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:14:46 INFO - Running post-action listener: _resource_record_post_action 09:14:46 INFO - Running post-action listener: set_extra_try_arguments 09:14:46 INFO - [mozharness: 2017-04-27 16:14:46.540585Z] Finished download-and-extract step (success) 09:14:46 INFO - [mozharness: 2017-04-27 16:14:46.540724Z] Running populate-webroot step. 09:14:46 INFO - Running pre-action listener: _resource_record_pre_action 09:14:46 INFO - Running main action method: populate_webroot 09:14:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:46 INFO - '--tppagecycles', 09:14:46 INFO - '7'], 09:14:46 INFO - 'tests': ['tsvgm']}}, 09:14:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['damp', 'tps']}, 09:14:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'tests': ['damp', 'tps']}, 09:14:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['dromaeo_dom']}, 09:14:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:14:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:14:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['a11yr', 09:14:46 INFO - 'ts_paint', 09:14:46 INFO - 'tpaint', 09:14:46 INFO - 'sessionrestore', 09:14:46 INFO - 'sessionrestore_no_auto_restore', 09:14:46 INFO - 'tabpaint']}, 09:14:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:46 INFO - 'ts_paint', 09:14:46 INFO - 'tpaint', 09:14:46 INFO - 'sessionrestore', 09:14:46 INFO - 'sessionrestore_no_auto_restore', 09:14:46 INFO - 'tabpaint']}, 09:14:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:46 INFO - 'ts_paint', 09:14:46 INFO - 'tpaint', 09:14:46 INFO - 'sessionrestore', 09:14:46 INFO - 'sessionrestore_no_auto_restore', 09:14:46 INFO - 'tabpaint']}, 09:14:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:46 INFO - 'ts_paint', 09:14:46 INFO - 'tpaint', 09:14:46 INFO - 'sessionrestore', 09:14:46 INFO - 'sessionrestore_no_auto_restore', 09:14:46 INFO - 'tabpaint']}, 09:14:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['a11yr', 09:14:46 INFO - 'ts_paint', 09:14:46 INFO - 'tpaint', 09:14:46 INFO - 'sessionrestore', 09:14:46 INFO - 'sessionrestore_no_auto_restore', 09:14:46 INFO - 'tabpaint']}, 09:14:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['a11yr', 09:14:46 INFO - 'ts_paint', 09:14:46 INFO - 'tpaint', 09:14:46 INFO - 'sessionrestore', 09:14:46 INFO - 'sessionrestore_no_auto_restore', 09:14:46 INFO - 'tabpaint']}, 09:14:46 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:14:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:14:46 INFO - 'bloom_basic_ref']}, 09:14:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['tsvgx', 09:14:46 INFO - 'tsvgr_opacity', 09:14:46 INFO - 'tart', 09:14:46 INFO - 'tscrollx', 09:14:46 INFO - 'cart', 09:14:46 INFO - 'tsvg_static']}, 09:14:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:46 INFO - 'tsvgr_opacity', 09:14:46 INFO - 'tart', 09:14:46 INFO - 'tscrollx', 09:14:46 INFO - 'cart', 09:14:46 INFO - 'tsvg_static']}, 09:14:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'talos_options': ['--disable-e10s'], 09:14:46 INFO - 'tests': ['tp5o']}, 09:14:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:14:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'talos_options': ['--disable-e10s', 09:14:46 INFO - '--xperf_path', 09:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:46 INFO - 'tests': ['tp5n']}, 09:14:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:14:46 INFO - 'talos_options': ['--xperf_path', 09:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:46 INFO - 'tests': ['tp5n']}}, 09:14:46 INFO - 'talos.zip': {'path': '', 09:14:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:46 INFO - Running post-action listener: _resource_record_post_action 09:14:46 INFO - [mozharness: 2017-04-27 16:14:46.559873Z] Finished populate-webroot step (success) 09:14:46 INFO - [mozharness: 2017-04-27 16:14:46.559999Z] Running create-virtualenv step. 09:14:46 INFO - Running pre-action listener: _resource_record_pre_action 09:14:46 INFO - Running main action method: create_virtualenv 09:14:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:46 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 09:14:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:46 INFO - Using real prefix '/tools/python27' 09:14:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:50 INFO - Installing pip.................done. 09:14:50 INFO - Return code: 0 09:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:14:50 INFO - Reading from file tmpfile_stdout 09:14:50 INFO - Output received: 09:14:50 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) 09:14:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:50 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')]} 09:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:50 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')]} 09:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:50 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:14:50 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 09:14:50 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 09:14:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:14:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:50 INFO - 'HOME': '/Users/cltbld', 09:14:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:50 INFO - 'LOGNAME': 'cltbld', 09:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:50 INFO - 'MOZ_NO_REMOTE': '1', 09:14:50 INFO - 'NO_EM_RESTART': '1', 09:14:50 INFO - 'PAGER': '/bin/cat', 09:14:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:50 INFO - 'PWD': '/builds/slave/test', 09:14:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:50 INFO - 'SHELL': '/bin/bash', 09:14:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:14:50 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:14:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:50 INFO - 'USER': 'cltbld', 09:14:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:50 INFO - 'XPC_FLAGS': '0x0', 09:14:50 INFO - 'XPC_SERVICE_NAME': '0', 09:14:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:50 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 09:14:50 INFO - Cleaning up... 09:14:50 INFO - Return code: 0 09:14:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:50 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')]} 09:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:50 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')]} 09:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:50 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:14:50 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 09:14:50 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 09:14:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:14:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:50 INFO - 'HOME': '/Users/cltbld', 09:14:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:50 INFO - 'LOGNAME': 'cltbld', 09:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:50 INFO - 'MOZ_NO_REMOTE': '1', 09:14:50 INFO - 'NO_EM_RESTART': '1', 09:14:50 INFO - 'PAGER': '/bin/cat', 09:14:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:50 INFO - 'PWD': '/builds/slave/test', 09:14:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:50 INFO - 'SHELL': '/bin/bash', 09:14:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:14:50 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:14:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:50 INFO - 'USER': 'cltbld', 09:14:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:50 INFO - 'XPC_FLAGS': '0x0', 09:14:50 INFO - 'XPC_SERVICE_NAME': '0', 09:14:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:51 INFO - Downloading/unpacking psutil>=3.1.1 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:51 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 09:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:54 INFO - Installing collected packages: psutil 09:14:54 INFO - Running setup.py install for psutil 09:14:54 INFO - building 'psutil._psutil_osx' extension 09:14:54 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 09:14:55 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 09:14:55 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 09:14:55 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 09:14:55 INFO - building 'psutil._psutil_posix' extension 09:14:55 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 09:14:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:14:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:14:55 INFO - ^ 09:14:55 INFO - 1 warning generated. 09:14:55 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 09:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:55 INFO - Successfully installed psutil 09:14:55 INFO - Cleaning up... 09:14:55 INFO - Return code: 0 09:14:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:14:55 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')]} 09:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:56 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:14:56 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 09:14:56 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 09:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:56 INFO - 'HOME': '/Users/cltbld', 09:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:56 INFO - 'LOGNAME': 'cltbld', 09:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:56 INFO - 'MOZ_NO_REMOTE': '1', 09:14:56 INFO - 'NO_EM_RESTART': '1', 09:14:56 INFO - 'PAGER': '/bin/cat', 09:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:56 INFO - 'PWD': '/builds/slave/test', 09:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:56 INFO - 'SHELL': '/bin/bash', 09:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:14:56 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:56 INFO - 'USER': 'cltbld', 09:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:56 INFO - 'XPC_FLAGS': '0x0', 09:14:56 INFO - 'XPC_SERVICE_NAME': '0', 09:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:59 INFO - Installing collected packages: mozsystemmonitor 09:14:59 INFO - Running setup.py install for mozsystemmonitor 09:14:59 INFO - Successfully installed mozsystemmonitor 09:14:59 INFO - Cleaning up... 09:15:00 INFO - Return code: 0 09:15:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:00 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:00 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 09:15:00 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 09:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:00 INFO - 'HOME': '/Users/cltbld', 09:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:00 INFO - 'LOGNAME': 'cltbld', 09:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:00 INFO - 'MOZ_NO_REMOTE': '1', 09:15:00 INFO - 'NO_EM_RESTART': '1', 09:15:00 INFO - 'PAGER': '/bin/cat', 09:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:00 INFO - 'PWD': '/builds/slave/test', 09:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:00 INFO - 'SHELL': '/bin/bash', 09:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:00 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:00 INFO - 'USER': 'cltbld', 09:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:00 INFO - 'XPC_FLAGS': '0x0', 09:15:00 INFO - 'XPC_SERVICE_NAME': '0', 09:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:15:02 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 09:15:02 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 09:15:02 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 09:15:02 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 09:15:02 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 09:15:02 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 09:15:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:03 INFO - warning: no files found matching '*.txt' 09:15:03 INFO - no previously-included directories found matching 'build' 09:15:03 INFO - no previously-included directories found matching 'dist' 09:15:03 INFO - no previously-included directories found matching '.git*' 09:15:03 INFO - Installing collected packages: jsonschema, functools32 09:15:03 INFO - Running setup.py install for functools32 09:15:03 INFO - warning: no files found matching '*.txt' 09:15:03 INFO - no previously-included directories found matching 'build' 09:15:03 INFO - no previously-included directories found matching 'dist' 09:15:03 INFO - no previously-included directories found matching '.git*' 09:15:03 INFO - Successfully installed jsonschema functools32 09:15:03 INFO - Cleaning up... 09:15:03 INFO - Return code: 0 09:15:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:03 INFO - 'HOME': '/Users/cltbld', 09:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:03 INFO - 'LOGNAME': 'cltbld', 09:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:03 INFO - 'MOZ_NO_REMOTE': '1', 09:15:03 INFO - 'NO_EM_RESTART': '1', 09:15:03 INFO - 'PAGER': '/bin/cat', 09:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:03 INFO - 'PWD': '/builds/slave/test', 09:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:03 INFO - 'SHELL': '/bin/bash', 09:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:03 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:03 INFO - 'USER': 'cltbld', 09:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:03 INFO - 'XPC_FLAGS': '0x0', 09:15:03 INFO - 'XPC_SERVICE_NAME': '0', 09:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:15:03 INFO - Cleaning up... 09:15:03 INFO - Return code: 0 09:15:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:03 INFO - 'HOME': '/Users/cltbld', 09:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:03 INFO - 'LOGNAME': 'cltbld', 09:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:03 INFO - 'MOZ_NO_REMOTE': '1', 09:15:03 INFO - 'NO_EM_RESTART': '1', 09:15:03 INFO - 'PAGER': '/bin/cat', 09:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:03 INFO - 'PWD': '/builds/slave/test', 09:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:03 INFO - 'SHELL': '/bin/bash', 09:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:03 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:03 INFO - 'USER': 'cltbld', 09:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:03 INFO - 'XPC_FLAGS': '0x0', 09:15:03 INFO - 'XPC_SERVICE_NAME': '0', 09:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:08 INFO - Downloading docopt-0.6.1.tar.gz 09:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:08 INFO - Running setup.py install for blobuploader 09:15:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:08 INFO - Running setup.py install for requests 09:15:08 INFO - Running setup.py install for docopt 09:15:09 INFO - Successfully installed blobuploader requests docopt 09:15:09 INFO - Cleaning up... 09:15:09 INFO - Return code: 0 09:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:09 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:09 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 09:15:09 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 09:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:09 INFO - 'HOME': '/Users/cltbld', 09:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:09 INFO - 'LOGNAME': 'cltbld', 09:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:09 INFO - 'MOZ_NO_REMOTE': '1', 09:15:09 INFO - 'NO_EM_RESTART': '1', 09:15:09 INFO - 'PAGER': '/bin/cat', 09:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:09 INFO - 'PWD': '/builds/slave/test', 09:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:09 INFO - 'SHELL': '/bin/bash', 09:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:09 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:09 INFO - 'USER': 'cltbld', 09:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:09 INFO - 'XPC_FLAGS': '0x0', 09:15:09 INFO - 'XPC_SERVICE_NAME': '0', 09:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:09 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-iO9Szv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:09 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-h4RUKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:09 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ZZs1tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:09 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-H75AcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:09 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-jgwZfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:09 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-b7Acoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-I62224-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Pk_L7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-zi_TVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-lwLQzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-yyeoDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Zd5Ao4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-VM5AEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-oOG7s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-EzRnBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:10 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-KlpWj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:11 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ule3kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:11 INFO - Running setup.py install for manifestparser 09:15:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozcrash 09:15:11 INFO - Running setup.py install for mozdebug 09:15:11 INFO - Running setup.py install for mozdevice 09:15:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:11 INFO - Running setup.py install for mozfile 09:15:11 INFO - Running setup.py install for mozhttpd 09:15:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozinfo 09:15:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozInstall 09:15:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozleak 09:15:12 INFO - Running setup.py install for mozlog 09:15:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for moznetwork 09:15:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:12 INFO - Running setup.py install for mozprocess 09:15:12 INFO - Running setup.py install for mozprofile 09:15:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozrunner 09:15:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Running setup.py install for mozscreenshot 09:15:13 INFO - Running setup.py install for moztest 09:15:13 INFO - Running setup.py install for mozversion 09:15:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:13 INFO - Cleaning up... 09:15:13 INFO - Return code: 0 09:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:13 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')]} 09:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:13 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')]} 09:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:13 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:13 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 09:15:13 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 09:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:13 INFO - 'HOME': '/Users/cltbld', 09:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:13 INFO - 'LOGNAME': 'cltbld', 09:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:13 INFO - 'MOZ_NO_REMOTE': '1', 09:15:13 INFO - 'NO_EM_RESTART': '1', 09:15:13 INFO - 'PAGER': '/bin/cat', 09:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:13 INFO - 'PWD': '/builds/slave/test', 09:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:13 INFO - 'SHELL': '/bin/bash', 09:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:13 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:13 INFO - 'USER': 'cltbld', 09:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:13 INFO - 'XPC_FLAGS': '0x0', 09:15:13 INFO - 'XPC_SERVICE_NAME': '0', 09:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-d01KXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-41JiX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-AlExYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-3HAMm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ZoaPWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-gWkurp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Nbfsxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-nwIYFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:14 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-oPVLIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:14 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)) 09:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-mrOIuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-R8F79M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-VVSx3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-lO8qf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-3fd7zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Lu4RS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-7rdwJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:15 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)) 09:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:15 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-bXFGjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:15 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)) 09:15:15 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)) 09:15:15 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)) 09:15:15 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)) 09:15:15 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)) 09:15:15 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)) 09:15:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:18 INFO - Downloading blessings-1.6.tar.gz 09:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:18 INFO - Installing collected packages: blessings 09:15:18 INFO - Running setup.py install for blessings 09:15:18 INFO - Successfully installed blessings 09:15:18 INFO - Cleaning up... 09:15:18 INFO - Return code: 0 09:15:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:19 INFO - Reading from file tmpfile_stdout 09:15:19 INFO - Current package versions: 09:15:19 INFO - blessings == 1.6 09:15:19 INFO - blobuploader == 1.2.4 09:15:19 INFO - docopt == 0.6.1 09:15:19 INFO - functools32 == 3.2.3-2 09:15:19 INFO - jsonschema == 2.5.1 09:15:19 INFO - manifestparser == 1.1 09:15:19 INFO - mozInstall == 1.12 09:15:19 INFO - mozcrash == 1.0 09:15:19 INFO - mozdebug == 0.1 09:15:19 INFO - mozdevice == 0.50 09:15:19 INFO - mozfile == 1.2 09:15:19 INFO - mozhttpd == 0.7 09:15:19 INFO - mozinfo == 0.9 09:15:19 INFO - mozleak == 0.1 09:15:19 INFO - mozlog == 3.4 09:15:19 INFO - moznetwork == 0.27 09:15:19 INFO - mozprocess == 0.25 09:15:19 INFO - mozprofile == 0.28 09:15:19 INFO - mozrunner == 6.13 09:15:19 INFO - mozscreenshot == 0.1 09:15:19 INFO - mozsystemmonitor == 0.3 09:15:19 INFO - moztest == 0.8 09:15:19 INFO - mozversion == 1.4 09:15:19 INFO - psutil == 3.1.1 09:15:19 INFO - requests == 1.2.3 09:15:19 INFO - wsgiref == 0.1.2 09:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:19 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')]} 09:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:19 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')]} 09:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:19 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:19 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 09:15:19 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 09:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:19 INFO - 'HOME': '/Users/cltbld', 09:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:19 INFO - 'LOGNAME': 'cltbld', 09:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:19 INFO - 'MOZ_NO_REMOTE': '1', 09:15:19 INFO - 'NO_EM_RESTART': '1', 09:15:19 INFO - 'PAGER': '/bin/cat', 09:15:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:19 INFO - 'PWD': '/builds/slave/test', 09:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:19 INFO - 'SHELL': '/bin/bash', 09:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:19 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:19 INFO - 'USER': 'cltbld', 09:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:19 INFO - 'XPC_FLAGS': '0x0', 09:15:19 INFO - 'XPC_SERVICE_NAME': '0', 09:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 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)) 09:15:19 INFO - Cleaning up... 09:15:19 INFO - Return code: 0 09:15:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:19 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')]} 09:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:19 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')]} 09:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:19 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 0x10323cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10323f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99ca585b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, '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.Dqt23XVri9/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.SoWOBIABsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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 09:15:19 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 09:15:19 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 09:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:19 INFO - 'HOME': '/Users/cltbld', 09:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:19 INFO - 'LOGNAME': 'cltbld', 09:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:19 INFO - 'MOZ_NO_REMOTE': '1', 09:15:19 INFO - 'NO_EM_RESTART': '1', 09:15:19 INFO - 'PAGER': '/bin/cat', 09:15:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:19 INFO - 'PWD': '/builds/slave/test', 09:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:19 INFO - 'SHELL': '/bin/bash', 09:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:19 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:19 INFO - 'USER': 'cltbld', 09:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:19 INFO - 'XPC_FLAGS': '0x0', 09:15:19 INFO - 'XPC_SERVICE_NAME': '0', 09:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:15:19 INFO - Cleaning up... 09:15:19 INFO - Return code: 0 09:15:19 INFO - Running post-action listener: _resource_record_post_action 09:15:19 INFO - Running post-action listener: _start_resource_monitoring 09:15:19 INFO - Starting resource monitoring. 09:15:19 INFO - [mozharness: 2017-04-27 16:15:19.690624Z] Finished create-virtualenv step (success) 09:15:19 INFO - [mozharness: 2017-04-27 16:15:19.691594Z] Running install step. 09:15:19 INFO - Running pre-action listener: _resource_record_pre_action 09:15:19 INFO - Running main action method: install 09:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:19 INFO - Reading from file tmpfile_stdout 09:15:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:20 INFO - Reading from file tmpfile_stdout 09:15:20 INFO - Output received: 09:15:20 INFO - Usage: mozinstall [options] installer 09:15:20 INFO - Options: 09:15:20 INFO - -h, --help show this help message and exit 09:15:20 INFO - -d DEST, --destination=DEST 09:15:20 INFO - Directory to install application into. [default: 09:15:20 INFO - "/builds/slave/test"] 09:15:20 INFO - --app=APP Application being installed. [default: firefox] 09:15:20 INFO - mkdir: /builds/slave/test/build/application 09:15:20 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'] 09:15:20 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 09:15:39 INFO - Reading from file tmpfile_stdout 09:15:39 INFO - Output received: 09:15:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:15:39 INFO - Running post-action listener: _resource_record_post_action 09:15:39 INFO - [mozharness: 2017-04-27 16:15:39.690913Z] Finished install step (success) 09:15:39 INFO - [mozharness: 2017-04-27 16:15:39.691030Z] Running run-tests step. 09:15:39 INFO - Running pre-action listener: _resource_record_pre_action 09:15:39 INFO - Running main action method: run_tests 09:15:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:15:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:15:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:15:39 INFO - 2017-04-27 09:15:39.703 screenresolution[1617:7479] starting screenresolution argv=screenresolution get 09:15:39 INFO - 2017-04-27 09:15:39.706 screenresolution[1617:7479] Display 0: 1600x1200x32@60 09:15:39 INFO - 2017-04-27 09:15:39.711 screenresolution[1618:7482] starting screenresolution argv=screenresolution list 09:15:39 INFO - Available Modes on Display 0 09:15:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:15:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:15:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:15:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:15:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:15:39 INFO - Intel Iris: 09:15:39 INFO - Chipset Model: Intel Iris 09:15:39 INFO - Type: GPU 09:15:39 INFO - Bus: Built-In 09:15:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:15:39 INFO - Vendor: Intel (0x8086) 09:15:39 INFO - Device ID: 0x0a2e 09:15:39 INFO - Revision ID: 0x0009 09:15:39 INFO - Displays: 09:15:39 INFO - Display: 09:15:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:15:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:15:39 INFO - Display Serial Number: 1600x1200 60 09:15:39 INFO - Main Display: Yes 09:15:39 INFO - Mirror: Off 09:15:39 INFO - Online: Yes 09:15:39 INFO - Rotation: Supported 09:15:39 INFO - Return code: 0 09:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:39 INFO - Python 2.7.3 09:15:39 INFO - Return code: 0 09:15:39 INFO - grabbing minidump binary from tooltool 09:15:39 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')]} 09:15:39 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 0x10301ad30>, '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 0x102f40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10300fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:39 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 09:15:39 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 09:15:39 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 09:15:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:40 INFO - Return code: 0 09:15:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:15:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:40 INFO - ENV: RUST_BACKTRACE is now 1 09:15:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:15:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0285 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dqt23XVri9/Render', 09:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:40 INFO - 'HOME': '/Users/cltbld', 09:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:40 INFO - 'LOGNAME': 'cltbld', 09:15:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:40 INFO - 'MOZ_NO_REMOTE': '1', 09:15:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:40 INFO - 'NO_EM_RESTART': '1', 09:15:40 INFO - 'PAGER': '/bin/cat', 09:15:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:40 INFO - 'PWD': '/builds/slave/test', 09:15:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:40 INFO - 'RUST_BACKTRACE': '1', 09:15:40 INFO - 'SHELL': '/bin/bash', 09:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SoWOBIABsd/Listeners', 09:15:40 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 09:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:40 INFO - 'USER': 'cltbld', 09:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:40 INFO - 'XPC_FLAGS': '0x0', 09:15:40 INFO - 'XPC_SERVICE_NAME': '0', 09:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:15:40 INFO - mozversion application_buildid: 20170427075325 09:15:40 INFO - mozversion application_changeset: abe5868346c7abb5b0bdf76f29bc3d9f839461f5 09:15:40 INFO - mozversion application_display_name: Nightly 09:15:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:40 INFO - mozversion application_name: Firefox 09:15:40 INFO - mozversion application_remotingname: firefox 09:15:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:15:40 INFO - mozversion application_vendor: Mozilla 09:15:40 INFO - mozversion application_version: 55.0a1 09:15:40 INFO - mozversion platform_buildid: 20170427075325 09:15:40 INFO - mozversion platform_changeset: abe5868346c7abb5b0bdf76f29bc3d9f839461f5 09:15:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:15:40 INFO - mozversion platform_version: 55.0a1 09:15:40 INFO - using testdate: 1493309740 09:15:40 INFO - actual date: 1493309740 09:15:40 INFO - starting webserver on 'localhost:49241' 09:15:40 INFO - SUITE-START | Running 2 tests 09:15:40 INFO - TEST-START | dromaeo_css 09:15:40 INFO - operating with platform_type : mac_ 09:15:40 INFO - Initialising browser for dromaeo_css test... 09:15:40 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp8_c2dM/profile http://localhost:49241/getInfo.html) 09:15:43 INFO - PID 1628 | 2017-04-27 09:15:43.485 plugin-container[1630:7658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 09:15:43 INFO - PID 1628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:43 INFO - PID 1628 | 2017-04-27 09:15:43.488 plugin-container[1630:7658] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c1f, name = 'com.apple.CFPasteboardClient' 09:15:43 INFO - PID 1628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:43 INFO - PID 1628 | 2017-04-27 09:15:43.488 plugin-container[1630:7658] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:15:43 INFO - PID 1628 | __metrics Screen width/height:1600/1200 09:15:43 INFO - PID 1628 | colorDepth:24 09:15:43 INFO - PID 1628 | Browser inner width/height: 1024/689 09:15:43 INFO - PID 1628 | __metrics 09:15:43 ERROR - PID 1628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 09:15:44 INFO - TEST-INFO | 1628: exit 0 09:15:44 INFO - Browser initialized. 09:15:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:44 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp8_c2dM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:46 INFO - PID 1631 | 2017-04-27 09:15:46.958 plugin-container[1632:7797] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 09:15:46 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:46 INFO - PID 1631 | 2017-04-27 09:15:46.959 plugin-container[1632:7797] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 09:15:46 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:15:46 INFO - PID 1631 | 2017-04-27 09:15:46.959 plugin-container[1632:7797] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:15:56 INFO - PID 1631 | RSS: Main: 235536384 09:15:56 INFO - PID 1631 | 09:19:00 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:19:02 INFO - PID 1631 | RSS: Main: 252248064 09:19:02 INFO - PID 1631 | 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 09:20:45 INFO - PID 1631 | 09:20:45 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:20:45 INFO - PID 1631 | Full stack: 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 09:20:45 INFO - PID 1631 | 09:20:45 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:20:45 INFO - PID 1631 | Full stack: 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 09:20:45 INFO - PID 1631 | 09:20:45 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:20:45 INFO - PID 1631 | Full stack: 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | ************************* 09:20:45 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 09:20:45 INFO - PID 1631 | 09:20:45 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:20:45 INFO - PID 1631 | Full stack: 09:20:45 INFO - PID 1631 | ************************* 09:22:04 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:22:04 INFO - PID 1631 | RSS: Main: 256925696 09:22:04 INFO - PID 1631 | 09:25:06 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:25:07 INFO - PID 1631 | RSS: Main: 267653120 09:25:07 INFO - PID 1631 | 09:28:08 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:28:09 INFO - PID 1631 | RSS: Main: 260444160 09:28:09 INFO - PID 1631 | 09:31:12 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:31:12 INFO - PID 1631 | RSS: Main: 272293888 09:31:12 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:34:14 INFO - PID 1631 | RSS: Main: 267071488 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | __start_tp_report 09:34:14 INFO - PID 1631 | _x_x_mozilla_page_load 09:34:14 INFO - PID 1631 | _x_x_mozilla_page_load_details 09:34:14 INFO - PID 1631 | |i|pagename|runs| 09:34:14 INFO - PID 1631 | |0;dojo.html;3567.6432356764326;3578.159132603838;3584.498170256163;3616.4756110363996;3630.5824830144534;5977.252843394575;6156.322804491508;6225.284092329383;6247.156633854428;6248.625082495054;4966.57784088352;6095.105866018741;6101.126216676348;6187.597806142598;6235.033569796688;5385.380681221661;5387.057264978613;5411.891762164774;5470.8085217017415;5556.138798486241;4857.6599638025355;5291.3650361956425;5494.423085576017;5547.140193270049;5568.415316391782;5423.538999185034;5456.945430545723;5490.862728431801;5507.449255074501;5571.247881535981;5249.265102885599;5364.034473794715;5370.140777475624;5478.890422191574;5525.254090697745;5386.91919621206;5405.7567409466665;5420.83737487876;5451.809186678447;5475.917861232085;5146.716930568818;5981.222441082631;6228.4394404503355;6240.375962403768;6258.935980883215;6358.841028974266;6566.441852442548;6570;6580.605163690146;6590.93409065908;6215.56491045627;6511;6570.901436478457;6657.367550082734;6674.16572928384;6308.93691063088;6314.652694101868;6335.334789847092;6346.365363463663;6348.9365106348805;6495.837604059841;6672.733090676318;6829.146356705412;6874.759383421656;6905.75829845953;6289.496840252768;6342.39747224013;6401.07184458251;6456.741730330828;6465.450436712932;6030.849228769316;6250.718717657716;6620.768273110514;6643.40209381158;6669.799906002828;5434.64674796137;5853.5317174625925;6492.935070649328;6508.60948343101;6543.967280163569;5110.514501122388;6265.592736472115;6322.589031712924;6459.354064593503;6471.191101112361;5230.764615592308;5239.476052394806;5243.895122097537;5245.921311180336;5273.34083239595;4590;4701.106789709944;4708.058388322349;4713.9764301178275;4750.311204875343;5385.892282154335;5871.853203669857;6160.168377269011;6275.497960163176;6331.366863313724;6607.041978913031;6639.302873198245;6644.66776661165;6659.700313485905;6684.030815531721;6295.685215739195;6299.118123462719;6312.52656050798;6315.210598675166;6337.556371053982;5788.623739456922;5793.565482588822;5809.186713860063;5814.329412349804;5823.4467725566;6172.043333283438;6527.3472652734345;6544.607323560602;6832.145981752281;6859.725610975505;5746.655200687972;5822.679752613478;6674.16572928384;6721.966390168018;6736.461083113437;6511.902321465087;6559.917613593703;6582;6608.801735947929;6750.35871592198;6572.14562106923;6595.868082638416;6599.505037122139;6624.30444803308;6642.335766423319;5924.822255332347;6375.266844312778;6397.168368112116;6467.579607325509;6722.630255336004;6359.491240700825;6415.454686351713;6446.742130314735;6464.450521705708;6470.255920569195;6499.122618446449;6500.772472963424;6503.414692677682;6511.120998665119;6522.706478208397;6246.531510136667;6372.107904893412;6374.649394283359;6377.87244255103;6388.39310265524;6180.938190618036;6313.747450101944;6392.360763923571;6505.349465053457;6516.804495865132;5794.768209271582;6090.636117690217;6327.746890124527;6351.809445716636;6356.872862542816 09:34:14 INFO - PID 1631 | |1;ext.html;804.3082948664148;820.7619790260823;1124.8425220469135;1130.2314426190192;1236.6104677026742;26847;33843.32313353734;36620.633793662055;36948;36950;36761.448578271345;36938;37142.70000549981;37227.06932326693;37276.69531566396;7693.422993275512;7817.983662123916;7824.413169012319;7838.804029899241;7843.176466471024;8251.834963300731;8421.578921053953;8432.367572432062;8444.662213511452;8454.450460720034;8460.450070745383;8474.491530508158;8489.151084891524;8509.021462531795;8517.53153576553;8434.704785332515;8472;8494.447860889022;8500.532470714108;8501.872471912926;8238.546879921601;8294.58527073644;8301.252887240116;8307.460015098999;8317.251447369705;37440.50237990477;37625;37635.623643763756;37674.86975390743;37928.43107353392;3648.9817550912076;3653.488511608377;3686.5207523022104;3688.207035487383;3691.446283057536;25501.61747573788;30601.846990764905;30612;30683.772649094008;30707.232319191975;3141.827199504049;3183.981126039668;3188.1232661018175;3188.4260833050043;3188.505781603832;291135;293481;293748.53125734447;294311;295687;38687.61312386896;40656.79671601623;48111;48431.757841210565;48448.51551484511;41492.58507414947;41636.79181604073;50039.999200015794;50737;50771;14116.22360770147;14128.929355353363;14213.715725685428;14231.501897433747;14252.429902803979;11249.83125253122;11392;11415.200935934405;11417.771644567229;11422.25755325901;11156.497957591766;12379.257244565355;12432.875671243353;13454.394552245172;13712.45150194001;6016.157737916695;6048;6071.574989750675;6073.969630151821;6080.635161890301;1029.3360782295526;1046.858674079005;1056.1550759392455;1075.3547871277171;1084.3331351218944;23232.65151022736;24001.399965001016;24456.755432445803;24647;24664.890079946446;1019.3425240719695;1073.3452593917705;1110.4780753046055;1124.3984468309416;1174.2719513901436;11233.943830280796;12309.446074926649;12454.377281136089;12473.313967731681;12532.561360352527;324307;326520.5109616788;326601;326786;327069;52853.735731321096;53226.46773532215;53312.46687533153;53400.73299633477;53663.73168134134;1486.420296084528;1537.2697968465113;1538.1617018725046;1538.5999640093655;1560.3446552448;23839.761602383755;23925.282241532783;23965.760342396352;24113.51772964496;24234.87882560576;37911.43132852954;38039;38062.238755224185;38185.23629527338;38311.85064447959;302713.4864325664;303283;303505;304565;305825;33287.33425331528;33617.83191084029;35669.46495802513;36287;36396;43304.54955535452;45130.77434612806;45625.54374456213;45701.62895113152;45744;29031.419371612028;29042.709572904845;30422.847885760428;31174.68825311718;31624.841875791393;30352.848235759564;30974.690253097182;31150.68849311478;31317.53023704601;31375.90184343537;36347.63652363443;37082;37549.555314479796;37756.811215943744;37839.62160378361;24815.50368992574;31055;31646.841765791025;31812.84093579517;31878.36243275075;22757.317280481613;24125.758742412352;24481;24634;24780.876095619406 09:34:14 INFO - PID 1631 | |2;jquery.html;413.3427849718946;434.8440752494748;437.313417933844;449.5414677029429;462.99537004629946;21206.89396553017;21492.785072149254;21981.780182198174;22436.88781556094;22654.773452265472;22747.658785118238;22974.310770676908;23223;23437.531249375003;23526;6195.442410183083;6431.935680643181;6447.613143211399;6449.70976306065;6686.331366863299;6939.27137650547;7036.190838053612;7057.082579264714;7077.36303732664;7084.362407383334;6855.622940738257;7020.648967551628;7028.367446929776;7058.54119482232;7092.751753688622;6891.173059232874;6933.479989000845;7110.680019399114;7190.8561828763395;7201.279872012783;6844.076049733322;6865.382115609619;6874.553154044971;6885.965570172167;6899.137607799025;28482.857585712147;29578.556321655193;29741.256468588243;29894.402111957857;30200.54699179514;2289.290320000805;2360.1031607989025;2365.6451532270125;2371.750966148564;2377.7384487706513;18596.163172657263;18915.81084189168;19236.422907312804;19330.806691933183;19352.32266870653;2114.7250857388594;2124.5113623866596;2283.394900351408;2346.5658853112227;2370.8696021718797;150535;151688;152524.2373788135;153686;153784.231078845;20560.58878822415;23201.53596928052;24365.878170609034;24591.87704061504;24722.50554988926;40731.592684073374;41077;41092.58907410948;41199.38200926989;41432.79283603562;8671.653133874574;8954.597043133075;10210.183185345155;10696.144308455305;10703.464826758787;8371.874421883555;8376.329893608498;8406.915930840736;8564;8566.78583035429;11350.829737553944;11426.428678566204;11454.713632159262;11480.942595287137;11626.186166968231;3806.352920003606;3808.8383043171543;4333.501647310537;4425.5574442556135;4481.260592002348;982.8427451607852;986.4673076538588;992.7666998255404;1009.0918173643779;1020.4999550220339;16365.91817040931;20993.68509472359;21321.933903305082;21405;21418.678719819214;885.7741275974586;943.5376665434026;993.881882881758;1023.9795204095876;1044.5926088825213;10204.23468239885;11059.391733454737;11163.83254251187;11197.608083717194;11237.04485118774;513525;515780;517929;518432;522991;111337;125519;126850;130436.3478182622;131047.37905241842;1215.1736818963013;1238.4303220518661;1259.9227660350452;1264.2477725753163;1264.8039553869164;21712.782872171076;22716.772832271465;23060.308190754306;23088.191913282953;23123.76876231216;45603.315950261436;57307.713461432424;57481.425185747605;58189.4181058184;58552;79181.60409197917;79290;79411;79760;79910.6004469974;8917.910820891708;8946.507942062988;9004.86492702623;9329.626814927327;9518.333716640045;12032.338221397908;14583.562493125222;14662.853371466148;14791.704165916406;15058.623534411727;12126.211796233216;12351.073669474647;12462.127651064338;12521.49914003466;12564.246145231315;9597.712068637951;10977.506012229309;11640.767184656428;11653.30080195191;11840.763184736084;11074.944625276821;12526.311052892179;12639.368031598568;12863.807042894552;12904.612861614167;8834.779130521789;8922.73231803047;9192.483240265281;9334.439933604006;9343.626254949726;11553.884461155281;12058.336791476202;12318.260904345769;12404.689882753004;12447.004239660986 09:34:14 INFO - PID 1631 | |3;mootools.html;1310.200777525709;1468.0457702493377;1484.970300593989;1491.425801066589;1499.4676889704158;11226.270292430987;11343.659690209286;11825.881741182597;11858.169928105037;11929;10162.390256584591;11710.297382157076;11798.87910648487;11824.172307938448;11945.522179112846;2088.154297509507;2330.755270696578;2475.665785119013;2479.9752002480013;2487.502499500098;2468.0868078810777;2526.507331070442;2534;2540.174443305924;2543.1099115309585;2112.302940029794;2526.987365063181;2542.9319685731944;2551.9362015949655;2553.399951011511;2104.2740254612286;2403.351095204294;2415.879206039691;2449.7305296417467;2460.3849037740565;2348.8120950323932;2376.702912135983;2387.0213212582757;2394.5330660521204;2467.481828815951;11921.940390297994;11970.700732481671;11972.521099156023;12004.879951200464;12045.759084818343;6634.966825165891;6851.725930962755;6883.449324054063;6901.654917254117;6929.826754331131;4060.8781736547658;4379.671524635665;4467.664925130595;4473.418455600784;4496.910061798779;1076.1928553584812;1248.9937550312281;1256.1395444120715;1291.7158225190442;1295.1322613848745;16348.264328105264;16570.337186512526;16721.247543860434;16722.581935451588;17010.489685309585;5506.201600767866;5718.571107166896;5816.709164541756;5877.941220587825;5914.408559144137;11784.528618855322;11828.34944078084;11832.526698932119;11839.28964262147;11893.583724569598;6604.042413849965;6634.137562116894;6645.269020407752;6667.866642667216;6676.232233293234;6001.549883758648;6229.283632382243;6267.749290028439;6280.403361680633;6286.842828929313;4278.122984788111;4357.825686972549;4389.692721509464;4397.2085024695225;4398.69209155356;1273.1978853322532;1291.4704970961861;1291.754566632337;1305.301663609983;1305.778017736987;761.919998400171;808.7250334886166;823.8187598728271;830.5099991005336;858.6737039924789;6142.539309551712;6180.66006369645;6363.840903977438;6399.7520483506205;6439.066335381437;588.1031427073661;601.8435206846251;602.8161410769669;605.3432026251567;620.1581303528513;4074.5925407459017;4285.46431696038;4479.484859241229;4506.022654754287;4589.35748995141;14898.702025959421;15034.849651503346;15248.08511489292;15308.234588270765;15360.385584576716;14690.926545367418;15007.774883376758;15236.162011089275;15258.313375898111;15285.770713439086;6207.689615519206;8391.748247552583;8551.700690475804;8640.179182977607;8644.438111522732;6069.878602428015;6199.907001395073;7037.225905150327;7129.750458733919;7332.266773322625;12944.741105178033;12980.8052879205;13001.739965200832;13007.544735934196;13128.60614181576;12528.749425011267;13671.17972921588;13888.305584720925;13949.651258718613;14182.574522764333;9220.492872891788;9513.714588562354;9516.33385662997;9529.475878826732;9550.331476796557;10592.470376481298;10609.416482093558;10714.035736783728;10870.347779133277;10874.510647020745;8879.778005549913;8920.776980575538;8978.910210897808;9001.459912405277;9180.770480738034;7157.24848890859;8815.338849586435;8857.778555536162;8882.467051976902;8971.685990990283;8163.469374490639;8316.334693224406;8329.791755205926;8345.457545259538;8359.874601881098;5259.21111833228;6051.152838602688;6073.240844894388;6184.474319682878;6233.065040244;6148.139260503443;6170.722317495633;6203.100550420074;6289.559730818799;6319.684015799284 09:34:14 INFO - PID 1631 | |4;prototype.html;391.82172111689164;407.830750238651;413.9877998294172;415.7484721743345;417.0636920114343;5829.562782791291;5999.520038396929;6091.482224010964;6280.995040793468;6326.746930122789;5110.667806592569;5654.434556544344;6102.572819902609;6154.630722156674;6166.198394208746;3588.892333229994;4392.736435813854;4474.798634061475;4476.61948734358;4483.30508771141;3694.07648087978;4205.158968206356;4417.690761646686;4440.911181776362;4466.486354069275;4225.323948168294;4371.540988196241;4376.1247750449875;4394.802233899466;4401.933970990438;3895.5714871364125;4356.978215108936;4407.955920440787;4424.712393694415;4432.556744325541;2905.7094290570985;3581.4985901973746;3695.5380577427823;3741.6530049182275;3792.355299599075;5972.372900845436;5976.880462390728;5985.940140598582;5991.490723288525;6016.909746353808;5219.739013049332;5227.660202086852;5233.371995360543;5248.317718696545;5264.052130806722;5313.203019547061;5686.488216060533;6479.49674975892;6502.869942601169;6509.381608747209;4271.497372154834;4272.2950713132295;4275.40144379787;4275.636570891478;4313.82744690212;5030.9245361319245;6027.969860150715;6522.543052182351;6709.798706038827;6923.896141557881;4241.851535196253;4321.632661223768;4329.964916489245;4339.262325404626;4345.435093437833;4389.231884420214;4394.384786129945;4405.118976204708;4409.845655402046;4442.533533978885;4377;5094.286799848024;5245.816396426183;5260.658057226268;5279.894402111936;5822.080342110909;5945.940540594539;6392.849287128269;6568.67156642166;6578.375054369827;1412.7951447040123;1484.3394689363129;1486.8067151270266;1506.6082818467057;1509.5018643847504;798.5847359373093;979.4172467381896;980.5783513089298;984.8276551603441;992.6972273456665;5669;5945.97836735512;6257.812265632038;6269.780557680459;6296.670232014092;6234;6651.401373876374;6735.4274886635185;6843.3840954314355;6881.8967715484305;5696.1455781633085;6207.937920620736;6218.409251121137;6226.6575338355915;6247.781682571946;3146.276356438032;3402.9829850850588;3522.7005704515404;3555.306715190513;3567.8959305403946;5398;6660.267370589231;6972;7018.473614478935;7084.689332473509;6867.725290988305;6977.581345119309;7057.858842823115;7060;7107.005019297302;5909.96575599277;6430.196225471816;6986.7205311787975;7124.180719217253;7125.180604230476;6104.969475152596;6354.90467642995;6709.630970296681;6888.035675005403;6919.965400172967;6591.274959754519;6703.463722902058;6809.421199198124;6822.488313376417;6833;7101.2898710128575;7125.928740712734;7126.501144920013;7159.427245820218;7163.6060016699585;3554.253606742613;3744.4757733916726;3805.543334799842;4254.468191476066;4364.912701745884;5985.521158307412;6043.3352331244405;6812.965935170292;6902.309769023058;6951.826204344932;6442.8389290268115;6590.637514936533;6638;6646.767363142267;6695.296993815774;5889.027175896123;6290.654014029273;6461.289258181502;6513.348665133449;6683.665816709243;6314.652694101868;6511.837204069936;6544.901826472512;6572.4084832365315;6583.317932298625;6469.320721324381;6629.635370054693;6633.767818126343;6637.435817955527;6651.73393064272;5708.857278568069;6455.128557644845;6493.448056915026;6502.902456463063;6533.836654083496 09:34:14 INFO - PID 1631 | |5;yui.html;770.5607803551976;830.6428235858579;843.713137533239;849.2484151525899;863;16476.91761541192;16542.17289135543;16912.238949247283;18264.908675456638;19273.518162045955;17624.82375176248;17803.821961780377;17937.820621793777;18198.454046378596;18267.90392576446;988.1748739802256;1005.3214080495673;1006.783541538569;1007.702727695328;1010.4493051287067;972.3776782858976;977.4282045003681;996.3822430093317;1000.3197825478671;1018.1345856022396;1049.1606714628306;1070.2133931560297;1072.5816931396762;1076.3488089705734;1081.1783044885865;1026.7279171019686;1065.9680209593687;1068.0174239699495;1068.8450174724699;1071.6570697376842;753.7776355975001;776.1384862802284;790.1505881177757;796.9442139050269;798.5647821937058;16635.584110397336;16881.493555193363;17004;17056.65886682272;17326.306947722074;17418.564535886577;17453.389131380467;17513;17598.94406335624;17631.471055868344;13758.105723128065;14008.089474184146;14035.368408421646;14225.004249702524;14301.213433261166;3470.9652903470896;3482.4776283557417;3494.336076145524;3495.056334789618;3498.282852015356;127983.8806447741;128958;129792;131105.34447327798;131217.99999999904;11128.777424451628;13225.73548529024;13239.66900827487;13279.601611951657;13414.396352164176;22180.890955452163;23490.412739681644;24204.394890127536;24300.756992430204;24823.13119040825;7678.193789652118;7903;7914.722984695508;7915.208479152154;7923.920760792434;3692.0585250760882;3737.9626203737616;3747.7938713371027;3772.4529943158086;3778.301014312361;4237.343211802176;4333.306670932699;4395.186890425218;4396.560343965578;4404.7357158570585;930.6463543853292;959.9424034557809;968.7626531499686;972.4165500699523;977.2914636888199;617.1914791622988;646.4375992886219;663.9502037347219;677.989830152548;693.0989713372595;11257.380844053492;11681.591144310078;12116.27302361861;12170.269783812822;12260.386980650932;660.7720336483906;662.4634046422414;666.1606375966318;676.6988690032987;694.3820000199826;5401.1358182691365;5418.485243901823;5528.253685752372;5537.141743029837;5648.71756412186;100324.49837750911;104709;104726;105892;106691.46654266679;93603;93922.06077939134;94150;94188.52905735564;95423;82901.58549207215;83585;84229;85696.57151714202;85833;10808.45957702096;11240.9321114494;11265.831012534982;11428.085753139896;11628.592999244986;40203.3969490452;40700.59299406968;40843.52830009364;41256.79371603123;42251.36622950597;67568;71522.56954860978;73115.63442182755;73160.63419682867;74141;14188.006839521135;16260.430884918971;16789.580260493585;16908.32366705318;17097.145142742564;17885.910570447584;17929.641407172043;18387.816121838612;18709;18740.906295468434;16384.590385240463;17172.570685732957;17221.56946076358;17244.051577163376;17499.56251093733;16735.74896376531;16736.581585460463;17140.40008599693;17166.39917602878;17295.30818767235;15880.682386352439;16259.51221463358;16794.160291985598;16806.075665838496;16830.326786928876;10973.23187376876;10998.670039898816;11065.114790816877;11545.942270288595;12067.698307542381;11592.594259200887;12306;13229.404676789374;13251.469941202244;13830 09:34:14 INFO - PID 1631 | __end_tp_report 09:34:14 INFO - PID 1631 | __start_cc_report 09:34:14 INFO - PID 1631 | _x_x_mozilla_cycle_collect,423 09:34:14 INFO - PID 1631 | __end_cc_report 09:34:14 INFO - PID 1631 | __startTimestamp1493310854831__endTimestamp 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | ------- Summary: start ------- 09:34:14 INFO - PID 1631 | Number of tests: 6 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:6033.86 Median:6308.94 stddev:690.64 (10.9%) stddev-sans-first:665.11 09:34:14 INFO - PID 1631 | Values: 3567.6 3578.2 3584.5 3616.5 3630.6 5977.3 6156.3 6225.3 6247.2 6248.6 4966.6 6095.1 6101.1 6187.6 6235.0 5385.4 5387.1 5411.9 5470.8 5556.1 4857.7 5291.4 5494.4 5547.1 5568.4 5423.5 5456.9 5490.9 5507.4 5571.2 5249.3 5364.0 5370.1 5478.9 5525.3 5386.9 5405.8 5420.8 5451.8 5475.9 5146.7 5981.2 6228.4 6240.4 6258.9 6358.8 6566.4 6570.0 6580.6 6590.9 6215.6 6511.0 6570.9 6657.4 6674.2 6308.9 6314.7 6335.3 6346.4 6348.9 6495.8 6672.7 6829.1 6874.8 6905.8 6289.5 6342.4 6401.1 6456.7 6465.5 6030.8 6250.7 6620.8 6643.4 6669.8 5434.6 5853.5 6492.9 6508.6 6544.0 5110.5 6265.6 6322.6 6459.4 6471.2 5230.8 5239.5 5243.9 5245.9 5273.3 4590.0 4701.1 4708.1 4714.0 4750.3 5385.9 5871.9 6160.2 6275.5 6331.4 6607.0 6639.3 6644.7 6659.7 6684.0 6295.7 6299.1 6312.5 6315.2 6337.6 5788.6 5793.6 5809.2 5814.3 5823.4 6172.0 6527.3 6544.6 6832.1 6859.7 5746.7 5822.7 6674.2 6722.0 6736.5 6511.9 6559.9 6582.0 6608.8 6750.4 6572.1 6595.9 6599.5 6624.3 6642.3 5924.8 6375.3 6397.2 6467.6 6722.6 6359.5 6415.5 6446.7 6464.5 6470.3 6499.1 6500.8 6503.4 6511.1 6522.7 6246.5 6372.1 6374.6 6377.9 6388.4 6180.9 6313.7 6392.4 6505.3 6516.8 5794.8 6090.6 6327.7 6351.8 6356.9 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:45459.98 Median:326560.76 stddev:80909.78 (24.8%) stddev-sans-first:81067.28 09:34:14 INFO - PID 1631 | Values: 804.3 820.8 1124.8 1130.2 1236.6 26847.0 33843.3 36620.6 36948.0 36950.0 36761.4 36938.0 37142.7 37227.1 37276.7 7693.4 7818.0 7824.4 7838.8 7843.2 8251.8 8421.6 8432.4 8444.7 8454.5 8460.5 8474.5 8489.2 8509.0 8517.5 8434.7 8472.0 8494.4 8500.5 8501.9 8238.5 8294.6 8301.3 8307.5 8317.3 37440.5 37625.0 37635.6 37674.9 37928.4 3649.0 3653.5 3686.5 3688.2 3691.4 25501.6 30601.8 30612.0 30683.8 30707.2 3141.8 3184.0 3188.1 3188.4 3188.5 291135.0 293481.0 293748.5 294311.0 295687.0 38687.6 40656.8 48111.0 48431.8 48448.5 41492.6 41636.8 50040.0 50737.0 50771.0 14116.2 14128.9 14213.7 14231.5 14252.4 11249.8 11392.0 11415.2 11417.8 11422.3 11156.5 12379.3 12432.9 13454.4 13712.5 6016.2 6048.0 6071.6 6074.0 6080.6 1029.3 1046.9 1056.2 1075.4 1084.3 23232.7 24001.4 24456.8 24647.0 24664.9 1019.3 1073.3 1110.5 1124.4 1174.3 11233.9 12309.4 12454.4 12473.3 12532.6 324307.0 326520.5 326601.0 326786.0 327069.0 52853.7 53226.5 53312.5 53400.7 53663.7 1486.4 1537.3 1538.2 1538.6 1560.3 23839.8 23925.3 23965.8 24113.5 24234.9 37911.4 38039.0 38062.2 38185.2 38311.9 302713.5 303283.0 303505.0 304565.0 305825.0 33287.3 33617.8 35669.5 36287.0 36396.0 43304.5 45130.8 45625.5 45701.6 45744.0 29031.4 29042.7 30422.8 31174.7 31624.8 30352.8 30974.7 31150.7 31317.5 31375.9 36347.6 37082.0 37549.6 37756.8 37839.6 24815.5 31055.0 31646.8 31812.8 31878.4 22757.3 24125.8 24481.0 24634.0 24780.9 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:36105.62 Median:2371.31 stddev:87891.06 (3706.4%) stddev-sans-first:88096.76 09:34:14 INFO - PID 1631 | Values: 413.3 434.8 437.3 449.5 463.0 21206.9 21492.8 21981.8 22436.9 22654.8 22747.7 22974.3 23223.0 23437.5 23526.0 6195.4 6431.9 6447.6 6449.7 6686.3 6939.3 7036.2 7057.1 7077.4 7084.4 6855.6 7020.6 7028.4 7058.5 7092.8 6891.2 6933.5 7110.7 7190.9 7201.3 6844.1 6865.4 6874.6 6886.0 6899.1 28482.9 29578.6 29741.3 29894.4 30200.5 2289.3 2360.1 2365.6 2371.8 2377.7 18596.2 18915.8 19236.4 19330.8 19352.3 2114.7 2124.5 2283.4 2346.6 2370.9 150535.0 151688.0 152524.2 153686.0 153784.2 20560.6 23201.5 24365.9 24591.9 24722.5 40731.6 41077.0 41092.6 41199.4 41432.8 8671.7 8954.6 10210.2 10696.1 10703.5 8371.9 8376.3 8406.9 8564.0 8566.8 11350.8 11426.4 11454.7 11480.9 11626.2 3806.4 3808.8 4333.5 4425.6 4481.3 982.8 986.5 992.8 1009.1 1020.5 16365.9 20993.7 21321.9 21405.0 21418.7 885.8 943.5 993.9 1024.0 1044.6 10204.2 11059.4 11163.8 11197.6 11237.0 513525.0 515780.0 517929.0 518432.0 522991.0 111337.0 125519.0 126850.0 130436.3 131047.4 1215.2 1238.4 1259.9 1264.2 1264.8 21712.8 22716.8 23060.3 23088.2 23123.8 45603.3 57307.7 57481.4 58189.4 58552.0 79181.6 79290.0 79411.0 79760.0 79910.6 8917.9 8946.5 9004.9 9329.6 9518.3 12032.3 14583.6 14662.9 14791.7 15058.6 12126.2 12351.1 12462.1 12521.5 12564.2 9597.7 10977.5 11640.8 11653.3 11840.8 11074.9 12526.3 12639.4 12863.8 12904.6 8834.8 8922.7 9192.5 9334.4 9343.6 11553.9 12058.3 12318.3 12404.7 12447.0 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:7111.36 Median:4067.74 stddev:4526.60 (111.3%) stddev-sans-first:4518.31 09:34:14 INFO - PID 1631 | Values: 1310.2 1468.0 1485.0 1491.4 1499.5 11226.3 11343.7 11825.9 11858.2 11929.0 10162.4 11710.3 11798.9 11824.2 11945.5 2088.2 2330.8 2475.7 2480.0 2487.5 2468.1 2526.5 2534.0 2540.2 2543.1 2112.3 2527.0 2542.9 2551.9 2553.4 2104.3 2403.4 2415.9 2449.7 2460.4 2348.8 2376.7 2387.0 2394.5 2467.5 11921.9 11970.7 11972.5 12004.9 12045.8 6635.0 6851.7 6883.4 6901.7 6929.8 4060.9 4379.7 4467.7 4473.4 4496.9 1076.2 1249.0 1256.1 1291.7 1295.1 16348.3 16570.3 16721.2 16722.6 17010.5 5506.2 5718.6 5816.7 5877.9 5914.4 11784.5 11828.3 11832.5 11839.3 11893.6 6604.0 6634.1 6645.3 6667.9 6676.2 6001.5 6229.3 6267.7 6280.4 6286.8 4278.1 4357.8 4389.7 4397.2 4398.7 1273.2 1291.5 1291.8 1305.3 1305.8 761.9 808.7 823.8 830.5 858.7 6142.5 6180.7 6363.8 6399.8 6439.1 588.1 601.8 602.8 605.3 620.2 4074.6 4285.5 4479.5 4506.0 4589.4 14898.7 15034.8 15248.1 15308.2 15360.4 14690.9 15007.8 15236.2 15258.3 15285.8 6207.7 8391.7 8551.7 8640.2 8644.4 6069.9 6199.9 7037.2 7129.8 7332.3 12944.7 12980.8 13001.7 13007.5 13128.6 12528.7 13671.2 13888.3 13949.7 14182.6 9220.5 9513.7 9516.3 9529.5 9550.3 10592.5 10609.4 10714.0 10870.3 10874.5 8879.8 8920.8 8978.9 9001.5 9180.8 7157.2 8815.3 8857.8 8882.5 8971.7 8163.5 8316.3 8329.8 8345.5 8359.9 5259.2 6051.2 6073.2 6184.5 6233.1 6148.1 6170.7 6203.1 6289.6 6319.7 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:5262.59 Median:6008.21 stddev:1713.32 (28.5%) stddev-sans-first:1678.66 09:34:14 INFO - PID 1631 | Values: 391.8 407.8 414.0 415.7 417.1 5829.6 5999.5 6091.5 6281.0 6326.7 5110.7 5654.4 6102.6 6154.6 6166.2 3588.9 4392.7 4474.8 4476.6 4483.3 3694.1 4205.2 4417.7 4440.9 4466.5 4225.3 4371.5 4376.1 4394.8 4401.9 3895.6 4357.0 4408.0 4424.7 4432.6 2905.7 3581.5 3695.5 3741.7 3792.4 5972.4 5976.9 5985.9 5991.5 6016.9 5219.7 5227.7 5233.4 5248.3 5264.1 5313.2 5686.5 6479.5 6502.9 6509.4 4271.5 4272.3 4275.4 4275.6 4313.8 5030.9 6028.0 6522.5 6709.8 6923.9 4241.9 4321.6 4330.0 4339.3 4345.4 4389.2 4394.4 4405.1 4409.8 4442.5 4377.0 5094.3 5245.8 5260.7 5279.9 5822.1 5945.9 6392.8 6568.7 6578.4 1412.8 1484.3 1486.8 1506.6 1509.5 798.6 979.4 980.6 984.8 992.7 5669.0 5946.0 6257.8 6269.8 6296.7 6234.0 6651.4 6735.4 6843.4 6881.9 5696.1 6207.9 6218.4 6226.7 6247.8 3146.3 3403.0 3522.7 3555.3 3567.9 5398.0 6660.3 6972.0 7018.5 7084.7 6867.7 6977.6 7057.9 7060.0 7107.0 5910.0 6430.2 6986.7 7124.2 7125.2 6105.0 6354.9 6709.6 6888.0 6920.0 6591.3 6703.5 6809.4 6822.5 6833.0 7101.3 7125.9 7126.5 7159.4 7163.6 3554.3 3744.5 3805.5 4254.5 4364.9 5985.5 6043.3 6813.0 6902.3 6951.8 6442.8 6590.6 6638.0 6646.8 6695.3 5889.0 6290.7 6461.3 6513.3 6683.7 6314.7 6511.8 6544.9 6572.4 6583.3 6469.3 6629.6 6633.8 6637.4 6651.7 5708.9 6455.1 6493.4 6502.9 6533.8 09:34:14 INFO - PID 1631 | 09:34:14 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:22560.53 Median:17844.87 stddev:31994.92 (179.3%) stddev-sans-first:32042.84 09:34:14 INFO - PID 1631 | Values: 770.6 830.6 843.7 849.2 863.0 16476.9 16542.2 16912.2 18264.9 19273.5 17624.8 17803.8 17937.8 18198.5 18267.9 988.2 1005.3 1006.8 1007.7 1010.4 972.4 977.4 996.4 1000.3 1018.1 1049.2 1070.2 1072.6 1076.3 1081.2 1026.7 1066.0 1068.0 1068.8 1071.7 753.8 776.1 790.2 796.9 798.6 16635.6 16881.5 17004.0 17056.7 17326.3 17418.6 17453.4 17513.0 17598.9 17631.5 13758.1 14008.1 14035.4 14225.0 14301.2 3471.0 3482.5 3494.3 3495.1 3498.3 127983.9 128958.0 129792.0 131105.3 131218.0 11128.8 13225.7 13239.7 13279.6 13414.4 22180.9 23490.4 24204.4 24300.8 24823.1 7678.2 7903.0 7914.7 7915.2 7923.9 3692.1 3738.0 3747.8 3772.5 3778.3 4237.3 4333.3 4395.2 4396.6 4404.7 930.6 959.9 968.8 972.4 977.3 617.2 646.4 664.0 678.0 693.1 11257.4 11681.6 12116.3 12170.3 12260.4 660.8 662.5 666.2 676.7 694.4 5401.1 5418.5 5528.3 5537.1 5648.7 100324.5 104709.0 104726.0 105892.0 106691.5 93603.0 93922.1 94150.0 94188.5 95423.0 82901.6 83585.0 84229.0 85696.6 85833.0 10808.5 11240.9 11265.8 11428.1 11628.6 40203.4 40700.6 40843.5 41256.8 42251.4 67568.0 71522.6 73115.6 73160.6 74141.0 14188.0 16260.4 16789.6 16908.3 17097.1 17885.9 17929.6 18387.8 18709.0 18740.9 16384.6 17172.6 17221.6 17244.1 17499.6 16735.7 16736.6 17140.4 17166.4 17295.3 15880.7 16259.5 16794.2 16806.1 16830.3 10973.2 10998.7 11065.1 11545.9 12067.7 11592.6 12306.0 13229.4 13251.5 13830.0 09:34:14 INFO - PID 1631 | -------- Summary: end -------- 09:34:14 INFO - PID 1631 | 09:34:15 INFO - TEST-INFO | 1631: exit 0 09:34:15 INFO - TEST-OK | dromaeo_css | took 1115155ms 09:34:15 INFO - TEST-START | kraken 09:34:15 INFO - operating with platform_type : mac_ 09:34:15 INFO - Initialising browser for kraken test... 09:34:15 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpWl0tpG/profile http://localhost:49241/getInfo.html) 09:34:18 INFO - PID 1643 | 2017-04-27 09:34:18.129 plugin-container[1644:10238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9233, name = 'com.apple.tsm.portname' 09:34:18 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:18 INFO - PID 1643 | 2017-04-27 09:34:18.131 plugin-container[1644:10238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 09:34:18 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:18 INFO - PID 1643 | 2017-04-27 09:34:18.131 plugin-container[1644:10238] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:34:18 INFO - PID 1643 | __metrics Screen width/height:1600/1200 09:34:18 INFO - PID 1643 | colorDepth:24 09:34:18 INFO - PID 1643 | Browser inner width/height: 1024/689 09:34:18 INFO - PID 1643 | __metrics 09:34:18 ERROR - PID 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 09:34:19 INFO - TEST-INFO | 1643: exit 0 09:34:19 INFO - Browser initialized. 09:34:19 INFO - Running cycle 1/1 for kraken test... 09:34:19 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpWl0tpG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:21 INFO - PID 1645 | 2017-04-27 09:34:21.621 plugin-container[1646:10370] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 09:34:21 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:21 INFO - PID 1645 | 2017-04-27 09:34:21.622 plugin-container[1646:10370] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.CFPasteboardClient' 09:34:21 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:21 INFO - PID 1645 | 2017-04-27 09:34:21.622 plugin-container[1646:10370] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:34:31 INFO - PID 1645 | RSS: Main: 236371968 09:34:31 INFO - PID 1645 | 09:34:34 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:35 INFO - PID 1645 | RSS: Main: 248336384 09:34:35 INFO - PID 1645 | 09:34:37 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:34:38 INFO - PID 1645 | RSS: Main: 256737280 09:34:38 INFO - PID 1645 | 09:34:41 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:34:42 INFO - PID 1645 | RSS: Main: 259096576 09:34:42 INFO - PID 1645 | 09:34:44 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:34:44 INFO - PID 1645 | RSS: Main: 261238784 09:34:44 INFO - PID 1645 | 09:34:46 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:47 INFO - PID 1645 | RSS: Main: 262086656 09:34:47 INFO - PID 1645 | 09:34:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:50 INFO - PID 1645 | RSS: Main: 267616256 09:34:50 INFO - PID 1645 | 09:34:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:54 INFO - PID 1645 | RSS: Main: 269131776 09:34:54 INFO - PID 1645 | 09:34:57 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:34:58 INFO - PID 1645 | RSS: Main: 268324864 09:34:58 INFO - PID 1645 | 09:34:59 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:00 INFO - PID 1645 | RSS: Main: 268378112 09:35:00 INFO - PID 1645 | 09:35:02 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:02 INFO - PID 1645 | RSS: Main: 268103680 09:35:02 INFO - PID 1645 | 09:35:05 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:05 INFO - PID 1645 | RSS: Main: 267644928 09:35:05 INFO - PID 1645 | 09:35:08 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:09 INFO - PID 1645 | RSS: Main: 267698176 09:35:09 INFO - PID 1645 | 09:35:12 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:13 INFO - PID 1645 | RSS: Main: 268218368 09:35:13 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:35:15 INFO - PID 1645 | RSS: Main: 269688832 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | __start_tp_report 09:35:15 INFO - PID 1645 | _x_x_mozilla_page_load 09:35:15 INFO - PID 1645 | _x_x_mozilla_page_load_details 09:35:15 INFO - PID 1645 | |i|pagename|runs| 09:35:15 INFO - PID 1645 | |0;ai-astar;104;115;116;114;113;116;114;114;117;114 09:35:15 INFO - PID 1645 | |1;audio-beat-detection;143;111;108;146;147;147;141;110;148;142 09:35:15 INFO - PID 1645 | |2;audio-dft;201;200;200;218;220;210;208;208;204;201 09:35:15 INFO - PID 1645 | |3;audio-fft;75;58;60;83;55;58;56;57;77;58 09:35:15 INFO - PID 1645 | |4;audio-oscillator;83;70;84;71;70;71;88;69;69;95 09:35:15 INFO - PID 1645 | |5;imaging-gaussian-blur;89;90;89;88;90;88;89;89;89;101 09:35:15 INFO - PID 1645 | |6;imaging-darkroom;105;149;97;96;97;97;97;96;97;96 09:35:15 INFO - PID 1645 | |7;imaging-desaturate;90;107;141;89;133;99;89;98;92;91 09:35:15 INFO - PID 1645 | |8;json-parse-financial;50;47;49;49;51;49;50;50;53;51 09:35:15 INFO - PID 1645 | |9;json-stringify-tinderbox;57;63;60;85;72;60;61;56;56;60 09:35:15 INFO - PID 1645 | |10;stanford-crypto-aes;83;83;80;82;81;82;83;92;106;85 09:35:15 INFO - PID 1645 | |11;stanford-crypto-ccm;139;137;132;141;162;147;147;147;204;140 09:35:15 INFO - PID 1645 | |12;stanford-crypto-pbkdf2;178;221;184;234;229;185;187;182;214;236 09:35:15 INFO - PID 1645 | |13;stanford-crypto-sha256-iterative;70;72;87;91;94;68;61;93;89;98 09:35:15 INFO - PID 1645 | __end_tp_report 09:35:15 INFO - PID 1645 | __start_cc_report 09:35:15 INFO - PID 1645 | _x_x_mozilla_cycle_collect,1017 09:35:15 INFO - PID 1645 | __end_cc_report 09:35:15 INFO - PID 1645 | __startTimestamp1493310915362__endTimestamp 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | ------- Summary: start ------- 09:35:15 INFO - PID 1645 | Number of tests: 14 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:3.62 (3.2%) stddev-sans-first:1.30 09:35:15 INFO - PID 1645 | Values: 104.0 115.0 116.0 114.0 113.0 116.0 114.0 114.0 117.0 114.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:144.50 stddev:17.17 (11.9%) stddev-sans-first:17.92 09:35:15 INFO - PID 1645 | Values: 143.0 111.0 108.0 146.0 147.0 147.0 141.0 110.0 148.0 142.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#2] audio-dft Cycles:10 Average:207.00 Median:208.00 stddev:7.30 (3.5%) stddev-sans-first:7.42 09:35:15 INFO - PID 1645 | Values: 201.0 200.0 200.0 218.0 220.0 210.0 208.0 208.0 204.0 201.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#3] audio-fft Cycles:10 Average:63.70 Median:59.00 stddev:10.37 (17.6%) stddev-sans-first:10.16 09:35:15 INFO - PID 1645 | Values: 75.0 58.0 60.0 83.0 55.0 58.0 56.0 57.0 77.0 58.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:9.59 (12.5%) stddev-sans-first:9.92 09:35:15 INFO - PID 1645 | Values: 83.0 70.0 84.0 71.0 70.0 71.0 88.0 69.0 69.0 95.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:89.00 stddev:3.85 (4.3%) stddev-sans-first:4.06 09:35:15 INFO - PID 1645 | Values: 89.0 90.0 89.0 88.0 90.0 88.0 89.0 89.0 89.0 101.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#6] imaging-darkroom Cycles:10 Average:102.70 Median:97.00 stddev:16.49 (17.0%) stddev-sans-first:17.47 09:35:15 INFO - PID 1645 | Values: 105.0 149.0 97.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:90.50 stddev:18.94 (20.9%) stddev-sans-first:19.50 09:35:15 INFO - PID 1645 | Values: 90.0 107.0 141.0 89.0 133.0 99.0 89.0 98.0 92.0 91.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:1.60 (3.2%) stddev-sans-first:1.69 09:35:15 INFO - PID 1645 | Values: 50.0 47.0 49.0 49.0 51.0 49.0 50.0 50.0 53.0 51.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:60.50 stddev:9.01 (14.9%) stddev-sans-first:9.29 09:35:15 INFO - PID 1645 | Values: 57.0 63.0 60.0 85.0 72.0 60.0 61.0 56.0 56.0 60.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:83.00 stddev:7.86 (9.5%) stddev-sans-first:8.28 09:35:15 INFO - PID 1645 | Values: 83.0 83.0 80.0 82.0 81.0 82.0 83.0 92.0 106.0 85.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:147.00 stddev:20.76 (14.1%) stddev-sans-first:21.67 09:35:15 INFO - PID 1645 | Values: 139.0 137.0 132.0 141.0 162.0 147.0 147.0 147.0 204.0 140.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.00 Median:217.50 stddev:23.89 (11.0%) stddev-sans-first:23.26 09:35:15 INFO - PID 1645 | Values: 178.0 221.0 184.0 234.0 229.0 185.0 187.0 182.0 214.0 236.0 09:35:15 INFO - PID 1645 | 09:35:15 INFO - PID 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.30 Median:90.00 stddev:13.15 (14.6%) stddev-sans-first:13.17 09:35:15 INFO - PID 1645 | Values: 70.0 72.0 87.0 91.0 94.0 68.0 61.0 93.0 89.0 98.0 09:35:15 INFO - PID 1645 | -------- Summary: end -------- 09:35:15 INFO - PID 1645 | 09:35:16 INFO - TEST-INFO | 1645: exit 0 09:35:16 INFO - TEST-OK | kraken | took 61011ms 09:35:16 INFO - SUITE-END | took 1176s 09:35:16 INFO - Completed test suite (00:19:36) 09:35:16 INFO - javascript benchmark 09:35:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7994.671657804949, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3567.6432356764326, 3578.159132603838, 3584.498170256163, 3616.4756110363996, 3630.5824830144534, 5977.252843394575, 6156.322804491508, 6225.284092329383, 6247.156633854428, 6248.625082495054, 4966.57784088352, 6095.105866018741, 6101.126216676348, 6187.597806142598, 6235.033569796688, 5385.380681221661, 5387.057264978613, 5411.891762164774, 5470.8085217017415, 5556.138798486241, 4857.6599638025355, 5291.3650361956425, 5494.423085576017, 5547.140193270049, 5568.415316391782, 5423.538999185034, 5456.945430545723, 5490.862728431801, 5507.449255074501, 5571.247881535981, 5249.265102885599, 5364.034473794715, 5370.140777475624, 5478.890422191574, 5525.254090697745, 5386.91919621206, 5405.7567409466665, 5420.83737487876, 5451.809186678447, 5475.917861232085, 5146.716930568818, 5981.222441082631, 6228.4394404503355, 6240.375962403768, 6258.935980883215, 6358.841028974266, 6566.441852442548, 6570.0, 6580.605163690146, 6590.93409065908, 6215.56491045627, 6511.0, 6570.901436478457, 6657.367550082734, 6674.16572928384, 6308.93691063088, 6314.652694101868, 6335.334789847092, 6346.365363463663, 6348.9365106348805, 6495.837604059841, 6672.733090676318, 6829.146356705412, 6874.759383421656, 6905.75829845953, 6289.496840252768, 6342.39747224013, 6401.07184458251, 6456.741730330828, 6465.450436712932, 6030.849228769316, 6250.718717657716, 6620.768273110514, 6643.40209381158, 6669.799906002828, 5434.64674796137, 5853.5317174625925, 6492.935070649328, 6508.60948343101, 6543.967280163569, 5110.514501122388, 6265.592736472115, 6322.589031712924, 6459.354064593503, 6471.191101112361, 5230.764615592308, 5239.476052394806, 5243.895122097537, 5245.921311180336, 5273.34083239595, 4590.0, 4701.106789709944, 4708.058388322349, 4713.9764301178275, 4750.311204875343, 5385.892282154335, 5871.853203669857, 6160.168377269011, 6275.497960163176, 6331.366863313724, 6607.041978913031, 6639.302873198245, 6644.66776661165, 6659.700313485905, 6684.030815531721, 6295.685215739195, 6299.118123462719, 6312.52656050798, 6315.210598675166, 6337.556371053982, 5788.623739456922, 5793.565482588822, 5809.186713860063, 5814.329412349804, 5823.4467725566, 6172.043333283438, 6527.3472652734345, 6544.607323560602, 6832.145981752281, 6859.725610975505, 5746.655200687972, 5822.679752613478, 6674.16572928384, 6721.966390168018, 6736.461083113437, 6511.902321465087, 6559.917613593703, 6582.0, 6608.801735947929, 6750.35871592198, 6572.14562106923, 6595.868082638416, 6599.505037122139, 6624.30444803308, 6642.335766423319, 5924.822255332347, 6375.266844312778, 6397.168368112116, 6467.579607325509, 6722.630255336004, 6359.491240700825, 6415.454686351713, 6446.742130314735, 6464.450521705708, 6470.255920569195, 6499.122618446449, 6500.772472963424, 6503.414692677682, 6511.120998665119, 6522.706478208397, 6246.531510136667, 6372.107904893412, 6374.649394283359, 6377.87244255103, 6388.39310265524, 6180.938190618036, 6313.747450101944, 6392.360763923571, 6505.349465053457, 6516.804495865132, 5794.768209271582, 6090.636117690217, 6327.746890124527, 6351.809445716636, 6356.872862542816], "value": 5992.172034696078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.3082948664148, 820.7619790260823, 1124.8425220469135, 1130.2314426190192, 1236.6104677026742, 26847.0, 33843.32313353734, 36620.633793662055, 36948.0, 36950.0, 36761.448578271345, 36938.0, 37142.70000549981, 37227.06932326693, 37276.69531566396, 7693.422993275512, 7817.983662123916, 7824.413169012319, 7838.804029899241, 7843.176466471024, 8251.834963300731, 8421.578921053953, 8432.367572432062, 8444.662213511452, 8454.450460720034, 8460.450070745383, 8474.491530508158, 8489.151084891524, 8509.021462531795, 8517.53153576553, 8434.704785332515, 8472.0, 8494.447860889022, 8500.532470714108, 8501.872471912926, 8238.546879921601, 8294.58527073644, 8301.252887240116, 8307.460015098999, 8317.251447369705, 37440.50237990477, 37625.0, 37635.623643763756, 37674.86975390743, 37928.43107353392, 3648.9817550912076, 3653.488511608377, 3686.5207523022104, 3688.207035487383, 3691.446283057536, 25501.61747573788, 30601.846990764905, 30612.0, 30683.772649094008, 30707.232319191975, 3141.827199504049, 3183.981126039668, 3188.1232661018175, 3188.4260833050043, 3188.505781603832, 291135.0, 293481.0, 293748.53125734447, 294311.0, 295687.0, 38687.61312386896, 40656.79671601623, 48111.0, 48431.757841210565, 48448.51551484511, 41492.58507414947, 41636.79181604073, 50039.999200015794, 50737.0, 50771.0, 14116.22360770147, 14128.929355353363, 14213.715725685428, 14231.501897433747, 14252.429902803979, 11249.83125253122, 11392.0, 11415.200935934405, 11417.771644567229, 11422.25755325901, 11156.497957591766, 12379.257244565355, 12432.875671243353, 13454.394552245172, 13712.45150194001, 6016.157737916695, 6048.0, 6071.574989750675, 6073.969630151821, 6080.635161890301, 1029.3360782295526, 1046.858674079005, 1056.1550759392455, 1075.3547871277171, 1084.3331351218944, 23232.65151022736, 24001.399965001016, 24456.755432445803, 24647.0, 24664.890079946446, 1019.3425240719695, 1073.3452593917705, 1110.4780753046055, 1124.3984468309416, 1174.2719513901436, 11233.943830280796, 12309.446074926649, 12454.377281136089, 12473.313967731681, 12532.561360352527, 324307.0, 326520.5109616788, 326601.0, 326786.0, 327069.0, 52853.735731321096, 53226.46773532215, 53312.46687533153, 53400.73299633477, 53663.73168134134, 1486.420296084528, 1537.2697968465113, 1538.1617018725046, 1538.5999640093655, 1560.3446552448, 23839.761602383755, 23925.282241532783, 23965.760342396352, 24113.51772964496, 24234.87882560576, 37911.43132852954, 38039.0, 38062.238755224185, 38185.23629527338, 38311.85064447959, 302713.4864325664, 303283.0, 303505.0, 304565.0, 305825.0, 33287.33425331528, 33617.83191084029, 35669.46495802513, 36287.0, 36396.0, 43304.54955535452, 45130.77434612806, 45625.54374456213, 45701.62895113152, 45744.0, 29031.419371612028, 29042.709572904845, 30422.847885760428, 31174.68825311718, 31624.841875791393, 30352.848235759564, 30974.690253097182, 31150.68849311478, 31317.53023704601, 31375.90184343537, 36347.63652363443, 37082.0, 37549.555314479796, 37756.811215943744, 37839.62160378361, 24815.50368992574, 31055.0, 31646.841765791025, 31812.84093579517, 31878.36243275075, 22757.317280481613, 24125.758742412352, 24481.0, 24634.0, 24780.876095619406], "value": 17465.892775703713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.3427849718946, 434.8440752494748, 437.313417933844, 449.5414677029429, 462.99537004629946, 21206.89396553017, 21492.785072149254, 21981.780182198174, 22436.88781556094, 22654.773452265472, 22747.658785118238, 22974.310770676908, 23223.0, 23437.531249375003, 23526.0, 6195.442410183083, 6431.935680643181, 6447.613143211399, 6449.70976306065, 6686.331366863299, 6939.27137650547, 7036.190838053612, 7057.082579264714, 7077.36303732664, 7084.362407383334, 6855.622940738257, 7020.648967551628, 7028.367446929776, 7058.54119482232, 7092.751753688622, 6891.173059232874, 6933.479989000845, 7110.680019399114, 7190.8561828763395, 7201.279872012783, 6844.076049733322, 6865.382115609619, 6874.553154044971, 6885.965570172167, 6899.137607799025, 28482.857585712147, 29578.556321655193, 29741.256468588243, 29894.402111957857, 30200.54699179514, 2289.290320000805, 2360.1031607989025, 2365.6451532270125, 2371.750966148564, 2377.7384487706513, 18596.163172657263, 18915.81084189168, 19236.422907312804, 19330.806691933183, 19352.32266870653, 2114.7250857388594, 2124.5113623866596, 2283.394900351408, 2346.5658853112227, 2370.8696021718797, 150535.0, 151688.0, 152524.2373788135, 153686.0, 153784.231078845, 20560.58878822415, 23201.53596928052, 24365.878170609034, 24591.87704061504, 24722.50554988926, 40731.592684073374, 41077.0, 41092.58907410948, 41199.38200926989, 41432.79283603562, 8671.653133874574, 8954.597043133075, 10210.183185345155, 10696.144308455305, 10703.464826758787, 8371.874421883555, 8376.329893608498, 8406.915930840736, 8564.0, 8566.78583035429, 11350.829737553944, 11426.428678566204, 11454.713632159262, 11480.942595287137, 11626.186166968231, 3806.352920003606, 3808.8383043171543, 4333.501647310537, 4425.5574442556135, 4481.260592002348, 982.8427451607852, 986.4673076538588, 992.7666998255404, 1009.0918173643779, 1020.4999550220339, 16365.91817040931, 20993.68509472359, 21321.933903305082, 21405.0, 21418.678719819214, 885.7741275974586, 943.5376665434026, 993.881882881758, 1023.9795204095876, 1044.5926088825213, 10204.23468239885, 11059.391733454737, 11163.83254251187, 11197.608083717194, 11237.04485118774, 513525.0, 515780.0, 517929.0, 518432.0, 522991.0, 111337.0, 125519.0, 126850.0, 130436.3478182622, 131047.37905241842, 1215.1736818963013, 1238.4303220518661, 1259.9227660350452, 1264.2477725753163, 1264.8039553869164, 21712.782872171076, 22716.772832271465, 23060.308190754306, 23088.191913282953, 23123.76876231216, 45603.315950261436, 57307.713461432424, 57481.425185747605, 58189.4181058184, 58552.0, 79181.60409197917, 79290.0, 79411.0, 79760.0, 79910.6004469974, 8917.910820891708, 8946.507942062988, 9004.86492702623, 9329.626814927327, 9518.333716640045, 12032.338221397908, 14583.562493125222, 14662.853371466148, 14791.704165916406, 15058.623534411727, 12126.211796233216, 12351.073669474647, 12462.127651064338, 12521.49914003466, 12564.246145231315, 9597.712068637951, 10977.506012229309, 11640.767184656428, 11653.30080195191, 11840.763184736084, 11074.944625276821, 12526.311052892179, 12639.368031598568, 12863.807042894552, 12904.612861614167, 8834.779130521789, 8922.73231803047, 9192.483240265281, 9334.439933604006, 9343.626254949726, 11553.884461155281, 12058.336791476202, 12318.260904345769, 12404.689882753004, 12447.004239660986], "value": 11676.55167843363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.200777525709, 1468.0457702493377, 1484.970300593989, 1491.425801066589, 1499.4676889704158, 11226.270292430987, 11343.659690209286, 11825.881741182597, 11858.169928105037, 11929.0, 10162.390256584591, 11710.297382157076, 11798.87910648487, 11824.172307938448, 11945.522179112846, 2088.154297509507, 2330.755270696578, 2475.665785119013, 2479.9752002480013, 2487.502499500098, 2468.0868078810777, 2526.507331070442, 2534.0, 2540.174443305924, 2543.1099115309585, 2112.302940029794, 2526.987365063181, 2542.9319685731944, 2551.9362015949655, 2553.399951011511, 2104.2740254612286, 2403.351095204294, 2415.879206039691, 2449.7305296417467, 2460.3849037740565, 2348.8120950323932, 2376.702912135983, 2387.0213212582757, 2394.5330660521204, 2467.481828815951, 11921.940390297994, 11970.700732481671, 11972.521099156023, 12004.879951200464, 12045.759084818343, 6634.966825165891, 6851.725930962755, 6883.449324054063, 6901.654917254117, 6929.826754331131, 4060.8781736547658, 4379.671524635665, 4467.664925130595, 4473.418455600784, 4496.910061798779, 1076.1928553584812, 1248.9937550312281, 1256.1395444120715, 1291.7158225190442, 1295.1322613848745, 16348.264328105264, 16570.337186512526, 16721.247543860434, 16722.581935451588, 17010.489685309585, 5506.201600767866, 5718.571107166896, 5816.709164541756, 5877.941220587825, 5914.408559144137, 11784.528618855322, 11828.34944078084, 11832.526698932119, 11839.28964262147, 11893.583724569598, 6604.042413849965, 6634.137562116894, 6645.269020407752, 6667.866642667216, 6676.232233293234, 6001.549883758648, 6229.283632382243, 6267.749290028439, 6280.403361680633, 6286.842828929313, 4278.122984788111, 4357.825686972549, 4389.692721509464, 4397.2085024695225, 4398.69209155356, 1273.1978853322532, 1291.4704970961861, 1291.754566632337, 1305.301663609983, 1305.778017736987, 761.919998400171, 808.7250334886166, 823.8187598728271, 830.5099991005336, 858.6737039924789, 6142.539309551712, 6180.66006369645, 6363.840903977438, 6399.7520483506205, 6439.066335381437, 588.1031427073661, 601.8435206846251, 602.8161410769669, 605.3432026251567, 620.1581303528513, 4074.5925407459017, 4285.46431696038, 4479.484859241229, 4506.022654754287, 4589.35748995141, 14898.702025959421, 15034.849651503346, 15248.08511489292, 15308.234588270765, 15360.385584576716, 14690.926545367418, 15007.774883376758, 15236.162011089275, 15258.313375898111, 15285.770713439086, 6207.689615519206, 8391.748247552583, 8551.700690475804, 8640.179182977607, 8644.438111522732, 6069.878602428015, 6199.907001395073, 7037.225905150327, 7129.750458733919, 7332.266773322625, 12944.741105178033, 12980.8052879205, 13001.739965200832, 13007.544735934196, 13128.60614181576, 12528.749425011267, 13671.17972921588, 13888.305584720925, 13949.651258718613, 14182.574522764333, 9220.492872891788, 9513.714588562354, 9516.33385662997, 9529.475878826732, 9550.331476796557, 10592.470376481298, 10609.416482093558, 10714.035736783728, 10870.347779133277, 10874.510647020745, 8879.778005549913, 8920.776980575538, 8978.910210897808, 9001.459912405277, 9180.770480738034, 7157.24848890859, 8815.338849586435, 8857.778555536162, 8882.467051976902, 8971.685990990283, 8163.469374490639, 8316.334693224406, 8329.791755205926, 8345.457545259538, 8359.874601881098, 5259.21111833228, 6051.152838602688, 6073.240844894388, 6184.474319682878, 6233.065040244, 6148.139260503443, 6170.722317495633, 6203.100550420074, 6289.559730818799, 6319.684015799284], "value": 5323.0653713299935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.82172111689164, 407.830750238651, 413.9877998294172, 415.7484721743345, 417.0636920114343, 5829.562782791291, 5999.520038396929, 6091.482224010964, 6280.995040793468, 6326.746930122789, 5110.667806592569, 5654.434556544344, 6102.572819902609, 6154.630722156674, 6166.198394208746, 3588.892333229994, 4392.736435813854, 4474.798634061475, 4476.61948734358, 4483.30508771141, 3694.07648087978, 4205.158968206356, 4417.690761646686, 4440.911181776362, 4466.486354069275, 4225.323948168294, 4371.540988196241, 4376.1247750449875, 4394.802233899466, 4401.933970990438, 3895.5714871364125, 4356.978215108936, 4407.955920440787, 4424.712393694415, 4432.556744325541, 2905.7094290570985, 3581.4985901973746, 3695.5380577427823, 3741.6530049182275, 3792.355299599075, 5972.372900845436, 5976.880462390728, 5985.940140598582, 5991.490723288525, 6016.909746353808, 5219.739013049332, 5227.660202086852, 5233.371995360543, 5248.317718696545, 5264.052130806722, 5313.203019547061, 5686.488216060533, 6479.49674975892, 6502.869942601169, 6509.381608747209, 4271.497372154834, 4272.2950713132295, 4275.40144379787, 4275.636570891478, 4313.82744690212, 5030.9245361319245, 6027.969860150715, 6522.543052182351, 6709.798706038827, 6923.896141557881, 4241.851535196253, 4321.632661223768, 4329.964916489245, 4339.262325404626, 4345.435093437833, 4389.231884420214, 4394.384786129945, 4405.118976204708, 4409.845655402046, 4442.533533978885, 4377.0, 5094.286799848024, 5245.816396426183, 5260.658057226268, 5279.894402111936, 5822.080342110909, 5945.940540594539, 6392.849287128269, 6568.67156642166, 6578.375054369827, 1412.7951447040123, 1484.3394689363129, 1486.8067151270266, 1506.6082818467057, 1509.5018643847504, 798.5847359373093, 979.4172467381896, 980.5783513089298, 984.8276551603441, 992.6972273456665, 5669.0, 5945.97836735512, 6257.812265632038, 6269.780557680459, 6296.670232014092, 6234.0, 6651.401373876374, 6735.4274886635185, 6843.3840954314355, 6881.8967715484305, 5696.1455781633085, 6207.937920620736, 6218.409251121137, 6226.6575338355915, 6247.781682571946, 3146.276356438032, 3402.9829850850588, 3522.7005704515404, 3555.306715190513, 3567.8959305403946, 5398.0, 6660.267370589231, 6972.0, 7018.473614478935, 7084.689332473509, 6867.725290988305, 6977.581345119309, 7057.858842823115, 7060.0, 7107.005019297302, 5909.96575599277, 6430.196225471816, 6986.7205311787975, 7124.180719217253, 7125.180604230476, 6104.969475152596, 6354.90467642995, 6709.630970296681, 6888.035675005403, 6919.965400172967, 6591.274959754519, 6703.463722902058, 6809.421199198124, 6822.488313376417, 6833.0, 7101.2898710128575, 7125.928740712734, 7126.501144920013, 7159.427245820218, 7163.6060016699585, 3554.253606742613, 3744.4757733916726, 3805.543334799842, 4254.468191476066, 4364.912701745884, 5985.521158307412, 6043.3352331244405, 6812.965935170292, 6902.309769023058, 6951.826204344932, 6442.8389290268115, 6590.637514936533, 6638.0, 6646.767363142267, 6695.296993815774, 5889.027175896123, 6290.654014029273, 6461.289258181502, 6513.348665133449, 6683.665816709243, 6314.652694101868, 6511.837204069936, 6544.901826472512, 6572.4084832365315, 6583.317932298625, 6469.320721324381, 6629.635370054693, 6633.767818126343, 6637.435817955527, 6651.73393064272, 5708.857278568069, 6455.128557644845, 6493.448056915026, 6502.902456463063, 6533.836654083496], "value": 4725.5507587218835, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.5607803551976, 830.6428235858579, 843.713137533239, 849.2484151525899, 863.0, 16476.91761541192, 16542.17289135543, 16912.238949247283, 18264.908675456638, 19273.518162045955, 17624.82375176248, 17803.821961780377, 17937.820621793777, 18198.454046378596, 18267.90392576446, 988.1748739802256, 1005.3214080495673, 1006.783541538569, 1007.702727695328, 1010.4493051287067, 972.3776782858976, 977.4282045003681, 996.3822430093317, 1000.3197825478671, 1018.1345856022396, 1049.1606714628306, 1070.2133931560297, 1072.5816931396762, 1076.3488089705734, 1081.1783044885865, 1026.7279171019686, 1065.9680209593687, 1068.0174239699495, 1068.8450174724699, 1071.6570697376842, 753.7776355975001, 776.1384862802284, 790.1505881177757, 796.9442139050269, 798.5647821937058, 16635.584110397336, 16881.493555193363, 17004.0, 17056.65886682272, 17326.306947722074, 17418.564535886577, 17453.389131380467, 17513.0, 17598.94406335624, 17631.471055868344, 13758.105723128065, 14008.089474184146, 14035.368408421646, 14225.004249702524, 14301.213433261166, 3470.9652903470896, 3482.4776283557417, 3494.336076145524, 3495.056334789618, 3498.282852015356, 127983.8806447741, 128958.0, 129792.0, 131105.34447327798, 131217.99999999904, 11128.777424451628, 13225.73548529024, 13239.66900827487, 13279.601611951657, 13414.396352164176, 22180.890955452163, 23490.412739681644, 24204.394890127536, 24300.756992430204, 24823.13119040825, 7678.193789652118, 7903.0, 7914.722984695508, 7915.208479152154, 7923.920760792434, 3692.0585250760882, 3737.9626203737616, 3747.7938713371027, 3772.4529943158086, 3778.301014312361, 4237.343211802176, 4333.306670932699, 4395.186890425218, 4396.560343965578, 4404.7357158570585, 930.6463543853292, 959.9424034557809, 968.7626531499686, 972.4165500699523, 977.2914636888199, 617.1914791622988, 646.4375992886219, 663.9502037347219, 677.989830152548, 693.0989713372595, 11257.380844053492, 11681.591144310078, 12116.27302361861, 12170.269783812822, 12260.386980650932, 660.7720336483906, 662.4634046422414, 666.1606375966318, 676.6988690032987, 694.3820000199826, 5401.1358182691365, 5418.485243901823, 5528.253685752372, 5537.141743029837, 5648.71756412186, 100324.49837750911, 104709.0, 104726.0, 105892.0, 106691.46654266679, 93603.0, 93922.06077939134, 94150.0, 94188.52905735564, 95423.0, 82901.58549207215, 83585.0, 84229.0, 85696.57151714202, 85833.0, 10808.45957702096, 11240.9321114494, 11265.831012534982, 11428.085753139896, 11628.592999244986, 40203.3969490452, 40700.59299406968, 40843.52830009364, 41256.79371603123, 42251.36622950597, 67568.0, 71522.56954860978, 73115.63442182755, 73160.63419682867, 74141.0, 14188.006839521135, 16260.430884918971, 16789.580260493585, 16908.32366705318, 17097.145142742564, 17885.910570447584, 17929.641407172043, 18387.816121838612, 18709.0, 18740.906295468434, 16384.590385240463, 17172.570685732957, 17221.56946076358, 17244.051577163376, 17499.56251093733, 16735.74896376531, 16736.581585460463, 17140.40008599693, 17166.39917602878, 17295.30818767235, 15880.682386352439, 16259.51221463358, 16794.160291985598, 16806.075665838496, 16830.326786928876, 10973.23187376876, 10998.670039898816, 11065.114790816877, 11545.942270288595, 12067.698307542381, 11592.594259200887, 12306.0, 13229.404676789374, 13251.469941202244, 13830.0], "value": 8493.108557095746, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 116.0, 114.0, 113.0, 116.0, 114.0, 114.0, 117.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 108.0, 146.0, 147.0, 147.0, 141.0, 110.0, 148.0, 142.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 200.0, 200.0, 218.0, 220.0, 210.0, 208.0, 208.0, 204.0, 201.0], "value": 207.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 58.0, 60.0, 83.0, 55.0, 58.0, 56.0, 57.0, 77.0, 58.0], "value": 63.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 84.0, 71.0, 70.0, 71.0, 88.0, 69.0, 69.0, 95.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 88.0, 90.0, 88.0, 89.0, 89.0, 89.0, 101.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 149.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "value": 102.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 107.0, 141.0, 89.0, 133.0, 99.0, 89.0, 98.0, 92.0, 91.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 47.0, 49.0, 49.0, 51.0, 49.0, 50.0, 50.0, 53.0, 51.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 60.0, 85.0, 72.0, 60.0, 61.0, 56.0, 56.0, 60.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 80.0, 82.0, 81.0, 82.0, 83.0, 92.0, 106.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 132.0, 141.0, 162.0, 147.0, 147.0, 147.0, 204.0, 140.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 221.0, 184.0, 234.0, 229.0, 185.0, 187.0, 182.0, 214.0, 236.0], "value": 205.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 87.0, 91.0, 94.0, 68.0, 61.0, 93.0, 89.0, 98.0], "value": 82.3, "unit": "score"}]}]} 09:35:16 INFO - Return code: 0 09:35:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:35:16 ERROR - # TBPL SUCCESS # 09:35:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:35:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:35:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:35:16 INFO - 2017-04-27 09:35:16.680 screenresolution[1650:10756] starting screenresolution argv=screenresolution get 09:35:16 INFO - 2017-04-27 09:35:16.682 screenresolution[1650:10756] Display 0: 1600x1200x32@60 09:35:16 INFO - 2017-04-27 09:35:16.689 screenresolution[1651:10759] starting screenresolution argv=screenresolution list 09:35:16 INFO - Available Modes on Display 0 09:35:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:35:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:35:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:35:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:35:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:35:16 INFO - Intel Iris: 09:35:16 INFO - Chipset Model: Intel Iris 09:35:16 INFO - Type: GPU 09:35:16 INFO - Bus: Built-In 09:35:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:35:16 INFO - Vendor: Intel (0x8086) 09:35:16 INFO - Device ID: 0x0a2e 09:35:16 INFO - Revision ID: 0x0009 09:35:16 INFO - Displays: 09:35:16 INFO - Display: 09:35:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:35:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:35:16 INFO - Display Serial Number: 1600x1200 60 09:35:16 INFO - Main Display: Yes 09:35:16 INFO - Mirror: Off 09:35:16 INFO - Online: Yes 09:35:16 INFO - Rotation: Supported 09:35:16 INFO - Return code: 0 09:35:16 INFO - Running post-action listener: _resource_record_post_action 09:35:16 INFO - [mozharness: 2017-04-27 16:35:16.936086Z] Finished run-tests step (success) 09:35:16 INFO - Running post-run listener: _resource_record_post_run 09:35:17 INFO - Total resource usage - Wall time: 1196s; CPU: 55.0%; Read bytes: 39397888; Write bytes: 508969984; Read time: 255; Write time: 1599 09:35:17 INFO - TinderboxPrint: CPU usage
54.5% 09:35:17 INFO - TinderboxPrint: I/O read bytes / time
39,397,888 / 255 09:35:17 INFO - TinderboxPrint: I/O write bytes / time
508,969,984 / 1,599 09:35:17 INFO - TinderboxPrint: CPU idle
2,175.7 (45.5%) 09:35:17 INFO - TinderboxPrint: CPU system
971.5 (20.3%) 09:35:17 INFO - TinderboxPrint: CPU user
1,638.4 (34.2%) 09:35:17 INFO - TinderboxPrint: Swap in / out
247,558,144 / 0 09:35:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193606144; Write bytes: 194106880; Read time: 15004; Write time: 423 09:35:17 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 38152704; Write bytes: 298024448; Read time: 234; Write time: 1126 09:35:17 INFO - Running post-run listener: _upload_blobber_files 09:35:17 INFO - Blob upload gear active. 09:35:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:17 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 09:35:17 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'] 09:35:17 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 09:35:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:35:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:18 INFO - (blobuploader) - INFO - Done attempting. 09:35:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:35:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:19 INFO - (blobuploader) - INFO - Done attempting. 09:35:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:35:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:20 INFO - (blobuploader) - INFO - Done attempting. 09:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:35:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:22 INFO - (blobuploader) - INFO - Done attempting. 09:35:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:22 INFO - Return code: 0 09:35:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:35:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73a285f5e0b1ab1a15a901c9c8238639b08aef94f1cee2752f551140bc337be53c05a64200c6e90bfa337c4670d19c9bd99e5fbafebebeec6b3fd9f6a1cb7d8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e783a2886cc7e17f5f5ee1c0cd1874219117001a7d8192328284970b8d12b298b8e5bbca09bbc661b67753eb670fe2978c9a00d4b9352eba9aafdef1c0200a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d48211bd8f199912c19059fb1944503e29a5e366a2511cc2c7b9f050eb3764c310559aeec688ff8bbdaa5e36821dcf6cd225e189cafa3db35c03f6636a5c6d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6052fffcc8a687e21c4f1de91866409ccd0de93ee8d25d7c45e066c08d947bb0fe276b9dde01f2d12db7e14dd5aa4e7ccda5e8e45c3177a9d2fb5369c0f528c3"} 09:35:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:35:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:35:22 INFO - Contents: 09:35:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73a285f5e0b1ab1a15a901c9c8238639b08aef94f1cee2752f551140bc337be53c05a64200c6e90bfa337c4670d19c9bd99e5fbafebebeec6b3fd9f6a1cb7d8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e783a2886cc7e17f5f5ee1c0cd1874219117001a7d8192328284970b8d12b298b8e5bbca09bbc661b67753eb670fe2978c9a00d4b9352eba9aafdef1c0200a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d48211bd8f199912c19059fb1944503e29a5e366a2511cc2c7b9f050eb3764c310559aeec688ff8bbdaa5e36821dcf6cd225e189cafa3db35c03f6636a5c6d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6052fffcc8a687e21c4f1de91866409ccd0de93ee8d25d7c45e066c08d947bb0fe276b9dde01f2d12db7e14dd5aa4e7ccda5e8e45c3177a9d2fb5369c0f528c3"} 09:35:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:22 INFO - Copying logs to upload dir... 09:35:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:35:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.722579 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-27 09:35:23.023072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 09:35:23.026473) ========= 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.Dqt23XVri9/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.SoWOBIABsd/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73a285f5e0b1ab1a15a901c9c8238639b08aef94f1cee2752f551140bc337be53c05a64200c6e90bfa337c4670d19c9bd99e5fbafebebeec6b3fd9f6a1cb7d8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e783a2886cc7e17f5f5ee1c0cd1874219117001a7d8192328284970b8d12b298b8e5bbca09bbc661b67753eb670fe2978c9a00d4b9352eba9aafdef1c0200a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d48211bd8f199912c19059fb1944503e29a5e366a2511cc2c7b9f050eb3764c310559aeec688ff8bbdaa5e36821dcf6cd225e189cafa3db35c03f6636a5c6d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6052fffcc8a687e21c4f1de91866409ccd0de93ee8d25d7c45e066c08d947bb0fe276b9dde01f2d12db7e14dd5aa4e7ccda5e8e45c3177a9d2fb5369c0f528c3"} build_url:https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/blwGItHDQ-azYYZjEPsk_w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73a285f5e0b1ab1a15a901c9c8238639b08aef94f1cee2752f551140bc337be53c05a64200c6e90bfa337c4670d19c9bd99e5fbafebebeec6b3fd9f6a1cb7d8e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e783a2886cc7e17f5f5ee1c0cd1874219117001a7d8192328284970b8d12b298b8e5bbca09bbc661b67753eb670fe2978c9a00d4b9352eba9aafdef1c0200a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d48211bd8f199912c19059fb1944503e29a5e366a2511cc2c7b9f050eb3764c310559aeec688ff8bbdaa5e36821dcf6cd225e189cafa3db35c03f6636a5c6d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6052fffcc8a687e21c4f1de91866409ccd0de93ee8d25d7c45e066c08d947bb0fe276b9dde01f2d12db7e14dd5aa4e7ccda5e8e45c3177a9d2fb5369c0f528c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 09:35:23.061225) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:35:23.061537) ========= 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.Dqt23XVri9/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.SoWOBIABsd/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:35:23.109736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 09:35:23.110041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 09:35:23.110354) ========= ========= Total master_lag: 0.42 =========