builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0039 starttime: 1493425954.38 results: success (0) buildid: 20170428170828 builduid: ad5c2de523704d7993fd18e062415b87 revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.375537) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.375971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.376251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.401427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.401743) ========= 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.gIKchLTbn5/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.eG2IWGaLLV/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-28 17:32:34-- 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% 142M=0s 2017-04-28 17:32:34 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.579663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.579979) ========= 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.gIKchLTbn5/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.eG2IWGaLLV/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.021844 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:34.631594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:32:34.631974) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3b32894d9326d147238d9f071e1814ab3fdc850 --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 b3b32894d9326d147238d9f071e1814ab3fdc850 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gIKchLTbn5/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.eG2IWGaLLV/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-28 17:32:34,721 truncating revision to first 12 chars 2017-04-28 17:32:34,721 Setting DEBUG logging. 2017-04-28 17:32:34,721 attempt 1/10 2017-04-28 17:32:34,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3b32894d932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 17:32:36,125 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=1.678169 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:32:36.334333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:36.334653) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:36.335038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:36.335341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:32:36.355857) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-28 17:32:36.356240) ========= /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.gIKchLTbn5/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.eG2IWGaLLV/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:32:36 INFO - MultiFileLogger online at 20170428 17:32:36 in /builds/slave/test 17:32:36 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 17:32:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:36 INFO - {'append_to_log': False, 17:32:36 INFO - 'base_work_dir': '/builds/slave/test', 17:32:36 INFO - 'blob_upload_branch': 'Firefox', 17:32:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:36 INFO - 'branch': 'Firefox', 17:32:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:36 INFO - 'config_files': ('talos/mac_config.py',), 17:32:36 INFO - 'default_actions': ('clobber', 17:32:36 INFO - 'read-buildbot-config', 17:32:36 INFO - 'download-and-extract', 17:32:36 INFO - 'populate-webroot', 17:32:36 INFO - 'create-virtualenv', 17:32:36 INFO - 'install', 17:32:36 INFO - 'run-tests'), 17:32:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:36 INFO - 'download_minidump_stackwalk': True, 17:32:36 INFO - 'download_symbols': 'ondemand', 17:32:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:36 INFO - 'gecko_profile': False, 17:32:36 INFO - 'gecko_profile_interval': 0, 17:32:36 INFO - 'installer_path': 'installer.exe', 17:32:36 INFO - 'log_level': 'info', 17:32:36 INFO - 'log_name': 'talos', 17:32:36 INFO - 'log_to_console': True, 17:32:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:32:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:32:36 INFO - 'opt_config_files': (), 17:32:36 INFO - 'pip_index': False, 17:32:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:32:36 INFO - 'cmd': ('bash', 17:32:36 INFO - '-c', 17:32:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:32:36 INFO - 'enabled': True, 17:32:36 INFO - 'halt_on_failure': False, 17:32:36 INFO - 'name': 'check_screen_resolution'},), 17:32:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:32:36 INFO - 'cmd': ('bash', 17:32:36 INFO - '-c', 17:32:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:32:36 INFO - 'enabled': True, 17:32:36 INFO - 'halt_on_failure': False, 17:32:36 INFO - 'name': 'check_screen_resolution'},), 17:32:36 INFO - 'run_cmd_checks_enabled': True, 17:32:36 INFO - 'suite': 'dromaeojs-e10s', 17:32:36 INFO - 'system_bits': '32', 17:32:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:36 INFO - 'title': 't-yosemite-r7-0039', 17:32:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:36 INFO - 'use_talos_json': True, 17:32:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:36 INFO - 'work_dir': 'build'} 17:32:36 INFO - [mozharness: 2017-04-29 00:32:36.572128Z] Running clobber step. 17:32:36 INFO - Running pre-action listener: _resource_record_pre_action 17:32:36 INFO - Running main action method: clobber 17:32:36 INFO - rmtree: /builds/slave/test/build 17:32:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:32:38 INFO - Running post-action listener: _resource_record_post_action 17:32:38 INFO - [mozharness: 2017-04-29 00:32:38.704396Z] Finished clobber step (success) 17:32:38 INFO - [mozharness: 2017-04-29 00:32:38.704570Z] Running read-buildbot-config step. 17:32:38 INFO - Running pre-action listener: _resource_record_pre_action 17:32:38 INFO - Running main action method: read_buildbot_config 17:32:38 INFO - Using buildbot properties: 17:32:38 INFO - { 17:32:38 INFO - "project": "", 17:32:38 INFO - "product": "firefox", 17:32:38 INFO - "script_repo_revision": "production", 17:32:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:32:38 INFO - "repository": "", 17:32:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:32:38 INFO - "buildid": "20170428170828", 17:32:38 INFO - "stage_platform": "macosx64", 17:32:38 INFO - "basedir": "/builds/slave/test", 17:32:38 INFO - "buildnumber": 18, 17:32:38 INFO - "platform": "yosemite_r7", 17:32:38 INFO - "mozci_request": { 17:32:38 INFO - "priority": 0, 17:32:38 INFO - "type": "trigger_all_talos_jobs", 17:32:38 INFO - "times": 6 17:32:38 INFO - }, 17:32:38 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:32:38 INFO - "slavebuilddir": "test", 17:32:38 INFO - "branch": "mozilla-central", 17:32:38 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:32:38 INFO - "slavename": "t-yosemite-r7-0039", 17:32:38 INFO - "builduid": "ad5c2de523704d7993fd18e062415b87", 17:32:38 INFO - "repo_path": "mozilla-central" 17:32:38 INFO - } 17:32:38 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:32:38 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json. 17:32:38 INFO - Running post-action listener: _resource_record_post_action 17:32:38 INFO - [mozharness: 2017-04-29 00:32:38.708797Z] Finished read-buildbot-config step (success) 17:32:38 INFO - [mozharness: 2017-04-29 00:32:38.708933Z] Running download-and-extract step. 17:32:38 INFO - Running pre-action listener: _resource_record_pre_action 17:32:38 INFO - Running main action method: download_and_extract 17:32:38 INFO - mkdir: /builds/slave/test/build/tests 17:32:38 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')]} 17:32:38 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:32:38 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:32:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/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 17:32:39 INFO - Downloaded 1325 bytes. 17:32:39 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:32:39 INFO - Using the following test package requirements: 17:32:39 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:32:39 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:32:39 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:32:39 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:32:39 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'jsshell-mac.zip'], 17:32:39 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:32:39 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:32:39 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:32:39 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:32:39 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:32:39 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:32:39 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:32:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:32:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:32:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:32:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:32:40 INFO - Content-Length response header: 52698163 17:32:40 INFO - Bytes received: 52698163 17:32:56 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 17:32:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:32:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:32:56 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:32:58 INFO - Content-Length response header: 52698163 17:32:58 INFO - Bytes received: 52698163 17:33:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip 17:33:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:33:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:33:14 INFO - Content-Length response header: 14408809 17:33:14 INFO - Bytes received: 14408809 17:33:14 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')]} 17:33:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:33:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:33:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:33:16 INFO - Downloaded 71219323 bytes. 17:33:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:33:16 INFO - mkdir: /builds/slave/test/properties 17:33:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:33:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:33:16 INFO - Contents: 17:33:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:33:16 INFO - Running post-action listener: _resource_record_post_action 17:33:16 INFO - Running post-action listener: set_extra_try_arguments 17:33:16 INFO - [mozharness: 2017-04-29 00:33:16.436327Z] Finished download-and-extract step (success) 17:33:16 INFO - [mozharness: 2017-04-29 00:33:16.436445Z] Running populate-webroot step. 17:33:16 INFO - Running pre-action listener: _resource_record_pre_action 17:33:16 INFO - Running main action method: populate_webroot 17:33:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:33:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:33:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:33:16 INFO - '--tppagecycles', 17:33:16 INFO - '7'], 17:33:16 INFO - 'tests': ['tsvgm']}}, 17:33:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:33:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:33:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:33:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:33:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:33:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:33:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['damp', 'tps']}, 17:33:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'tests': ['damp', 'tps']}, 17:33:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['dromaeo_dom']}, 17:33:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:33:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:33:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:33:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['a11yr', 17:33:16 INFO - 'ts_paint', 17:33:16 INFO - 'tpaint', 17:33:16 INFO - 'sessionrestore', 17:33:16 INFO - 'sessionrestore_no_auto_restore', 17:33:16 INFO - 'tabpaint']}, 17:33:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:33:16 INFO - 'ts_paint', 17:33:16 INFO - 'tpaint', 17:33:16 INFO - 'sessionrestore', 17:33:16 INFO - 'sessionrestore_no_auto_restore', 17:33:16 INFO - 'tabpaint']}, 17:33:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:33:16 INFO - 'ts_paint', 17:33:16 INFO - 'tpaint', 17:33:16 INFO - 'sessionrestore', 17:33:16 INFO - 'sessionrestore_no_auto_restore', 17:33:16 INFO - 'tabpaint']}, 17:33:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:33:16 INFO - 'ts_paint', 17:33:16 INFO - 'tpaint', 17:33:16 INFO - 'sessionrestore', 17:33:16 INFO - 'sessionrestore_no_auto_restore', 17:33:16 INFO - 'tabpaint']}, 17:33:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['a11yr', 17:33:16 INFO - 'ts_paint', 17:33:16 INFO - 'tpaint', 17:33:16 INFO - 'sessionrestore', 17:33:16 INFO - 'sessionrestore_no_auto_restore', 17:33:16 INFO - 'tabpaint']}, 17:33:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['a11yr', 17:33:16 INFO - 'ts_paint', 17:33:16 INFO - 'tpaint', 17:33:16 INFO - 'sessionrestore', 17:33:16 INFO - 'sessionrestore_no_auto_restore', 17:33:16 INFO - 'tabpaint']}, 17:33:16 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:33:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:33:16 INFO - 'bloom_basic_ref']}, 17:33:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['tsvgx', 17:33:16 INFO - 'tsvgr_opacity', 17:33:16 INFO - 'tart', 17:33:16 INFO - 'tscrollx', 17:33:16 INFO - 'cart', 17:33:16 INFO - 'tsvg_static']}, 17:33:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:33:16 INFO - 'tsvgr_opacity', 17:33:16 INFO - 'tart', 17:33:16 INFO - 'tscrollx', 17:33:16 INFO - 'cart', 17:33:16 INFO - 'tsvg_static']}, 17:33:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'talos_options': ['--disable-e10s'], 17:33:16 INFO - 'tests': ['tp5o']}, 17:33:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:33:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'talos_options': ['--disable-e10s', 17:33:16 INFO - '--xperf_path', 17:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:16 INFO - 'tests': ['tp5n']}, 17:33:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:33:16 INFO - 'talos_options': ['--xperf_path', 17:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:33:16 INFO - 'tests': ['tp5n']}}, 17:33:16 INFO - 'talos.zip': {'path': '', 17:33:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:33:16 INFO - Running post-action listener: _resource_record_post_action 17:33:16 INFO - [mozharness: 2017-04-29 00:33:16.455421Z] Finished populate-webroot step (success) 17:33:16 INFO - [mozharness: 2017-04-29 00:33:16.455530Z] Running create-virtualenv step. 17:33:16 INFO - Running pre-action listener: _resource_record_pre_action 17:33:16 INFO - Running main action method: create_virtualenv 17:33:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:33:16 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 17:33:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:33:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:33:16 INFO - Using real prefix '/tools/python27' 17:33:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:33:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:33:20 INFO - Installing pip.................done. 17:33:20 INFO - Return code: 0 17:33:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:33:20 INFO - Reading from file tmpfile_stdout 17:33:20 INFO - Output received: 17:33:20 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) 17:33:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:20 INFO - 'HOME': '/Users/cltbld', 17:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:20 INFO - 'LOGNAME': 'cltbld', 17:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:20 INFO - 'MOZ_NO_REMOTE': '1', 17:33:20 INFO - 'NO_EM_RESTART': '1', 17:33:20 INFO - 'PAGER': '/bin/cat', 17:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:20 INFO - 'PWD': '/builds/slave/test', 17:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:20 INFO - 'SHELL': '/bin/bash', 17:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:20 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:20 INFO - 'USER': 'cltbld', 17:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:20 INFO - 'XPC_FLAGS': '0x0', 17:33:20 INFO - 'XPC_SERVICE_NAME': '0', 17:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:20 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 17:33:20 INFO - Cleaning up... 17:33:20 INFO - Return code: 0 17:33:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:20 INFO - 'HOME': '/Users/cltbld', 17:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:20 INFO - 'LOGNAME': 'cltbld', 17:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:20 INFO - 'MOZ_NO_REMOTE': '1', 17:33:20 INFO - 'NO_EM_RESTART': '1', 17:33:20 INFO - 'PAGER': '/bin/cat', 17:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:20 INFO - 'PWD': '/builds/slave/test', 17:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:20 INFO - 'SHELL': '/bin/bash', 17:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:20 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:20 INFO - 'USER': 'cltbld', 17:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:20 INFO - 'XPC_FLAGS': '0x0', 17:33:20 INFO - 'XPC_SERVICE_NAME': '0', 17:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:20 INFO - Downloading/unpacking psutil>=3.1.1 17:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:33:24 INFO - Installing collected packages: psutil 17:33:24 INFO - Running setup.py install for psutil 17:33:24 INFO - building 'psutil._psutil_osx' extension 17:33:24 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 17:33:24 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 17:33:24 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 17:33:25 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 17:33:25 INFO - building 'psutil._psutil_posix' extension 17:33:25 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 17:33:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:33:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:33:25 INFO - ^ 17:33:25 INFO - 1 warning generated. 17:33:25 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 17:33:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:33:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:33:25 INFO - Successfully installed psutil 17:33:25 INFO - Cleaning up... 17:33:25 INFO - Return code: 0 17:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:25 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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:25 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 17:33:25 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 17:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:25 INFO - 'HOME': '/Users/cltbld', 17:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:25 INFO - 'LOGNAME': 'cltbld', 17:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:25 INFO - 'MOZ_NO_REMOTE': '1', 17:33:25 INFO - 'NO_EM_RESTART': '1', 17:33:25 INFO - 'PAGER': '/bin/cat', 17:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:25 INFO - 'PWD': '/builds/slave/test', 17:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:25 INFO - 'SHELL': '/bin/bash', 17:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:25 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:25 INFO - 'USER': 'cltbld', 17:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:25 INFO - 'XPC_FLAGS': '0x0', 17:33:25 INFO - 'XPC_SERVICE_NAME': '0', 17:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:33:25 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 17:33:25 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 17:33:25 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 17:33:25 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 17:33:25 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 17:33:25 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 17:33:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:33:28 INFO - Installing collected packages: mozsystemmonitor 17:33:28 INFO - Running setup.py install for mozsystemmonitor 17:33:28 INFO - Successfully installed mozsystemmonitor 17:33:28 INFO - Cleaning up... 17:33:28 INFO - Return code: 0 17:33:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:28 INFO - 'HOME': '/Users/cltbld', 17:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:28 INFO - 'LOGNAME': 'cltbld', 17:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:28 INFO - 'MOZ_NO_REMOTE': '1', 17:33:28 INFO - 'NO_EM_RESTART': '1', 17:33:28 INFO - 'PAGER': '/bin/cat', 17:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:28 INFO - 'PWD': '/builds/slave/test', 17:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:28 INFO - 'SHELL': '/bin/bash', 17:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:28 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:28 INFO - 'USER': 'cltbld', 17:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:28 INFO - 'XPC_FLAGS': '0x0', 17:33:28 INFO - 'XPC_SERVICE_NAME': '0', 17:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:28 INFO - Downloading/unpacking jsonschema==2.5.1 17:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:33:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:33:31 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 17:33:31 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 17:33:31 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 17:33:31 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 17:33:31 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 17:33:31 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 17:33:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:33:31 INFO - warning: no files found matching '*.txt' 17:33:31 INFO - no previously-included directories found matching 'build' 17:33:31 INFO - no previously-included directories found matching 'dist' 17:33:31 INFO - no previously-included directories found matching '.git*' 17:33:31 INFO - Installing collected packages: jsonschema, functools32 17:33:31 INFO - Running setup.py install for functools32 17:33:32 INFO - warning: no files found matching '*.txt' 17:33:32 INFO - no previously-included directories found matching 'build' 17:33:32 INFO - no previously-included directories found matching 'dist' 17:33:32 INFO - no previously-included directories found matching '.git*' 17:33:32 INFO - Successfully installed jsonschema functools32 17:33:32 INFO - Cleaning up... 17:33:32 INFO - Return code: 0 17:33:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:32 INFO - 'HOME': '/Users/cltbld', 17:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:32 INFO - 'LOGNAME': 'cltbld', 17:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:32 INFO - 'MOZ_NO_REMOTE': '1', 17:33:32 INFO - 'NO_EM_RESTART': '1', 17:33:32 INFO - 'PAGER': '/bin/cat', 17:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:32 INFO - 'PWD': '/builds/slave/test', 17:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:32 INFO - 'SHELL': '/bin/bash', 17:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:32 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:32 INFO - 'USER': 'cltbld', 17:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:32 INFO - 'XPC_FLAGS': '0x0', 17:33:32 INFO - 'XPC_SERVICE_NAME': '0', 17:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:33:33 INFO - Cleaning up... 17:33:33 INFO - Return code: 0 17:33:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:33 INFO - 'HOME': '/Users/cltbld', 17:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:33 INFO - 'LOGNAME': 'cltbld', 17:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:33 INFO - 'MOZ_NO_REMOTE': '1', 17:33:33 INFO - 'NO_EM_RESTART': '1', 17:33:33 INFO - 'PAGER': '/bin/cat', 17:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:33 INFO - 'PWD': '/builds/slave/test', 17:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:33 INFO - 'SHELL': '/bin/bash', 17:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:33 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:33 INFO - 'USER': 'cltbld', 17:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:33 INFO - 'XPC_FLAGS': '0x0', 17:33:33 INFO - 'XPC_SERVICE_NAME': '0', 17:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:33:33 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 17:33:33 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 17:33:33 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 17:33:33 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 17:33:33 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 17:33:33 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 17:33:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:33:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:33:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:38 INFO - Downloading docopt-0.6.1.tar.gz 17:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:33:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:33:38 INFO - Running setup.py install for blobuploader 17:33:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:33:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:33:38 INFO - Running setup.py install for requests 17:33:38 INFO - Running setup.py install for docopt 17:33:39 INFO - Successfully installed blobuploader requests docopt 17:33:39 INFO - Cleaning up... 17:33:39 INFO - Return code: 0 17:33:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33: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')]} 17:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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')]} 17:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:39 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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:39 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 17:33:39 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 17:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:39 INFO - 'HOME': '/Users/cltbld', 17:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:39 INFO - 'LOGNAME': 'cltbld', 17:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:39 INFO - 'MOZ_NO_REMOTE': '1', 17:33:39 INFO - 'NO_EM_RESTART': '1', 17:33:39 INFO - 'PAGER': '/bin/cat', 17:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:39 INFO - 'PWD': '/builds/slave/test', 17:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:39 INFO - 'SHELL': '/bin/bash', 17:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:39 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:39 INFO - 'USER': 'cltbld', 17:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:39 INFO - 'XPC_FLAGS': '0x0', 17:33:39 INFO - 'XPC_SERVICE_NAME': '0', 17:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:39 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-kYHL1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:39 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ffwfsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:39 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-l1ltNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:39 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Gmsv3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:39 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Is7KFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:39 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-wkb7h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-LXpbG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5WTz2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-W3SQad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Uvovmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-rBePtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-9RCgya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-0GjzOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-7VyWo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:40 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-qfqjzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-QwOiw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:41 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-puI0m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:33:41 INFO - Running setup.py install for manifestparser 17:33:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:33:41 INFO - Running setup.py install for mozcrash 17:33:41 INFO - Running setup.py install for mozdebug 17:33:41 INFO - Running setup.py install for mozdevice 17:33:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:33:41 INFO - Running setup.py install for mozfile 17:33:41 INFO - Running setup.py install for mozhttpd 17:33:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Running setup.py install for mozinfo 17:33:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Running setup.py install for mozInstall 17:33:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Running setup.py install for mozleak 17:33:42 INFO - Running setup.py install for mozlog 17:33:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Running setup.py install for moznetwork 17:33:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:33:42 INFO - Running setup.py install for mozprocess 17:33:42 INFO - Running setup.py install for mozprofile 17:33:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:33:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:33:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:33:43 INFO - Running setup.py install for mozrunner 17:33:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:33:43 INFO - Running setup.py install for mozscreenshot 17:33:43 INFO - Running setup.py install for moztest 17:33:43 INFO - Running setup.py install for mozversion 17:33:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:33:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:33:43 INFO - Cleaning up... 17:33:43 INFO - Return code: 0 17:33:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33: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')]} 17:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33: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')]} 17:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:43 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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:43 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 17:33:43 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 17:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:43 INFO - 'HOME': '/Users/cltbld', 17:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:43 INFO - 'LOGNAME': 'cltbld', 17:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:43 INFO - 'MOZ_NO_REMOTE': '1', 17:33:43 INFO - 'NO_EM_RESTART': '1', 17:33:43 INFO - 'PAGER': '/bin/cat', 17:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:43 INFO - 'PWD': '/builds/slave/test', 17:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:43 INFO - 'SHELL': '/bin/bash', 17:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:43 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:43 INFO - 'USER': 'cltbld', 17:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:43 INFO - 'XPC_FLAGS': '0x0', 17:33:43 INFO - 'XPC_SERVICE_NAME': '0', 17:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-4g4cLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Cogy8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-pAqj3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-OBIZCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-0s5tu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-8oewSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-MlT7Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Bbs7wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-H6Xdv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:33:44 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)) 17:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:33:44 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-cm8txT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-paaGPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-kiY9MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-fggV4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-k7HfB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-zKp_xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-noeoKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:33:45 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)) 17:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:33:45 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ckl8jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:33:45 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)) 17:33:45 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)) 17:33:45 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)) 17:33:45 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)) 17:33:45 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)) 17:33:45 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)) 17:33:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:48 INFO - Downloading blessings-1.6.tar.gz 17:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:33:48 INFO - Installing collected packages: blessings 17:33:48 INFO - Running setup.py install for blessings 17:33:48 INFO - Successfully installed blessings 17:33:48 INFO - Cleaning up... 17:33:48 INFO - Return code: 0 17:33:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:49 INFO - Reading from file tmpfile_stdout 17:33:49 INFO - Current package versions: 17:33:49 INFO - blessings == 1.6 17:33:49 INFO - blobuploader == 1.2.4 17:33:49 INFO - docopt == 0.6.1 17:33:49 INFO - functools32 == 3.2.3-2 17:33:49 INFO - jsonschema == 2.5.1 17:33:49 INFO - manifestparser == 1.1 17:33:49 INFO - mozInstall == 1.12 17:33:49 INFO - mozcrash == 1.0 17:33:49 INFO - mozdebug == 0.1 17:33:49 INFO - mozdevice == 0.50 17:33:49 INFO - mozfile == 1.2 17:33:49 INFO - mozhttpd == 0.7 17:33:49 INFO - mozinfo == 0.9 17:33:49 INFO - mozleak == 0.1 17:33:49 INFO - mozlog == 3.4 17:33:49 INFO - moznetwork == 0.27 17:33:49 INFO - mozprocess == 0.25 17:33:49 INFO - mozprofile == 0.28 17:33:49 INFO - mozrunner == 6.13 17:33:49 INFO - mozscreenshot == 0.1 17:33:49 INFO - mozsystemmonitor == 0.3 17:33:49 INFO - moztest == 0.8 17:33:49 INFO - mozversion == 1.4 17:33:49 INFO - psutil == 3.1.1 17:33:49 INFO - requests == 1.2.3 17:33:49 INFO - wsgiref == 0.1.2 17:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:49 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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:49 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 17:33:49 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 17:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:49 INFO - 'HOME': '/Users/cltbld', 17:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:49 INFO - 'LOGNAME': 'cltbld', 17:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:49 INFO - 'MOZ_NO_REMOTE': '1', 17:33:49 INFO - 'NO_EM_RESTART': '1', 17:33:49 INFO - 'PAGER': '/bin/cat', 17:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:49 INFO - 'PWD': '/builds/slave/test', 17:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:49 INFO - 'SHELL': '/bin/bash', 17:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:49 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:49 INFO - 'USER': 'cltbld', 17:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:49 INFO - 'XPC_FLAGS': '0x0', 17:33:49 INFO - 'XPC_SERVICE_NAME': '0', 17:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 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)) 17:33:49 INFO - Cleaning up... 17:33:49 INFO - Return code: 0 17:33:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:33:49 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 0x101582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81cb483260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, '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.gIKchLTbn5/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.eG2IWGaLLV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 17:33:49 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 17:33:49 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 17:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:33:49 INFO - 'HOME': '/Users/cltbld', 17:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:33:49 INFO - 'LOGNAME': 'cltbld', 17:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:49 INFO - 'MOZ_NO_REMOTE': '1', 17:33:49 INFO - 'NO_EM_RESTART': '1', 17:33:49 INFO - 'PAGER': '/bin/cat', 17:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:49 INFO - 'PWD': '/builds/slave/test', 17:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:33:49 INFO - 'SHELL': '/bin/bash', 17:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:33:49 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:33:49 INFO - 'USER': 'cltbld', 17:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:49 INFO - 'XPC_FLAGS': '0x0', 17:33:49 INFO - 'XPC_SERVICE_NAME': '0', 17:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:33:49 INFO - Cleaning up... 17:33:49 INFO - Return code: 0 17:33:49 INFO - Running post-action listener: _resource_record_post_action 17:33:49 INFO - Running post-action listener: _start_resource_monitoring 17:33:49 INFO - Starting resource monitoring. 17:33:49 INFO - [mozharness: 2017-04-29 00:33:49.642398Z] Finished create-virtualenv step (success) 17:33:49 INFO - [mozharness: 2017-04-29 00:33:49.643423Z] Running install step. 17:33:49 INFO - Running pre-action listener: _resource_record_pre_action 17:33:49 INFO - Running main action method: install 17:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:49 INFO - Reading from file tmpfile_stdout 17:33:49 INFO - Detecting whether we're running mozinstall >=1.0... 17:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:33:50 INFO - Reading from file tmpfile_stdout 17:33:50 INFO - Output received: 17:33:50 INFO - Usage: mozinstall [options] installer 17:33:50 INFO - Options: 17:33:50 INFO - -h, --help show this help message and exit 17:33:50 INFO - -d DEST, --destination=DEST 17:33:50 INFO - Directory to install application into. [default: 17:33:50 INFO - "/builds/slave/test"] 17:33:50 INFO - --app=APP Application being installed. [default: firefox] 17:33:50 INFO - mkdir: /builds/slave/test/build/application 17:33:50 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'] 17:33:50 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 17:34:09 INFO - Reading from file tmpfile_stdout 17:34:09 INFO - Output received: 17:34:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:34:09 INFO - Running post-action listener: _resource_record_post_action 17:34:09 INFO - [mozharness: 2017-04-29 00:34:09.436953Z] Finished install step (success) 17:34:09 INFO - [mozharness: 2017-04-29 00:34:09.437078Z] Running run-tests step. 17:34:09 INFO - Running pre-action listener: _resource_record_pre_action 17:34:09 INFO - Running main action method: run_tests 17:34:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:34:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:34:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:34:09 INFO - 2017-04-28 17:34:09.452 screenresolution[2845:34538] starting screenresolution argv=screenresolution get 17:34:09 INFO - 2017-04-28 17:34:09.455 screenresolution[2845:34538] Display 0: 1600x1200x32@60 17:34:09 INFO - 2017-04-28 17:34:09.461 screenresolution[2846:34541] starting screenresolution argv=screenresolution list 17:34:09 INFO - Available Modes on Display 0 17:34:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:34:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:34:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:34:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:34:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:34:09 INFO - Intel Iris: 17:34:09 INFO - Chipset Model: Intel Iris 17:34:09 INFO - Type: GPU 17:34:09 INFO - Bus: Built-In 17:34:09 INFO - VRAM (Dynamic, Max): 1536 MB 17:34:09 INFO - Vendor: Intel (0x8086) 17:34:09 INFO - Device ID: 0x0a2e 17:34:09 INFO - Revision ID: 0x0009 17:34:09 INFO - Displays: 17:34:09 INFO - Display: 17:34:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:34:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:34:09 INFO - Display Serial Number: 1600x1200 60 17:34:09 INFO - Main Display: Yes 17:34:09 INFO - Mirror: Off 17:34:09 INFO - Online: Yes 17:34:09 INFO - Rotation: Supported 17:34:09 INFO - Return code: 0 17:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:34:09 INFO - Python 2.7.3 17:34:09 INFO - Return code: 0 17:34:09 INFO - grabbing minidump binary from tooltool 17:34: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')]} 17:34:09 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 0x101360d30>, '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 0x101286db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101355be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:34:09 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 17:34:09 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 17:34:09 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 17:34:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:34:09 INFO - Return code: 0 17:34:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:34:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:34:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:34:09 INFO - ENV: RUST_BACKTRACE is now 1 17:34:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:34:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:34:09 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 17:34:09 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0039 --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 17:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIKchLTbn5/Render', 17:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:09 INFO - 'HOME': '/Users/cltbld', 17:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:09 INFO - 'LOGNAME': 'cltbld', 17:34:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:34:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:09 INFO - 'MOZ_NO_REMOTE': '1', 17:34:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:34:09 INFO - 'NO_EM_RESTART': '1', 17:34:09 INFO - 'PAGER': '/bin/cat', 17:34:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:09 INFO - 'PWD': '/builds/slave/test', 17:34:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:09 INFO - 'RUST_BACKTRACE': '1', 17:34:09 INFO - 'SHELL': '/bin/bash', 17:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG2IWGaLLV/Listeners', 17:34:09 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 17:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:09 INFO - 'USER': 'cltbld', 17:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:09 INFO - 'XPC_FLAGS': '0x0', 17:34:09 INFO - 'XPC_SERVICE_NAME': '0', 17:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:09 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://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 17:34:10 INFO - mozversion application_buildid: 20170428075320 17:34:10 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:34:10 INFO - mozversion application_display_name: Nightly 17:34:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:34:10 INFO - mozversion application_name: Firefox 17:34:10 INFO - mozversion application_remotingname: firefox 17:34:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:34:10 INFO - mozversion application_vendor: Mozilla 17:34:10 INFO - mozversion application_version: 55.0a1 17:34:10 INFO - mozversion platform_buildid: 20170428075320 17:34:10 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:34:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:34:10 INFO - mozversion platform_version: 55.0a1 17:34:10 INFO - using testdate: 1493426050 17:34:10 INFO - actual date: 1493426050 17:34:10 INFO - starting webserver on 'localhost:50188' 17:34:10 INFO - SUITE-START | Running 2 tests 17:34:10 INFO - TEST-START | dromaeo_css 17:34:10 INFO - operating with platform_type : mac_ 17:34:10 INFO - Initialising browser for dromaeo_css test... 17:34:10 INFO - TEST-INFO | started process 2856 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpeujtMv/profile http://localhost:50188/getInfo.html) 17:34:12 INFO - PID 2856 | 2017-04-28 17:34:12.701 plugin-container[2857:34698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x964b, name = 'com.apple.tsm.portname' 17:34:12 INFO - PID 2856 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:12 INFO - PID 2856 | 2017-04-28 17:34:12.704 plugin-container[2857:34698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0f, name = 'com.apple.CFPasteboardClient' 17:34:12 INFO - PID 2856 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:12 INFO - PID 2856 | 2017-04-28 17:34:12.704 plugin-container[2857:34698] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:34:12 INFO - PID 2856 | __metrics Screen width/height:1600/1200 17:34:12 INFO - PID 2856 | colorDepth:24 17:34:12 INFO - PID 2856 | Browser inner width/height: 1024/689 17:34:12 INFO - PID 2856 | __metrics 17:34:12 ERROR - PID 2856 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:34:13 INFO - TEST-INFO | 2856: exit 0 17:34:13 INFO - Browser initialized. 17:34:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:34:13 INFO - TEST-INFO | started process 2858 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpeujtMv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:16 INFO - PID 2858 | 2017-04-28 17:34:16.036 plugin-container[2859:34829] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464b, name = 'com.apple.tsm.portname' 17:34:16 INFO - PID 2858 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:16 INFO - PID 2858 | 2017-04-28 17:34:16.038 plugin-container[2859:34829] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 17:34:16 INFO - PID 2858 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:34:16 INFO - PID 2858 | 2017-04-28 17:34:16.038 plugin-container[2859:34829] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:34:26 INFO - PID 2858 | RSS: Main: 253030400 17:34:26 INFO - PID 2858 | 17:37:30 INFO - PID 2858 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50188/tests/dromaeo/cssquery-ext.html) 17:37:32 INFO - PID 2858 | RSS: Main: 255574016 17:37:32 INFO - PID 2858 | 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | A coding exception was thrown and uncaught in a Task. 17:39:14 INFO - PID 2858 | 17:39:14 ERROR - PID 2858 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:39:14 INFO - PID 2858 | Full stack: 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | A coding exception was thrown and uncaught in a Task. 17:39:14 INFO - PID 2858 | 17:39:14 ERROR - PID 2858 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:39:14 INFO - PID 2858 | Full stack: 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | A coding exception was thrown and uncaught in a Task. 17:39:14 INFO - PID 2858 | 17:39:14 ERROR - PID 2858 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:39:14 INFO - PID 2858 | Full stack: 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | ************************* 17:39:14 INFO - PID 2858 | A coding exception was thrown and uncaught in a Task. 17:39:14 INFO - PID 2858 | 17:39:14 ERROR - PID 2858 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:39:14 INFO - PID 2858 | Full stack: 17:39:14 INFO - PID 2858 | ************************* 17:40:34 INFO - PID 2858 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-ext.html (next: http://localhost:50188/tests/dromaeo/cssquery-jquery.html) 17:40:34 INFO - PID 2858 | RSS: Main: 260845568 17:40:34 INFO - PID 2858 | 17:43:36 INFO - PID 2858 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50188/tests/dromaeo/cssquery-mootools.html) 17:43:37 INFO - PID 2858 | RSS: Main: 269651968 17:43:37 INFO - PID 2858 | 17:46:38 INFO - PID 2858 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50188/tests/dromaeo/cssquery-prototype.html) 17:46:39 INFO - PID 2858 | RSS: Main: 263143424 17:46:39 INFO - PID 2858 | 17:49:42 INFO - PID 2858 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50188/tests/dromaeo/cssquery-yui.html) 17:49:42 INFO - PID 2858 | RSS: Main: 272277504 17:49:42 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-yui.html (next: http://localhost:50188/tests/dromaeo/cssquery-dojo.html) 17:52:44 INFO - PID 2858 | RSS: Main: 267259904 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | __start_tp_report 17:52:44 INFO - PID 2858 | _x_x_mozilla_page_load 17:52:44 INFO - PID 2858 | _x_x_mozilla_page_load_details 17:52:44 INFO - PID 2858 | |i|pagename|runs| 17:52:44 INFO - PID 2858 | |0;dojo.html;3561.483584880192;3564.48314994326;3602.1895073608457;3606.459031145328;3623.6014038455764;6105.145279660851;6186.659733714644;6228.314885362613;6233.875322493553;6293.496520278378;6171.259448866131;6185.814425567229;6230.688465576725;6273.717682704278;6274.811755647338;5388.164834450667;5417.891642167155;5435.945640543583;5470.753816078286;5576.832695019156;5390.865228369303;5473.972630136864;5558.722063896809;5562.276904002474;5588.050031494656;5436.2661040759385;5454.481824226692;5501.724913754317;5507.752151153188;5533.059379905406;5314.654547454403;5450.5639548836;5458.754356053987;5460.372057213432;5464.808731694372;5400.594955378362;5406.702631355274;5468.507834294893;5470.671759694431;5474.042042642562;4652.58126768589;6165.784197553064;6177.351378105324;6188.257409110891;6212.9068063979075;5493.862653433656;6582.93417065828;6591.077249185118;6595.670216489157;6600.7689730859665;6520.054592084169;6573.408393244631;6585.637789921552;6642.800715978528;6774.762883299061;6258.311585725566;6303.275123360826;6332.68336583169;6333.809985700436;6340.397662222128;6932.896006559906;6937.861242775116;6938.444924406035;6949.235584085746;6950.992106144581;6346.492280617539;6452.645104519296;6459.515536334794;6575.079488871562;6601.504887133388;6660.9000864987065;6707.396334329934;6720.361565651256;6736.090627765287;6776.05135281061;6637.502187335969;6674.332566743286;6679.799606011828;6684.899726504106;6689.264180940093;6419.903701444482;6609.20689517261;6706.83232919181;6737.663116844138;6738.663066846638;5270.92093618596;5291.391489978625;5294.682319060792;5342.332208473941;5420.91868621971;4079.551249362568;4717.938463845608;4746.833860814855;4757.500462451462;4859.441164266154;6205.441510264098;6291.465225455888;6411.326810684905;6412.006139048455;6431.421172094534;6473.482121430275;6492.707828147744;6773.559718618274;6774.051632771416;6793.252742198354;5469;6336.968315158487;6378.457831084317;6397.040443933447;6409.67951602418;4950.331705219821;5904.084866845646;5906.527477801766;5932.614380065368;5971.343152253248;5736.225609542742;6933.618650974245;6949.30506949301;7004.474664400191;7031;5530.810875661752;5724.971375143097;6461.483081353575;6510.251321098134;6697.933020669731;6974.407175389946;6995.545289556163;6999.440044796303;7009.12385951756;7037.859242815012;6642.43539299165;6644.767433139817;6696.029075784081;6705.430038446787;6709.329067093252;6490.967545162244;6777.728890844508;6798.592084474947;6800.829979250559;6816.522843400914;6386.074019267087;6432.324605916311;6512.994508377408;6563.474922006323;6669.899951500634;6299.370062993664;6334.429901308904;6375.9362406377195;6584.374484423972;6604.0093985902495;4942.777575009061;6290.465310448663;6436.420722135031;6471.482281417381;6471.676416179078;6051.909221361595;6575.63833989116;6602.504812139013;6616.7022483987375;6620.966895165686;6257.7184026718;6354.092233276409;6355.078513615592;6360.395762402564;6430.356964303719 17:52:44 INFO - PID 2858 | |1;ext.html;758.9033846092395;815.5962798414786;836.569166879057;1202.8075507918734;1253.6552448076773;36566.45150322747;37813.86558403252;37871.24257514848;37880.43179352309;37924.43113353295;38252.42621360682;38538;38639.80680096603;38647.227055458876;38673;6972.790816275495;7719.382449404062;8206.22040906113;8410.663573457054;8420.368472364567;8436.957815210915;8445.408821382505;8479.872801907946;8550.315974722007;8567.485950842938;8562.443441176303;8563.95718021409;8579.056303806576;8581.313494920392;8609.784755381133;8486.575671216415;8533.232009119178;8557.828843423158;8572.185642363966;8582.013068497141;8381.49711017341;8392.286655634278;8448.619812108409;8451.830963380698;8467.661293548312;36636;36679;36769.63230367689;36777.264454710756;36987.4451883222;3622.9094272643133;3667.2482141161;3668.064643515913;3671.1189314564313;3672.6143754905884;27352;28053.438931221466;30264.54603180954;30370;30425.391492170034;3133.6082989626298;3155.7475401967786;3162.968370316313;3185.7769956103084;3197.888073917402;212565;233197;239455;296790;297243;38966.415503767465;47061.5293847064;47438;47544.5245547547;47547.762261189164;44787;49101.16179087799;49121.263181052316;49559;49736.751316243186;14195.716085678228;14196.787048194285;14340.426382944564;14348.641283967985;14358.784618230735;11802;11816.704582385337;11820.113491488;11888.167828252112;11891.643250702493;13448.731025379439;13490;13490.932545337408;13499.190048597116;13619.114757540729;4895.31465594817;5793.275840519935;5868.471837534642;5873.3245676746865;5880.970595147082;959.9760005999906;981.4552923127733;993.4734590666958;1007.2395341517108;1031.6389263757624;21964;22805.543889122124;23573;24122.155724549906;24367.634485482733;1105.8064838653204;1106.673531308266;1113.3653817324048;1137.3517095255625;1149.683836944847;12255.938720306342;12339;12362.072844536695;12396.566120185751;12434.502619895104;242754;323496;324489.3979770916;324883;325740;49506.504934950186;53433.7328313356;53474;53517;53561.73219133879;1503.624093976506;1548.5973646851673;1558.7661850722257;1558.8129424469137;1563.8201606815362;21761.564768704222;22654.886725566925;23504;23520.94155763029;23597;30919.690803091682;31771.20571985719;38286.80856595699;38348.84953451401;38424;289477.10522894503;289832;291019;291044;292673;33018.17454563655;33785;34584.61661533511;34604.82697586496;34651;42515;43072.78463607662;44255;44336.556634434535;44402.77798610986;24075.672351021327;24508.877455612608;28139.437211255252;28306.2923426916;30871.382572348877;29357;29735.553966690084;30221.546676800306;30417.695823041486;30504;36447.63552364442;36665.81667091754;36713.08217294589;36732.81633591815;36824.81587592045;25126.545844334247;28928.710712893444;30301.696983029888;30768;31044.844775775975;20141.395758126695;21633.783662163176;23797.762022379553;24209;24237 17:52:44 INFO - PID 2858 | |2;jquery.html;403.3002740245675;437.5165442186384;440.97354158750477;459.6644449551827;460.1280573313569;17995.19021644026;19377.709334359995;19765.703514447276;22231.1107555698;22374.66438003431;21609.1356345746;22885.4278643034;23244;23564.88217558914;23566.882165589148;6117.908231376522;6389.169407976957;6395.360463953591;6421.004744264623;6429.7106630201515;6035.094735789623;6342.904856427157;6362.618242905441;6372.012338087604;6374;6255.718492667841;6284.591501552384;6313.084602732601;6326.272478664943;6361.173047503818;6163.229596300463;6277.654728989904;6312.589681670676;6315.65263910487;6317.273513545955;4848.951510484885;5497.862553436156;5556.472135147154;5609.270794796691;5625.971870140664;26901.327466813487;27081;27454.5881811773;27665.03172388977;27906.860465697744;1955.2276850643916;2184.4429670433938;2236.474428509299;2238;2250.5386395788823;17502.91248543749;17631.118444077743;17651.470455886345;18107.818921810744;18305.7254141188;2177.2270843850365;2187.5296811185513;2230.163688616769;2231.765664605209;2234.1510226114137;155909;156423;158029.20985395;159179;160507.1974640131;11816.46825892837;11920.284782913053;12287.324197169242;12983.091183617056;13033;16569.585760356087;16841.747373789403;16932.661346772995;16941.91529042347;16961.830381696273;8516.1058088901;8670.479771213748;8714.69498567547;8772.210501054935;8870.467771933705;7987.1613480584865;8019.238172373615;8047.195280472023;8181.795455113551;8217.671293148207;6314.179156709598;7873.921260787319;7937.880931786028;7940.682372705027;7978.481398709181;1840.5490654789394;2170.7069545611457;2177.531830656385;2181.1384503121494;2373.9762602373753;958.7842735384482;964.5483547261326;968.7965527239359;1000.2198285337448;1005.2862467647906;20544.178232870818;20803.479913001993;20911.68632470514;21248.78751212499;21327.46681332948;822.6914906909909;881.7046289493092;978.021978021978;1004.864343313658;1026.5688410867454;10439.37363758177;10948;10962.725931851768;10974.725631859108;11022.889771102185;516177;525885;530380;533825;534971.3251433718;123902;125541;125915.3704231473;132416;136306.95539566915;1117.3686866920164;1153.867305259889;1161.6921515798151;1236.7959286717592;1247.875212478763;19090.33183838559;21140.78859211388;21591.676124858455;22774.430639234153;22825.972831222967;56043.71978140083;56122.94893459608;56716.86566268569;57371.713141434026;57416.1387579195;51372.74313628557;79491.20508794839;80349.59825200836;81490.37019259464;82614.58692706499;8984.955075224581;9007.279417646441;9067;9182;9262.675806346746;14092.436302547783;14161.716765664834;14341.85658143447;14531.854681453473;14596.92701536528;10035.795704515505;11053.336799792038;11358.807325231062;11844.585439509576;12096.274223546616;9485.810283794148;11386.658400248005;11420.885791141982;11501.137414693763;11654.650360489199;11985.940070299594;12197.817032744693;12248.938755306523;12409.62771116868;12477.688057798265;8887.777805554913;8977.326700497359;9093.22707569864;9141.542922853963;9281.48951807657;10082.747931301776;11805;12059.457324420247;12229.082818788804;12276.754464910473 17:52:44 INFO - PID 2858 | |3;mootools.html;1310.5806142034542;1390.2562129260843;1428.6785473268517;1457.6720237946463;1463.4292625875908;11146.21976461648;11641.35972521513;11658.708532286686;11661.242019268751;11996.100292478055;11641.883581164186;11689.240199387033;11810.933086709834;11817.231879927798;11843.170978031541;2501.32464234657;2560.116759717894;2561.7950563954837;2566.358410397401;2566.8074894382903;2483.950320993579;2515.4717509322973;2518.6725725655638;2526.557852375836;2527.936801579957;2107.2729908181655;2477.962830557543;2503.6119401492797;2513.447041650834;2543.8346507476954;2236.552689462114;2256.402053455827;2459.520393523255;2507.1726330311135;2513.560126977781;2066.52469931915;2147.9892600537055;2409.72288186859;2489.850608963468;2506.3358210074343;11659.417029148508;11762.294262344201;11818.349990750505;11883.702907427298;11905.523779048828;5740.54075673945;6739.595624262511;6773.983902414677;6777.864442711168;6793.966030169867;3977.8806635800684;4335.219660461115;4376.277914144162;4411.426514553087;4433.290673492225;1268.4926029588146;1272.0968112640037;1288.581211106385;1317.5059352742721;1323.7286356296936;14455.27723613815;14948.430414806397;16464.75302870446;16561;16578.66842663152;4559.361689363492;5334.546563542065;5377.0321342158;5487;5617.494425501724;11783.941080294544;11797.52809887595;11864.050875929905;11874.1094417919;11897.107716921266;6510.9023364649565;6517.51118666102;6530.444912182517;6532.346765323429;6535.901961470582;6019.939800601938;6068.666223357669;6079.331273559905;6159.630422174684;6187.288461826857;3606.6573675500786;4211.55778643238;4309.741415515079;4322.481302243688;4445.955540444555;1164.4818055965184;1169.3626973299572;1183.148133343991;1184.644606618011;1185.5731936502852;751.5490705576719;761.9619019049026;792.2790260862587;793.6190628498354;793.6944276453607;5217.321748172713;5841.970790146022;6577.243616984012;6832.760853370109;6963.651817409109;927.2396634759567;955.5986485676033;958.8657587937695;962.855571664242;981.8085473332775;3815.5993620669983;3853.9421908671393;4255.914881702349;4395.494518130392;4406.515283318832;14646.26768661584;14719.190444525653;14932.925335373253;14940.850591494163;14957.952943293865;11535.653930381934;14025;14792.704145917021;14837.629059273604;14885.479008234659;8184.877226841602;8388.035375931846;8530.530820804915;8569.871451928226;8625.956870215734;6664.400203981665;6791;6865.141857267841;6882.277360877036;6922.826929326606;13017.609471715863;13070.869291306964;13140.474381025035;13179.868201317864;13521.661958451117;13424.463021479422;13521.391537381038;13596.252206128758;13629;13726;8927.553622318988;9199.724008279762;9202.171804537624;9206.585703643486;9217.44695318283;10444.895551044696;10542.472876356305;10698;10701.946490267499;10721.088707459954;8967.417117887317;9013.774655633399;9098.90901091007;9195;9205.58574864146;8676.479411235347;8756.25571826402;8771.156427541806;8783.868241976248;8935;6816.386525212556;7996.680132794623;8129.512229266263;8148.1037085919315;8162.265396114378;5405.351357837085;5948.375420580776;6012.368701286302;6071.635701857903;6115.1438798569125;6012.278526576664;6075.7569697213385;6117.1741814856205;6188.690565471798;6303.842403939755 17:52:44 INFO - PID 2858 | |4;prototype.html;343.3853402409687;385.31029457271484;400.9859654912079;411.9917601647967;413.144790284112;5413.404525502192;5481.205225242337;6052.6368417894955;6254.312025677177;6262.152664963835;4661.078298726388;5849.894038146264;5960.374160713128;6056.364081771406;6099.756009759615;3862.94205586915;4419.160359531695;4439.822407103728;4444.977775111136;4445.22208613493;4372.2785740352965;4376.606105450524;4378.934315985262;4442.577955094277;4499.46006479223;4359.346098085281;4379.226413302602;4384.057427653054;4391;4392.011797345604;3789.919872836242;3943.921121577552;4031.475908131939;4386.254336762758;4392.297232442826;3128.5307203919365;3254.739620830328;3646.9241573735544;3650.2881938022097;3726.6273372662786;5870.823875283749;5876.853078673024;5909.793157239519;5982.52139828817;6004.669743164124;5189.221616757516;5206.95860827836;5216.37403511581;5250.9737451312885;5257.237700533439;5991.191189189491;6434.742610295582;6457.3865482779065;6460.93539064608;6499.447546958514;3564.3762341590377;4233.872983810491;4242.575742425764;4245.448091748084;4254.510731265913;6009.669468179249;6667.533272670915;6842.623655698934;6864.7940561782725;6920.446364290895;3610.819459027038;3620.855165793339;4271.337942618899;4324.308110702273;4335.631471324909;4401.647868170603;4403.8018289176425;4409.2724700424715;4414.205443020223;4420.668449866273;5098;5203.687778733288;5214.2960700304975;5232.712200828915;5261.316028916293;5190.091733946544;5702.486776190163;6506.299885547445;6513.804585862337;6514.804555863332;1261.1928365845865;1319.4194554396227;1477.7118461899827;1478.7929689843431;1500.0999400359915;953.1040821627786;963.4219468318953;970.2819913264134;971.9076687714655;988.649029594498;6039.577229593974;6205.410486003822;6206.782762603378;6241.812745617639;6271.184745982993;6478.870422591522;6487.578307410004;6505.739770409131;6520.054592084121;6738.35985581369;5926.970365148147;5966.43318884714;6170.598911070766;6205.751769929152;6216.191895053705;2864.6132772075503;3286.5398844161837;3508.8947331580093;3556.093196234995;3560.661737134968;6018.14631905359;6284.685765711788;6987.161540615159;7006.579605223601;7015.508914376047;6362.013887847391;6498.480121590356;6581.964796930352;6953.582785032914;6965.965170174117;6882.692288465176;6928.930710692929;6948.062011628567;6989.825254368681;7082.256363081905;5695.572832037531;6672;6745.5952642841585;6782.828560435395;6791.04925310447;5462.317210348707;5952.970235148797;6055.515558755201;6535.967320163369;6798.796036118924;7120.7894657907245;7162.498625096193;7177.662386990075;7192.31672991065;7196.640167991684;3884.572697003384;4357.89105272358;4367.606915377632;4379.518252992232;4397.604215620481;6288.460001598287;6820.3861652451515;6833.180018397626;6834.794956151323;6943.479239057192;5761.567882408753;5985.431384018511;6584.868302634016;6596.90104648421;6638.800835974928;5883.852903677443;6323.2294957412;6339.302676705651;6561.475081993333;6682.997550367484;6528.771492997722;6532.477401807939;6545.738170473318;6547.755926373974;6563.914959968807;5627.831165065055;6296.653684047421;6536.640484773383;6551.836204094936;6717.865642687217;5685.630434021776;5988.760449581968;6362.936370636419;6373.458256048288;6381.744730210925 17:52:44 INFO - PID 2858 | |5;yui.html;839.2782207301723;846.7671390367648;850.9149085091492;865.0786911938785;873.8164985353073;14705.411783528672;14933.178675172861;16759.748603770953;17207.913960430196;17225.483235502925;13649.590512284647;14089.29553522325;18310;18327.633447331078;18351.90824045878;971.1502435369052;975.3806332978575;987.2694206287332;996.1881066930465;998.8501724741311;969.6606187834237;1000.104906109032;1003.3779056984644;1003.64872294697;1004.9799004019915;1009.8790342719575;1047.748540350318;1056.9800142862136;1057.857189279449;1060.803751306007;1041.3231399590252;1051.9737006574821;1052.184556968352;1053.7260312318776;1055.530289021386;747.7457664394078;758.0600055930662;761.5240474703311;762.9890395226347;766.057748968766;16433.83566164335;16724.83275167257;16862.072586007765;17126.972381657142;17438;17139;17221.827781722146;17552;17554.03452810095;17659.20533575992;13898.305084745722;14025.228612426312;14041.297935103306;14143.929280353635;14244.430222791076;3368.2421455172635;3397.8640854365794;3405.3189362127673;3409.6760807723226;3409.6931276185014;114471.85528144779;127296;137773;139067;140980;13519.256440895846;13855.653608659864;13966.650833729034;14152.64618384528;14162.787558186636;25837.354066148495;25906.22281331563;26161.869190654306;26179.083732069666;26241.21276361712;7986.800329991681;8039.8794018089775;8069.596520173968;8073.434859559775;8099.676012959416;3968.980155099206;3979.3633018716864;3984.1633257015774;4011.117554138085;4052.068024354415;4367.432233809584;4455.532169122195;4456.77716114193;4457.3091170868565;4463.933041004322;817.2522142239903;960.2893858544627;963.9951800241095;973.9610415583439;981.3179840011123;651.9054737063194;669.7220653428773;679.3003206697011;683.3576438148125;693.5873155472486;11591.710207244887;11839.58561450345;12032.81950770739;12179.573714919936;13137.211767293802;576.2595065341017;598.3059650805045;635.4535099814157;649.95775274607;665.3047565294279;4954.950450495521;5272.894542109137;5366.570674346043;5734.340550836624;5745.592329879207;105184;105743;105796;106252.46873765581;108226;71249;90897;91084.54457727668;91578.54210729037;93827.53086234526;80896.52827773764;81489.59255203686;81661.77507337395;82166.89165541698;82314.17685823065;10966.835497467384;11197.104231661611;11429.371384573928;11563;11567.248128871597;38270.8086459577;38625;38877.80561097289;38993.80503097466;39702;29518.852405737834;49161.26258106203;49728;50340.74829625829;50683.74658126686;14528.346224419714;14588.781168282696;14632.853671463576;14670.779938301148;14855.628609284422;15131.167785771888;15331.386744530093;15692.92153539225;15713.842861571238;15779.921100394884;14682;14711;14802.333894974536;15043.774343385077;15137.924310378377;12096.75806483883;14366.497172598909;14469.131852088909;14703.485378012147;14767.335469903664;12534.686632834251;12731.363431828186;12866.549670761478;12872.613821585368;12874.16317939331;10860.294080884718;11174.608888688857;11794.351310677652;11862.525498979945;11929.9859511939;12817.551385701456;12948.8057679133;12969.870301297244;12984.610461686165;13002.414891330101 17:52:44 INFO - PID 2858 | __end_tp_report 17:52:44 INFO - PID 2858 | __start_cc_report 17:52:44 INFO - PID 2858 | _x_x_mozilla_cycle_collect,430 17:52:44 INFO - PID 2858 | __end_cc_report 17:52:44 INFO - PID 2858 | __startTimestamp1493427164867__endTimestamp 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | ------- Summary: start ------- 17:52:44 INFO - PID 2858 | Number of tests: 6 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | [#0] dojo.html Cycles:165 Average:6126.27 Median:6360.40 stddev:746.82 (11.7%) stddev-sans-first:721.49 17:52:44 INFO - PID 2858 | Values: 3561.5 3564.5 3602.2 3606.5 3623.6 6105.1 6186.7 6228.3 6233.9 6293.5 6171.3 6185.8 6230.7 6273.7 6274.8 5388.2 5417.9 5435.9 5470.8 5576.8 5390.9 5474.0 5558.7 5562.3 5588.1 5436.3 5454.5 5501.7 5507.8 5533.1 5314.7 5450.6 5458.8 5460.4 5464.8 5400.6 5406.7 5468.5 5470.7 5474.0 4652.6 6165.8 6177.4 6188.3 6212.9 5493.9 6582.9 6591.1 6595.7 6600.8 6520.1 6573.4 6585.6 6642.8 6774.8 6258.3 6303.3 6332.7 6333.8 6340.4 6932.9 6937.9 6938.4 6949.2 6951.0 6346.5 6452.6 6459.5 6575.1 6601.5 6660.9 6707.4 6720.4 6736.1 6776.1 6637.5 6674.3 6679.8 6684.9 6689.3 6419.9 6609.2 6706.8 6737.7 6738.7 5270.9 5291.4 5294.7 5342.3 5420.9 4079.6 4717.9 4746.8 4757.5 4859.4 6205.4 6291.5 6411.3 6412.0 6431.4 6473.5 6492.7 6773.6 6774.1 6793.3 5469.0 6337.0 6378.5 6397.0 6409.7 4950.3 5904.1 5906.5 5932.6 5971.3 5736.2 6933.6 6949.3 7004.5 7031.0 5530.8 5725.0 6461.5 6510.3 6697.9 6974.4 6995.5 6999.4 7009.1 7037.9 6642.4 6644.8 6696.0 6705.4 6709.3 6491.0 6777.7 6798.6 6800.8 6816.5 6386.1 6432.3 6513.0 6563.5 6669.9 6299.4 6334.4 6375.9 6584.4 6604.0 4942.8 6290.5 6436.4 6471.5 6471.7 6051.9 6575.6 6602.5 6616.7 6621.0 6257.7 6354.1 6355.1 6360.4 6430.4 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | [#1] ext.html Cycles:180 Average:43357.25 Median:179379.09 stddev:75286.20 (42.0%) stddev-sans-first:75429.46 17:52:44 INFO - PID 2858 | Values: 758.9 815.6 836.6 1202.8 1253.7 36566.5 37813.9 37871.2 37880.4 37924.4 38252.4 38538.0 38639.8 38647.2 38673.0 6972.8 7719.4 8206.2 8410.7 8420.4 8437.0 8445.4 8479.9 8550.3 8567.5 8562.4 8564.0 8579.1 8581.3 8609.8 8486.6 8533.2 8557.8 8572.2 8582.0 8381.5 8392.3 8448.6 8451.8 8467.7 36636.0 36679.0 36769.6 36777.3 36987.4 3622.9 3667.2 3668.1 3671.1 3672.6 27352.0 28053.4 30264.5 30370.0 30425.4 3133.6 3155.7 3163.0 3185.8 3197.9 212565.0 233197.0 239455.0 296790.0 297243.0 38966.4 47061.5 47438.0 47544.5 47547.8 44787.0 49101.2 49121.3 49559.0 49736.8 14195.7 14196.8 14340.4 14348.6 14358.8 11802.0 11816.7 11820.1 11888.2 11891.6 13448.7 13490.0 13490.9 13499.2 13619.1 4895.3 5793.3 5868.5 5873.3 5881.0 960.0 981.5 993.5 1007.2 1031.6 21964.0 22805.5 23573.0 24122.2 24367.6 1105.8 1106.7 1113.4 1137.4 1149.7 12255.9 12339.0 12362.1 12396.6 12434.5 242754.0 323496.0 324489.4 324883.0 325740.0 49506.5 53433.7 53474.0 53517.0 53561.7 1503.6 1548.6 1558.8 1558.8 1563.8 21761.6 22654.9 23504.0 23520.9 23597.0 30919.7 31771.2 38286.8 38348.8 38424.0 289477.1 289832.0 291019.0 291044.0 292673.0 33018.2 33785.0 34584.6 34604.8 34651.0 42515.0 43072.8 44255.0 44336.6 44402.8 24075.7 24508.9 28139.4 28306.3 30871.4 29357.0 29735.6 30221.5 30417.7 30504.0 36447.6 36665.8 36713.1 36732.8 36824.8 25126.5 28928.7 30301.7 30768.0 31044.8 20141.4 21633.8 23797.8 24209.0 24237.0 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | [#2] jquery.html Cycles:180 Average:35055.79 Median:12512.48 stddev:90037.68 (719.6%) stddev-sans-first:90252.67 17:52:44 INFO - PID 2858 | Values: 403.3 437.5 441.0 459.7 460.1 17995.2 19377.7 19765.7 22231.1 22374.7 21609.1 22885.4 23244.0 23564.9 23566.9 6117.9 6389.2 6395.4 6421.0 6429.7 6035.1 6342.9 6362.6 6372.0 6374.0 6255.7 6284.6 6313.1 6326.3 6361.2 6163.2 6277.7 6312.6 6315.7 6317.3 4849.0 5497.9 5556.5 5609.3 5626.0 26901.3 27081.0 27454.6 27665.0 27906.9 1955.2 2184.4 2236.5 2238.0 2250.5 17502.9 17631.1 17651.5 18107.8 18305.7 2177.2 2187.5 2230.2 2231.8 2234.2 155909.0 156423.0 158029.2 159179.0 160507.2 11816.5 11920.3 12287.3 12983.1 13033.0 16569.6 16841.7 16932.7 16941.9 16961.8 8516.1 8670.5 8714.7 8772.2 8870.5 7987.2 8019.2 8047.2 8181.8 8217.7 6314.2 7873.9 7937.9 7940.7 7978.5 1840.5 2170.7 2177.5 2181.1 2374.0 958.8 964.5 968.8 1000.2 1005.3 20544.2 20803.5 20911.7 21248.8 21327.5 822.7 881.7 978.0 1004.9 1026.6 10439.4 10948.0 10962.7 10974.7 11022.9 516177.0 525885.0 530380.0 533825.0 534971.3 123902.0 125541.0 125915.4 132416.0 136307.0 1117.4 1153.9 1161.7 1236.8 1247.9 19090.3 21140.8 21591.7 22774.4 22826.0 56043.7 56122.9 56716.9 57371.7 57416.1 51372.7 79491.2 80349.6 81490.4 82614.6 8985.0 9007.3 9067.0 9182.0 9262.7 14092.4 14161.7 14341.9 14531.9 14596.9 10035.8 11053.3 11358.8 11844.6 12096.3 9485.8 11386.7 11420.9 11501.1 11654.7 11985.9 12197.8 12248.9 12409.6 12477.7 8887.8 8977.3 9093.2 9141.5 9281.5 10082.7 11805.0 12059.5 12229.1 12276.8 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | [#3] mootools.html Cycles:180 Average:7014.14 Median:3711.13 stddev:4419.69 (119.1%) stddev-sans-first:4411.30 17:52:44 INFO - PID 2858 | Values: 1310.6 1390.3 1428.7 1457.7 1463.4 11146.2 11641.4 11658.7 11661.2 11996.1 11641.9 11689.2 11810.9 11817.2 11843.2 2501.3 2560.1 2561.8 2566.4 2566.8 2484.0 2515.5 2518.7 2526.6 2527.9 2107.3 2478.0 2503.6 2513.4 2543.8 2236.6 2256.4 2459.5 2507.2 2513.6 2066.5 2148.0 2409.7 2489.9 2506.3 11659.4 11762.3 11818.3 11883.7 11905.5 5740.5 6739.6 6774.0 6777.9 6794.0 3977.9 4335.2 4376.3 4411.4 4433.3 1268.5 1272.1 1288.6 1317.5 1323.7 14455.3 14948.4 16464.8 16561.0 16578.7 4559.4 5334.5 5377.0 5487.0 5617.5 11783.9 11797.5 11864.1 11874.1 11897.1 6510.9 6517.5 6530.4 6532.3 6535.9 6019.9 6068.7 6079.3 6159.6 6187.3 3606.7 4211.6 4309.7 4322.5 4446.0 1164.5 1169.4 1183.1 1184.6 1185.6 751.5 762.0 792.3 793.6 793.7 5217.3 5842.0 6577.2 6832.8 6963.7 927.2 955.6 958.9 962.9 981.8 3815.6 3853.9 4255.9 4395.5 4406.5 14646.3 14719.2 14932.9 14940.9 14958.0 11535.7 14025.0 14792.7 14837.6 14885.5 8184.9 8388.0 8530.5 8569.9 8626.0 6664.4 6791.0 6865.1 6882.3 6922.8 13017.6 13070.9 13140.5 13179.9 13521.7 13424.5 13521.4 13596.3 13629.0 13726.0 8927.6 9199.7 9202.2 9206.6 9217.4 10444.9 10542.5 10698.0 10701.9 10721.1 8967.4 9013.8 9098.9 9195.0 9205.6 8676.5 8756.3 8771.2 8783.9 8935.0 6816.4 7996.7 8129.5 8148.1 8162.3 5405.4 5948.4 6012.4 6071.6 6115.1 6012.3 6075.8 6117.2 6188.7 6303.8 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | [#4] prototype.html Cycles:180 Average:5228.27 Median:5987.10 stddev:1702.30 (28.4%) stddev-sans-first:1667.13 17:52:44 INFO - PID 2858 | Values: 343.4 385.3 401.0 412.0 413.1 5413.4 5481.2 6052.6 6254.3 6262.2 4661.1 5849.9 5960.4 6056.4 6099.8 3862.9 4419.2 4439.8 4445.0 4445.2 4372.3 4376.6 4378.9 4442.6 4499.5 4359.3 4379.2 4384.1 4391.0 4392.0 3789.9 3943.9 4031.5 4386.3 4392.3 3128.5 3254.7 3646.9 3650.3 3726.6 5870.8 5876.9 5909.8 5982.5 6004.7 5189.2 5207.0 5216.4 5251.0 5257.2 5991.2 6434.7 6457.4 6460.9 6499.4 3564.4 4233.9 4242.6 4245.4 4254.5 6009.7 6667.5 6842.6 6864.8 6920.4 3610.8 3620.9 4271.3 4324.3 4335.6 4401.6 4403.8 4409.3 4414.2 4420.7 5098.0 5203.7 5214.3 5232.7 5261.3 5190.1 5702.5 6506.3 6513.8 6514.8 1261.2 1319.4 1477.7 1478.8 1500.1 953.1 963.4 970.3 971.9 988.6 6039.6 6205.4 6206.8 6241.8 6271.2 6478.9 6487.6 6505.7 6520.1 6738.4 5927.0 5966.4 6170.6 6205.8 6216.2 2864.6 3286.5 3508.9 3556.1 3560.7 6018.1 6284.7 6987.2 7006.6 7015.5 6362.0 6498.5 6582.0 6953.6 6966.0 6882.7 6928.9 6948.1 6989.8 7082.3 5695.6 6672.0 6745.6 6782.8 6791.0 5462.3 5953.0 6055.5 6536.0 6798.8 7120.8 7162.5 7177.7 7192.3 7196.6 3884.6 4357.9 4367.6 4379.5 4397.6 6288.5 6820.4 6833.2 6834.8 6943.5 5761.6 5985.4 6584.9 6596.9 6638.8 5883.9 6323.2 6339.3 6561.5 6683.0 6528.8 6532.5 6545.7 6547.8 6563.9 5627.8 6296.7 6536.6 6551.8 6717.9 5685.6 5988.8 6362.9 6373.5 6381.7 17:52:44 INFO - PID 2858 | 17:52:44 INFO - PID 2858 | [#5] yui.html Cycles:180 Average:21295.01 Median:17223.66 stddev:31070.02 (180.4%) stddev-sans-first:31119.22 17:52:44 INFO - PID 2858 | Values: 839.3 846.8 850.9 865.1 873.8 14705.4 14933.2 16759.7 17207.9 17225.5 13649.6 14089.3 18310.0 18327.6 18351.9 971.2 975.4 987.3 996.2 998.9 969.7 1000.1 1003.4 1003.6 1005.0 1009.9 1047.7 1057.0 1057.9 1060.8 1041.3 1052.0 1052.2 1053.7 1055.5 747.7 758.1 761.5 763.0 766.1 16433.8 16724.8 16862.1 17127.0 17438.0 17139.0 17221.8 17552.0 17554.0 17659.2 13898.3 14025.2 14041.3 14143.9 14244.4 3368.2 3397.9 3405.3 3409.7 3409.7 114471.9 127296.0 137773.0 139067.0 140980.0 13519.3 13855.7 13966.7 14152.6 14162.8 25837.4 25906.2 26161.9 26179.1 26241.2 7986.8 8039.9 8069.6 8073.4 8099.7 3969.0 3979.4 3984.2 4011.1 4052.1 4367.4 4455.5 4456.8 4457.3 4463.9 817.3 960.3 964.0 974.0 981.3 651.9 669.7 679.3 683.4 693.6 11591.7 11839.6 12032.8 12179.6 13137.2 576.3 598.3 635.5 650.0 665.3 4955.0 5272.9 5366.6 5734.3 5745.6 105184.0 105743.0 105796.0 106252.5 108226.0 71249.0 90897.0 91084.5 91578.5 93827.5 80896.5 81489.6 81661.8 82166.9 82314.2 10966.8 11197.1 11429.4 11563.0 11567.2 38270.8 38625.0 38877.8 38993.8 39702.0 29518.9 49161.3 49728.0 50340.7 50683.7 14528.3 14588.8 14632.9 14670.8 14855.6 15131.2 15331.4 15692.9 15713.8 15779.9 14682.0 14711.0 14802.3 15043.8 15137.9 12096.8 14366.5 14469.1 14703.5 14767.3 12534.7 12731.4 12866.5 12872.6 12874.2 10860.3 11174.6 11794.4 11862.5 11930.0 12817.6 12948.8 12969.9 12984.6 13002.4 17:52:44 INFO - PID 2858 | -------- Summary: end -------- 17:52:44 INFO - PID 2858 | 17:52:45 INFO - TEST-INFO | 2858: exit 0 17:52:45 INFO - TEST-OK | dromaeo_css | took 1115493ms 17:52:45 INFO - TEST-START | kraken 17:52:45 INFO - operating with platform_type : mac_ 17:52:45 INFO - Initialising browser for kraken test... 17:52:45 INFO - TEST-INFO | started process 2861 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpAhPKEw/profile http://localhost:50188/getInfo.html) 17:52:47 INFO - PID 2861 | 2017-04-28 17:52:47.883 plugin-container[2862:37185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 17:52:47 INFO - PID 2861 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:47 INFO - PID 2861 | 2017-04-28 17:52:47.885 plugin-container[2862:37185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 17:52:47 INFO - PID 2861 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:47 INFO - PID 2861 | 2017-04-28 17:52:47.885 plugin-container[2862:37185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:52:48 INFO - PID 2861 | __metrics Screen width/height:1600/1200 17:52:48 INFO - PID 2861 | colorDepth:24 17:52:48 INFO - PID 2861 | Browser inner width/height: 1024/689 17:52:48 INFO - PID 2861 | __metrics 17:52:48 ERROR - PID 2861 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:52:49 INFO - TEST-INFO | 2861: exit 0 17:52:49 INFO - Browser initialized. 17:52:49 INFO - Running cycle 1/1 for kraken test... 17:52:49 INFO - TEST-INFO | started process 2863 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpAhPKEw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:52:51 INFO - PID 2863 | 2017-04-28 17:52:51.088 plugin-container[2864:37309] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 17:52:51 INFO - PID 2863 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:51 INFO - PID 2863 | 2017-04-28 17:52:51.088 plugin-container[2864:37309] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 17:52:51 INFO - PID 2863 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:52:51 INFO - PID 2863 | 2017-04-28 17:52:51.089 plugin-container[2864:37309] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:53:01 INFO - PID 2863 | RSS: Main: 251224064 17:53:01 INFO - PID 2863 | 17:53:03 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-beat-detection) 17:53:04 INFO - PID 2863 | RSS: Main: 259772416 17:53:04 INFO - PID 2863 | 17:53:07 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-dft) 17:53:08 INFO - PID 2863 | RSS: Main: 266293248 17:53:08 INFO - PID 2863 | 17:53:11 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-fft) 17:53:11 INFO - PID 2863 | RSS: Main: 261947392 17:53:11 INFO - PID 2863 | 17:53:13 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-oscillator) 17:53:14 INFO - PID 2863 | RSS: Main: 263352320 17:53:14 INFO - PID 2863 | 17:53:16 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:53:17 INFO - PID 2863 | RSS: Main: 265289728 17:53:17 INFO - PID 2863 | 17:53:19 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50188/tests/kraken/driver.html?testName=imaging-darkroom) 17:53:20 INFO - PID 2863 | RSS: Main: 271204352 17:53:20 INFO - PID 2863 | 17:53:23 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50188/tests/kraken/driver.html?testName=imaging-desaturate) 17:53:24 INFO - PID 2863 | RSS: Main: 272961536 17:53:24 INFO - PID 2863 | 17:53:27 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50188/tests/kraken/driver.html?testName=json-parse-financial) 17:53:28 INFO - PID 2863 | RSS: Main: 272232448 17:53:28 INFO - PID 2863 | 17:53:30 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:53:30 INFO - PID 2863 | RSS: Main: 271740928 17:53:30 INFO - PID 2863 | 17:53:32 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:53:33 INFO - PID 2863 | RSS: Main: 271921152 17:53:33 INFO - PID 2863 | 17:53:35 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:53:35 INFO - PID 2863 | RSS: Main: 271523840 17:53:35 INFO - PID 2863 | 17:53:38 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:53:39 INFO - PID 2863 | RSS: Main: 271962112 17:53:39 INFO - PID 2863 | 17:53:42 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:53:43 INFO - PID 2863 | RSS: Main: 271548416 17:53:43 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50188/tests/kraken/driver.html?testName=ai-astar) 17:53:45 INFO - PID 2863 | RSS: Main: 273018880 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | __start_tp_report 17:53:45 INFO - PID 2863 | _x_x_mozilla_page_load 17:53:45 INFO - PID 2863 | _x_x_mozilla_page_load_details 17:53:45 INFO - PID 2863 | |i|pagename|runs| 17:53:45 INFO - PID 2863 | |0;ai-astar;102;116;114;114;114;115;114;123;117;113 17:53:45 INFO - PID 2863 | |1;audio-beat-detection;145;110;110;149;120;143;130;109;139;110 17:53:45 INFO - PID 2863 | |2;audio-dft;203;200;196;212;215;211;211;199;203;197 17:53:45 INFO - PID 2863 | |3;audio-fft;78;57;60;88;62;70;62;57;78;57 17:53:45 INFO - PID 2863 | |4;audio-oscillator;93;72;86;73;72;74;97;94;101;79 17:53:45 INFO - PID 2863 | |5;imaging-gaussian-blur;89;89;88;88;88;88;89;89;103;87 17:53:45 INFO - PID 2863 | |6;imaging-darkroom;123;96;117;155;96;96;96;96;99;96 17:53:45 INFO - PID 2863 | |7;imaging-desaturate;75;75;140;142;74;145;140;101;98;117 17:53:45 INFO - PID 2863 | |8;json-parse-financial;53;50;52;53;52;52;53;54;60;78 17:53:45 INFO - PID 2863 | |9;json-stringify-tinderbox;56;64;58;66;69;62;59;69;86;57 17:53:45 INFO - PID 2863 | |10;stanford-crypto-aes;82;84;85;84;108;83;72;73;101;109 17:53:45 INFO - PID 2863 | |11;stanford-crypto-ccm;143;146;148;158;157;174;161;138;181;142 17:53:45 INFO - PID 2863 | |12;stanford-crypto-pbkdf2;217;193;197;197;197;196;194;192;219;248 17:53:45 INFO - PID 2863 | |13;stanford-crypto-sha256-iterative;73;74;72;69;81;104;96;101;104;81 17:53:45 INFO - PID 2863 | __end_tp_report 17:53:45 INFO - PID 2863 | __start_cc_report 17:53:45 INFO - PID 2863 | _x_x_mozilla_cycle_collect,1005 17:53:45 INFO - PID 2863 | __end_cc_report 17:53:45 INFO - PID 2863 | __startTimestamp1493427225677__endTimestamp 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | ------- Summary: start ------- 17:53:45 INFO - PID 2863 | Number of tests: 14 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:5.16 (4.5%) stddev-sans-first:3.05 17:53:45 INFO - PID 2863 | Values: 102.0 116.0 114.0 114.0 114.0 115.0 114.0 123.0 117.0 113.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#1] audio-beat-detection Cycles:10 Average:126.50 Median:134.50 stddev:16.51 (12.3%) stddev-sans-first:16.10 17:53:45 INFO - PID 2863 | Values: 145.0 110.0 110.0 149.0 120.0 143.0 130.0 109.0 139.0 110.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#2] audio-dft Cycles:10 Average:204.70 Median:207.00 stddev:6.95 (3.4%) stddev-sans-first:7.34 17:53:45 INFO - PID 2863 | Values: 203.0 200.0 196.0 212.0 215.0 211.0 211.0 199.0 203.0 197.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#3] audio-fft Cycles:10 Average:66.90 Median:66.00 stddev:11.01 (16.7%) stddev-sans-first:10.92 17:53:45 INFO - PID 2863 | Values: 78.0 57.0 60.0 88.0 62.0 70.0 62.0 57.0 78.0 57.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:82.50 stddev:11.44 (13.9%) stddev-sans-first:11.67 17:53:45 INFO - PID 2863 | Values: 93.0 72.0 86.0 73.0 72.0 74.0 97.0 94.0 101.0 79.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:88.50 stddev:4.69 (5.3%) stddev-sans-first:4.96 17:53:45 INFO - PID 2863 | Values: 89.0 89.0 88.0 88.0 88.0 88.0 89.0 89.0 103.0 87.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#6] imaging-darkroom Cycles:10 Average:107.00 Median:96.00 stddev:19.58 (20.4%) stddev-sans-first:19.89 17:53:45 INFO - PID 2863 | Values: 123.0 96.0 117.0 155.0 96.0 96.0 96.0 96.0 99.0 96.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#7] imaging-desaturate Cycles:10 Average:110.70 Median:109.50 stddev:29.93 (27.3%) stddev-sans-first:28.83 17:53:45 INFO - PID 2863 | Values: 75.0 75.0 140.0 142.0 74.0 145.0 140.0 101.0 98.0 117.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:53.00 stddev:8.26 (15.6%) stddev-sans-first:8.70 17:53:45 INFO - PID 2863 | Values: 53.0 50.0 52.0 53.0 52.0 52.0 53.0 54.0 60.0 78.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:8.90 (13.7%) stddev-sans-first:8.88 17:53:45 INFO - PID 2863 | Values: 56.0 64.0 58.0 66.0 69.0 62.0 59.0 69.0 86.0 57.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:82.50 stddev:13.30 (16.1%) stddev-sans-first:13.93 17:53:45 INFO - PID 2863 | Values: 82.0 84.0 85.0 84.0 108.0 83.0 72.0 73.0 101.0 109.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:157.50 stddev:14.21 (9.0%) stddev-sans-first:14.42 17:53:45 INFO - PID 2863 | Values: 143.0 146.0 148.0 158.0 157.0 174.0 161.0 138.0 181.0 142.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.00 Median:197.00 stddev:17.94 (9.1%) stddev-sans-first:18.49 17:53:45 INFO - PID 2863 | Values: 217.0 193.0 197.0 197.0 197.0 196.0 194.0 192.0 219.0 248.0 17:53:45 INFO - PID 2863 | 17:53:45 INFO - PID 2863 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.50 Median:73.50 stddev:14.21 (19.3%) stddev-sans-first:14.34 17:53:45 INFO - PID 2863 | Values: 73.0 74.0 72.0 69.0 81.0 104.0 96.0 101.0 104.0 81.0 17:53:45 INFO - PID 2863 | -------- Summary: end -------- 17:53:45 INFO - PID 2863 | 17:53:46 INFO - TEST-INFO | 2863: exit 0 17:53:46 INFO - TEST-OK | kraken | took 61206ms 17:53:46 INFO - SUITE-END | took 1176s 17:53:46 INFO - Completed test suite (00:19:36) 17:53:46 INFO - javascript benchmark 17:53:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7786.171413303669, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3561.483584880192, 3564.48314994326, 3602.1895073608457, 3606.459031145328, 3623.6014038455764, 6105.145279660851, 6186.659733714644, 6228.314885362613, 6233.875322493553, 6293.496520278378, 6171.259448866131, 6185.814425567229, 6230.688465576725, 6273.717682704278, 6274.811755647338, 5388.164834450667, 5417.891642167155, 5435.945640543583, 5470.753816078286, 5576.832695019156, 5390.865228369303, 5473.972630136864, 5558.722063896809, 5562.276904002474, 5588.050031494656, 5436.2661040759385, 5454.481824226692, 5501.724913754317, 5507.752151153188, 5533.059379905406, 5314.654547454403, 5450.5639548836, 5458.754356053987, 5460.372057213432, 5464.808731694372, 5400.594955378362, 5406.702631355274, 5468.507834294893, 5470.671759694431, 5474.042042642562, 4652.58126768589, 6165.784197553064, 6177.351378105324, 6188.257409110891, 6212.9068063979075, 5493.862653433656, 6582.93417065828, 6591.077249185118, 6595.670216489157, 6600.7689730859665, 6520.054592084169, 6573.408393244631, 6585.637789921552, 6642.800715978528, 6774.762883299061, 6258.311585725566, 6303.275123360826, 6332.68336583169, 6333.809985700436, 6340.397662222128, 6932.896006559906, 6937.861242775116, 6938.444924406035, 6949.235584085746, 6950.992106144581, 6346.492280617539, 6452.645104519296, 6459.515536334794, 6575.079488871562, 6601.504887133388, 6660.9000864987065, 6707.396334329934, 6720.361565651256, 6736.090627765287, 6776.05135281061, 6637.502187335969, 6674.332566743286, 6679.799606011828, 6684.899726504106, 6689.264180940093, 6419.903701444482, 6609.20689517261, 6706.83232919181, 6737.663116844138, 6738.663066846638, 5270.92093618596, 5291.391489978625, 5294.682319060792, 5342.332208473941, 5420.91868621971, 4079.551249362568, 4717.938463845608, 4746.833860814855, 4757.500462451462, 4859.441164266154, 6205.441510264098, 6291.465225455888, 6411.326810684905, 6412.006139048455, 6431.421172094534, 6473.482121430275, 6492.707828147744, 6773.559718618274, 6774.051632771416, 6793.252742198354, 5469.0, 6336.968315158487, 6378.457831084317, 6397.040443933447, 6409.67951602418, 4950.331705219821, 5904.084866845646, 5906.527477801766, 5932.614380065368, 5971.343152253248, 5736.225609542742, 6933.618650974245, 6949.30506949301, 7004.474664400191, 7031.0, 5530.810875661752, 5724.971375143097, 6461.483081353575, 6510.251321098134, 6697.933020669731, 6974.407175389946, 6995.545289556163, 6999.440044796303, 7009.12385951756, 7037.859242815012, 6642.43539299165, 6644.767433139817, 6696.029075784081, 6705.430038446787, 6709.329067093252, 6490.967545162244, 6777.728890844508, 6798.592084474947, 6800.829979250559, 6816.522843400914, 6386.074019267087, 6432.324605916311, 6512.994508377408, 6563.474922006323, 6669.899951500634, 6299.370062993664, 6334.429901308904, 6375.9362406377195, 6584.374484423972, 6604.0093985902495, 4942.777575009061, 6290.465310448663, 6436.420722135031, 6471.482281417381, 6471.676416179078, 6051.909221361595, 6575.63833989116, 6602.504812139013, 6616.7022483987375, 6620.966895165686, 6257.7184026718, 6354.092233276409, 6355.078513615592, 6360.395762402564, 6430.356964303719], "value": 6078.585517440066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.9033846092395, 815.5962798414786, 836.569166879057, 1202.8075507918734, 1253.6552448076773, 36566.45150322747, 37813.86558403252, 37871.24257514848, 37880.43179352309, 37924.43113353295, 38252.42621360682, 38538.0, 38639.80680096603, 38647.227055458876, 38673.0, 6972.790816275495, 7719.382449404062, 8206.22040906113, 8410.663573457054, 8420.368472364567, 8436.957815210915, 8445.408821382505, 8479.872801907946, 8550.315974722007, 8567.485950842938, 8562.443441176303, 8563.95718021409, 8579.056303806576, 8581.313494920392, 8609.784755381133, 8486.575671216415, 8533.232009119178, 8557.828843423158, 8572.185642363966, 8582.013068497141, 8381.49711017341, 8392.286655634278, 8448.619812108409, 8451.830963380698, 8467.661293548312, 36636.0, 36679.0, 36769.63230367689, 36777.264454710756, 36987.4451883222, 3622.9094272643133, 3667.2482141161, 3668.064643515913, 3671.1189314564313, 3672.6143754905884, 27352.0, 28053.438931221466, 30264.54603180954, 30370.0, 30425.391492170034, 3133.6082989626298, 3155.7475401967786, 3162.968370316313, 3185.7769956103084, 3197.888073917402, 212565.0, 233197.0, 239455.0, 296790.0, 297243.0, 38966.415503767465, 47061.5293847064, 47438.0, 47544.5245547547, 47547.762261189164, 44787.0, 49101.16179087799, 49121.263181052316, 49559.0, 49736.751316243186, 14195.716085678228, 14196.787048194285, 14340.426382944564, 14348.641283967985, 14358.784618230735, 11802.0, 11816.704582385337, 11820.113491488, 11888.167828252112, 11891.643250702493, 13448.731025379439, 13490.0, 13490.932545337408, 13499.190048597116, 13619.114757540729, 4895.31465594817, 5793.275840519935, 5868.471837534642, 5873.3245676746865, 5880.970595147082, 959.9760005999906, 981.4552923127733, 993.4734590666958, 1007.2395341517108, 1031.6389263757624, 21964.0, 22805.543889122124, 23573.0, 24122.155724549906, 24367.634485482733, 1105.8064838653204, 1106.673531308266, 1113.3653817324048, 1137.3517095255625, 1149.683836944847, 12255.938720306342, 12339.0, 12362.072844536695, 12396.566120185751, 12434.502619895104, 242754.0, 323496.0, 324489.3979770916, 324883.0, 325740.0, 49506.504934950186, 53433.7328313356, 53474.0, 53517.0, 53561.73219133879, 1503.624093976506, 1548.5973646851673, 1558.7661850722257, 1558.8129424469137, 1563.8201606815362, 21761.564768704222, 22654.886725566925, 23504.0, 23520.94155763029, 23597.0, 30919.690803091682, 31771.20571985719, 38286.80856595699, 38348.84953451401, 38424.0, 289477.10522894503, 289832.0, 291019.0, 291044.0, 292673.0, 33018.17454563655, 33785.0, 34584.61661533511, 34604.82697586496, 34651.0, 42515.0, 43072.78463607662, 44255.0, 44336.556634434535, 44402.77798610986, 24075.672351021327, 24508.877455612608, 28139.437211255252, 28306.2923426916, 30871.382572348877, 29357.0, 29735.553966690084, 30221.546676800306, 30417.695823041486, 30504.0, 36447.63552364442, 36665.81667091754, 36713.08217294589, 36732.81633591815, 36824.81587592045, 25126.545844334247, 28928.710712893444, 30301.696983029888, 30768.0, 31044.844775775975, 20141.395758126695, 21633.783662163176, 23797.762022379553, 24209.0, 24237.0], "value": 17214.95432140641, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.3002740245675, 437.5165442186384, 440.97354158750477, 459.6644449551827, 460.1280573313569, 17995.19021644026, 19377.709334359995, 19765.703514447276, 22231.1107555698, 22374.66438003431, 21609.1356345746, 22885.4278643034, 23244.0, 23564.88217558914, 23566.882165589148, 6117.908231376522, 6389.169407976957, 6395.360463953591, 6421.004744264623, 6429.7106630201515, 6035.094735789623, 6342.904856427157, 6362.618242905441, 6372.012338087604, 6374.0, 6255.718492667841, 6284.591501552384, 6313.084602732601, 6326.272478664943, 6361.173047503818, 6163.229596300463, 6277.654728989904, 6312.589681670676, 6315.65263910487, 6317.273513545955, 4848.951510484885, 5497.862553436156, 5556.472135147154, 5609.270794796691, 5625.971870140664, 26901.327466813487, 27081.0, 27454.5881811773, 27665.03172388977, 27906.860465697744, 1955.2276850643916, 2184.4429670433938, 2236.474428509299, 2238.0, 2250.5386395788823, 17502.91248543749, 17631.118444077743, 17651.470455886345, 18107.818921810744, 18305.7254141188, 2177.2270843850365, 2187.5296811185513, 2230.163688616769, 2231.765664605209, 2234.1510226114137, 155909.0, 156423.0, 158029.20985395, 159179.0, 160507.1974640131, 11816.46825892837, 11920.284782913053, 12287.324197169242, 12983.091183617056, 13033.0, 16569.585760356087, 16841.747373789403, 16932.661346772995, 16941.91529042347, 16961.830381696273, 8516.1058088901, 8670.479771213748, 8714.69498567547, 8772.210501054935, 8870.467771933705, 7987.1613480584865, 8019.238172373615, 8047.195280472023, 8181.795455113551, 8217.671293148207, 6314.179156709598, 7873.921260787319, 7937.880931786028, 7940.682372705027, 7978.481398709181, 1840.5490654789394, 2170.7069545611457, 2177.531830656385, 2181.1384503121494, 2373.9762602373753, 958.7842735384482, 964.5483547261326, 968.7965527239359, 1000.2198285337448, 1005.2862467647906, 20544.178232870818, 20803.479913001993, 20911.68632470514, 21248.78751212499, 21327.46681332948, 822.6914906909909, 881.7046289493092, 978.021978021978, 1004.864343313658, 1026.5688410867454, 10439.37363758177, 10948.0, 10962.725931851768, 10974.725631859108, 11022.889771102185, 516177.0, 525885.0, 530380.0, 533825.0, 534971.3251433718, 123902.0, 125541.0, 125915.3704231473, 132416.0, 136306.95539566915, 1117.3686866920164, 1153.867305259889, 1161.6921515798151, 1236.7959286717592, 1247.875212478763, 19090.33183838559, 21140.78859211388, 21591.676124858455, 22774.430639234153, 22825.972831222967, 56043.71978140083, 56122.94893459608, 56716.86566268569, 57371.713141434026, 57416.1387579195, 51372.74313628557, 79491.20508794839, 80349.59825200836, 81490.37019259464, 82614.58692706499, 8984.955075224581, 9007.279417646441, 9067.0, 9182.0, 9262.675806346746, 14092.436302547783, 14161.716765664834, 14341.85658143447, 14531.854681453473, 14596.92701536528, 10035.795704515505, 11053.336799792038, 11358.807325231062, 11844.585439509576, 12096.274223546616, 9485.810283794148, 11386.658400248005, 11420.885791141982, 11501.137414693763, 11654.650360489199, 11985.940070299594, 12197.817032744693, 12248.938755306523, 12409.62771116868, 12477.688057798265, 8887.777805554913, 8977.326700497359, 9093.22707569864, 9141.542922853963, 9281.48951807657, 10082.747931301776, 11805.0, 12059.457324420247, 12229.082818788804, 12276.754464910473], "value": 10470.973139869413, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.5806142034542, 1390.2562129260843, 1428.6785473268517, 1457.6720237946463, 1463.4292625875908, 11146.21976461648, 11641.35972521513, 11658.708532286686, 11661.242019268751, 11996.100292478055, 11641.883581164186, 11689.240199387033, 11810.933086709834, 11817.231879927798, 11843.170978031541, 2501.32464234657, 2560.116759717894, 2561.7950563954837, 2566.358410397401, 2566.8074894382903, 2483.950320993579, 2515.4717509322973, 2518.6725725655638, 2526.557852375836, 2527.936801579957, 2107.2729908181655, 2477.962830557543, 2503.6119401492797, 2513.447041650834, 2543.8346507476954, 2236.552689462114, 2256.402053455827, 2459.520393523255, 2507.1726330311135, 2513.560126977781, 2066.52469931915, 2147.9892600537055, 2409.72288186859, 2489.850608963468, 2506.3358210074343, 11659.417029148508, 11762.294262344201, 11818.349990750505, 11883.702907427298, 11905.523779048828, 5740.54075673945, 6739.595624262511, 6773.983902414677, 6777.864442711168, 6793.966030169867, 3977.8806635800684, 4335.219660461115, 4376.277914144162, 4411.426514553087, 4433.290673492225, 1268.4926029588146, 1272.0968112640037, 1288.581211106385, 1317.5059352742721, 1323.7286356296936, 14455.27723613815, 14948.430414806397, 16464.75302870446, 16561.0, 16578.66842663152, 4559.361689363492, 5334.546563542065, 5377.0321342158, 5487.0, 5617.494425501724, 11783.941080294544, 11797.52809887595, 11864.050875929905, 11874.1094417919, 11897.107716921266, 6510.9023364649565, 6517.51118666102, 6530.444912182517, 6532.346765323429, 6535.901961470582, 6019.939800601938, 6068.666223357669, 6079.331273559905, 6159.630422174684, 6187.288461826857, 3606.6573675500786, 4211.55778643238, 4309.741415515079, 4322.481302243688, 4445.955540444555, 1164.4818055965184, 1169.3626973299572, 1183.148133343991, 1184.644606618011, 1185.5731936502852, 751.5490705576719, 761.9619019049026, 792.2790260862587, 793.6190628498354, 793.6944276453607, 5217.321748172713, 5841.970790146022, 6577.243616984012, 6832.760853370109, 6963.651817409109, 927.2396634759567, 955.5986485676033, 958.8657587937695, 962.855571664242, 981.8085473332775, 3815.5993620669983, 3853.9421908671393, 4255.914881702349, 4395.494518130392, 4406.515283318832, 14646.26768661584, 14719.190444525653, 14932.925335373253, 14940.850591494163, 14957.952943293865, 11535.653930381934, 14025.0, 14792.704145917021, 14837.629059273604, 14885.479008234659, 8184.877226841602, 8388.035375931846, 8530.530820804915, 8569.871451928226, 8625.956870215734, 6664.400203981665, 6791.0, 6865.141857267841, 6882.277360877036, 6922.826929326606, 13017.609471715863, 13070.869291306964, 13140.474381025035, 13179.868201317864, 13521.661958451117, 13424.463021479422, 13521.391537381038, 13596.252206128758, 13629.0, 13726.0, 8927.553622318988, 9199.724008279762, 9202.171804537624, 9206.585703643486, 9217.44695318283, 10444.895551044696, 10542.472876356305, 10698.0, 10701.946490267499, 10721.088707459954, 8967.417117887317, 9013.774655633399, 9098.90901091007, 9195.0, 9205.58574864146, 8676.479411235347, 8756.25571826402, 8771.156427541806, 8783.868241976248, 8935.0, 6816.386525212556, 7996.680132794623, 8129.512229266263, 8148.1037085919315, 8162.265396114378, 5405.351357837085, 5948.375420580776, 6012.368701286302, 6071.635701857903, 6115.1438798569125, 6012.278526576664, 6075.7569697213385, 6117.1741814856205, 6188.690565471798, 6303.842403939755], "value": 5313.029730553802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3853402409687, 385.31029457271484, 400.9859654912079, 411.9917601647967, 413.144790284112, 5413.404525502192, 5481.205225242337, 6052.6368417894955, 6254.312025677177, 6262.152664963835, 4661.078298726388, 5849.894038146264, 5960.374160713128, 6056.364081771406, 6099.756009759615, 3862.94205586915, 4419.160359531695, 4439.822407103728, 4444.977775111136, 4445.22208613493, 4372.2785740352965, 4376.606105450524, 4378.934315985262, 4442.577955094277, 4499.46006479223, 4359.346098085281, 4379.226413302602, 4384.057427653054, 4391.0, 4392.011797345604, 3789.919872836242, 3943.921121577552, 4031.475908131939, 4386.254336762758, 4392.297232442826, 3128.5307203919365, 3254.739620830328, 3646.9241573735544, 3650.2881938022097, 3726.6273372662786, 5870.823875283749, 5876.853078673024, 5909.793157239519, 5982.52139828817, 6004.669743164124, 5189.221616757516, 5206.95860827836, 5216.37403511581, 5250.9737451312885, 5257.237700533439, 5991.191189189491, 6434.742610295582, 6457.3865482779065, 6460.93539064608, 6499.447546958514, 3564.3762341590377, 4233.872983810491, 4242.575742425764, 4245.448091748084, 4254.510731265913, 6009.669468179249, 6667.533272670915, 6842.623655698934, 6864.7940561782725, 6920.446364290895, 3610.819459027038, 3620.855165793339, 4271.337942618899, 4324.308110702273, 4335.631471324909, 4401.647868170603, 4403.8018289176425, 4409.2724700424715, 4414.205443020223, 4420.668449866273, 5098.0, 5203.687778733288, 5214.2960700304975, 5232.712200828915, 5261.316028916293, 5190.091733946544, 5702.486776190163, 6506.299885547445, 6513.804585862337, 6514.804555863332, 1261.1928365845865, 1319.4194554396227, 1477.7118461899827, 1478.7929689843431, 1500.0999400359915, 953.1040821627786, 963.4219468318953, 970.2819913264134, 971.9076687714655, 988.649029594498, 6039.577229593974, 6205.410486003822, 6206.782762603378, 6241.812745617639, 6271.184745982993, 6478.870422591522, 6487.578307410004, 6505.739770409131, 6520.054592084121, 6738.35985581369, 5926.970365148147, 5966.43318884714, 6170.598911070766, 6205.751769929152, 6216.191895053705, 2864.6132772075503, 3286.5398844161837, 3508.8947331580093, 3556.093196234995, 3560.661737134968, 6018.14631905359, 6284.685765711788, 6987.161540615159, 7006.579605223601, 7015.508914376047, 6362.013887847391, 6498.480121590356, 6581.964796930352, 6953.582785032914, 6965.965170174117, 6882.692288465176, 6928.930710692929, 6948.062011628567, 6989.825254368681, 7082.256363081905, 5695.572832037531, 6672.0, 6745.5952642841585, 6782.828560435395, 6791.04925310447, 5462.317210348707, 5952.970235148797, 6055.515558755201, 6535.967320163369, 6798.796036118924, 7120.7894657907245, 7162.498625096193, 7177.662386990075, 7192.31672991065, 7196.640167991684, 3884.572697003384, 4357.89105272358, 4367.606915377632, 4379.518252992232, 4397.604215620481, 6288.460001598287, 6820.3861652451515, 6833.180018397626, 6834.794956151323, 6943.479239057192, 5761.567882408753, 5985.431384018511, 6584.868302634016, 6596.90104648421, 6638.800835974928, 5883.852903677443, 6323.2294957412, 6339.302676705651, 6561.475081993333, 6682.997550367484, 6528.771492997722, 6532.477401807939, 6545.738170473318, 6547.755926373974, 6563.914959968807, 5627.831165065055, 6296.653684047421, 6536.640484773383, 6551.836204094936, 6717.865642687217, 5685.630434021776, 5988.760449581968, 6362.936370636419, 6373.458256048288, 6381.744730210925], "value": 4688.894053837987, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.2782207301723, 846.7671390367648, 850.9149085091492, 865.0786911938785, 873.8164985353073, 14705.411783528672, 14933.178675172861, 16759.748603770953, 17207.913960430196, 17225.483235502925, 13649.590512284647, 14089.29553522325, 18310.0, 18327.633447331078, 18351.90824045878, 971.1502435369052, 975.3806332978575, 987.2694206287332, 996.1881066930465, 998.8501724741311, 969.6606187834237, 1000.104906109032, 1003.3779056984644, 1003.64872294697, 1004.9799004019915, 1009.8790342719575, 1047.748540350318, 1056.9800142862136, 1057.857189279449, 1060.803751306007, 1041.3231399590252, 1051.9737006574821, 1052.184556968352, 1053.7260312318776, 1055.530289021386, 747.7457664394078, 758.0600055930662, 761.5240474703311, 762.9890395226347, 766.057748968766, 16433.83566164335, 16724.83275167257, 16862.072586007765, 17126.972381657142, 17438.0, 17139.0, 17221.827781722146, 17552.0, 17554.03452810095, 17659.20533575992, 13898.305084745722, 14025.228612426312, 14041.297935103306, 14143.929280353635, 14244.430222791076, 3368.2421455172635, 3397.8640854365794, 3405.3189362127673, 3409.6760807723226, 3409.6931276185014, 114471.85528144779, 127296.0, 137773.0, 139067.0, 140980.0, 13519.256440895846, 13855.653608659864, 13966.650833729034, 14152.64618384528, 14162.787558186636, 25837.354066148495, 25906.22281331563, 26161.869190654306, 26179.083732069666, 26241.21276361712, 7986.800329991681, 8039.8794018089775, 8069.596520173968, 8073.434859559775, 8099.676012959416, 3968.980155099206, 3979.3633018716864, 3984.1633257015774, 4011.117554138085, 4052.068024354415, 4367.432233809584, 4455.532169122195, 4456.77716114193, 4457.3091170868565, 4463.933041004322, 817.2522142239903, 960.2893858544627, 963.9951800241095, 973.9610415583439, 981.3179840011123, 651.9054737063194, 669.7220653428773, 679.3003206697011, 683.3576438148125, 693.5873155472486, 11591.710207244887, 11839.58561450345, 12032.81950770739, 12179.573714919936, 13137.211767293802, 576.2595065341017, 598.3059650805045, 635.4535099814157, 649.95775274607, 665.3047565294279, 4954.950450495521, 5272.894542109137, 5366.570674346043, 5734.340550836624, 5745.592329879207, 105184.0, 105743.0, 105796.0, 106252.46873765581, 108226.0, 71249.0, 90897.0, 91084.54457727668, 91578.54210729037, 93827.53086234526, 80896.52827773764, 81489.59255203686, 81661.77507337395, 82166.89165541698, 82314.17685823065, 10966.835497467384, 11197.104231661611, 11429.371384573928, 11563.0, 11567.248128871597, 38270.8086459577, 38625.0, 38877.80561097289, 38993.80503097466, 39702.0, 29518.852405737834, 49161.26258106203, 49728.0, 50340.74829625829, 50683.74658126686, 14528.346224419714, 14588.781168282696, 14632.853671463576, 14670.779938301148, 14855.628609284422, 15131.167785771888, 15331.386744530093, 15692.92153539225, 15713.842861571238, 15779.921100394884, 14682.0, 14711.0, 14802.333894974536, 15043.774343385077, 15137.924310378377, 12096.75806483883, 14366.497172598909, 14469.131852088909, 14703.485378012147, 14767.335469903664, 12534.686632834251, 12731.363431828186, 12866.549670761478, 12872.613821585368, 12874.16317939331, 10860.294080884718, 11174.608888688857, 11794.351310677652, 11862.525498979945, 11929.9859511939, 12817.551385701456, 12948.8057679133, 12969.870301297244, 12984.610461686165, 13002.414891330101], "value": 8162.150487329819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 114.0, 114.0, 114.0, 115.0, 114.0, 123.0, 117.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 110.0, 149.0, 120.0, 143.0, 130.0, 109.0, 139.0, 110.0], "value": 126.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 196.0, 212.0, 215.0, 211.0, 211.0, 199.0, 203.0, 197.0], "value": 204.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 60.0, 88.0, 62.0, 70.0, 62.0, 57.0, 78.0, 57.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 72.0, 86.0, 73.0, 72.0, 74.0, 97.0, 94.0, 101.0, 79.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 88.0, 88.0, 88.0, 89.0, 89.0, 103.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 96.0, 117.0, 155.0, 96.0, 96.0, 96.0, 96.0, 99.0, 96.0], "value": 107.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 140.0, 142.0, 74.0, 145.0, 140.0, 101.0, 98.0, 117.0], "value": 110.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 52.0, 53.0, 52.0, 52.0, 53.0, 54.0, 60.0, 78.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 58.0, 66.0, 69.0, 62.0, 59.0, 69.0, 86.0, 57.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 85.0, 84.0, 108.0, 83.0, 72.0, 73.0, 101.0, 109.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 148.0, 158.0, 157.0, 174.0, 161.0, 138.0, 181.0, 142.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 193.0, 197.0, 197.0, 197.0, 196.0, 194.0, 192.0, 219.0, 248.0], "value": 205.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 69.0, 81.0, 104.0, 96.0, 101.0, 104.0, 81.0], "value": 85.5, "unit": "score"}]}]} 17:53:46 INFO - Return code: 0 17:53:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:53:46 ERROR - # TBPL SUCCESS # 17:53:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:53:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:53:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:53:47 INFO - 2017-04-28 17:53:47.006 screenresolution[2868:37693] starting screenresolution argv=screenresolution get 17:53:47 INFO - 2017-04-28 17:53:47.009 screenresolution[2868:37693] Display 0: 1600x1200x32@60 17:53:47 INFO - 2017-04-28 17:53:47.016 screenresolution[2869:37696] starting screenresolution argv=screenresolution list 17:53:47 INFO - Available Modes on Display 0 17:53:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:53:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:53:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:53:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:53:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:53:47 INFO - Intel Iris: 17:53:47 INFO - Chipset Model: Intel Iris 17:53:47 INFO - Type: GPU 17:53:47 INFO - Bus: Built-In 17:53:47 INFO - VRAM (Dynamic, Max): 1536 MB 17:53:47 INFO - Vendor: Intel (0x8086) 17:53:47 INFO - Device ID: 0x0a2e 17:53:47 INFO - Revision ID: 0x0009 17:53:47 INFO - Displays: 17:53:47 INFO - Display: 17:53:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:53:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:53:47 INFO - Display Serial Number: 1600x1200 60 17:53:47 INFO - Main Display: Yes 17:53:47 INFO - Mirror: Off 17:53:47 INFO - Online: Yes 17:53:47 INFO - Rotation: Supported 17:53:47 INFO - Return code: 0 17:53:47 INFO - Running post-action listener: _resource_record_post_action 17:53:47 INFO - [mozharness: 2017-04-29 00:53:47.267669Z] Finished run-tests step (success) 17:53:47 INFO - Running post-run listener: _resource_record_post_run 17:53:47 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 671744; Write bytes: 510688256; Read time: 5; Write time: 1633 17:53:47 INFO - TinderboxPrint: CPU usage
54.0% 17:53:47 INFO - TinderboxPrint: I/O read bytes / time
671,744 / 5 17:53:47 INFO - TinderboxPrint: I/O write bytes / time
510,688,256 / 1,633 17:53:47 INFO - TinderboxPrint: CPU idle
2,203.0 (46.0%) 17:53:47 INFO - TinderboxPrint: CPU system
961.8 (20.1%) 17:53:47 INFO - TinderboxPrint: CPU user
1,625.0 (33.9%) 17:53:47 INFO - TinderboxPrint: Swap in / out
208,826,368 / 0 17:53:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 197239296; Write bytes: 192954368; Read time: 15049; Write time: 357 17:53:47 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 671744; Write bytes: 300891136; Read time: 5; Write time: 1226 17:53:47 INFO - Running post-run listener: _upload_blobber_files 17:53:47 INFO - Blob upload gear active. 17:53:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:53:47 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 17:53:47 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'] 17:53:47 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 17:53:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:53:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:49 INFO - (blobuploader) - INFO - Done attempting. 17:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:50 INFO - (blobuploader) - INFO - Done attempting. 17:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:51 INFO - (blobuploader) - INFO - Done attempting. 17:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:53:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:53 INFO - (blobuploader) - INFO - Done attempting. 17:53:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:53:53 INFO - Return code: 0 17:53:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:53:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:53:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/423262d44cac83fcd038ec5c3ecb99c83ddb0fc35d47b8823e2f8d73e5421ef89e3929248bb7fd50177002eaaf69e156c7371e74d3cd2bc4cd025e781a43129e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/835f5e8412909cdfaf949c09bdd2d3ab721b0d62ad50fa14ce750c4d25ee0fc33145db7cc16c05cfb5cf6c7cacbc5ec95f32d35a119a025b3e1294e3a4ce84bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe6136ba5a3ff203366e30e27d2302d5fd234bb957412faaabbaa55f70cc9d1c01d209eac577199ce5112fc6a5a7d3ef82dd3489ee0bdea351bfa2aa432e8a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d206e16f8a5b865b47dfb9d93274addb8f8304915fa5c1f8eda7e987bfa86ea337692bb7ea1d6082d6c6fd57920c9f910465c0c184f00013389fd57b03cae3c6"} 17:53:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:53:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:53:53 INFO - Contents: 17:53:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/423262d44cac83fcd038ec5c3ecb99c83ddb0fc35d47b8823e2f8d73e5421ef89e3929248bb7fd50177002eaaf69e156c7371e74d3cd2bc4cd025e781a43129e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/835f5e8412909cdfaf949c09bdd2d3ab721b0d62ad50fa14ce750c4d25ee0fc33145db7cc16c05cfb5cf6c7cacbc5ec95f32d35a119a025b3e1294e3a4ce84bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe6136ba5a3ff203366e30e27d2302d5fd234bb957412faaabbaa55f70cc9d1c01d209eac577199ce5112fc6a5a7d3ef82dd3489ee0bdea351bfa2aa432e8a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d206e16f8a5b865b47dfb9d93274addb8f8304915fa5c1f8eda7e987bfa86ea337692bb7ea1d6082d6c6fd57920c9f910465c0c184f00013389fd57b03cae3c6"} 17:53:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:53:53 INFO - Copying logs to upload dir... 17:53:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:53:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.987207 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-28 17:53:53.389235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:53:53.392893) ========= 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.gIKchLTbn5/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.eG2IWGaLLV/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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/423262d44cac83fcd038ec5c3ecb99c83ddb0fc35d47b8823e2f8d73e5421ef89e3929248bb7fd50177002eaaf69e156c7371e74d3cd2bc4cd025e781a43129e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/835f5e8412909cdfaf949c09bdd2d3ab721b0d62ad50fa14ce750c4d25ee0fc33145db7cc16c05cfb5cf6c7cacbc5ec95f32d35a119a025b3e1294e3a4ce84bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe6136ba5a3ff203366e30e27d2302d5fd234bb957412faaabbaa55f70cc9d1c01d209eac577199ce5112fc6a5a7d3ef82dd3489ee0bdea351bfa2aa432e8a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d206e16f8a5b865b47dfb9d93274addb8f8304915fa5c1f8eda7e987bfa86ea337692bb7ea1d6082d6c6fd57920c9f910465c0c184f00013389fd57b03cae3c6"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/423262d44cac83fcd038ec5c3ecb99c83ddb0fc35d47b8823e2f8d73e5421ef89e3929248bb7fd50177002eaaf69e156c7371e74d3cd2bc4cd025e781a43129e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/835f5e8412909cdfaf949c09bdd2d3ab721b0d62ad50fa14ce750c4d25ee0fc33145db7cc16c05cfb5cf6c7cacbc5ec95f32d35a119a025b3e1294e3a4ce84bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe6136ba5a3ff203366e30e27d2302d5fd234bb957412faaabbaa55f70cc9d1c01d209eac577199ce5112fc6a5a7d3ef82dd3489ee0bdea351bfa2aa432e8a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d206e16f8a5b865b47dfb9d93274addb8f8304915fa5c1f8eda7e987bfa86ea337692bb7ea1d6082d6c6fd57920c9f910465c0c184f00013389fd57b03cae3c6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:53:53.431688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:53:53.432303) ========= 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.gIKchLTbn5/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.eG2IWGaLLV/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005390 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:53:53.482451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:53:53.482825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:53:53.483165) ========= ========= Total master_lag: 0.19 =========