builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0296 starttime: 1493426028.99 results: success (0) buildid: 20170428170836 builduid: 6b8bcd7c8734466680ca5e4df8bade4e revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:48.991939) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:48.992376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:48.992656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.039261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-28 17:33:49.039611) ========= 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.tvIxyhQepg/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.ViV77yRdiR/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:33:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-04-28 17:33:49 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091371 ========= master_lag: 3.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-28 17:33:52.590567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2017-04-28 17:33:52.591115) ========= 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.tvIxyhQepg/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.ViV77yRdiR/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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.026402 ========= master_lag: 4.35 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2017-04-28 17:33:56.967647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-04-28 17:33:56.971021) ========= 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.tvIxyhQepg/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.ViV77yRdiR/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:33:57,007 truncating revision to first 12 chars 2017-04-28 17:33:57,007 Setting DEBUG logging. 2017-04-28 17:33:57,007 attempt 1/10 2017-04-28 17:33:57,007 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:33:58,542 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=1.830331 ========= master_lag: 3.94 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-04-28 17:34:02.743719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:34:02.744068) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:34:02.744509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:34:02.744822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:34:02.767646) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-28 17:34:02.768072) ========= /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.tvIxyhQepg/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.ViV77yRdiR/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:34:03 INFO - MultiFileLogger online at 20170428 17:34:03 in /builds/slave/test 17:34:03 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:34:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:03 INFO - {'append_to_log': False, 17:34:03 INFO - 'base_work_dir': '/builds/slave/test', 17:34:03 INFO - 'blob_upload_branch': 'Firefox', 17:34:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:03 INFO - 'branch': 'Firefox', 17:34:03 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:03 INFO - 'config_files': ('talos/mac_config.py',), 17:34:03 INFO - 'default_actions': ('clobber', 17:34:03 INFO - 'read-buildbot-config', 17:34:03 INFO - 'download-and-extract', 17:34:03 INFO - 'populate-webroot', 17:34:03 INFO - 'create-virtualenv', 17:34:03 INFO - 'install', 17:34:03 INFO - 'run-tests'), 17:34:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:03 INFO - 'download_minidump_stackwalk': True, 17:34:03 INFO - 'download_symbols': 'ondemand', 17:34:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:03 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:03 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:03 INFO - 'gecko_profile': False, 17:34:03 INFO - 'gecko_profile_interval': 0, 17:34:03 INFO - 'installer_path': 'installer.exe', 17:34:03 INFO - 'log_level': 'info', 17:34:03 INFO - 'log_name': 'talos', 17:34:03 INFO - 'log_to_console': True, 17:34:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:34:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:34:03 INFO - 'opt_config_files': (), 17:34:03 INFO - 'pip_index': False, 17:34:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:34:03 INFO - 'cmd': ('bash', 17:34:03 INFO - '-c', 17:34:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:34:03 INFO - 'enabled': True, 17:34:03 INFO - 'halt_on_failure': False, 17:34:03 INFO - 'name': 'check_screen_resolution'},), 17:34:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:34:03 INFO - 'cmd': ('bash', 17:34:03 INFO - '-c', 17:34:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:34:03 INFO - 'enabled': True, 17:34:03 INFO - 'halt_on_failure': False, 17:34:03 INFO - 'name': 'check_screen_resolution'},), 17:34:03 INFO - 'run_cmd_checks_enabled': True, 17:34:03 INFO - 'suite': 'dromaeojs-e10s', 17:34:03 INFO - 'system_bits': '32', 17:34:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:03 INFO - 'title': 't-yosemite-r7-0296', 17:34:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:03 INFO - 'use_talos_json': True, 17:34:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:03 INFO - 'work_dir': 'build'} 17:34:03 INFO - [mozharness: 2017-04-29 00:34:03.051673Z] Running clobber step. 17:34:03 INFO - Running pre-action listener: _resource_record_pre_action 17:34:03 INFO - Running main action method: clobber 17:34:03 INFO - rmtree: /builds/slave/test/build 17:34:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:05 INFO - Running post-action listener: _resource_record_post_action 17:34:05 INFO - [mozharness: 2017-04-29 00:34:05.446840Z] Finished clobber step (success) 17:34:05 INFO - [mozharness: 2017-04-29 00:34:05.447022Z] Running read-buildbot-config step. 17:34:05 INFO - Running pre-action listener: _resource_record_pre_action 17:34:05 INFO - Running main action method: read_buildbot_config 17:34:05 INFO - Using buildbot properties: 17:34:05 INFO - { 17:34:05 INFO - "project": "", 17:34:05 INFO - "product": "firefox", 17:34:05 INFO - "script_repo_revision": "production", 17:34:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:34:05 INFO - "repository": "", 17:34:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:34:05 INFO - "buildid": "20170428170836", 17:34:05 INFO - "stage_platform": "macosx64", 17:34:05 INFO - "basedir": "/builds/slave/test", 17:34:05 INFO - "buildnumber": 147, 17:34:05 INFO - "platform": "yosemite_r7", 17:34:05 INFO - "mozci_request": { 17:34:05 INFO - "priority": 0, 17:34:05 INFO - "type": "trigger_all_talos_jobs", 17:34:05 INFO - "times": 6 17:34:05 INFO - }, 17:34:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:34:05 INFO - "slavebuilddir": "test", 17:34:05 INFO - "branch": "mozilla-central", 17:34:05 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:34:05 INFO - "slavename": "t-yosemite-r7-0296", 17:34:05 INFO - "builduid": "6b8bcd7c8734466680ca5e4df8bade4e", 17:34:05 INFO - "repo_path": "mozilla-central" 17:34:05 INFO - } 17:34:05 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:34:05 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:34:05 INFO - Running post-action listener: _resource_record_post_action 17:34:05 INFO - [mozharness: 2017-04-29 00:34:05.451692Z] Finished read-buildbot-config step (success) 17:34:05 INFO - [mozharness: 2017-04-29 00:34:05.451849Z] Running download-and-extract step. 17:34:05 INFO - Running pre-action listener: _resource_record_pre_action 17:34:05 INFO - Running main action method: download_and_extract 17:34:05 INFO - mkdir: /builds/slave/test/build/tests 17:34:05 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:05 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:34:05 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:34:05 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:34:05 INFO - Downloaded 1325 bytes. 17:34:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:34:05 INFO - Using the following test package requirements: 17:34:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:34:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:34:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:34:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:34:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'jsshell-mac.zip'], 17:34:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:34:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:34:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:34:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:34:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:34:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:34:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:34:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:34:05 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:34:05 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:34:05 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:34:06 INFO - Content-Length response header: 52698163 17:34:06 INFO - Bytes received: 52698163 17:34:23 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:34:23 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:34:23 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:34:23 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:34:24 INFO - Content-Length response header: 52698163 17:34:24 INFO - Bytes received: 52698163 17:34: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.talos.tests.zip 17:34: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.talos.tests.zip'}, attempt #1 17:34:39 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:34:40 INFO - Content-Length response header: 14408809 17:34:40 INFO - Bytes received: 14408809 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:40 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:34:40 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:34:42 INFO - Downloaded 71219323 bytes. 17:34:42 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:34:42 INFO - mkdir: /builds/slave/test/properties 17:34:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:42 INFO - Contents: 17:34:42 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:42 INFO - Running post-action listener: _resource_record_post_action 17:34:42 INFO - Running post-action listener: set_extra_try_arguments 17:34:42 INFO - [mozharness: 2017-04-29 00:34:42.550473Z] Finished download-and-extract step (success) 17:34:42 INFO - [mozharness: 2017-04-29 00:34:42.550627Z] Running populate-webroot step. 17:34:42 INFO - Running pre-action listener: _resource_record_pre_action 17:34:42 INFO - Running main action method: populate_webroot 17:34:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:42 INFO - '--tppagecycles', 17:34:42 INFO - '7'], 17:34:42 INFO - 'tests': ['tsvgm']}}, 17:34:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['damp', 'tps']}, 17:34:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'tests': ['damp', 'tps']}, 17:34:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['dromaeo_dom']}, 17:34:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:34:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:34:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['a11yr', 17:34:42 INFO - 'ts_paint', 17:34:42 INFO - 'tpaint', 17:34:42 INFO - 'sessionrestore', 17:34:42 INFO - 'sessionrestore_no_auto_restore', 17:34:42 INFO - 'tabpaint']}, 17:34:42 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:34:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:34:42 INFO - 'bloom_basic_ref']}, 17:34:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['tsvgx', 17:34:42 INFO - 'tsvgr_opacity', 17:34:42 INFO - 'tart', 17:34:42 INFO - 'tscrollx', 17:34:42 INFO - 'cart', 17:34:42 INFO - 'tsvg_static']}, 17:34:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:42 INFO - 'tsvgr_opacity', 17:34:42 INFO - 'tart', 17:34:42 INFO - 'tscrollx', 17:34:42 INFO - 'cart', 17:34:42 INFO - 'tsvg_static']}, 17:34:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-e10s'], 17:34:42 INFO - 'tests': ['tp5o']}, 17:34:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--disable-e10s', 17:34:42 INFO - '--xperf_path', 17:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:42 INFO - 'tests': ['tp5n']}, 17:34:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:42 INFO - 'talos_options': ['--xperf_path', 17:34:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:42 INFO - 'tests': ['tp5n']}}, 17:34:42 INFO - 'talos.zip': {'path': '', 17:34:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:42 INFO - Running post-action listener: _resource_record_post_action 17:34:42 INFO - [mozharness: 2017-04-29 00:34:42.569298Z] Finished populate-webroot step (success) 17:34:42 INFO - [mozharness: 2017-04-29 00:34:42.569411Z] Running create-virtualenv step. 17:34:42 INFO - Running pre-action listener: _resource_record_pre_action 17:34:42 INFO - Running main action method: create_virtualenv 17:34:42 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:42 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:34:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:42 INFO - Using real prefix '/tools/python27' 17:34:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:43 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:46 INFO - Installing pip.................done. 17:34:46 INFO - Return code: 0 17:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:46 INFO - Reading from file tmpfile_stdout 17:34:46 INFO - Output received: 17:34:46 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:34:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:47 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:34:47 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:34:47 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:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:47 INFO - 'HOME': '/Users/cltbld', 17:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:47 INFO - 'LOGNAME': 'cltbld', 17:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:47 INFO - 'MOZ_NO_REMOTE': '1', 17:34:47 INFO - 'NO_EM_RESTART': '1', 17:34:47 INFO - 'PAGER': '/bin/cat', 17:34:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:47 INFO - 'PWD': '/builds/slave/test', 17:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:47 INFO - 'SHELL': '/bin/bash', 17:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:34:47 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:47 INFO - 'USER': 'cltbld', 17:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:47 INFO - 'XPC_FLAGS': '0x0', 17:34:47 INFO - 'XPC_SERVICE_NAME': '0', 17:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:47 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:34:47 INFO - Cleaning up... 17:34:47 INFO - Return code: 0 17:34:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:47 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:34:47 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:34:47 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:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:47 INFO - 'HOME': '/Users/cltbld', 17:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:47 INFO - 'LOGNAME': 'cltbld', 17:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:47 INFO - 'MOZ_NO_REMOTE': '1', 17:34:47 INFO - 'NO_EM_RESTART': '1', 17:34:47 INFO - 'PAGER': '/bin/cat', 17:34:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:47 INFO - 'PWD': '/builds/slave/test', 17:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:47 INFO - 'SHELL': '/bin/bash', 17:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:34:47 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:47 INFO - 'USER': 'cltbld', 17:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:47 INFO - 'XPC_FLAGS': '0x0', 17:34:47 INFO - 'XPC_SERVICE_NAME': '0', 17:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 INFO - Downloading/unpacking psutil>=3.1.1 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:51 INFO - Installing collected packages: psutil 17:34:51 INFO - Running setup.py install for psutil 17:34:52 INFO - building 'psutil._psutil_osx' extension 17:34:52 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:34:52 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:34:52 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:34:52 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:34:52 INFO - building 'psutil._psutil_posix' extension 17:34:52 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:34:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:34:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:34:52 INFO - ^ 17:34:52 INFO - 1 warning generated. 17:34:52 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:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:53 INFO - Successfully installed psutil 17:34:53 INFO - Cleaning up... 17:34:53 INFO - Return code: 0 17:34:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:53 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:34:53 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:34:53 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:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:53 INFO - 'HOME': '/Users/cltbld', 17:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:53 INFO - 'LOGNAME': 'cltbld', 17:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:53 INFO - 'MOZ_NO_REMOTE': '1', 17:34:53 INFO - 'NO_EM_RESTART': '1', 17:34:53 INFO - 'PAGER': '/bin/cat', 17:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:53 INFO - 'PWD': '/builds/slave/test', 17:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:53 INFO - 'SHELL': '/bin/bash', 17:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:34:53 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:53 INFO - 'USER': 'cltbld', 17:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:53 INFO - 'XPC_FLAGS': '0x0', 17:34:53 INFO - 'XPC_SERVICE_NAME': '0', 17:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:56 INFO - Installing collected packages: mozsystemmonitor 17:34:56 INFO - Running setup.py install for mozsystemmonitor 17:34:56 INFO - Successfully installed mozsystemmonitor 17:34:56 INFO - Cleaning up... 17:34:56 INFO - Return code: 0 17:34:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:56 INFO - 'HOME': '/Users/cltbld', 17:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:56 INFO - 'LOGNAME': 'cltbld', 17:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:56 INFO - 'MOZ_NO_REMOTE': '1', 17:34:56 INFO - 'NO_EM_RESTART': '1', 17:34:56 INFO - 'PAGER': '/bin/cat', 17:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:56 INFO - 'PWD': '/builds/slave/test', 17:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:56 INFO - 'SHELL': '/bin/bash', 17:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:34:56 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:56 INFO - 'USER': 'cltbld', 17:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:56 INFO - 'XPC_FLAGS': '0x0', 17:34:56 INFO - 'XPC_SERVICE_NAME': '0', 17:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:56 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34:59 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:34:59 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:34:59 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:34:59 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:34:59 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:34:59 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:34:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:59 INFO - warning: no files found matching '*.txt' 17:34:59 INFO - no previously-included directories found matching 'build' 17:34:59 INFO - no previously-included directories found matching 'dist' 17:34:59 INFO - no previously-included directories found matching '.git*' 17:34:59 INFO - Installing collected packages: jsonschema, functools32 17:34:59 INFO - Running setup.py install for functools32 17:34:59 INFO - warning: no files found matching '*.txt' 17:34:59 INFO - no previously-included directories found matching 'build' 17:34:59 INFO - no previously-included directories found matching 'dist' 17:34:59 INFO - no previously-included directories found matching '.git*' 17:34:59 INFO - Successfully installed jsonschema functools32 17:34:59 INFO - Cleaning up... 17:35:00 INFO - Return code: 0 17:35:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:35:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:00 INFO - 'HOME': '/Users/cltbld', 17:35:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:00 INFO - 'LOGNAME': 'cltbld', 17:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:00 INFO - 'MOZ_NO_REMOTE': '1', 17:35:00 INFO - 'NO_EM_RESTART': '1', 17:35:00 INFO - 'PAGER': '/bin/cat', 17:35:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:00 INFO - 'PWD': '/builds/slave/test', 17:35:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:00 INFO - 'SHELL': '/bin/bash', 17:35:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:00 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:00 INFO - 'USER': 'cltbld', 17:35:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:00 INFO - 'XPC_FLAGS': '0x0', 17:35:00 INFO - 'XPC_SERVICE_NAME': '0', 17:35:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:35:00 INFO - Cleaning up... 17:35:00 INFO - Return code: 0 17:35:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:35:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:00 INFO - 'HOME': '/Users/cltbld', 17:35:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:00 INFO - 'LOGNAME': 'cltbld', 17:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:00 INFO - 'MOZ_NO_REMOTE': '1', 17:35:00 INFO - 'NO_EM_RESTART': '1', 17:35:00 INFO - 'PAGER': '/bin/cat', 17:35:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:00 INFO - 'PWD': '/builds/slave/test', 17:35:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:00 INFO - 'SHELL': '/bin/bash', 17:35:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:00 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:00 INFO - 'USER': 'cltbld', 17:35:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:00 INFO - 'XPC_FLAGS': '0x0', 17:35:00 INFO - 'XPC_SERVICE_NAME': '0', 17:35:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:04 INFO - Downloading docopt-0.6.1.tar.gz 17:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:04 INFO - Running setup.py install for blobuploader 17:35:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:04 INFO - Running setup.py install for requests 17:35:05 INFO - Running setup.py install for docopt 17:35:05 INFO - Successfully installed blobuploader requests docopt 17:35:05 INFO - Cleaning up... 17:35:05 INFO - Return code: 0 17:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:05 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:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:05 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:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:05 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:35:05 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:35:05 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:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:05 INFO - 'HOME': '/Users/cltbld', 17:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:05 INFO - 'LOGNAME': 'cltbld', 17:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:05 INFO - 'MOZ_NO_REMOTE': '1', 17:35:05 INFO - 'NO_EM_RESTART': '1', 17:35:05 INFO - 'PAGER': '/bin/cat', 17:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:05 INFO - 'PWD': '/builds/slave/test', 17:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:05 INFO - 'SHELL': '/bin/bash', 17:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:05 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:05 INFO - 'USER': 'cltbld', 17:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:05 INFO - 'XPC_FLAGS': '0x0', 17:35:05 INFO - 'XPC_SERVICE_NAME': '0', 17:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:05 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-7Qmqdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:05 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-piCj_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:05 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-UL9tmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-mo5eRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-sWU98X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-gc9N6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-RNHg42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-2rrmSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-BMfuNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-hm5Fpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-QcqxSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-3GIwbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:06 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-EC38nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:07 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-VvFiaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:07 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-brQZXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:07 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-_5V773-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:07 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-SGGm_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:07 INFO - Running setup.py install for manifestparser 17:35:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozcrash 17:35:07 INFO - Running setup.py install for mozdebug 17:35:07 INFO - Running setup.py install for mozdevice 17:35:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Running setup.py install for mozfile 17:35:08 INFO - Running setup.py install for mozhttpd 17:35:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Running setup.py install for mozinfo 17:35:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Running setup.py install for mozInstall 17:35:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Running setup.py install for mozleak 17:35:08 INFO - Running setup.py install for mozlog 17:35:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Running setup.py install for moznetwork 17:35:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Running setup.py install for mozprocess 17:35:09 INFO - Running setup.py install for mozprofile 17:35:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Running setup.py install for mozrunner 17:35:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Running setup.py install for mozscreenshot 17:35:09 INFO - Running setup.py install for moztest 17:35:09 INFO - Running setup.py install for mozversion 17:35:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:09 INFO - Cleaning up... 17:35:09 INFO - Return code: 0 17:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35: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:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:09 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:35:09 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:35:09 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:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:09 INFO - 'HOME': '/Users/cltbld', 17:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:09 INFO - 'LOGNAME': 'cltbld', 17:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:09 INFO - 'MOZ_NO_REMOTE': '1', 17:35:09 INFO - 'NO_EM_RESTART': '1', 17:35:09 INFO - 'PAGER': '/bin/cat', 17:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:09 INFO - 'PWD': '/builds/slave/test', 17:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:09 INFO - 'SHELL': '/bin/bash', 17:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:09 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:09 INFO - 'USER': 'cltbld', 17:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:09 INFO - 'XPC_FLAGS': '0x0', 17:35:09 INFO - 'XPC_SERVICE_NAME': '0', 17:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-nf4Awz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-uzAEN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-i2ZWt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-c3BH9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-oyxG0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-lHB6Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-1Brn9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:10 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-1i0K6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-AzukYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-10nhG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-nh05bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-XdIvAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-j7g76n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-iMNBZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-735DEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-baRE2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:11 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-2utFeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:12 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:35:12 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:35:12 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:35:12 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:35:12 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:35:12 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:35:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:14 INFO - Downloading blessings-1.6.tar.gz 17:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:14 INFO - Installing collected packages: blessings 17:35:14 INFO - Running setup.py install for blessings 17:35:14 INFO - Successfully installed blessings 17:35:14 INFO - Cleaning up... 17:35:14 INFO - Return code: 0 17:35:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:15 INFO - Reading from file tmpfile_stdout 17:35:15 INFO - Current package versions: 17:35:15 INFO - blessings == 1.6 17:35:15 INFO - blobuploader == 1.2.4 17:35:15 INFO - docopt == 0.6.1 17:35:15 INFO - functools32 == 3.2.3-2 17:35:15 INFO - jsonschema == 2.5.1 17:35:15 INFO - manifestparser == 1.1 17:35:15 INFO - mozInstall == 1.12 17:35:15 INFO - mozcrash == 1.0 17:35:15 INFO - mozdebug == 0.1 17:35:15 INFO - mozdevice == 0.50 17:35:15 INFO - mozfile == 1.2 17:35:15 INFO - mozhttpd == 0.7 17:35:15 INFO - mozinfo == 0.9 17:35:15 INFO - mozleak == 0.1 17:35:15 INFO - mozlog == 3.4 17:35:15 INFO - moznetwork == 0.27 17:35:15 INFO - mozprocess == 0.25 17:35:15 INFO - mozprofile == 0.28 17:35:15 INFO - mozrunner == 6.13 17:35:15 INFO - mozscreenshot == 0.1 17:35:15 INFO - mozsystemmonitor == 0.3 17:35:15 INFO - moztest == 0.8 17:35:15 INFO - mozversion == 1.4 17:35:15 INFO - psutil == 3.1.1 17:35:15 INFO - requests == 1.2.3 17:35:15 INFO - wsgiref == 0.1.2 17:35:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:35:15 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:35:15 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:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:15 INFO - 'HOME': '/Users/cltbld', 17:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PAGER': '/bin/cat', 17:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:15 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - 'XPC_FLAGS': '0x0', 17:35:15 INFO - 'XPC_SERVICE_NAME': '0', 17:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 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:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x103d21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa5b569490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, '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.tvIxyhQepg/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.ViV77yRdiR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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:35:15 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:35:15 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:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:15 INFO - 'HOME': '/Users/cltbld', 17:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PAGER': '/bin/cat', 17:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:15 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - 'XPC_FLAGS': '0x0', 17:35:15 INFO - 'XPC_SERVICE_NAME': '0', 17:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Running post-action listener: _resource_record_post_action 17:35:15 INFO - Running post-action listener: _start_resource_monitoring 17:35:15 INFO - Starting resource monitoring. 17:35:15 INFO - [mozharness: 2017-04-29 00:35:15.819373Z] Finished create-virtualenv step (success) 17:35:15 INFO - [mozharness: 2017-04-29 00:35:15.820316Z] Running install step. 17:35:15 INFO - Running pre-action listener: _resource_record_pre_action 17:35:15 INFO - Running main action method: install 17:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:16 INFO - Reading from file tmpfile_stdout 17:35:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:16 INFO - Reading from file tmpfile_stdout 17:35:16 INFO - Output received: 17:35:16 INFO - Usage: mozinstall [options] installer 17:35:16 INFO - Options: 17:35:16 INFO - -h, --help show this help message and exit 17:35:16 INFO - -d DEST, --destination=DEST 17:35:16 INFO - Directory to install application into. [default: 17:35:16 INFO - "/builds/slave/test"] 17:35:16 INFO - --app=APP Application being installed. [default: firefox] 17:35:16 INFO - mkdir: /builds/slave/test/build/application 17:35:16 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:35:16 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:35:35 INFO - Reading from file tmpfile_stdout 17:35:35 INFO - Output received: 17:35:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:35:35 INFO - Running post-action listener: _resource_record_post_action 17:35:35 INFO - [mozharness: 2017-04-29 00:35:35.747067Z] Finished install step (success) 17:35:35 INFO - [mozharness: 2017-04-29 00:35:35.747220Z] Running run-tests step. 17:35:35 INFO - Running pre-action listener: _resource_record_pre_action 17:35:35 INFO - Running main action method: run_tests 17:35:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:35 INFO - 2017-04-28 17:35:35.761 screenresolution[1629:7321] starting screenresolution argv=screenresolution get 17:35:35 INFO - 2017-04-28 17:35:35.764 screenresolution[1629:7321] Display 0: 1600x1200x32@60 17:35:35 INFO - 2017-04-28 17:35:35.770 screenresolution[1630:7324] starting screenresolution argv=screenresolution list 17:35:35 INFO - Available Modes on Display 0 17:35:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:35 INFO - Intel Iris: 17:35:35 INFO - Chipset Model: Intel Iris 17:35:35 INFO - Type: GPU 17:35:35 INFO - Bus: Built-In 17:35:35 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:35 INFO - Vendor: Intel (0x8086) 17:35:35 INFO - Device ID: 0x0a2e 17:35:35 INFO - Revision ID: 0x0009 17:35:35 INFO - Displays: 17:35:35 INFO - Display: 17:35:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:35 INFO - Display Serial Number: 1600x1200 60 17:35:35 INFO - Main Display: Yes 17:35:35 INFO - Mirror: Off 17:35:35 INFO - Online: Yes 17:35:35 INFO - Rotation: Supported 17:35:36 INFO - Return code: 0 17:35:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:36 INFO - Python 2.7.3 17:35:36 INFO - Return code: 0 17:35:36 INFO - grabbing minidump binary from tooltool 17:35:36 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:35:36 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 0x103affd30>, '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 0x103a25db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:36 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:35:36 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:35:36 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:35:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:36 INFO - Return code: 0 17:35:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:35:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:36 INFO - ENV: RUST_BACKTRACE is now 1 17:35:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:35:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:36 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-0296', '--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:35:36 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-0296 --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:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tvIxyhQepg/Render', 17:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:36 INFO - 'HOME': '/Users/cltbld', 17:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:36 INFO - 'LOGNAME': 'cltbld', 17:35:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:36 INFO - 'MOZ_NO_REMOTE': '1', 17:35:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:36 INFO - 'NO_EM_RESTART': '1', 17:35:36 INFO - 'PAGER': '/bin/cat', 17:35:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:36 INFO - 'PWD': '/builds/slave/test', 17:35:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:36 INFO - 'RUST_BACKTRACE': '1', 17:35:36 INFO - 'SHELL': '/bin/bash', 17:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ViV77yRdiR/Listeners', 17:35:36 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 17:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:36 INFO - 'USER': 'cltbld', 17:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:36 INFO - 'XPC_FLAGS': '0x0', 17:35:36 INFO - 'XPC_SERVICE_NAME': '0', 17:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:36 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-0296', '--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:35:36 INFO - mozversion application_buildid: 20170428075320 17:35:36 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:35:36 INFO - mozversion application_display_name: Nightly 17:35:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:36 INFO - mozversion application_name: Firefox 17:35:36 INFO - mozversion application_remotingname: firefox 17:35:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:36 INFO - mozversion application_vendor: Mozilla 17:35:36 INFO - mozversion application_version: 55.0a1 17:35:36 INFO - mozversion platform_buildid: 20170428075320 17:35:36 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:35:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:36 INFO - mozversion platform_version: 55.0a1 17:35:36 INFO - using testdate: 1493426136 17:35:36 INFO - actual date: 1493426136 17:35:36 INFO - starting webserver on 'localhost:49227' 17:35:36 INFO - SUITE-START | Running 2 tests 17:35:36 INFO - TEST-START | dromaeo_css 17:35:36 INFO - operating with platform_type : mac_ 17:35:36 INFO - Initialising browser for dromaeo_css test... 17:35:36 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpsOwt1z/profile http://localhost:49227/getInfo.html) 17:35:38 INFO - PID 1640 | 2017-04-28 17:35:38.833 plugin-container[1645:7565] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484b, name = 'com.apple.tsm.portname' 17:35:38 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:38 INFO - PID 1640 | 2017-04-28 17:35:38.835 plugin-container[1645:7565] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 17:35:38 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:38 INFO - PID 1640 | 2017-04-28 17:35:38.835 plugin-container[1645:7565] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:39 INFO - PID 1640 | __metrics Screen width/height:1600/1200 17:35:39 INFO - PID 1640 | colorDepth:24 17:35:39 INFO - PID 1640 | Browser inner width/height: 1024/689 17:35:39 INFO - PID 1640 | __metrics 17:35:39 ERROR - PID 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:35:40 INFO - TEST-INFO | 1640: exit 0 17:35:40 INFO - Browser initialized. 17:35:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:40 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpsOwt1z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:42 INFO - PID 1646 | 2017-04-28 17:35:42.492 plugin-container[1647:7697] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x953b, name = 'com.apple.tsm.portname' 17:35:42 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:42 INFO - PID 1646 | 2017-04-28 17:35:42.493 plugin-container[1647:7697] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.CFPasteboardClient' 17:35:42 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:42 INFO - PID 1646 | 2017-04-28 17:35:42.493 plugin-container[1647:7697] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:52 INFO - PID 1646 | RSS: Main: 251994112 17:35:52 INFO - PID 1646 | 17:38:56 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49227/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49227/tests/dromaeo/cssquery-ext.html) 17:38:58 INFO - PID 1646 | RSS: Main: 254705664 17:38:58 INFO - PID 1646 | 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 17:40:40 INFO - PID 1646 | 17:40:40 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:40 INFO - PID 1646 | Full stack: 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 17:40:40 INFO - PID 1646 | 17:40:40 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:40 INFO - PID 1646 | Full stack: 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 17:40:40 INFO - PID 1646 | 17:40:40 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:40 INFO - PID 1646 | Full stack: 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | ************************* 17:40:40 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 17:40:40 INFO - PID 1646 | 17:40:40 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:40 INFO - PID 1646 | Full stack: 17:40:40 INFO - PID 1646 | ************************* 17:42:00 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49227/tests/dromaeo/cssquery-ext.html (next: http://localhost:49227/tests/dromaeo/cssquery-jquery.html) 17:42:00 INFO - PID 1646 | RSS: Main: 260882432 17:42:00 INFO - PID 1646 | 17:45:02 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49227/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49227/tests/dromaeo/cssquery-mootools.html) 17:45:02 INFO - PID 1646 | RSS: Main: 269983744 17:45:02 INFO - PID 1646 | 17:48:04 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49227/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49227/tests/dromaeo/cssquery-prototype.html) 17:48:05 INFO - PID 1646 | RSS: Main: 262770688 17:48:05 INFO - PID 1646 | 17:51:08 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49227/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49227/tests/dromaeo/cssquery-yui.html) 17:51:08 INFO - PID 1646 | RSS: Main: 272351232 17:51:08 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49227/tests/dromaeo/cssquery-yui.html (next: http://localhost:49227/tests/dromaeo/cssquery-dojo.html) 17:54:10 INFO - PID 1646 | RSS: Main: 267055104 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | __start_tp_report 17:54:10 INFO - PID 1646 | _x_x_mozilla_page_load 17:54:10 INFO - PID 1646 | _x_x_mozilla_page_load_details 17:54:10 INFO - PID 1646 | |i|pagename|runs| 17:54:10 INFO - PID 1646 | |0;dojo.html;3061.3112049788797;3562.038249672587;3606.4410016447428;3615.92768144637;3627.818609069546;5594.160875868622;5632.7746890124445;6119.388061193884;6205.28639206492;6242.812715618527;5549.805756798512;5860.710643658399;6103.246756470926;6122.489639783232;6185.69071546422;5365.409804921455;5365.812196573121;5384.946150538483;5403.2165336026255;5416.620836541444;5429.321334833146;5495.450454954513;5510.228568000483;5569.275994120779;5570.2480165177585;5286.444923283038;5438.700871452069;5439.782408703647;5488.341399032121;5498.395176530578;4461.353103799964;5353.223782551547;5368.865778355573;5391.946080539223;5404.540614047811;5338.412774594792;5373.140297552372;5409.459054094598;5423.728813559345;5452.809151679672;5128.2564028216075;5483.656504156507;6265.310815810257;6288.182536270301;6297.181366422382;6336.46140078094;6652.268250492442;6652.334766523358;6670;6686.297938716413;6520.608763474207;6717.059611654372;6800.149981252343;6812.62530560819;6822.215445223813;6236.781712640036;6259.7496100156395;6267.9373206268265;6287.371262873676;6289.465395441347;6863.622500762506;6908.378245957888;6918.515703900779;6919.7232110715;6938.236793952661;6240.251169859555;6376.872462550816;6393.808185754435;6559.278479367265;6575.309592492815;6595.274519802818;6707;6719.899201511981;6738.663066846736;6755.49333799967;6338.30278669346;6565.146530950946;6620.139381880324;6625.0724898514245;6644.501662375341;6421.903671444932;6536.150300460909;6588;6601.636909969901;6636.203655561363;5312.017276803804;5327.706976116273;5336.066188417011;5344.946550534522;5351.09031464652;4698.976505117521;4707.929381059287;4714.127886341038;4751.192297309466;4751.548602882721;6025.3974602540275;6156.907646385308;6240.843978900473;6269.968650156811;6338.58799178052;6067.8774426730315;6707.0610114584;6739.696713647898;6749.763758268536;6752.797416077526;5791.536677065825;6304.810855674337;6320.715567799368;6327.683615819191;6329.272133704683;5600.467955544217;5784.219130417424;5785.971070144707;5863.853403664943;5890.67601281925;5970.76116955317;6770.593764374054;6868.587884726932;6926.722931082701;6977.2673869243;6458.483321334376;6768.695408706521;6788.185417749902;6808.251092379934;6818.8636227276165;6012.579119461596;6679.833004174934;6680.766173183915;6694.029365742038;6936.549124306904;6610.239822420291;6621.238557565749;6641.1034510342415;6641.435477984425;6650.4347130492515;6378.330275321025;6447.548671592944;6676.232233293039;6722.932770672231;6811.386975172259;6464.22429308486;6528.934710653023;6543.770968016097;6559.245686746085;6588.8023359299295;5561.304836895388;6210.720517576629;6580.703868325841;6585.111010013587;6595.142631457879;6220.533459990428;6240.594361366497;6335.90496142549;6420.454261387835;6443.2590252119735;6456;6494.1232933553365;6589.143411356493;6593.439557637655;6595.175603049619;6343.238811342669;6387.041943708481;6396.072569477306;6404.615723056631;6408.455281301141 17:54:10 INFO - PID 1646 | |1;ext.html;800.7077416742889;821.7699044267605;1115.1079136690646;1156.2484385149646;1291.6641673164975;36395.272094558124;37546.62453375466;37649.058773530676;37804.43293350599;37839.243215135684;29666.11001669948;37762.43356349657;38080.80959595198;38222;38253.61746382535;7486.737964171228;7806.492577982442;7971.9601401993195;8442.113578074306;8450.32397408209;8447.535385553792;8544.316454683641;8545.359098067638;8576.485410875337;8583.570821458934;8470.49177049376;8513.148685131498;8531.701390451335;8601.95699021504;8608.956955215246;8531.445456045369;8577.442466239736;8580;8588.785280367978;8597.828043439158;8328.708495202638;8355;8397.6221070052;8416.957915210445;8432.241098301121;37263;37409;37507.4373884392;37641.81179094087;37662.62337376618;3674.6141655126094;3693;3694.649008344203;3714.331420344337;3714.4985426967282;30712.84643576768;30736.692633073606;30821.537676934862;30860.0741977741;30985.535216971763;3086.5678804967324;3150.70068343507;3166.9524957125664;3168.255459966906;3175.7935734177436;282164;282213;282371;282955;284270;37478.62521374806;45420.3186952196;47787.522124779;48072.27891581629;48111.75944120257;44027.77986110113;45316;46766.29850552244;50255.74872125616;50898.74550627223;14187.93590480718;14323.35544900482;14444.133351998913;14456.638584035483;14483.058601190889;11184.888151118548;11331.660050198507;11381.772364552662;11381.886181138249;11407.600733974272;10818.729531761768;13221.603351899459;13313.933430332787;13315.467381304834;13512.783849453597;5915.881682366328;5962.85092872673;5998.880022399615;6008.218931538872;6035.637861728311;996.6461906023402;1017.0947856407655;1029.7580068683853;1050.5482642463662;1052.5158427123608;19604.411867643994;21753.78246217549;23437.296881093593;24510.019599215833;24625.63061554078;1010.686687126993;1131.6378758797107;1157.6006277834133;1162.6802629276847;1169.1348402182323;12104.815568165492;12537.87462125367;12549.560765373351;12564.057695672862;12567.245965242115;318310;320558;320719;321450;322963;53785.924281514934;54043.45956540384;54081.72959135179;54176.18735718967;54297;1511.7581187010026;1568.3648122510401;1572.75622278547;1575.6848630273992;1580.3125640346257;18625.627487450445;24020.63969040501;24110.794460277266;24122.39694007664;24228.39429014289;32287.35425291528;34347.191393205474;36388.27223455463;36599;36626.8168659155;196113;198675;198679;283969;285782;28559.857200713865;35198.47202292019;37335;37577;37736.81131594325;45140.32289515594;45457;47050;47093;47296;27361.452770944867;30714.924977625677;31371.84314078415;31469.370612588078;32178.517322240652;31155.221119472193;31598;31970.68029319677;32003.83998079995;32204.033878983668;31745.30164935914;31868.84065579657;38551.03622409462;38750.61249387583;38886.222275554894;30748.23129421693;32113.518297226026;32547.02358929236;32576.83711581522;32791;22167;23582.764172358744;24689.4848795871;24792.25623231306;25367.74632253654 17:54:10 INFO - PID 1646 | |2;jquery.html;435.65800846335634;443.2774577438775;443.4390496022532;455.32157085941947;456.915470637932;19733.50666233345;21023.789762102373;21789.891050544724;21880;21940;22133;22520.211792587263;23371.766282337172;23451.5309693806;23643;5994.250718660168;6101.420365065312;6208.565400421972;6254.781082662085;6275.560710750249;6059.66671833049;6177.722002509875;6192.225971753531;6226.315105338409;6249.281332646736;5986.431289027557;6103.725332360033;6176.227971503562;6186.072089186636;6229.501639868799;6206.751729930797;6221.751129954796;6233;6240.438360547527;6263.060540918876;5424;5462.617616766828;5574.832755017356;5581.190727344512;5592.412796656374;23625.93683284239;26236.8688156558;27570.035048773396;28151.0147144851;28336.43327133446;2218.389942765736;2297.8506397084134;2312.4218945263683;2316.7683231676865;2322.129201549419;17721.911390442965;17783.555411114696;18008.189631466616;18564.25742970293;18714.62570748591;2121.289368061701;2146.9694546617557;2189.4745261137214;2191.550732099932;2195.692603035576;131159.34420327932;136858.31570842082;150403.49596504006;164024;165007.17496412562;12183.817242741366;12773.169743966613;12787.552435664707;12795.93602031984;12805.615831525069;16345.182740862909;16552.586185345222;16563.171841407882;16566.83433165677;16599.253033613517;7561.621918904033;7650.360625584164;8854.86717699235;9064.954675226581;9065.68270110543;8540.829183416421;8573;8598.140185981352;8700.78248043804;8765.649374025095;7961.44269901113;8055.5972201389695;8117.878231826528;8124.512529248264;8151.633176507072;1789.7673302470596;2233.218373569238;2233.4416395901026;2251.7860803223666;2420.8547487150477;870.4559650218613;947.966821161256;960.558143254111;961.5817119553017;985.1380042462845;18373.897566146075;21220.681689774665;21644.675329870064;21792.45518862041;22046.559068818533;1011.8633984412011;1019.3374306700556;1024.6772266735954;1043.2905624175482;1047.0628787235382;9195.896492420952;9385.399386094765;10675.558799562115;10801.67594972152;11071.280366776295;543262;550398;552612;557329;557387;123022;125624.37187814002;129557.70442295645;132533.33733331272;134768;1186.347508870118;1210;1227.2268470863298;1236.2829558855842;1237.1340061956666;21761.564768704222;22445.5510889778;22680.092796288624;23027;23029.309120726404;56980.290591282326;60261;60628;60902.69548652229;61416;81154.18845811703;83023;83040.58479707563;83744.16255837363;84608;8684.2184203422;8795.736127916172;8822.294216462797;9047.502387368759;9237.722868313962;13952.58142255734;14113.435462581381;14189.574312770634;14494.347754350869;14531.491397801026;10204.540795664361;11896.345700986183;11976.820347694616;12136.453859576517;12327.506899724269;10962;11179.832302515306;11284.717882053013;11364.54541818318;11374.43127843621;10261.897381026094;11607.883921161017;12202.938985305016;12376.690582735504;12469.688257793629;7649.694012239448;8676.349273804364;8695.826083478421;8871.157240062184;8942.46345219289;12074.335911524598;12087.456064477296;12175.417195764494;12179.939100304442;12271.263724176579 17:54:10 INFO - PID 1646 | |3;mootools.html;1280.5134049061355;1450.6445920749418;1470.6396932751477;1474.638713515189;1484.9109053456793;11242.775144497105;11430.314181149137;11945;11978.880211197886;11980.34108124053;11613.651590452278;11842.348670823101;11946.462409191585;11961.820572691417;11963.940180299109;2530.1903390914913;2560.9871950640313;2561.0140096062964;2563.7051739049966;2568.0754928225824;2454;2502.0492212959143;2509.5482813093636;2510.6108553174286;2516;2501.187114187896;2519.1812660885194;2549.12055340908;2549.7322781107996;2550.591905295153;2478.7397323280975;2488.539620170265;2525.6464095026713;2527.6208568714655;2545.109211775873;2102.4533621258583;2405.1822380390577;2490.140901389018;2495.9750402496106;2514.5473814713346;11675.824862626983;11737.88262117385;11810.586629467927;11829.822552661717;11830.881691183064;6563.967180164116;6729.057931889491;6821.522493425462;6832.93167068328;6850.972354146868;4002.459667944819;4320.265554855682;4379.890502737457;4394.780260986938;4403.471583410012;1259.7606454773563;1266.9873301266962;1279.4818098670053;1299.6750812296925;1300.2913412190285;16269.779766517559;16496.010239385676;16655.25051372691;16658;16910.15449227546;5401.675899446046;5456.399796022434;5580.441955804468;5763.567732420085;5781.421857814269;11836.526538938519;11901.285922844658;11947;11949.462274197682;11955.103367247491;6536.673166341664;6613.305602911625;6617.073609694647;6625.138731964814;6626.237982631963;5909.497692696083;6258.874822503524;6262.6868656566985;6296.307406185316;6307.621542707452;4248.320268756984;4372.300431930876;4394.231009573312;4417.757023363746;4424.181526417558;1264.367816091954;1285.5693342730103;1288.6340479092191;1299.6490947444138;1300.7983762516826;776.989913112951;779.380392587894;797.4171270028988;799.6841247707123;809.1180613131714;6386.680665966776;7269.018682477904;7521.172671006185;7555.357794587411;7594.772156835304;948.4119845695575;958.4105774948357;959.5490119643896;961.2214106573698;962.1340793286098;4336.154449882306;4375.431193944767;4408.074304396048;4467.441569803775;4500.459944806578;14914.850851491346;15315.234238288042;15419.845801542066;15465.613359665873;15480.845191548166;11590.768184636428;12512.749745005049;15417.306221220071;15418.922905385625;15428.537143885702;7470.290322419471;7905.328047115944;8050.07424146219;8589.914100858912;8617.922759655043;5799.869025539979;6226.750929962932;7173.928260717326;7233.276672332725;7263.4915555910575;12511.749765004832;12661.113722039368;12880.613581592566;12908;13148.73702525925;12890.548830790878;12949.352532373532;13116.606501804961;13183.868161318647;13455.730885382041;9197.954010230174;9504.287178461782;9639.566219520279;9643.710688679352;9651.372660777028;10955.233133680566;11003.17476189273;11093.5562577496;11095.112391008539;11169.497372618089;9202.079792020744;9249.12133347331;9342.719718408458;9358.298127640319;9408.670696525589;8412.522213538792;8566.014908285377;9015.504147271962;9024.278057755495;9222.861657075284;7063.894041589483;8252.803343515037;8360.372972027244;8417.747467575982;8468.576571171294;6128.356522565245;6147.72335244924;6201.317855036033;6292.748290068529;6338.176037115146;5040.722760248075;6080.574359794772;6099.481544068626;6222.782202622887;6328.936710632835 17:54:10 INFO - PID 1646 | |4;prototype.html;406.78033861714675;413.66906474820144;419.3374468340023;420.0506854508809;427.4357847641115;5032.723200223986;6013.188219590354;6146.4775494083;6191.50467962563;6222.408871157244;5849.795257166;5976.701164941757;5977.731002104905;6037.818865434044;6050.667213303266;4278.4010238566625;4377.080813029268;4403.339499075132;4423;4462.955370446302;3751.9437208441896;3958.782266975315;4073.002114481956;4275.102228531997;4393.802278897458;4341.500727416356;4361.80371883266;4372;4381.561843815625;4395.560443955595;4311.935320970172;4353.499347575038;4354.629856462205;4356.6514678825615;4379.737215767048;3088.3514461963014;3716.591174970778;3734.6452087051684;3760.2103558252797;3761.4357846322996;5871.1193321001765;5887.205227294303;5905.468507834273;5910.290765108171;5910.556708246899;5034.773435195425;5135.922961155586;5165.9225111623355;5166.535011848951;5203;6071.148299768569;6273.870703273455;6433.485321174342;6444.677766111676;6471;4149.813258403379;4267.551907049746;4272.46594175728;4272.5086615039045;4283.571642835723;4677.812887484497;5760.683162426065;6704.999999999951;6734.797956061277;6814.522983391164;3977.3238549446664;4261.595148460891;4271.10306835568;4313.33936434475;4331.956680433155;3811.7522361046445;3890.533136023695;4318.762468064287;4368.432103826546;4374.58441448062;4946.554810067039;5120.718360490208;5156.613254005964;5167.199084141964;5176.922346164811;5410.3507579090765;6235.719392627343;6484.675766211765;6487.54587178893;6514.697060587901;1252.7306629074792;1472.5214305350803;1491.7016596680708;1495.7831114488338;1495.9925200373928;942.948137852411;974.8537719342155;983.7540614846289;990.9256805739454;992.1616234282164;5017.874553136127;5617.505995203902;5975;6131.96934015327;6188.535859810532;5287.41838397776;5433.8369848904595;5941.494972927263;6467.611943283324;6552.443042341359;5935.910961335583;6079.483243924227;6106.511479081662;6146.508279337642;6168.784092556739;2883.783716221292;3110.7822452428563;3129.5462157986963;3458.4812278157974;3517.402041652925;6228.34602366754;6334.588251763621;6796.796096117125;6991.203518592502;7013.509054366247;6861;6944.062551555577;6955.1653801544135;6959.512834101564;6965.547239429421;5572.777088916479;5694.032014557618;6839.487038472134;6952.721891124298;6954.3393377629045;5874.206982057539;6629.867402652017;6750.729970801113;6761.357671021246;6779.288174741581;6439.356064393523;6565.474762018932;6648.966755166193;6649.73401063952;6651.640921334695;6818.761343352959;7055.506114571931;7057.964710176417;7095.8266308312095;7109.075820143348;4325.7837108145095;4334.544872788312;4346.543612920598;4349.695521313604;4366.716163449366;6209.534284928558;6289.804937061944;6529;6568.838543816261;6743.35938085881;5647.3787883333625;6526.282108968105;6558.213014438298;6575.63833989116;6580.21037475506;6414.550981431442;6543.476521878333;6565.835854103686;6578.671066446755;6598.241202261801;5299.5760339172;5910.852228694317;6067.968445364387;6423.96788016057;6447.258565265054;5678.68767217807;6423.518236132402;6580.30906754803;6591.780520603704;6615.4376877965915;5555.833325000256;6380.585261957958;6386.93613063882;6395.360463953567;6422.935770642233 17:54:10 INFO - PID 1646 | |5;yui.html;778.3850757901258;840.3949156607241;844.2528362399279;860.5138096975209;878.6880657366635;14057.507987220462;14560.927195364035;15153.318100685468;16648;17135.57161070974;17001.149942502856;17401.91299043503;17807;17828.019458929786;17904.910475447603;805.7743831727112;995.149147478906;1009.0918173643743;1028.8250997330472;1029.3360782295415;815.5799763121997;991.8413053911376;999.6601155607092;1011.0546638892622;1017.5573625472942;1031.7214352124922;1041.9374837509736;1044.5404022230232;1056.8520407142967;1058.9099926506256;1043.5251960358057;1051.6319288249128;1054.4674939155755;1054.7152268887396;1054.7995880782628;758.2341834746891;782.3780094824629;782.718221440281;783.0525064671754;783.2324322164311;16481.25834337458;16958.067306298148;17006.659866802718;17137.657246854993;17173.7423938641;15323.387064517407;16702.83297167025;16844.410445634465;16885.831141688548;17023.829761702473;13470.797938030937;13822.585322440344;13930.164190148624;13941.233232172226;13948.372323245478;3411.710004649608;3481.8433170507387;3612.837422316002;3644.2893635741043;3645.76302540334;127373;127895;128971;129259.99999999905;130410;12899.871001290056;13281.468741250243;13823.585292441243;13824.239666818221;13829.654258643413;24807.5038499229;25398.746012540007;25559.977600895756;25691.871540642176;26006.6099008515;7603.543787372775;8034.919650803534;8056.436049476598;8072.192780721881;8091.1504292048485;3916.3342231820657;3967.3453880110037;3995.7402768819934;3997.700172487017;4000.0599859033105;4287.442632457823;4321.373400856921;4423.889402764957;4456.264716321771;4458.866234012985;916.9312301577409;932.7061975477839;937.9624815007323;954.06025065312;957.1816097236901;642.4763817488732;645.8966565349522;649.9480041596661;661.8610091880663;682.4301708073715;9354.766130846647;12136.5145394185;12140.696482588006;12148.271103733805;12204.206726562745;645.6513482719279;645.985802290409;673.7877568565887;678.2302087131142;683.3849535418065;4706.411698537683;5080.390353157644;5485.259489968803;5509.283793106871;5509.834704958857;107603;108192;108520;108775;109756.4512177434;94352.11295774046;94605;96083.51958240164;96089;96683;64029.67985160044;85559.71660425099;86835.56582217175;87273.96349419898;88302;10746.408947507962;11367.431628418712;11533.192676512563;11612.94193529027;11770.882291176978;42869.356959645;42883.571164287954;43436.56563434325;43684.344734828366;44194.558054419045;56271.43728562662;56679.43320566742;56886.43113568977;57363.42636573581;57707.71146144242;14663.413463461342;15006.774898376314;15456.768148477557;16108.516744497683;16664;17674.293028278724;18549;18768.53078673044;18838.811611883706;18862.151203196165;15518.9224053879;16292.592685182964;16589;17613.20740566652;17637.206325715117;14465.710685786014;17019.40432084871;17187.882787618764;17451.738223926906;17782.288708452033;14083.366248519047;16461.613066105587;16583.91708041452;16857.662846743242;17144.885582437102;11875.168738188244;12098.939505302416;12181.939090304491;12265.754684906073;12294.508219671114;13597.320133993459;13690;13693.657658558615;13888.375023124187;13891.930540347234 17:54:10 INFO - PID 1646 | __end_tp_report 17:54:10 INFO - PID 1646 | __start_cc_report 17:54:10 INFO - PID 1646 | _x_x_mozilla_cycle_collect,421 17:54:10 INFO - PID 1646 | __end_cc_report 17:54:10 INFO - PID 1646 | __startTimestamp1493427250917__endTimestamp 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | ------- Summary: start ------- 17:54:10 INFO - PID 1646 | Number of tests: 6 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | [#0] dojo.html Cycles:165 Average:6098.43 Median:6335.90 stddev:738.98 (11.7%) stddev-sans-first:701.78 17:54:10 INFO - PID 1646 | Values: 3061.3 3562.0 3606.4 3615.9 3627.8 5594.2 5632.8 6119.4 6205.3 6242.8 5549.8 5860.7 6103.2 6122.5 6185.7 5365.4 5365.8 5384.9 5403.2 5416.6 5429.3 5495.5 5510.2 5569.3 5570.2 5286.4 5438.7 5439.8 5488.3 5498.4 4461.4 5353.2 5368.9 5391.9 5404.5 5338.4 5373.1 5409.5 5423.7 5452.8 5128.3 5483.7 6265.3 6288.2 6297.2 6336.5 6652.3 6652.3 6670.0 6686.3 6520.6 6717.1 6800.1 6812.6 6822.2 6236.8 6259.7 6267.9 6287.4 6289.5 6863.6 6908.4 6918.5 6919.7 6938.2 6240.3 6376.9 6393.8 6559.3 6575.3 6595.3 6707.0 6719.9 6738.7 6755.5 6338.3 6565.1 6620.1 6625.1 6644.5 6421.9 6536.2 6588.0 6601.6 6636.2 5312.0 5327.7 5336.1 5344.9 5351.1 4699.0 4707.9 4714.1 4751.2 4751.5 6025.4 6156.9 6240.8 6270.0 6338.6 6067.9 6707.1 6739.7 6749.8 6752.8 5791.5 6304.8 6320.7 6327.7 6329.3 5600.5 5784.2 5786.0 5863.9 5890.7 5970.8 6770.6 6868.6 6926.7 6977.3 6458.5 6768.7 6788.2 6808.3 6818.9 6012.6 6679.8 6680.8 6694.0 6936.5 6610.2 6621.2 6641.1 6641.4 6650.4 6378.3 6447.5 6676.2 6722.9 6811.4 6464.2 6528.9 6543.8 6559.2 6588.8 5561.3 6210.7 6580.7 6585.1 6595.1 6220.5 6240.6 6335.9 6420.5 6443.3 6456.0 6494.1 6589.1 6593.4 6595.2 6343.2 6387.0 6396.1 6404.6 6408.5 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | [#1] ext.html Cycles:180 Average:43149.32 Median:32191.28 stddev:73958.65 (229.7%) stddev-sans-first:74097.77 17:54:10 INFO - PID 1646 | Values: 800.7 821.8 1115.1 1156.2 1291.7 36395.3 37546.6 37649.1 37804.4 37839.2 29666.1 37762.4 38080.8 38222.0 38253.6 7486.7 7806.5 7972.0 8442.1 8450.3 8447.5 8544.3 8545.4 8576.5 8583.6 8470.5 8513.1 8531.7 8602.0 8609.0 8531.4 8577.4 8580.0 8588.8 8597.8 8328.7 8355.0 8397.6 8417.0 8432.2 37263.0 37409.0 37507.4 37641.8 37662.6 3674.6 3693.0 3694.6 3714.3 3714.5 30712.8 30736.7 30821.5 30860.1 30985.5 3086.6 3150.7 3167.0 3168.3 3175.8 282164.0 282213.0 282371.0 282955.0 284270.0 37478.6 45420.3 47787.5 48072.3 48111.8 44027.8 45316.0 46766.3 50255.7 50898.7 14187.9 14323.4 14444.1 14456.6 14483.1 11184.9 11331.7 11381.8 11381.9 11407.6 10818.7 13221.6 13313.9 13315.5 13512.8 5915.9 5962.9 5998.9 6008.2 6035.6 996.6 1017.1 1029.8 1050.5 1052.5 19604.4 21753.8 23437.3 24510.0 24625.6 1010.7 1131.6 1157.6 1162.7 1169.1 12104.8 12537.9 12549.6 12564.1 12567.2 318310.0 320558.0 320719.0 321450.0 322963.0 53785.9 54043.5 54081.7 54176.2 54297.0 1511.8 1568.4 1572.8 1575.7 1580.3 18625.6 24020.6 24110.8 24122.4 24228.4 32287.4 34347.2 36388.3 36599.0 36626.8 196113.0 198675.0 198679.0 283969.0 285782.0 28559.9 35198.5 37335.0 37577.0 37736.8 45140.3 45457.0 47050.0 47093.0 47296.0 27361.5 30714.9 31371.8 31469.4 32178.5 31155.2 31598.0 31970.7 32003.8 32204.0 31745.3 31868.8 38551.0 38750.6 38886.2 30748.2 32113.5 32547.0 32576.8 32791.0 22167.0 23582.8 24689.5 24792.3 25367.7 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | [#2] jquery.html Cycles:180 Average:35847.78 Median:12670.87 stddev:93545.03 (738.3%) stddev-sans-first:93769.66 17:54:10 INFO - PID 1646 | Values: 435.7 443.3 443.4 455.3 456.9 19733.5 21023.8 21789.9 21880.0 21940.0 22133.0 22520.2 23371.8 23451.5 23643.0 5994.3 6101.4 6208.6 6254.8 6275.6 6059.7 6177.7 6192.2 6226.3 6249.3 5986.4 6103.7 6176.2 6186.1 6229.5 6206.8 6221.8 6233.0 6240.4 6263.1 5424.0 5462.6 5574.8 5581.2 5592.4 23625.9 26236.9 27570.0 28151.0 28336.4 2218.4 2297.9 2312.4 2316.8 2322.1 17721.9 17783.6 18008.2 18564.3 18714.6 2121.3 2147.0 2189.5 2191.6 2195.7 131159.3 136858.3 150403.5 164024.0 165007.2 12183.8 12773.2 12787.6 12795.9 12805.6 16345.2 16552.6 16563.2 16566.8 16599.3 7561.6 7650.4 8854.9 9065.0 9065.7 8540.8 8573.0 8598.1 8700.8 8765.6 7961.4 8055.6 8117.9 8124.5 8151.6 1789.8 2233.2 2233.4 2251.8 2420.9 870.5 948.0 960.6 961.6 985.1 18373.9 21220.7 21644.7 21792.5 22046.6 1011.9 1019.3 1024.7 1043.3 1047.1 9195.9 9385.4 10675.6 10801.7 11071.3 543262.0 550398.0 552612.0 557329.0 557387.0 123022.0 125624.4 129557.7 132533.3 134768.0 1186.3 1210.0 1227.2 1236.3 1237.1 21761.6 22445.6 22680.1 23027.0 23029.3 56980.3 60261.0 60628.0 60902.7 61416.0 81154.2 83023.0 83040.6 83744.2 84608.0 8684.2 8795.7 8822.3 9047.5 9237.7 13952.6 14113.4 14189.6 14494.3 14531.5 10204.5 11896.3 11976.8 12136.5 12327.5 10962.0 11179.8 11284.7 11364.5 11374.4 10261.9 11607.9 12202.9 12376.7 12469.7 7649.7 8676.3 8695.8 8871.2 8942.5 12074.3 12087.5 12175.4 12179.9 12271.3 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | [#3] mootools.html Cycles:180 Average:7135.87 Median:4125.39 stddev:4459.25 (108.1%) stddev-sans-first:4450.05 17:54:10 INFO - PID 1646 | Values: 1280.5 1450.6 1470.6 1474.6 1484.9 11242.8 11430.3 11945.0 11978.9 11980.3 11613.7 11842.3 11946.5 11961.8 11963.9 2530.2 2561.0 2561.0 2563.7 2568.1 2454.0 2502.0 2509.5 2510.6 2516.0 2501.2 2519.2 2549.1 2549.7 2550.6 2478.7 2488.5 2525.6 2527.6 2545.1 2102.5 2405.2 2490.1 2496.0 2514.5 11675.8 11737.9 11810.6 11829.8 11830.9 6564.0 6729.1 6821.5 6832.9 6851.0 4002.5 4320.3 4379.9 4394.8 4403.5 1259.8 1267.0 1279.5 1299.7 1300.3 16269.8 16496.0 16655.3 16658.0 16910.2 5401.7 5456.4 5580.4 5763.6 5781.4 11836.5 11901.3 11947.0 11949.5 11955.1 6536.7 6613.3 6617.1 6625.1 6626.2 5909.5 6258.9 6262.7 6296.3 6307.6 4248.3 4372.3 4394.2 4417.8 4424.2 1264.4 1285.6 1288.6 1299.6 1300.8 777.0 779.4 797.4 799.7 809.1 6386.7 7269.0 7521.2 7555.4 7594.8 948.4 958.4 959.5 961.2 962.1 4336.2 4375.4 4408.1 4467.4 4500.5 14914.9 15315.2 15419.8 15465.6 15480.8 11590.8 12512.7 15417.3 15418.9 15428.5 7470.3 7905.3 8050.1 8589.9 8617.9 5799.9 6226.8 7173.9 7233.3 7263.5 12511.7 12661.1 12880.6 12908.0 13148.7 12890.5 12949.4 13116.6 13183.9 13455.7 9198.0 9504.3 9639.6 9643.7 9651.4 10955.2 11003.2 11093.6 11095.1 11169.5 9202.1 9249.1 9342.7 9358.3 9408.7 8412.5 8566.0 9015.5 9024.3 9222.9 7063.9 8252.8 8360.4 8417.7 8468.6 6128.4 6147.7 6201.3 6292.7 6338.2 5040.7 6080.6 6099.5 6222.8 6328.9 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | [#4] prototype.html Cycles:180 Average:5184.04 Median:5910.70 stddev:1667.21 (28.2%) stddev-sans-first:1632.88 17:54:10 INFO - PID 1646 | Values: 406.8 413.7 419.3 420.1 427.4 5032.7 6013.2 6146.5 6191.5 6222.4 5849.8 5976.7 5977.7 6037.8 6050.7 4278.4 4377.1 4403.3 4423.0 4463.0 3751.9 3958.8 4073.0 4275.1 4393.8 4341.5 4361.8 4372.0 4381.6 4395.6 4311.9 4353.5 4354.6 4356.7 4379.7 3088.4 3716.6 3734.6 3760.2 3761.4 5871.1 5887.2 5905.5 5910.3 5910.6 5034.8 5135.9 5165.9 5166.5 5203.0 6071.1 6273.9 6433.5 6444.7 6471.0 4149.8 4267.6 4272.5 4272.5 4283.6 4677.8 5760.7 6705.0 6734.8 6814.5 3977.3 4261.6 4271.1 4313.3 4332.0 3811.8 3890.5 4318.8 4368.4 4374.6 4946.6 5120.7 5156.6 5167.2 5176.9 5410.4 6235.7 6484.7 6487.5 6514.7 1252.7 1472.5 1491.7 1495.8 1496.0 942.9 974.9 983.8 990.9 992.2 5017.9 5617.5 5975.0 6132.0 6188.5 5287.4 5433.8 5941.5 6467.6 6552.4 5935.9 6079.5 6106.5 6146.5 6168.8 2883.8 3110.8 3129.5 3458.5 3517.4 6228.3 6334.6 6796.8 6991.2 7013.5 6861.0 6944.1 6955.2 6959.5 6965.5 5572.8 5694.0 6839.5 6952.7 6954.3 5874.2 6629.9 6750.7 6761.4 6779.3 6439.4 6565.5 6649.0 6649.7 6651.6 6818.8 7055.5 7058.0 7095.8 7109.1 4325.8 4334.5 4346.5 4349.7 4366.7 6209.5 6289.8 6529.0 6568.8 6743.4 5647.4 6526.3 6558.2 6575.6 6580.2 6414.6 6543.5 6565.8 6578.7 6598.2 5299.6 5910.9 6068.0 6424.0 6447.3 5678.7 6423.5 6580.3 6591.8 6615.4 5555.8 6380.6 6386.9 6395.4 6422.9 17:54:10 INFO - PID 1646 | 17:54:10 INFO - PID 1646 | [#5] yui.html Cycles:180 Average:22249.78 Median:17728.29 stddev:31708.24 (178.9%) stddev-sans-first:31756.20 17:54:10 INFO - PID 1646 | Values: 778.4 840.4 844.3 860.5 878.7 14057.5 14560.9 15153.3 16648.0 17135.6 17001.1 17401.9 17807.0 17828.0 17904.9 805.8 995.1 1009.1 1028.8 1029.3 815.6 991.8 999.7 1011.1 1017.6 1031.7 1041.9 1044.5 1056.9 1058.9 1043.5 1051.6 1054.5 1054.7 1054.8 758.2 782.4 782.7 783.1 783.2 16481.3 16958.1 17006.7 17137.7 17173.7 15323.4 16702.8 16844.4 16885.8 17023.8 13470.8 13822.6 13930.2 13941.2 13948.4 3411.7 3481.8 3612.8 3644.3 3645.8 127373.0 127895.0 128971.0 129260.0 130410.0 12899.9 13281.5 13823.6 13824.2 13829.7 24807.5 25398.7 25560.0 25691.9 26006.6 7603.5 8034.9 8056.4 8072.2 8091.2 3916.3 3967.3 3995.7 3997.7 4000.1 4287.4 4321.4 4423.9 4456.3 4458.9 916.9 932.7 938.0 954.1 957.2 642.5 645.9 649.9 661.9 682.4 9354.8 12136.5 12140.7 12148.3 12204.2 645.7 646.0 673.8 678.2 683.4 4706.4 5080.4 5485.3 5509.3 5509.8 107603.0 108192.0 108520.0 108775.0 109756.5 94352.1 94605.0 96083.5 96089.0 96683.0 64029.7 85559.7 86835.6 87274.0 88302.0 10746.4 11367.4 11533.2 11612.9 11770.9 42869.4 42883.6 43436.6 43684.3 44194.6 56271.4 56679.4 56886.4 57363.4 57707.7 14663.4 15006.8 15456.8 16108.5 16664.0 17674.3 18549.0 18768.5 18838.8 18862.2 15518.9 16292.6 16589.0 17613.2 17637.2 14465.7 17019.4 17187.9 17451.7 17782.3 14083.4 16461.6 16583.9 16857.7 17144.9 11875.2 12098.9 12181.9 12265.8 12294.5 13597.3 13690.0 13693.7 13888.4 13891.9 17:54:10 INFO - PID 1646 | -------- Summary: end -------- 17:54:10 INFO - PID 1646 | 17:54:11 INFO - TEST-INFO | 1646: exit 0 17:54:11 INFO - TEST-OK | dromaeo_css | took 1115198ms 17:54:11 INFO - TEST-START | kraken 17:54:11 INFO - operating with platform_type : mac_ 17:54:11 INFO - Initialising browser for kraken test... 17:54:11 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpsNFTl7/profile http://localhost:49227/getInfo.html) 17:54:13 INFO - PID 1655 | 2017-04-28 17:54:13.914 plugin-container[1656:10107] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 17:54:13 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:13 INFO - PID 1655 | 2017-04-28 17:54:13.917 plugin-container[1656:10107] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 17:54:13 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:13 INFO - PID 1655 | 2017-04-28 17:54:13.917 plugin-container[1656:10107] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:54:14 INFO - PID 1655 | __metrics Screen width/height:1600/1200 17:54:14 INFO - PID 1655 | colorDepth:24 17:54:14 INFO - PID 1655 | Browser inner width/height: 1024/689 17:54:14 INFO - PID 1655 | __metrics 17:54:14 ERROR - PID 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:54:15 INFO - TEST-INFO | 1655: exit 0 17:54:15 INFO - Browser initialized. 17:54:15 INFO - Running cycle 1/1 for kraken test... 17:54:15 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpsNFTl7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:17 INFO - PID 1657 | 2017-04-28 17:54:17.357 plugin-container[1658:10233] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:54:17 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:17 INFO - PID 1657 | 2017-04-28 17:54:17.358 plugin-container[1658:10233] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 17:54:17 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:17 INFO - PID 1657 | 2017-04-28 17:54:17.358 plugin-container[1658:10233] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:54:27 INFO - PID 1657 | RSS: Main: 252489728 17:54:27 INFO - PID 1657 | 17:54:30 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49227/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:31 INFO - PID 1657 | RSS: Main: 259829760 17:54:31 INFO - PID 1657 | 17:54:33 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49227/tests/kraken/driver.html?testName=audio-dft) 17:54:34 INFO - PID 1657 | RSS: Main: 266575872 17:54:34 INFO - PID 1657 | 17:54:37 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49227/tests/kraken/driver.html?testName=audio-fft) 17:54:38 INFO - PID 1657 | RSS: Main: 262721536 17:54:38 INFO - PID 1657 | 17:54:40 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49227/tests/kraken/driver.html?testName=audio-oscillator) 17:54:41 INFO - PID 1657 | RSS: Main: 264794112 17:54:41 INFO - PID 1657 | 17:54:42 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49227/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:43 INFO - PID 1657 | RSS: Main: 265297920 17:54:43 INFO - PID 1657 | 17:54:46 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49227/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:47 INFO - PID 1657 | RSS: Main: 271282176 17:54:47 INFO - PID 1657 | 17:54:50 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49227/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:50 INFO - PID 1657 | RSS: Main: 272547840 17:54:50 INFO - PID 1657 | 17:54:53 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49227/tests/kraken/driver.html?testName=json-parse-financial) 17:54:54 INFO - PID 1657 | RSS: Main: 271790080 17:54:54 INFO - PID 1657 | 17:54:55 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49227/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:56 INFO - PID 1657 | RSS: Main: 271417344 17:54:56 INFO - PID 1657 | 17:54:58 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:59 INFO - PID 1657 | RSS: Main: 271486976 17:54:59 INFO - PID 1657 | 17:55:01 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:55:01 INFO - PID 1657 | RSS: Main: 270974976 17:55:01 INFO - PID 1657 | 17:55:04 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:05 INFO - PID 1657 | RSS: Main: 271384576 17:55:05 INFO - PID 1657 | 17:55:08 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:09 INFO - PID 1657 | RSS: Main: 271470592 17:55:09 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49227/tests/kraken/driver.html?testName=ai-astar) 17:55:11 INFO - PID 1657 | RSS: Main: 273063936 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | __start_tp_report 17:55:11 INFO - PID 1657 | _x_x_mozilla_page_load 17:55:11 INFO - PID 1657 | _x_x_mozilla_page_load_details 17:55:11 INFO - PID 1657 | |i|pagename|runs| 17:55:11 INFO - PID 1657 | |0;ai-astar;101;117;114;114;141;146;116;113;129;116 17:55:11 INFO - PID 1657 | |1;audio-beat-detection;139;110;132;193;112;111;112;112;138;111 17:55:11 INFO - PID 1657 | |2;audio-dft;196;196;198;252;222;220;195;201;198;196 17:55:11 INFO - PID 1657 | |3;audio-fft;79;62;59;83;52;51;100;77;93;81 17:55:11 INFO - PID 1657 | |4;audio-oscillator;83;70;84;73;71;71;86;70;70;92 17:55:11 INFO - PID 1657 | |5;imaging-gaussian-blur;88;80;136;136;89;89;88;90;89;92 17:55:11 INFO - PID 1657 | |6;imaging-darkroom;94;97;96;96;97;96;95;113;153;95 17:55:11 INFO - PID 1657 | |7;imaging-desaturate;92;90;91;91;92;103;143;89;92;90 17:55:11 INFO - PID 1657 | |8;json-parse-financial;48;49;50;51;48;48;51;50;49;51 17:55:11 INFO - PID 1657 | |9;json-stringify-tinderbox;57;58;61;61;64;76;81;85;84;47 17:55:11 INFO - PID 1657 | |10;stanford-crypto-aes;86;82;85;82;82;85;85;86;82;83 17:55:11 INFO - PID 1657 | |11;stanford-crypto-ccm;139;145;152;158;130;137;137;137;188;140 17:55:11 INFO - PID 1657 | |12;stanford-crypto-pbkdf2;189;198;187;187;237;239;188;188;184;196 17:55:11 INFO - PID 1657 | |13;stanford-crypto-sha256-iterative;68;71;67;69;72;92;69;65;76;100 17:55:11 INFO - PID 1657 | __end_tp_report 17:55:11 INFO - PID 1657 | __start_cc_report 17:55:11 INFO - PID 1657 | _x_x_mozilla_cycle_collect,1010 17:55:11 INFO - PID 1657 | __end_cc_report 17:55:11 INFO - PID 1657 | __startTimestamp1493427311353__endTimestamp 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | ------- Summary: start ------- 17:55:11 INFO - PID 1657 | Number of tests: 14 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#0] ai-astar Cycles:10 Average:120.70 Median:116.50 stddev:13.81 (11.9%) stddev-sans-first:12.67 17:55:11 INFO - PID 1657 | Values: 101.0 117.0 114.0 114.0 141.0 146.0 116.0 113.0 129.0 116.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:122.00 stddev:26.08 (21.4%) stddev-sans-first:27.30 17:55:11 INFO - PID 1657 | Values: 139.0 110.0 132.0 193.0 112.0 111.0 112.0 112.0 138.0 111.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#2] audio-dft Cycles:10 Average:207.40 Median:199.50 stddev:18.63 (9.3%) stddev-sans-first:19.29 17:55:11 INFO - PID 1657 | Values: 196.0 196.0 198.0 252.0 222.0 220.0 195.0 201.0 198.0 196.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#3] audio-fft Cycles:10 Average:73.70 Median:78.00 stddev:16.94 (21.7%) stddev-sans-first:17.86 17:55:11 INFO - PID 1657 | Values: 79.0 62.0 59.0 83.0 52.0 51.0 100.0 77.0 93.0 81.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.00 stddev:8.34 (10.7%) stddev-sans-first:8.56 17:55:11 INFO - PID 1657 | Values: 83.0 70.0 84.0 73.0 71.0 71.0 86.0 70.0 70.0 92.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:89.00 stddev:20.42 (22.9%) stddev-sans-first:21.36 17:55:11 INFO - PID 1657 | Values: 88.0 80.0 136.0 136.0 89.0 89.0 88.0 90.0 89.0 92.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:96.00 stddev:18.34 (19.1%) stddev-sans-first:19.15 17:55:11 INFO - PID 1657 | Values: 94.0 97.0 96.0 96.0 97.0 96.0 95.0 113.0 153.0 95.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:91.00 stddev:16.53 (18.2%) stddev-sans-first:17.42 17:55:11 INFO - PID 1657 | Values: 92.0 90.0 91.0 91.0 92.0 103.0 143.0 89.0 92.0 90.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:50.00 stddev:1.27 (2.5%) stddev-sans-first:1.22 17:55:11 INFO - PID 1657 | Values: 48.0 49.0 50.0 51.0 48.0 48.0 51.0 50.0 49.0 51.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:70.00 stddev:13.13 (18.8%) stddev-sans-first:13.37 17:55:11 INFO - PID 1657 | Values: 57.0 58.0 61.0 61.0 64.0 76.0 81.0 85.0 84.0 47.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:1.67 17:55:11 INFO - PID 1657 | Values: 86.0 82.0 85.0 82.0 82.0 85.0 85.0 86.0 82.0 83.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:142.50 stddev:16.76 (11.8%) stddev-sans-first:17.57 17:55:11 INFO - PID 1657 | Values: 139.0 145.0 152.0 158.0 130.0 137.0 137.0 137.0 188.0 140.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.30 Median:192.50 stddev:20.84 (10.8%) stddev-sans-first:21.77 17:55:11 INFO - PID 1657 | Values: 189.0 198.0 187.0 187.0 237.0 239.0 188.0 188.0 184.0 196.0 17:55:11 INFO - PID 1657 | 17:55:11 INFO - PID 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:70.00 stddev:11.67 (16.7%) stddev-sans-first:12.10 17:55:11 INFO - PID 1657 | Values: 68.0 71.0 67.0 69.0 72.0 92.0 69.0 65.0 76.0 100.0 17:55:11 INFO - PID 1657 | -------- Summary: end -------- 17:55:11 INFO - PID 1657 | 17:55:12 INFO - TEST-INFO | 1657: exit 0 17:55:12 INFO - TEST-OK | kraken | took 60859ms 17:55:12 INFO - SUITE-END | took 1176s 17:55:12 INFO - Completed test suite (00:19:36) 17:55:12 INFO - javascript benchmark 17:55:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7869.210107534986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.3112049788797, 3562.038249672587, 3606.4410016447428, 3615.92768144637, 3627.818609069546, 5594.160875868622, 5632.7746890124445, 6119.388061193884, 6205.28639206492, 6242.812715618527, 5549.805756798512, 5860.710643658399, 6103.246756470926, 6122.489639783232, 6185.69071546422, 5365.409804921455, 5365.812196573121, 5384.946150538483, 5403.2165336026255, 5416.620836541444, 5429.321334833146, 5495.450454954513, 5510.228568000483, 5569.275994120779, 5570.2480165177585, 5286.444923283038, 5438.700871452069, 5439.782408703647, 5488.341399032121, 5498.395176530578, 4461.353103799964, 5353.223782551547, 5368.865778355573, 5391.946080539223, 5404.540614047811, 5338.412774594792, 5373.140297552372, 5409.459054094598, 5423.728813559345, 5452.809151679672, 5128.2564028216075, 5483.656504156507, 6265.310815810257, 6288.182536270301, 6297.181366422382, 6336.46140078094, 6652.268250492442, 6652.334766523358, 6670.0, 6686.297938716413, 6520.608763474207, 6717.059611654372, 6800.149981252343, 6812.62530560819, 6822.215445223813, 6236.781712640036, 6259.7496100156395, 6267.9373206268265, 6287.371262873676, 6289.465395441347, 6863.622500762506, 6908.378245957888, 6918.515703900779, 6919.7232110715, 6938.236793952661, 6240.251169859555, 6376.872462550816, 6393.808185754435, 6559.278479367265, 6575.309592492815, 6595.274519802818, 6707.0, 6719.899201511981, 6738.663066846736, 6755.49333799967, 6338.30278669346, 6565.146530950946, 6620.139381880324, 6625.0724898514245, 6644.501662375341, 6421.903671444932, 6536.150300460909, 6588.0, 6601.636909969901, 6636.203655561363, 5312.017276803804, 5327.706976116273, 5336.066188417011, 5344.946550534522, 5351.09031464652, 4698.976505117521, 4707.929381059287, 4714.127886341038, 4751.192297309466, 4751.548602882721, 6025.3974602540275, 6156.907646385308, 6240.843978900473, 6269.968650156811, 6338.58799178052, 6067.8774426730315, 6707.0610114584, 6739.696713647898, 6749.763758268536, 6752.797416077526, 5791.536677065825, 6304.810855674337, 6320.715567799368, 6327.683615819191, 6329.272133704683, 5600.467955544217, 5784.219130417424, 5785.971070144707, 5863.853403664943, 5890.67601281925, 5970.76116955317, 6770.593764374054, 6868.587884726932, 6926.722931082701, 6977.2673869243, 6458.483321334376, 6768.695408706521, 6788.185417749902, 6808.251092379934, 6818.8636227276165, 6012.579119461596, 6679.833004174934, 6680.766173183915, 6694.029365742038, 6936.549124306904, 6610.239822420291, 6621.238557565749, 6641.1034510342415, 6641.435477984425, 6650.4347130492515, 6378.330275321025, 6447.548671592944, 6676.232233293039, 6722.932770672231, 6811.386975172259, 6464.22429308486, 6528.934710653023, 6543.770968016097, 6559.245686746085, 6588.8023359299295, 5561.304836895388, 6210.720517576629, 6580.703868325841, 6585.111010013587, 6595.142631457879, 6220.533459990428, 6240.594361366497, 6335.90496142549, 6420.454261387835, 6443.2590252119735, 6456.0, 6494.1232933553365, 6589.143411356493, 6593.439557637655, 6595.175603049619, 6343.238811342669, 6387.041943708481, 6396.072569477306, 6404.615723056631, 6408.455281301141], "value": 6049.145534776341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.7077416742889, 821.7699044267605, 1115.1079136690646, 1156.2484385149646, 1291.6641673164975, 36395.272094558124, 37546.62453375466, 37649.058773530676, 37804.43293350599, 37839.243215135684, 29666.11001669948, 37762.43356349657, 38080.80959595198, 38222.0, 38253.61746382535, 7486.737964171228, 7806.492577982442, 7971.9601401993195, 8442.113578074306, 8450.32397408209, 8447.535385553792, 8544.316454683641, 8545.359098067638, 8576.485410875337, 8583.570821458934, 8470.49177049376, 8513.148685131498, 8531.701390451335, 8601.95699021504, 8608.956955215246, 8531.445456045369, 8577.442466239736, 8580.0, 8588.785280367978, 8597.828043439158, 8328.708495202638, 8355.0, 8397.6221070052, 8416.957915210445, 8432.241098301121, 37263.0, 37409.0, 37507.4373884392, 37641.81179094087, 37662.62337376618, 3674.6141655126094, 3693.0, 3694.649008344203, 3714.331420344337, 3714.4985426967282, 30712.84643576768, 30736.692633073606, 30821.537676934862, 30860.0741977741, 30985.535216971763, 3086.5678804967324, 3150.70068343507, 3166.9524957125664, 3168.255459966906, 3175.7935734177436, 282164.0, 282213.0, 282371.0, 282955.0, 284270.0, 37478.62521374806, 45420.3186952196, 47787.522124779, 48072.27891581629, 48111.75944120257, 44027.77986110113, 45316.0, 46766.29850552244, 50255.74872125616, 50898.74550627223, 14187.93590480718, 14323.35544900482, 14444.133351998913, 14456.638584035483, 14483.058601190889, 11184.888151118548, 11331.660050198507, 11381.772364552662, 11381.886181138249, 11407.600733974272, 10818.729531761768, 13221.603351899459, 13313.933430332787, 13315.467381304834, 13512.783849453597, 5915.881682366328, 5962.85092872673, 5998.880022399615, 6008.218931538872, 6035.637861728311, 996.6461906023402, 1017.0947856407655, 1029.7580068683853, 1050.5482642463662, 1052.5158427123608, 19604.411867643994, 21753.78246217549, 23437.296881093593, 24510.019599215833, 24625.63061554078, 1010.686687126993, 1131.6378758797107, 1157.6006277834133, 1162.6802629276847, 1169.1348402182323, 12104.815568165492, 12537.87462125367, 12549.560765373351, 12564.057695672862, 12567.245965242115, 318310.0, 320558.0, 320719.0, 321450.0, 322963.0, 53785.924281514934, 54043.45956540384, 54081.72959135179, 54176.18735718967, 54297.0, 1511.7581187010026, 1568.3648122510401, 1572.75622278547, 1575.6848630273992, 1580.3125640346257, 18625.627487450445, 24020.63969040501, 24110.794460277266, 24122.39694007664, 24228.39429014289, 32287.35425291528, 34347.191393205474, 36388.27223455463, 36599.0, 36626.8168659155, 196113.0, 198675.0, 198679.0, 283969.0, 285782.0, 28559.857200713865, 35198.47202292019, 37335.0, 37577.0, 37736.81131594325, 45140.32289515594, 45457.0, 47050.0, 47093.0, 47296.0, 27361.452770944867, 30714.924977625677, 31371.84314078415, 31469.370612588078, 32178.517322240652, 31155.221119472193, 31598.0, 31970.68029319677, 32003.83998079995, 32204.033878983668, 31745.30164935914, 31868.84065579657, 38551.03622409462, 38750.61249387583, 38886.222275554894, 30748.23129421693, 32113.518297226026, 32547.02358929236, 32576.83711581522, 32791.0, 22167.0, 23582.764172358744, 24689.4848795871, 24792.25623231306, 25367.74632253654], "value": 17402.73115071638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.65800846335634, 443.2774577438775, 443.4390496022532, 455.32157085941947, 456.915470637932, 19733.50666233345, 21023.789762102373, 21789.891050544724, 21880.0, 21940.0, 22133.0, 22520.211792587263, 23371.766282337172, 23451.5309693806, 23643.0, 5994.250718660168, 6101.420365065312, 6208.565400421972, 6254.781082662085, 6275.560710750249, 6059.66671833049, 6177.722002509875, 6192.225971753531, 6226.315105338409, 6249.281332646736, 5986.431289027557, 6103.725332360033, 6176.227971503562, 6186.072089186636, 6229.501639868799, 6206.751729930797, 6221.751129954796, 6233.0, 6240.438360547527, 6263.060540918876, 5424.0, 5462.617616766828, 5574.832755017356, 5581.190727344512, 5592.412796656374, 23625.93683284239, 26236.8688156558, 27570.035048773396, 28151.0147144851, 28336.43327133446, 2218.389942765736, 2297.8506397084134, 2312.4218945263683, 2316.7683231676865, 2322.129201549419, 17721.911390442965, 17783.555411114696, 18008.189631466616, 18564.25742970293, 18714.62570748591, 2121.289368061701, 2146.9694546617557, 2189.4745261137214, 2191.550732099932, 2195.692603035576, 131159.34420327932, 136858.31570842082, 150403.49596504006, 164024.0, 165007.17496412562, 12183.817242741366, 12773.169743966613, 12787.552435664707, 12795.93602031984, 12805.615831525069, 16345.182740862909, 16552.586185345222, 16563.171841407882, 16566.83433165677, 16599.253033613517, 7561.621918904033, 7650.360625584164, 8854.86717699235, 9064.954675226581, 9065.68270110543, 8540.829183416421, 8573.0, 8598.140185981352, 8700.78248043804, 8765.649374025095, 7961.44269901113, 8055.5972201389695, 8117.878231826528, 8124.512529248264, 8151.633176507072, 1789.7673302470596, 2233.218373569238, 2233.4416395901026, 2251.7860803223666, 2420.8547487150477, 870.4559650218613, 947.966821161256, 960.558143254111, 961.5817119553017, 985.1380042462845, 18373.897566146075, 21220.681689774665, 21644.675329870064, 21792.45518862041, 22046.559068818533, 1011.8633984412011, 1019.3374306700556, 1024.6772266735954, 1043.2905624175482, 1047.0628787235382, 9195.896492420952, 9385.399386094765, 10675.558799562115, 10801.67594972152, 11071.280366776295, 543262.0, 550398.0, 552612.0, 557329.0, 557387.0, 123022.0, 125624.37187814002, 129557.70442295645, 132533.33733331272, 134768.0, 1186.347508870118, 1210.0, 1227.2268470863298, 1236.2829558855842, 1237.1340061956666, 21761.564768704222, 22445.5510889778, 22680.092796288624, 23027.0, 23029.309120726404, 56980.290591282326, 60261.0, 60628.0, 60902.69548652229, 61416.0, 81154.18845811703, 83023.0, 83040.58479707563, 83744.16255837363, 84608.0, 8684.2184203422, 8795.736127916172, 8822.294216462797, 9047.502387368759, 9237.722868313962, 13952.58142255734, 14113.435462581381, 14189.574312770634, 14494.347754350869, 14531.491397801026, 10204.540795664361, 11896.345700986183, 11976.820347694616, 12136.453859576517, 12327.506899724269, 10962.0, 11179.832302515306, 11284.717882053013, 11364.54541818318, 11374.43127843621, 10261.897381026094, 11607.883921161017, 12202.938985305016, 12376.690582735504, 12469.688257793629, 7649.694012239448, 8676.349273804364, 8695.826083478421, 8871.157240062184, 8942.46345219289, 12074.335911524598, 12087.456064477296, 12175.417195764494, 12179.939100304442, 12271.263724176579], "value": 10566.454654028254, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.5134049061355, 1450.6445920749418, 1470.6396932751477, 1474.638713515189, 1484.9109053456793, 11242.775144497105, 11430.314181149137, 11945.0, 11978.880211197886, 11980.34108124053, 11613.651590452278, 11842.348670823101, 11946.462409191585, 11961.820572691417, 11963.940180299109, 2530.1903390914913, 2560.9871950640313, 2561.0140096062964, 2563.7051739049966, 2568.0754928225824, 2454.0, 2502.0492212959143, 2509.5482813093636, 2510.6108553174286, 2516.0, 2501.187114187896, 2519.1812660885194, 2549.12055340908, 2549.7322781107996, 2550.591905295153, 2478.7397323280975, 2488.539620170265, 2525.6464095026713, 2527.6208568714655, 2545.109211775873, 2102.4533621258583, 2405.1822380390577, 2490.140901389018, 2495.9750402496106, 2514.5473814713346, 11675.824862626983, 11737.88262117385, 11810.586629467927, 11829.822552661717, 11830.881691183064, 6563.967180164116, 6729.057931889491, 6821.522493425462, 6832.93167068328, 6850.972354146868, 4002.459667944819, 4320.265554855682, 4379.890502737457, 4394.780260986938, 4403.471583410012, 1259.7606454773563, 1266.9873301266962, 1279.4818098670053, 1299.6750812296925, 1300.2913412190285, 16269.779766517559, 16496.010239385676, 16655.25051372691, 16658.0, 16910.15449227546, 5401.675899446046, 5456.399796022434, 5580.441955804468, 5763.567732420085, 5781.421857814269, 11836.526538938519, 11901.285922844658, 11947.0, 11949.462274197682, 11955.103367247491, 6536.673166341664, 6613.305602911625, 6617.073609694647, 6625.138731964814, 6626.237982631963, 5909.497692696083, 6258.874822503524, 6262.6868656566985, 6296.307406185316, 6307.621542707452, 4248.320268756984, 4372.300431930876, 4394.231009573312, 4417.757023363746, 4424.181526417558, 1264.367816091954, 1285.5693342730103, 1288.6340479092191, 1299.6490947444138, 1300.7983762516826, 776.989913112951, 779.380392587894, 797.4171270028988, 799.6841247707123, 809.1180613131714, 6386.680665966776, 7269.018682477904, 7521.172671006185, 7555.357794587411, 7594.772156835304, 948.4119845695575, 958.4105774948357, 959.5490119643896, 961.2214106573698, 962.1340793286098, 4336.154449882306, 4375.431193944767, 4408.074304396048, 4467.441569803775, 4500.459944806578, 14914.850851491346, 15315.234238288042, 15419.845801542066, 15465.613359665873, 15480.845191548166, 11590.768184636428, 12512.749745005049, 15417.306221220071, 15418.922905385625, 15428.537143885702, 7470.290322419471, 7905.328047115944, 8050.07424146219, 8589.914100858912, 8617.922759655043, 5799.869025539979, 6226.750929962932, 7173.928260717326, 7233.276672332725, 7263.4915555910575, 12511.749765004832, 12661.113722039368, 12880.613581592566, 12908.0, 13148.73702525925, 12890.548830790878, 12949.352532373532, 13116.606501804961, 13183.868161318647, 13455.730885382041, 9197.954010230174, 9504.287178461782, 9639.566219520279, 9643.710688679352, 9651.372660777028, 10955.233133680566, 11003.17476189273, 11093.5562577496, 11095.112391008539, 11169.497372618089, 9202.079792020744, 9249.12133347331, 9342.719718408458, 9358.298127640319, 9408.670696525589, 8412.522213538792, 8566.014908285377, 9015.504147271962, 9024.278057755495, 9222.861657075284, 7063.894041589483, 8252.803343515037, 8360.372972027244, 8417.747467575982, 8468.576571171294, 6128.356522565245, 6147.72335244924, 6201.317855036033, 6292.748290068529, 6338.176037115146, 5040.722760248075, 6080.574359794772, 6099.481544068626, 6222.782202622887, 6328.936710632835], "value": 5426.002331627609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.78033861714675, 413.66906474820144, 419.3374468340023, 420.0506854508809, 427.4357847641115, 5032.723200223986, 6013.188219590354, 6146.4775494083, 6191.50467962563, 6222.408871157244, 5849.795257166, 5976.701164941757, 5977.731002104905, 6037.818865434044, 6050.667213303266, 4278.4010238566625, 4377.080813029268, 4403.339499075132, 4423.0, 4462.955370446302, 3751.9437208441896, 3958.782266975315, 4073.002114481956, 4275.102228531997, 4393.802278897458, 4341.500727416356, 4361.80371883266, 4372.0, 4381.561843815625, 4395.560443955595, 4311.935320970172, 4353.499347575038, 4354.629856462205, 4356.6514678825615, 4379.737215767048, 3088.3514461963014, 3716.591174970778, 3734.6452087051684, 3760.2103558252797, 3761.4357846322996, 5871.1193321001765, 5887.205227294303, 5905.468507834273, 5910.290765108171, 5910.556708246899, 5034.773435195425, 5135.922961155586, 5165.9225111623355, 5166.535011848951, 5203.0, 6071.148299768569, 6273.870703273455, 6433.485321174342, 6444.677766111676, 6471.0, 4149.813258403379, 4267.551907049746, 4272.46594175728, 4272.5086615039045, 4283.571642835723, 4677.812887484497, 5760.683162426065, 6704.999999999951, 6734.797956061277, 6814.522983391164, 3977.3238549446664, 4261.595148460891, 4271.10306835568, 4313.33936434475, 4331.956680433155, 3811.7522361046445, 3890.533136023695, 4318.762468064287, 4368.432103826546, 4374.58441448062, 4946.554810067039, 5120.718360490208, 5156.613254005964, 5167.199084141964, 5176.922346164811, 5410.3507579090765, 6235.719392627343, 6484.675766211765, 6487.54587178893, 6514.697060587901, 1252.7306629074792, 1472.5214305350803, 1491.7016596680708, 1495.7831114488338, 1495.9925200373928, 942.948137852411, 974.8537719342155, 983.7540614846289, 990.9256805739454, 992.1616234282164, 5017.874553136127, 5617.505995203902, 5975.0, 6131.96934015327, 6188.535859810532, 5287.41838397776, 5433.8369848904595, 5941.494972927263, 6467.611943283324, 6552.443042341359, 5935.910961335583, 6079.483243924227, 6106.511479081662, 6146.508279337642, 6168.784092556739, 2883.783716221292, 3110.7822452428563, 3129.5462157986963, 3458.4812278157974, 3517.402041652925, 6228.34602366754, 6334.588251763621, 6796.796096117125, 6991.203518592502, 7013.509054366247, 6861.0, 6944.062551555577, 6955.1653801544135, 6959.512834101564, 6965.547239429421, 5572.777088916479, 5694.032014557618, 6839.487038472134, 6952.721891124298, 6954.3393377629045, 5874.206982057539, 6629.867402652017, 6750.729970801113, 6761.357671021246, 6779.288174741581, 6439.356064393523, 6565.474762018932, 6648.966755166193, 6649.73401063952, 6651.640921334695, 6818.761343352959, 7055.506114571931, 7057.964710176417, 7095.8266308312095, 7109.075820143348, 4325.7837108145095, 4334.544872788312, 4346.543612920598, 4349.695521313604, 4366.716163449366, 6209.534284928558, 6289.804937061944, 6529.0, 6568.838543816261, 6743.35938085881, 5647.3787883333625, 6526.282108968105, 6558.213014438298, 6575.63833989116, 6580.21037475506, 6414.550981431442, 6543.476521878333, 6565.835854103686, 6578.671066446755, 6598.241202261801, 5299.5760339172, 5910.852228694317, 6067.968445364387, 6423.96788016057, 6447.258565265054, 5678.68767217807, 6423.518236132402, 6580.30906754803, 6591.780520603704, 6615.4376877965915, 5555.833325000256, 6380.585261957958, 6386.93613063882, 6395.360463953567, 6422.935770642233], "value": 4668.206626414358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.3850757901258, 840.3949156607241, 844.2528362399279, 860.5138096975209, 878.6880657366635, 14057.507987220462, 14560.927195364035, 15153.318100685468, 16648.0, 17135.57161070974, 17001.149942502856, 17401.91299043503, 17807.0, 17828.019458929786, 17904.910475447603, 805.7743831727112, 995.149147478906, 1009.0918173643743, 1028.8250997330472, 1029.3360782295415, 815.5799763121997, 991.8413053911376, 999.6601155607092, 1011.0546638892622, 1017.5573625472942, 1031.7214352124922, 1041.9374837509736, 1044.5404022230232, 1056.8520407142967, 1058.9099926506256, 1043.5251960358057, 1051.6319288249128, 1054.4674939155755, 1054.7152268887396, 1054.7995880782628, 758.2341834746891, 782.3780094824629, 782.718221440281, 783.0525064671754, 783.2324322164311, 16481.25834337458, 16958.067306298148, 17006.659866802718, 17137.657246854993, 17173.7423938641, 15323.387064517407, 16702.83297167025, 16844.410445634465, 16885.831141688548, 17023.829761702473, 13470.797938030937, 13822.585322440344, 13930.164190148624, 13941.233232172226, 13948.372323245478, 3411.710004649608, 3481.8433170507387, 3612.837422316002, 3644.2893635741043, 3645.76302540334, 127373.0, 127895.0, 128971.0, 129259.99999999905, 130410.0, 12899.871001290056, 13281.468741250243, 13823.585292441243, 13824.239666818221, 13829.654258643413, 24807.5038499229, 25398.746012540007, 25559.977600895756, 25691.871540642176, 26006.6099008515, 7603.543787372775, 8034.919650803534, 8056.436049476598, 8072.192780721881, 8091.1504292048485, 3916.3342231820657, 3967.3453880110037, 3995.7402768819934, 3997.700172487017, 4000.0599859033105, 4287.442632457823, 4321.373400856921, 4423.889402764957, 4456.264716321771, 4458.866234012985, 916.9312301577409, 932.7061975477839, 937.9624815007323, 954.06025065312, 957.1816097236901, 642.4763817488732, 645.8966565349522, 649.9480041596661, 661.8610091880663, 682.4301708073715, 9354.766130846647, 12136.5145394185, 12140.696482588006, 12148.271103733805, 12204.206726562745, 645.6513482719279, 645.985802290409, 673.7877568565887, 678.2302087131142, 683.3849535418065, 4706.411698537683, 5080.390353157644, 5485.259489968803, 5509.283793106871, 5509.834704958857, 107603.0, 108192.0, 108520.0, 108775.0, 109756.4512177434, 94352.11295774046, 94605.0, 96083.51958240164, 96089.0, 96683.0, 64029.67985160044, 85559.71660425099, 86835.56582217175, 87273.96349419898, 88302.0, 10746.408947507962, 11367.431628418712, 11533.192676512563, 11612.94193529027, 11770.882291176978, 42869.356959645, 42883.571164287954, 43436.56563434325, 43684.344734828366, 44194.558054419045, 56271.43728562662, 56679.43320566742, 56886.43113568977, 57363.42636573581, 57707.71146144242, 14663.413463461342, 15006.774898376314, 15456.768148477557, 16108.516744497683, 16664.0, 17674.293028278724, 18549.0, 18768.53078673044, 18838.811611883706, 18862.151203196165, 15518.9224053879, 16292.592685182964, 16589.0, 17613.20740566652, 17637.206325715117, 14465.710685786014, 17019.40432084871, 17187.882787618764, 17451.738223926906, 17782.288708452033, 14083.366248519047, 16461.613066105587, 16583.91708041452, 16857.662846743242, 17144.885582437102, 11875.168738188244, 12098.939505302416, 12181.939090304491, 12265.754684906073, 12294.508219671114, 13597.320133993459, 13690.0, 13693.657658558615, 13888.375023124187, 13891.930540347234], "value": 8427.228054675024, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 117.0, 114.0, 114.0, 141.0, 146.0, 116.0, 113.0, 129.0, 116.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 132.0, 193.0, 112.0, 111.0, 112.0, 112.0, 138.0, 111.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 196.0, 198.0, 252.0, 222.0, 220.0, 195.0, 201.0, 198.0, 196.0], "value": 207.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 62.0, 59.0, 83.0, 52.0, 51.0, 100.0, 77.0, 93.0, 81.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 84.0, 73.0, 71.0, 71.0, 86.0, 70.0, 70.0, 92.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 136.0, 136.0, 89.0, 89.0, 88.0, 90.0, 89.0, 92.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 96.0, 96.0, 97.0, 96.0, 95.0, 113.0, 153.0, 95.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 91.0, 92.0, 103.0, 143.0, 89.0, 92.0, 90.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 50.0, 51.0, 48.0, 48.0, 51.0, 50.0, 49.0, 51.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 61.0, 61.0, 64.0, 76.0, 81.0, 85.0, 84.0, 47.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 85.0, 82.0, 82.0, 85.0, 85.0, 86.0, 82.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 152.0, 158.0, 130.0, 137.0, 137.0, 137.0, 188.0, 140.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 198.0, 187.0, 187.0, 237.0, 239.0, 188.0, 188.0, 184.0, 196.0], "value": 199.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 69.0, 72.0, 92.0, 69.0, 65.0, 76.0, 100.0], "value": 74.9, "unit": "score"}]}]} 17:55:12 INFO - Return code: 0 17:55:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:12 ERROR - # TBPL SUCCESS # 17:55:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:55:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:55:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:55:12 INFO - 2017-04-28 17:55:12.686 screenresolution[1662:10621] starting screenresolution argv=screenresolution get 17:55:12 INFO - 2017-04-28 17:55:12.689 screenresolution[1662:10621] Display 0: 1600x1200x32@60 17:55:12 INFO - 2017-04-28 17:55:12.695 screenresolution[1663:10624] starting screenresolution argv=screenresolution list 17:55:12 INFO - Available Modes on Display 0 17:55:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:55:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:55:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:55:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:55:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:55:12 INFO - Intel Iris: 17:55:12 INFO - Chipset Model: Intel Iris 17:55:12 INFO - Type: GPU 17:55:12 INFO - Bus: Built-In 17:55:12 INFO - VRAM (Dynamic, Max): 1536 MB 17:55:12 INFO - Vendor: Intel (0x8086) 17:55:12 INFO - Device ID: 0x0a2e 17:55:12 INFO - Revision ID: 0x0009 17:55:12 INFO - Displays: 17:55:12 INFO - Display: 17:55:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:55:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:55:12 INFO - Display Serial Number: 1600x1200 60 17:55:12 INFO - Main Display: Yes 17:55:12 INFO - Mirror: Off 17:55:12 INFO - Online: Yes 17:55:12 INFO - Rotation: Supported 17:55:12 INFO - Return code: 0 17:55:12 INFO - Running post-action listener: _resource_record_post_action 17:55:12 INFO - [mozharness: 2017-04-29 00:55:12.940706Z] Finished run-tests step (success) 17:55:12 INFO - Running post-run listener: _resource_record_post_run 17:55:13 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 37382656; Write bytes: 510412288; Read time: 252; Write time: 1613 17:55:13 INFO - TinderboxPrint: CPU usage
54.0% 17:55:13 INFO - TinderboxPrint: I/O read bytes / time
37,382,656 / 252 17:55:13 INFO - TinderboxPrint: I/O write bytes / time
510,412,288 / 1,613 17:55:13 INFO - TinderboxPrint: CPU idle
2,201.2 (46.0%) 17:55:13 INFO - TinderboxPrint: CPU system
958.0 (20.0%) 17:55:13 INFO - TinderboxPrint: CPU user
1,626.4 (34.0%) 17:55:13 INFO - TinderboxPrint: Swap in / out
246,214,656 / 0 17:55:13 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195408384; Write bytes: 192905216; Read time: 14954; Write time: 396 17:55:13 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36411904; Write bytes: 300664320; Read time: 238; Write time: 1165 17:55:13 INFO - Running post-run listener: _upload_blobber_files 17:55:13 INFO - Blob upload gear active. 17:55:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:13 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:55:13 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:55:13 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:55:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:15 INFO - (blobuploader) - INFO - Done attempting. 17:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:16 INFO - (blobuploader) - INFO - Done attempting. 17:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:55:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:17 INFO - (blobuploader) - INFO - Done attempting. 17:55:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:20 INFO - (blobuploader) - INFO - Done attempting. 17:55:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:20 INFO - Return code: 0 17:55:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe5eba8d4014302bac282fdebc0c04f89f34e8539996ec6342ef560e20cd017b789dc7581139b7ba69e7819308f1d2bbd33b3024f45f4a879c2084b59a77012e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48c5cac4f05fc3c8905ccd9c4a065849f5e825b3859186847db32198f8b92dd41a7768c06f108cef18eea5f40ecfb8aff5738c70a11cd02087ebb98816cda0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df02ed9a80056615556ba01b4e20178aaa9b6b009f47d7819727a275c110400a70112c651a10b871fbd41f367f38c13a73205a584158f74b6482fcf51207d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c914a26dfa54e702294ce3581abbc3b527ad1d5bb1dad112e07911b26be0f5294ef7ced37bbdb837271b584ceca2c13520dff1fa3a70c91e4833b9460142593"} 17:55:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:20 INFO - Contents: 17:55:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe5eba8d4014302bac282fdebc0c04f89f34e8539996ec6342ef560e20cd017b789dc7581139b7ba69e7819308f1d2bbd33b3024f45f4a879c2084b59a77012e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48c5cac4f05fc3c8905ccd9c4a065849f5e825b3859186847db32198f8b92dd41a7768c06f108cef18eea5f40ecfb8aff5738c70a11cd02087ebb98816cda0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df02ed9a80056615556ba01b4e20178aaa9b6b009f47d7819727a275c110400a70112c651a10b871fbd41f367f38c13a73205a584158f74b6482fcf51207d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c914a26dfa54e702294ce3581abbc3b527ad1d5bb1dad112e07911b26be0f5294ef7ced37bbdb837271b584ceca2c13520dff1fa3a70c91e4833b9460142593"} 17:55:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:20 INFO - Copying logs to upload dir... 17:55:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.305647 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-28 17:55:20.140460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:20.144172) ========= 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.tvIxyhQepg/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.ViV77yRdiR/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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/fe5eba8d4014302bac282fdebc0c04f89f34e8539996ec6342ef560e20cd017b789dc7581139b7ba69e7819308f1d2bbd33b3024f45f4a879c2084b59a77012e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48c5cac4f05fc3c8905ccd9c4a065849f5e825b3859186847db32198f8b92dd41a7768c06f108cef18eea5f40ecfb8aff5738c70a11cd02087ebb98816cda0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df02ed9a80056615556ba01b4e20178aaa9b6b009f47d7819727a275c110400a70112c651a10b871fbd41f367f38c13a73205a584158f74b6482fcf51207d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c914a26dfa54e702294ce3581abbc3b527ad1d5bb1dad112e07911b26be0f5294ef7ced37bbdb837271b584ceca2c13520dff1fa3a70c91e4833b9460142593"} 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.011094 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/fe5eba8d4014302bac282fdebc0c04f89f34e8539996ec6342ef560e20cd017b789dc7581139b7ba69e7819308f1d2bbd33b3024f45f4a879c2084b59a77012e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48c5cac4f05fc3c8905ccd9c4a065849f5e825b3859186847db32198f8b92dd41a7768c06f108cef18eea5f40ecfb8aff5738c70a11cd02087ebb98816cda0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df02ed9a80056615556ba01b4e20178aaa9b6b009f47d7819727a275c110400a70112c651a10b871fbd41f367f38c13a73205a584158f74b6482fcf51207d58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c914a26dfa54e702294ce3581abbc3b527ad1d5bb1dad112e07911b26be0f5294ef7ced37bbdb837271b584ceca2c13520dff1fa3a70c91e4833b9460142593"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:20.179453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:20.179790) ========= 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.tvIxyhQepg/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.ViV77yRdiR/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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.005152 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:20.227855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:55:20.228189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:55:20.228722) ========= ========= Total master_lag: 11.89 =========