builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0024 starttime: 1493426029.51 results: success (0) buildid: 20170428170836 builduid: 6e41478030cf478a8c627cee63a63436 revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.506726) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.507195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.507534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.534720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.535050) ========= 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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-04-28 17:33:49 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155274 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.715407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.715794) ========= 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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.028023 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:49.766705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:33:49.767081) ========= 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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:49,869 truncating revision to first 12 chars 2017-04-28 17:33:49,869 Setting DEBUG logging. 2017-04-28 17:33:49,870 attempt 1/10 2017-04-28 17:33:49,870 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:51,377 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=1.797382 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:33:51.590915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:51.591532) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:51.592200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:51.592635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:51.613866) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-28 17:33:51.614300) ========= /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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:33:51 INFO - MultiFileLogger online at 20170428 17:33:51 in /builds/slave/test 17:33:51 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:33:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:33:51 INFO - {'append_to_log': False, 17:33:51 INFO - 'base_work_dir': '/builds/slave/test', 17:33:51 INFO - 'blob_upload_branch': 'Firefox', 17:33:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:33:51 INFO - 'branch': 'Firefox', 17:33:51 INFO - 'buildbot_json_path': 'buildprops.json', 17:33:51 INFO - 'config_files': ('talos/mac_config.py',), 17:33:51 INFO - 'default_actions': ('clobber', 17:33:51 INFO - 'read-buildbot-config', 17:33:51 INFO - 'download-and-extract', 17:33:51 INFO - 'populate-webroot', 17:33:51 INFO - 'create-virtualenv', 17:33:51 INFO - 'install', 17:33:51 INFO - 'run-tests'), 17:33:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:33:51 INFO - 'download_minidump_stackwalk': True, 17:33:51 INFO - 'download_symbols': 'ondemand', 17:33:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:33:51 INFO - 'tooltool.py': '/tools/tooltool.py', 17:33:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:33:51 INFO - '/tools/misc-python/virtualenv.py')}, 17:33:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:33:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:33:51 INFO - 'gecko_profile': False, 17:33:51 INFO - 'gecko_profile_interval': 0, 17:33:51 INFO - 'installer_path': 'installer.exe', 17:33:51 INFO - 'log_level': 'info', 17:33:51 INFO - 'log_name': 'talos', 17:33:51 INFO - 'log_to_console': True, 17:33:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:33:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:33:51 INFO - 'opt_config_files': (), 17:33:51 INFO - 'pip_index': False, 17:33:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:51 INFO - 'cmd': ('bash', 17:33:51 INFO - '-c', 17:33:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:51 INFO - 'enabled': True, 17:33:51 INFO - 'halt_on_failure': False, 17:33:51 INFO - 'name': 'check_screen_resolution'},), 17:33:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:51 INFO - 'cmd': ('bash', 17:33:51 INFO - '-c', 17:33:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:51 INFO - 'enabled': True, 17:33:51 INFO - 'halt_on_failure': False, 17:33:51 INFO - 'name': 'check_screen_resolution'},), 17:33:51 INFO - 'run_cmd_checks_enabled': True, 17:33:51 INFO - 'suite': 'dromaeojs-e10s', 17:33:51 INFO - 'system_bits': '32', 17:33:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:33:51 INFO - 'title': 't-yosemite-r7-0024', 17:33:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:33:51 INFO - 'use_talos_json': True, 17:33:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:33:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:33:51 INFO - 'work_dir': 'build'} 17:33:51 INFO - [mozharness: 2017-04-29 00:33:51.828413Z] Running clobber step. 17:33:51 INFO - Running pre-action listener: _resource_record_pre_action 17:33:51 INFO - Running main action method: clobber 17:33:51 INFO - rmtree: /builds/slave/test/build 17:33:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:33:54 INFO - Running post-action listener: _resource_record_post_action 17:33:54 INFO - [mozharness: 2017-04-29 00:33:54.377272Z] Finished clobber step (success) 17:33:54 INFO - [mozharness: 2017-04-29 00:33:54.377397Z] Running read-buildbot-config step. 17:33:54 INFO - Running pre-action listener: _resource_record_pre_action 17:33:54 INFO - Running main action method: read_buildbot_config 17:33:54 INFO - Using buildbot properties: 17:33:54 INFO - { 17:33:54 INFO - "project": "", 17:33:54 INFO - "product": "firefox", 17:33:54 INFO - "script_repo_revision": "production", 17:33:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:33:54 INFO - "repository": "", 17:33:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:33:54 INFO - "buildid": "20170428170836", 17:33:54 INFO - "stage_platform": "macosx64", 17:33:54 INFO - "basedir": "/builds/slave/test", 17:33:54 INFO - "buildnumber": 53, 17:33:54 INFO - "platform": "yosemite_r7", 17:33:54 INFO - "mozci_request": { 17:33:54 INFO - "priority": 0, 17:33:54 INFO - "type": "trigger_all_talos_jobs", 17:33:54 INFO - "times": 6 17:33:54 INFO - }, 17:33:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:33:54 INFO - "slavebuilddir": "test", 17:33:54 INFO - "branch": "mozilla-central", 17:33:54 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:33:54 INFO - "slavename": "t-yosemite-r7-0024", 17:33:54 INFO - "builduid": "6e41478030cf478a8c627cee63a63436", 17:33:54 INFO - "repo_path": "mozilla-central" 17:33:54 INFO - } 17:33:54 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:33:54 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:33:54 INFO - Running post-action listener: _resource_record_post_action 17:33:54 INFO - [mozharness: 2017-04-29 00:33:54.381277Z] Finished read-buildbot-config step (success) 17:33:54 INFO - [mozharness: 2017-04-29 00:33:54.381451Z] Running download-and-extract step. 17:33:54 INFO - Running pre-action listener: _resource_record_pre_action 17:33:54 INFO - Running main action method: download_and_extract 17:33:54 INFO - mkdir: /builds/slave/test/build/tests 17:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:54 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:33:54 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:33:54 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:33:54 INFO - Downloaded 1325 bytes. 17:33:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:33:54 INFO - Using the following test package requirements: 17:33:54 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:33:54 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:33:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:33:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:33:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'jsshell-mac.zip'], 17:33:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:33:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:33:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:33:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:33:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:33:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:33:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:33:54 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:33:54 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:33:54 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:33:56 INFO - Content-Length response header: 52698163 17:33:56 INFO - Bytes received: 52698163 17:34:12 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:12 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:12 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:12 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:13 INFO - Content-Length response header: 52698163 17:34:13 INFO - Bytes received: 52698163 17:34:28 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:28 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:28 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:29 INFO - Content-Length response header: 14408809 17:34:29 INFO - Bytes received: 14408809 17:34:29 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:29 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:29 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:29 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:30 INFO - Downloaded 71219323 bytes. 17:34:30 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:30 INFO - mkdir: /builds/slave/test/properties 17:34:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:30 INFO - Contents: 17:34:30 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:31 INFO - Running post-action listener: _resource_record_post_action 17:34:31 INFO - Running post-action listener: set_extra_try_arguments 17:34:31 INFO - [mozharness: 2017-04-29 00:34:31.268132Z] Finished download-and-extract step (success) 17:34:31 INFO - [mozharness: 2017-04-29 00:34:31.268259Z] Running populate-webroot step. 17:34:31 INFO - Running pre-action listener: _resource_record_pre_action 17:34:31 INFO - Running main action method: populate_webroot 17:34:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:31 INFO - '--tppagecycles', 17:34:31 INFO - '7'], 17:34:31 INFO - 'tests': ['tsvgm']}}, 17:34:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['damp', 'tps']}, 17:34:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'tests': ['damp', 'tps']}, 17:34:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['dromaeo_dom']}, 17:34:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:34:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:34:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['a11yr', 17:34:31 INFO - 'ts_paint', 17:34:31 INFO - 'tpaint', 17:34:31 INFO - 'sessionrestore', 17:34:31 INFO - 'sessionrestore_no_auto_restore', 17:34:31 INFO - 'tabpaint']}, 17:34:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:31 INFO - 'ts_paint', 17:34:31 INFO - 'tpaint', 17:34:31 INFO - 'sessionrestore', 17:34:31 INFO - 'sessionrestore_no_auto_restore', 17:34:31 INFO - 'tabpaint']}, 17:34:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:31 INFO - 'ts_paint', 17:34:31 INFO - 'tpaint', 17:34:31 INFO - 'sessionrestore', 17:34:31 INFO - 'sessionrestore_no_auto_restore', 17:34:31 INFO - 'tabpaint']}, 17:34:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:31 INFO - 'ts_paint', 17:34:31 INFO - 'tpaint', 17:34:31 INFO - 'sessionrestore', 17:34:31 INFO - 'sessionrestore_no_auto_restore', 17:34:31 INFO - 'tabpaint']}, 17:34:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['a11yr', 17:34:31 INFO - 'ts_paint', 17:34:31 INFO - 'tpaint', 17:34:31 INFO - 'sessionrestore', 17:34:31 INFO - 'sessionrestore_no_auto_restore', 17:34:31 INFO - 'tabpaint']}, 17:34:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['a11yr', 17:34:31 INFO - 'ts_paint', 17:34:31 INFO - 'tpaint', 17:34:31 INFO - 'sessionrestore', 17:34:31 INFO - 'sessionrestore_no_auto_restore', 17:34:31 INFO - 'tabpaint']}, 17:34:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:34:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:34:31 INFO - 'bloom_basic_ref']}, 17:34:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['tsvgx', 17:34:31 INFO - 'tsvgr_opacity', 17:34:31 INFO - 'tart', 17:34:31 INFO - 'tscrollx', 17:34:31 INFO - 'cart', 17:34:31 INFO - 'tsvg_static']}, 17:34:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:31 INFO - 'tsvgr_opacity', 17:34:31 INFO - 'tart', 17:34:31 INFO - 'tscrollx', 17:34:31 INFO - 'cart', 17:34:31 INFO - 'tsvg_static']}, 17:34:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'talos_options': ['--disable-e10s'], 17:34:31 INFO - 'tests': ['tp5o']}, 17:34:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'talos_options': ['--disable-e10s', 17:34:31 INFO - '--xperf_path', 17:34:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:31 INFO - 'tests': ['tp5n']}, 17:34:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:31 INFO - 'talos_options': ['--xperf_path', 17:34:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:31 INFO - 'tests': ['tp5n']}}, 17:34:31 INFO - 'talos.zip': {'path': '', 17:34:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:31 INFO - Running post-action listener: _resource_record_post_action 17:34:31 INFO - [mozharness: 2017-04-29 00:34:31.287226Z] Finished populate-webroot step (success) 17:34:31 INFO - [mozharness: 2017-04-29 00:34:31.287348Z] Running create-virtualenv step. 17:34:31 INFO - Running pre-action listener: _resource_record_pre_action 17:34:31 INFO - Running main action method: create_virtualenv 17:34:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:31 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:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:31 INFO - Using real prefix '/tools/python27' 17:34:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:35 INFO - Installing pip.................done. 17:34:35 INFO - Return code: 0 17:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:35 INFO - Reading from file tmpfile_stdout 17:34:35 INFO - Output received: 17:34:35 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:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:35 INFO - 'HOME': '/Users/cltbld', 17:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:35 INFO - 'LOGNAME': 'cltbld', 17:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:35 INFO - 'MOZ_NO_REMOTE': '1', 17:34:35 INFO - 'NO_EM_RESTART': '1', 17:34:35 INFO - 'PAGER': '/bin/cat', 17:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:35 INFO - 'PWD': '/builds/slave/test', 17:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:35 INFO - 'SHELL': '/bin/bash', 17:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:35 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:35 INFO - 'USER': 'cltbld', 17:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:35 INFO - 'XPC_FLAGS': '0x0', 17:34:35 INFO - 'XPC_SERVICE_NAME': '0', 17:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:35 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:35 INFO - Cleaning up... 17:34:35 INFO - Return code: 0 17:34:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:35 INFO - 'HOME': '/Users/cltbld', 17:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:35 INFO - 'LOGNAME': 'cltbld', 17:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:35 INFO - 'MOZ_NO_REMOTE': '1', 17:34:35 INFO - 'NO_EM_RESTART': '1', 17:34:35 INFO - 'PAGER': '/bin/cat', 17:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:35 INFO - 'PWD': '/builds/slave/test', 17:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:35 INFO - 'SHELL': '/bin/bash', 17:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:35 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:35 INFO - 'USER': 'cltbld', 17:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:35 INFO - 'XPC_FLAGS': '0x0', 17:34:35 INFO - 'XPC_SERVICE_NAME': '0', 17:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:35 INFO - Downloading/unpacking psutil>=3.1.1 17:34:35 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:35 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:35 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:35 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:35 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:35 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:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:39 INFO - Installing collected packages: psutil 17:34:39 INFO - Running setup.py install for psutil 17:34:39 INFO - building 'psutil._psutil_osx' extension 17:34:39 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:40 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:40 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:40 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:40 INFO - building 'psutil._psutil_posix' extension 17:34:40 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:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:34:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:34:40 INFO - ^ 17:34:40 INFO - 1 warning generated. 17:34:40 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:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:40 INFO - Successfully installed psutil 17:34:40 INFO - Cleaning up... 17:34:40 INFO - Return code: 0 17:34:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:40 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:40 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:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:40 INFO - 'HOME': '/Users/cltbld', 17:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:40 INFO - 'LOGNAME': 'cltbld', 17:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:40 INFO - 'MOZ_NO_REMOTE': '1', 17:34:40 INFO - 'NO_EM_RESTART': '1', 17:34:40 INFO - 'PAGER': '/bin/cat', 17:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:40 INFO - 'PWD': '/builds/slave/test', 17:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:40 INFO - 'SHELL': '/bin/bash', 17:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:40 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:40 INFO - 'USER': 'cltbld', 17:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:40 INFO - 'XPC_FLAGS': '0x0', 17:34:40 INFO - 'XPC_SERVICE_NAME': '0', 17:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:43 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:43 INFO - Installing collected packages: mozsystemmonitor 17:34:43 INFO - Running setup.py install for mozsystemmonitor 17:34:43 INFO - Successfully installed mozsystemmonitor 17:34:43 INFO - Cleaning up... 17:34:43 INFO - Return code: 0 17:34:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:43 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:43 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:43 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:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:43 INFO - 'HOME': '/Users/cltbld', 17:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:43 INFO - 'LOGNAME': 'cltbld', 17:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:43 INFO - 'MOZ_NO_REMOTE': '1', 17:34:43 INFO - 'NO_EM_RESTART': '1', 17:34:43 INFO - 'PAGER': '/bin/cat', 17:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:43 INFO - 'PWD': '/builds/slave/test', 17:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:43 INFO - 'SHELL': '/bin/bash', 17:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:43 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:43 INFO - 'USER': 'cltbld', 17:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:43 INFO - 'XPC_FLAGS': '0x0', 17:34:43 INFO - 'XPC_SERVICE_NAME': '0', 17:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:44 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34:46 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:46 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:46 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:46 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:46 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:46 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:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:47 INFO - warning: no files found matching '*.txt' 17:34:47 INFO - no previously-included directories found matching 'build' 17:34:47 INFO - no previously-included directories found matching 'dist' 17:34:47 INFO - no previously-included directories found matching '.git*' 17:34:47 INFO - Installing collected packages: jsonschema, functools32 17:34:47 INFO - Running setup.py install for functools32 17:34:47 INFO - warning: no files found matching '*.txt' 17:34:47 INFO - no previously-included directories found matching 'build' 17:34:47 INFO - no previously-included directories found matching 'dist' 17:34:47 INFO - no previously-included directories found matching '.git*' 17:34:47 INFO - Successfully installed jsonschema functools32 17:34:47 INFO - Cleaning up... 17:34:47 INFO - Return code: 0 17:34:47 INFO - Installing functools32==3.2.3-2 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:48 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:48 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:34:48 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:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:48 INFO - 'HOME': '/Users/cltbld', 17:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PAGER': '/bin/cat', 17:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:48 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - 'XPC_FLAGS': '0x0', 17:34:48 INFO - 'XPC_SERVICE_NAME': '0', 17:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:48 INFO - Cleaning up... 17:34:48 INFO - Return code: 0 17:34:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:48 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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:48 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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:48 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:48 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:34:48 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:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:48 INFO - 'HOME': '/Users/cltbld', 17:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PAGER': '/bin/cat', 17:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:48 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - 'XPC_FLAGS': '0x0', 17:34:48 INFO - 'XPC_SERVICE_NAME': '0', 17:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:49 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:49 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:49 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:49 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:49 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:49 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:49 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:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:52 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:52 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:52 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:52 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:52 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:52 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:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:52 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:52 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:52 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:52 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:52 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:52 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 - Downloading docopt-0.6.1.tar.gz 17:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:53 INFO - Running setup.py install for blobuploader 17:34:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:53 INFO - Running setup.py install for requests 17:34:54 INFO - Running setup.py install for docopt 17:34:54 INFO - Successfully installed blobuploader requests docopt 17:34:54 INFO - Cleaning up... 17:34:54 INFO - Return code: 0 17:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:54 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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:54 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:54 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:34:54 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:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:54 INFO - 'HOME': '/Users/cltbld', 17:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:54 INFO - 'LOGNAME': 'cltbld', 17:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:54 INFO - 'MOZ_NO_REMOTE': '1', 17:34:54 INFO - 'NO_EM_RESTART': '1', 17:34:54 INFO - 'PAGER': '/bin/cat', 17:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:54 INFO - 'PWD': '/builds/slave/test', 17:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:54 INFO - 'SHELL': '/bin/bash', 17:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:54 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:54 INFO - 'USER': 'cltbld', 17:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:54 INFO - 'XPC_FLAGS': '0x0', 17:34:54 INFO - 'XPC_SERVICE_NAME': '0', 17:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-xA3_DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Sy4YcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-j_EjY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-xIv6en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:54 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LdB2w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-MzqEXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ktDGi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-vi7pFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-7VK8XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-13xzO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-bpkry2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-AZTGpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-JmDrrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-NdldQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:55 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-YiTRXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:56 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-vtZi3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:56 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BRPexw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:56 INFO - Running setup.py install for manifestparser 17:34:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:34:56 INFO - Running setup.py install for mozcrash 17:34:56 INFO - Running setup.py install for mozdebug 17:34:56 INFO - Running setup.py install for mozdevice 17:34:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:34:56 INFO - Running setup.py install for mozfile 17:34:57 INFO - Running setup.py install for mozhttpd 17:34:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Running setup.py install for mozinfo 17:34:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Running setup.py install for mozInstall 17:34:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Running setup.py install for mozleak 17:34:57 INFO - Running setup.py install for mozlog 17:34:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Running setup.py install for moznetwork 17:34:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:34:57 INFO - Running setup.py install for mozprocess 17:34:58 INFO - Running setup.py install for mozprofile 17:34:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:34:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:34:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:34:58 INFO - Running setup.py install for mozrunner 17:34:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:34:58 INFO - Running setup.py install for mozscreenshot 17:34:58 INFO - Running setup.py install for moztest 17:34:58 INFO - Running setup.py install for mozversion 17:34:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:34:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:34:58 INFO - Cleaning up... 17:34:58 INFO - Return code: 0 17:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:58 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:58 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:34:58 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:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:58 INFO - 'HOME': '/Users/cltbld', 17:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:58 INFO - 'LOGNAME': 'cltbld', 17:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:58 INFO - 'MOZ_NO_REMOTE': '1', 17:34:58 INFO - 'NO_EM_RESTART': '1', 17:34:58 INFO - 'PAGER': '/bin/cat', 17:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:58 INFO - 'PWD': '/builds/slave/test', 17:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:58 INFO - 'SHELL': '/bin/bash', 17:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:34:58 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:58 INFO - 'USER': 'cltbld', 17:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:58 INFO - 'XPC_FLAGS': '0x0', 17:34:58 INFO - 'XPC_SERVICE_NAME': '0', 17:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BHuyY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-LuYTME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-WbU2DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-0h03tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Le_mYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-s2e72h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SgqHYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-BYT0Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:59 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:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:59 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-IUeVY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-xE05b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-cCZMza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-564Yx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-yDcSMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ZmP0fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-O4R6L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-C7QKTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:00 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-g5pSbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:00 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:00 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:00 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:00 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:00 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:00 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:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 17:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:03 INFO - Installing collected packages: blessings 17:35:03 INFO - Running setup.py install for blessings 17:35:03 INFO - Successfully installed blessings 17:35:03 INFO - Cleaning up... 17:35:04 INFO - Return code: 0 17:35:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:04 INFO - Reading from file tmpfile_stdout 17:35:04 INFO - Current package versions: 17:35:04 INFO - blessings == 1.6 17:35:04 INFO - blobuploader == 1.2.4 17:35:04 INFO - docopt == 0.6.1 17:35:04 INFO - functools32 == 3.2.3-2 17:35:04 INFO - jsonschema == 2.5.1 17:35:04 INFO - manifestparser == 1.1 17:35:04 INFO - mozInstall == 1.12 17:35:04 INFO - mozcrash == 1.0 17:35:04 INFO - mozdebug == 0.1 17:35:04 INFO - mozdevice == 0.50 17:35:04 INFO - mozfile == 1.2 17:35:04 INFO - mozhttpd == 0.7 17:35:04 INFO - mozinfo == 0.9 17:35:04 INFO - mozleak == 0.1 17:35:04 INFO - mozlog == 3.4 17:35:04 INFO - moznetwork == 0.27 17:35:04 INFO - mozprocess == 0.25 17:35:04 INFO - mozprofile == 0.28 17:35:04 INFO - mozrunner == 6.13 17:35:04 INFO - mozscreenshot == 0.1 17:35:04 INFO - mozsystemmonitor == 0.3 17:35:04 INFO - moztest == 0.8 17:35:04 INFO - mozversion == 1.4 17:35:04 INFO - psutil == 3.1.1 17:35:04 INFO - requests == 1.2.3 17:35:04 INFO - wsgiref == 0.1.2 17:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:04 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:04 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:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:04 INFO - 'HOME': '/Users/cltbld', 17:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:04 INFO - 'LOGNAME': 'cltbld', 17:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:04 INFO - 'MOZ_NO_REMOTE': '1', 17:35:04 INFO - 'NO_EM_RESTART': '1', 17:35:04 INFO - 'PAGER': '/bin/cat', 17:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:04 INFO - 'PWD': '/builds/slave/test', 17:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:04 INFO - 'SHELL': '/bin/bash', 17:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:35:04 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:04 INFO - 'USER': 'cltbld', 17:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:04 INFO - 'XPC_FLAGS': '0x0', 17:35:04 INFO - 'XPC_SERVICE_NAME': '0', 17:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 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:04 INFO - Cleaning up... 17:35:04 INFO - Return code: 0 17:35:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 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 0x10dab5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb79c7a780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, '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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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:04 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:04 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:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:04 INFO - 'HOME': '/Users/cltbld', 17:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:04 INFO - 'LOGNAME': 'cltbld', 17:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:04 INFO - 'MOZ_NO_REMOTE': '1', 17:35:04 INFO - 'NO_EM_RESTART': '1', 17:35:04 INFO - 'PAGER': '/bin/cat', 17:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:04 INFO - 'PWD': '/builds/slave/test', 17:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:04 INFO - 'SHELL': '/bin/bash', 17:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:35:04 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:04 INFO - 'USER': 'cltbld', 17:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:04 INFO - 'XPC_FLAGS': '0x0', 17:35:04 INFO - 'XPC_SERVICE_NAME': '0', 17:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:04 INFO - Cleaning up... 17:35:04 INFO - Return code: 0 17:35:04 INFO - Running post-action listener: _resource_record_post_action 17:35:04 INFO - Running post-action listener: _start_resource_monitoring 17:35:04 INFO - Starting resource monitoring. 17:35:04 INFO - [mozharness: 2017-04-29 00:35:04.862334Z] Finished create-virtualenv step (success) 17:35:04 INFO - [mozharness: 2017-04-29 00:35:04.863341Z] Running install step. 17:35:04 INFO - Running pre-action listener: _resource_record_pre_action 17:35:04 INFO - Running main action method: install 17:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:05 INFO - Reading from file tmpfile_stdout 17:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:05 INFO - Reading from file tmpfile_stdout 17:35:05 INFO - Output received: 17:35:05 INFO - Usage: mozinstall [options] installer 17:35:05 INFO - Options: 17:35:05 INFO - -h, --help show this help message and exit 17:35:05 INFO - -d DEST, --destination=DEST 17:35:05 INFO - Directory to install application into. [default: 17:35:05 INFO - "/builds/slave/test"] 17:35:05 INFO - --app=APP Application being installed. [default: firefox] 17:35:05 INFO - mkdir: /builds/slave/test/build/application 17:35:05 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:05 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:24 INFO - Reading from file tmpfile_stdout 17:35:24 INFO - Output received: 17:35:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:35:24 INFO - Running post-action listener: _resource_record_post_action 17:35:24 INFO - [mozharness: 2017-04-29 00:35:24.685018Z] Finished install step (success) 17:35:24 INFO - [mozharness: 2017-04-29 00:35:24.685172Z] Running run-tests step. 17:35:24 INFO - Running pre-action listener: _resource_record_pre_action 17:35:24 INFO - Running main action method: run_tests 17:35:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:24 INFO - 2017-04-28 17:35:24.699 screenresolution[1623:7403] starting screenresolution argv=screenresolution get 17:35:24 INFO - 2017-04-28 17:35:24.702 screenresolution[1623:7403] Display 0: 1600x1200x32@60 17:35:24 INFO - 2017-04-28 17:35:24.707 screenresolution[1624:7406] starting screenresolution argv=screenresolution list 17:35:24 INFO - Available Modes on Display 0 17:35:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:24 INFO - Intel Iris: 17:35:24 INFO - Chipset Model: Intel Iris 17:35:24 INFO - Type: GPU 17:35:24 INFO - Bus: Built-In 17:35:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:24 INFO - Vendor: Intel (0x8086) 17:35:24 INFO - Device ID: 0x0a2e 17:35:24 INFO - Revision ID: 0x0009 17:35:24 INFO - Displays: 17:35:24 INFO - Display: 17:35:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:24 INFO - Display Serial Number: 1600x1200 60 17:35:24 INFO - Main Display: Yes 17:35:24 INFO - Mirror: Off 17:35:24 INFO - Online: Yes 17:35:24 INFO - Rotation: Supported 17:35:24 INFO - Return code: 0 17:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:24 INFO - Python 2.7.3 17:35:24 INFO - Return code: 0 17:35:24 INFO - grabbing minidump binary from tooltool 17:35:24 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:24 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 0x10d893d30>, '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 0x10d7b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d888be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:24 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:24 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:24 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:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:25 INFO - Return code: 0 17:35:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:35:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:25 INFO - ENV: RUST_BACKTRACE is now 1 17:35:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:35:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:25 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-0024', '--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:25 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-0024 --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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VmhJw3lXq8/Render', 17:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:25 INFO - 'HOME': '/Users/cltbld', 17:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:25 INFO - 'LOGNAME': 'cltbld', 17:35:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:25 INFO - 'MOZ_NO_REMOTE': '1', 17:35:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:25 INFO - 'NO_EM_RESTART': '1', 17:35:25 INFO - 'PAGER': '/bin/cat', 17:35:25 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:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:25 INFO - 'PWD': '/builds/slave/test', 17:35:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:25 INFO - 'RUST_BACKTRACE': '1', 17:35:25 INFO - 'SHELL': '/bin/bash', 17:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J6CYoAbzv9/Listeners', 17:35:25 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 17:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:25 INFO - 'USER': 'cltbld', 17:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:25 INFO - 'XPC_FLAGS': '0x0', 17:35:25 INFO - 'XPC_SERVICE_NAME': '0', 17:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:25 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-0024', '--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:25 INFO - mozversion application_buildid: 20170428075320 17:35:25 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:35:25 INFO - mozversion application_display_name: Nightly 17:35:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:25 INFO - mozversion application_name: Firefox 17:35:25 INFO - mozversion application_remotingname: firefox 17:35:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:25 INFO - mozversion application_vendor: Mozilla 17:35:25 INFO - mozversion application_version: 55.0a1 17:35:25 INFO - mozversion platform_buildid: 20170428075320 17:35:25 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:35:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:25 INFO - mozversion platform_version: 55.0a1 17:35:25 INFO - using testdate: 1493426125 17:35:25 INFO - actual date: 1493426125 17:35:25 INFO - starting webserver on 'localhost:49228' 17:35:25 INFO - SUITE-START | Running 2 tests 17:35:25 INFO - TEST-START | dromaeo_css 17:35:25 INFO - operating with platform_type : mac_ 17:35:25 INFO - Initialising browser for dromaeo_css test... 17:35:25 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpMxKEJz/profile http://localhost:49228/getInfo.html) 17:35:27 INFO - PID 1634 | 2017-04-28 17:35:27.827 plugin-container[1636:7582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 17:35:27 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:27 INFO - PID 1634 | 2017-04-28 17:35:27.830 plugin-container[1636:7582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9743, name = 'com.apple.CFPasteboardClient' 17:35:27 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:27 INFO - PID 1634 | 2017-04-28 17:35:27.830 plugin-container[1636:7582] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:28 INFO - PID 1634 | __metrics Screen width/height:1600/1200 17:35:28 INFO - PID 1634 | colorDepth:24 17:35:28 INFO - PID 1634 | Browser inner width/height: 1024/689 17:35:28 INFO - PID 1634 | __metrics 17:35:28 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:35:29 INFO - TEST-INFO | 1634: exit 0 17:35:29 INFO - Browser initialized. 17:35:29 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:29 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpMxKEJz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:31 INFO - PID 1637 | 2017-04-28 17:35:31.189 plugin-container[1638:7700] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 17:35:31 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:31 INFO - PID 1637 | 2017-04-28 17:35:31.190 plugin-container[1638:7700] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9717, name = 'com.apple.CFPasteboardClient' 17:35:31 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:31 INFO - PID 1637 | 2017-04-28 17:35:31.190 plugin-container[1638:7700] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:41 INFO - PID 1637 | RSS: Main: 251305984 17:35:41 INFO - PID 1637 | 17:38:45 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49228/tests/dromaeo/cssquery-ext.html) 17:38:46 INFO - PID 1637 | RSS: Main: 258166784 17:38:46 INFO - PID 1637 | 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 17:40:29 INFO - PID 1637 | 17:40:29 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:29 INFO - PID 1637 | Full stack: 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 17:40:29 INFO - PID 1637 | 17:40:29 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:29 INFO - PID 1637 | Full stack: 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 17:40:29 INFO - PID 1637 | 17:40:29 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:29 INFO - PID 1637 | Full stack: 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | ************************* 17:40:29 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 17:40:29 INFO - PID 1637 | 17:40:29 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:29 INFO - PID 1637 | Full stack: 17:40:29 INFO - PID 1637 | ************************* 17:41:48 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-ext.html (next: http://localhost:49228/tests/dromaeo/cssquery-jquery.html) 17:41:49 INFO - PID 1637 | RSS: Main: 260067328 17:41:49 INFO - PID 1637 | 17:44:51 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49228/tests/dromaeo/cssquery-mootools.html) 17:44:51 INFO - PID 1637 | RSS: Main: 269041664 17:44:51 INFO - PID 1637 | 17:47:53 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49228/tests/dromaeo/cssquery-prototype.html) 17:47:54 INFO - PID 1637 | RSS: Main: 261451776 17:47:54 INFO - PID 1637 | 17:50:57 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49228/tests/dromaeo/cssquery-yui.html) 17:50:57 INFO - PID 1637 | RSS: Main: 270569472 17:50:57 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-yui.html (next: http://localhost:49228/tests/dromaeo/cssquery-dojo.html) 17:53:59 INFO - PID 1637 | RSS: Main: 266420224 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | __start_tp_report 17:53:59 INFO - PID 1637 | _x_x_mozilla_page_load 17:53:59 INFO - PID 1637 | _x_x_mozilla_page_load_details 17:53:59 INFO - PID 1637 | |i|pagename|runs| 17:53:59 INFO - PID 1637 | |0;dojo.html;3126.8123912565247;3609.8917032489035;3620.981895090524;3659.1218107654154;3683.300172967136;6107.969460152704;6192.287886893008;6205.503559715224;6242.250929888414;6276.654783986879;6107.097787096192;6151.753929842801;6164.198654174962;6226.283977342607;6261.373862613747;5425.511703946644;5448.891022179554;5463.344398672165;5464.453554644533;5486.286782718261;4993.567260044134;5576.358718747356;5588.245586845765;5593.944060559404;5615.101583746601;5354.116570765819;5413.53984911283;5478.698671573062;5493.450654934514;5572.331320241577;5474.644148130359;5506.669599823983;5510.9448905510835;5513.558915286768;5543.722813859291;5387.622866399353;5425.7287135643455;5440;5483.314585676791;5486.61593688442;5096.694198348111;6041.456268935817;6119.441623354618;6242.906356404657;6259.655718935457;6512.967435162841;6572.572782769104;6633.4693224541925;6646.069550262967;6669.599824010526;6732.158480189976;6782.491313151533;6784;6786.966065169642;6793.728250869959;6263.091851681481;6292.842678933018;6305.68471576424;6322.178116844781;6341.4609758170145;6585.308542603054;6681.599104053772;6882.793516194522;6889.379955804002;6968.581885086911;6294.496440284766;6331.271903731038;6494.123293355431;6540.247871494839;6622.437092847162;6669.699863506154;6804.931950680529;6808.8978665320055;6811.659417029129;6813;6501.31736167705;6684.498662600325;6711.798646040626;6711.832204194934;6716.932830671729;6514.6416947068365;6533.803985880336;6623;6665.066890635315;6683.7660681875905;5332.253484512172;5336.519713225751;5343.118385466432;5356.705381203993;5361.490658387447;4741.431028276629;4748.762561871893;4758.500357462486;4780.450248221429;4801.68789028712;6136.427173609184;6244.344343843922;6340.9365906340345;6357.713902874381;6362.141110950055;5657.434256574392;6763.086983257197;6796.592204467748;6802.897956530656;6813.761518346834;6336.239651241881;6366.649834259068;6373.298937117006;6385.074164246158;6405.327440618761;5725.198472213893;5795.710214489259;5802.187693722883;5816.767329306865;5923.141144534018;6800.93199068003;6840.452763778786;6955.791326260221;6984.546004509691;7006.159260888726;6781.42357899584;6821.795346139624;6824;6831.863362732817;6862.519623626498;6984.2317345093015;7013.579185248901;7016.824579385556;7041.43668506508;7044.15470143586;6423.775167869102;6468.482521398371;6589.47284217271;6662.966685166737;6683.331666833278;6150.7847225346895;6736.360045795642;6805.89791153143;6807.625580593115;6815.693293801692;5607.719614019201;6370.77702280418;6374.394432528902;6537.444317233088;6549.279579246374;6589.110470086669;6602.966985165043;6608.43828274602;6610.6694665267505;6621.172353455818;5306.25712400272;6231.22109736283;6283.088952102011;6452.128962590178;6456.741730330734;6526.934730652632;6534.346565343428;6555.737770489318;6596.637184954873;6614.305497922649;6392.776252831129;6396.6481843497195;6410.935890641033;6426.742930282923;6457.483401327976 17:53:59 INFO - PID 1637 | |1;ext.html;816.1471262530656;837.8324335132972;1162.5233654201775;1236.9876301236995;1246.4515613130227;37788.43317350242;38227.61772382279;38291.85124446264;38346.23307533851;38413.03967400816;37710.0572485688;38024.23951520968;38079;38082.238355232876;38110;6842.863142737142;7875.133735289128;8029;8195.221453961864;8366.37252206087;8493.787655308604;8516.361272904525;8613.612387442548;8621.95689021554;8626.870596941051;8527.530985795778;8556.48661080334;8598.011228708716;8635.69775057873;8647.783805404852;7299.452541059389;7630.694772209105;8156.124091458968;8451.957740211259;8577.699780507652;8356.997160340798;8358.498490090553;8417;8430.53632050237;8431.494110353337;29317.56023659647;36736.63263367359;36794.816025919965;36830.263394732225;36895.4465683015;3568.7858728476376;3606.7114630829733;3611.3138503684218;3613.837377318027;3619.348517266891;29283.707162928313;29716.257093572618;29738.553921691193;29764.10707678773;29784.40431191386;3064.7548196144253;3114.7508199343997;3130.780845340827;3139.5133754268127;3156.3687262547583;293909;295064;296740;296787;297164;45030.549694503294;47425;47520.7623961878;48124;48329.75835120802;41185.79407102945;49770.75573110701;49786.75106624516;49851.25223121656;49945.25082123771;14102.083364581269;14219.36012879423;14220;14225;14247.287635618384;11338.829917551244;11395.316281023164;11436.885631143748;11462.713432164262;11479.19645624815;13008.349582521025;13038.674033149247;13094.803577946339;13148.934255328662;13232.073754837069;5767.798127065533;5840.970795145997;5865.882682346414;5870.647761134345;5878.382769809108;1023.7696518283476;1026.2559644257854;1027.3733022856052;1055.9208059395576;1062.8724553053682;21013.474663133544;29921.850390747906;29966.85016574903;30066.69933300683;30495.237619059702;1100.5652767156928;1103.7130346110068;1140;1143.4568579924469;1151.401271338899;11951.641450756491;12130.968867646348;12179.817302740466;12198.268103913793;12225.694357640952;315116;317338;317741;318723;319353;50620;50684.239736403986;50820.74589627102;50830.74584627053;50920.23619645708;1454.2292584930003;1488.709701608176;1530.1431198528637;1530.2731202678638;1548.914809685478;18606.81393186105;21163;23163;23556;23908.40228994289;37056;49267;50144.24783628321;50282.748586256836;50350;295823;296666;296679;297437;297984;34500.137496562784;34809.47785783266;34881.825590871886;34906.9527914163;35125.64874351326;43047.56952430436;43185.136297274505;44297;45250.77374613106;45265.773671131436;26228.344291392867;30672.539911900894;30762;31222.494374415146;31350;30532.542011869395;31062.378752425277;31082.53376199404;31140.844295778377;31277.68722312748;37138;37482.812585936896;37501;37503.81248093742;37629;29507.704922950496;30902;30946.0716178515;31913.68086319107;32179.678203217667;21109.788902110784;22365.888170559043;23593.88203058974;24234.394140146636;24613.87693061523 17:53:59 INFO - PID 1637 | |2;jquery.html;369.42001058338406;432.61713383655456;432.71873282366437;448.76365612736913;460.084431980359;17913.7312940306;18357.541061473436;20762.6885596716;21546.676799848014;21617.135314587416;21718.782812171874;22031.33905982819;22149.335519934386;22244.110235590597;22265.66601500975;5221.765020574065;5597.216389705444;5742.454466825655;6006.309274433453;6022.187004754368;5867.941320586782;5899.823005309848;6016.879662406749;6135.8772824543485;6180;6119.326874043852;6122.204113465244;6127.142200091991;6140.140380346755;6158.507319414436;5937.7624895004365;6071.544634152434;6078.787242446538;6086.847828804271;6094;5002.549770520634;5061.468545802674;5318.760655770499;5367.087595108841;5389.973050134763;25269.494610107697;25367;25862.482750344887;26025;26101.477970440486;2158.7733288004847;2221.3224966385246;2243.618584840565;2256.954860902773;2262.9434264143365;16973.3210671573;17217.397391091377;17379.13104344778;17554.85893416924;17586.472405827844;1874.6157037807218;2067.648499755045;2129.1376992318137;2150.182930486421;2165.1664109317867;146594.26702866418;151851;152903;153645.23177384154;157606;11752.94123529394;12177.573784917486;12216.205946613441;12231.449584768707;12276.079294052981;15747.921260393625;15788.289526971084;15801.288941997638;15807.683846323009;15821.446249381217;8582.055973842873;8698.304135669132;8753.606087726068;8828.293736501064;8891.155340242667;8151.307138893142;8296.83406331882;8358.749237522885;8437.789055273544;8451.323894088458;6410.967945160244;7540.622968851536;7588.436002857488;7689.730859419893;7753.496022758615;1874.7375367448567;1900.7814101378242;2180.945476363104;2194.6049711052165;2337.812974961999;954.4845783277092;969.8739163908647;976.4239098931664;1007.8538611901233;1009.4094954451581;18950.43148705541;19944.401667949984;20127.69170003945;20152;20457.874816884916;961.5240455974198;1009.3641006166068;1027.2536687631057;1035.1822060572215;1041.6458404142627;8498.74503764888;8756.518391488402;9897.901020989842;10026.598936042623;10397.792044159074;499535;500207.49896250287;506957.46521267155;510191;517150;101477.49261253646;119531;122787;123813.14280285803;125219.37390313172;1164.9068074554016;1175.5474142455216;1206.1797977375293;1210.1831263896834;1212.7877621416394;16800.57998550046;17045.744313835054;17274;20903.686444703646;22498.550028999656;41516.58483415248;58519;59046;60409;60599.69700151471;76880.30918917811;77255.61372193103;77631.8947242104;78055.60972195103;79236;8581.742547723577;8635.87046194295;8752.781180470285;8954.865677014981;8982.416142950688;13795.517156899461;13819.378127984064;13893.374798133906;14169.574912752634;14180.787288190479;11168.72078198019;11833.349165795964;11904;11910.940445297718;12009.699757506132;10807.189460790314;10864.185186111232;10875.564977400816;11208;11209.991100800968;11836.940815295868;11847.76304473923;12079.818802717791;12110.45502952387;12159.966402855502;8459.492430454193;8611.354148438766;8721.345899057469;8737.326637376;8779.736607901774;11552.249103808226;11689.298642081503;11795.823062653895;11884.405779711153;11915.2255103418 17:53:59 INFO - PID 1637 | |3;mootools.html;1382.854800245974;1425.4939496478755;1444.884409247259;1446.2118145610648;1456.1699831096275;9555.56999935003;9945;12071.75856482871;12097.274163550193;12097.395130243485;11581.536738530449;11717.121215908799;11836.171467997243;11841.052715782738;11842.881571184285;2527.254459934319;2557.7825884799813;2571.742825717432;2574.6524219230446;2576.240009197282;2481.057198264657;2523.823332366735;2534.3664083979006;2537.0486067724605;2537.581299085658;2497.4880149569294;2517.0686845866962;2547.5796493578537;2547.6688030556;2559.1298958354155;2468.888899999495;2469.469064151207;2509.0841842727455;2509.1970569417795;2517.559427100259;2398.940026499334;2484.962725559118;2493.5386953413677;2495.962560561593;2501.1496091328854;11631.6510504685;11708.707282317924;11731.413429328499;11772.529098836036;11792.174547781658;5514.283143191399;5647.774089036434;6551.80344589663;6821.658917054127;6827.658617069176;3816.3512202925567;3966.186931678999;4097.8770636880945;4270.829166833354;4351.521332653406;1125.881782412843;1231.6797632615494;1243.2913239453515;1291.7416516696699;1295.2681734819796;16056.518304450885;16415.83584164155;16567.17164141788;16594.08732519711;16654.417095401604;5407.432219616962;5552.7223638817895;5567.220589117527;5695.971520142372;5702.771889124471;11551.306921584732;11644.6506604802;11738.295702257721;11742.941285293518;11743.941280293715;5468.28912241406;6392.520560957947;6456.806295811133;6481.837954051187;6491.253505846888;5969.641821490638;6086.117512960596;6141.92516309644;6204.317525072239;6257.311695713468;3991.261616600938;4035.2736507428945;4207.116505533811;4321.870343889688;4340.327249276367;1109.89565382445;1244.2099266965542;1274.5029438518984;1285.6785803549112;1290.6966862787237;752.2928447259559;807.1113594189625;818.9631466584018;827.5986146718836;856.5160684213399;5129.717865517432;6009.828083523671;6104.328523862371;6430.035494675836;7315.049043624401;806.6531391501593;904.2675432899373;956.6941125363828;961.3654987708079;970.3886551472668;4373.6282415994365;4393.626541743987;4422.624076953431;4444;4540.79566419512;14942.477013304482;15276.465323713617;15285.082895026111;15401.306941187673;15419.460318888785;14951;15035.473758418622;15227.695446091016;15423.383064677288;15444.845551544566;8363.58182090893;8565.78585535354;8636.913630863737;8755.781105472286;8845.380823342433;6980.197277313174;7049.7885063448175;7090.4682148840075;7219.855602887807;7234.312740289664;11282.830757538808;13034.348282585643;13147.474101035852;13671.31643417845;13804.447822087004;13825.723485530434;13990.510332138327;14013.229272390117;14041.36813843359;14421.495247666282;9301.046780176239;9576.042395760369;9578.281628878001;9595.23238140933;9622.278329125484;8191.877121843297;9033.728988130366;10495;10512.684619461428;10856.077233435246;9139.862902056342;9234;9235.753173321784;9259.583318750538;9328.766780830534;8837.248833849195;8942.46345219289;9064.093590640883;9085.409448385833;9127.22418594427;7023.648817559204;8237.135100814328;8270.751877443687;8368.707095251637;8391.118932511998;6028.8794224116145;6105.114758360101;6163.630182189083;6186.505079593531;6216.285127210248;6117.265928088658;6172.259328880563;6281.623102613858;6304.464120549805;6324.272708638566 17:53:59 INFO - PID 1637 | |4;prototype.html;415.54705371145457;415.8771317442904;422.46769070970566;424.10302210824096;429.1288683971539;6106.664133472657;6161.907571386427;6349.174607301056;6371.426571608555;6376.80869573913;5586.55307575394;5901.527877769779;6171;6199.380061993798;6234;3799.7530160539613;4097.651699605537;4372.256716358211;4428.759947214785;4482.551744825508;4459.531749166324;4474.530174331697;4483.887902802439;4505.8648240552675;4512.1426928883575;4230.809613567381;4452.621527170194;4458.2866741321395;4458.687891847572;4465.397171381855;4262.126264115849;4382.6055654991205;4417.514073451917;4433.623142032899;4451.1542806866755;3225.032730034677;3341.3484370547753;3735.34631439497;3785.6592906638534;3794.165283637623;4987.700737955698;6010.025037606413;6030.758769649209;6032.125341825411;6034.728437220292;4674.953250467486;5211.348581427322;5305.938812237568;5317.096093664048;5327.413984461706;6206.162168107293;6250.4374606285655;6582.44049255809;6609.041688955074;6709.798706038827;3934.380370059552;4012.29784787661;4320.861173718998;4329.5237523872665;4332.610065094125;5659.236003139565;6427.389398007182;6992.370686638176;7014.333638304353;7178.451649664398;4235.4917409911;4349.434573505424;4352.1513304905875;4355.823927539546;4396.780160991938;3746.83139258734;4416.977915110404;4465.106978604292;4472.351509031172;4474.821007159742;5172.431032586413;5182.896342073137;5261.131913234273;5281.656692315064;5325.334333208349;5668.343918172755;5705.686187259657;5957.493613042853;6478.2873883872735;6565;1401.5444980381417;1499.7525408307724;1528.2740698168504;1532.716447457224;1537.3389442539815;959.9808003839884;980.7401038724744;987.7728122531857;996.2378780233128;997.6109317366233;5895.587308888336;6343.921533339343;6376.808695739135;6385.201849768779;6404.615723056631;6026.819195424145;6285;6542.34576542342;6903.378695917391;6933.757318493828;5379.838604841861;6436.517261205428;6475.3200913903365;6480.57876238043;6490.383413575702;3199.2481766784786;3482.7387945904156;3564.803935783557;3593.161402492054;3642.1805093853673;7097.432205423554;7133.928660713326;7168.139823221142;7186.461015423864;7207.783766487014;6210.9068363974575;6809.182898052265;7107.466939979522;7119.291370071249;7132.857342853217;5955.79154729591;6269.896401281304;7169.694426124526;7176.102987126609;7187.856242875113;6659.567128136656;6722.899156512754;6897.827554311182;7002.474814389043;7005.949107633692;5476.849861529124;6692.832679182865;6738.629375384205;6861.622610756456;6869.656517174021;7248.383887369632;7279.381252593377;7299.197088320387;7336.523125996793;7438.437928034957;4053.331200352027;4398.450193725785;4403.647708183402;4420.182266280748;4434.312681534368;5795.7971471;6331.335209803088;6576.506761992774;6946.131733533309;7061.1173603299585;5568.972155139199;6738.494612903954;6752.966235168793;6764.222114456704;6766.86466270662;6492.935070649233;6685.130932978682;6701.832454188684;6749.763758268437;6761.594304341756;5483.341998960151;6577.6053436792035;6595.637239951849;6596.8350791230605;6609.3060228675295;6186.19579454668;6235.719392627252;6475.935240647534;6525.902111468236;6728.180124192636;5479.808206712746;5732.742026608729;5808.1123634818005;6595.472362210916;6628.933710663025 17:53:59 INFO - PID 1637 | |5;yui.html;796.4305521552089;833.8874251975982;841.381584535366;868.9087645797191;873.2053831013777;16393;16907.985520868755;17104.23030963608;18137.546561335974;19296.4211073668;17668.11659417027;18097;18169.636607267847;18346.266149354044;18437.446876593724;1005.8943810899841;1017.6031347774374;1031.1029404418166;1043.3270540501371;1045.6131231444376;998.0568362897066;1026.7535791410046;1041.5677493840046;1046.2676126711294;1047.455323231919;1069.1393428290223;1108.4346983038668;1120.7590368070862;1122.831575263713;1123.1576317761678;1096.3915027159924;1113.9053180479668;1114.2701530497536;1116.743149075713;1120.7590368070823;811.8822770698275;823.016495288131;830.8546004449197;832.7793134819278;834.9165083491603;16947.745783813254;16950.57623559421;17008.57478563046;17453.389131380467;17622.383216587485;16962.406315778888;17087.060211688353;17315.220815063225;17399;17484.213210405564;12223.899849013631;13550.051496395256;13583.660408489768;13862;14100.294985250799;3462.671046250602;3486.5467489226494;3489.8604055837736;3492;3496.9825150874085;76566.32017879348;112259;118078.22882656768;125837;128231.71768282291;12143.02855771536;12225.755484890253;12349.259044457362;12400.937995310147;12452.81320780189;23291;23954.40113997129;24292.785360731894;24305;24316.27051188467;7844.37245020397;8080.313173380328;8081.919180808234;8089.757307280791;8131.024277086787;3826.368649172911;3939.4484772131923;3958.5843486434087;4034.9394759078637;4051.9392209116886;4262.403263543107;4343.500497442835;4350.412694286231;4354.194474022316;4360.193364227628;936.7751739582587;937.8077494113691;941.651588912107;950.2635457520339;958.4872093429982;646.0696596900449;660.313274194832;666.5534092158266;667.9732810687615;689.5793565924782;10680.412577308167;11551.133664975161;11782.469788859522;12157.148999570121;12204.267743935392;609.6464050850585;615.3047056825758;619.9876002479925;624.2321944008804;626.3579830673596;5511.5039646432015;5681.091025435993;5692.316921969307;5735.799247026417;5766.336871259775;114908;117119;117244;117398;120791;99701.5044774329;100720.49639751755;101939;103572.44641330386;105181;76026;83995;86149.56925215459;89674.55162724275;89764.99999999869;9237.538123093953;10245.692629221136;10602.20483463728;11393.829092563452;11706.297622142698;38609.613903861726;43880.56119438892;43993.340099899164;44203.778981104886;44453.11093778042;47314.763426182646;53663.6584085401;57099.42900570941;57830.7108464455;58472;15792.526224213292;17887.28450861951;17961.191746371183;17964.91017544956;18080.18639161267;17773.46679599614;18085;18815.529611759815;19104.140313686195;19202.519937001685;17554.824451755318;17718.82281177172;17889.10554472245;18346.51416230912;18387.356442524448;17589.824101759332;17665.646687065928;18306.725399118757;18308.084595770426;18674.439766806474;16659.500214993568;16925.74611380855;17070.402535911184;17173.227204775565;17258.482245532654;11883.465244064211;11973.580924667594;12204.633860984184;12210.206336588093;12573.182743121668;11559.30644161353;12199.085068620067;13850.515231966832;14191;14215.715685686435 17:53:59 INFO - PID 1637 | __end_tp_report 17:53:59 INFO - PID 1637 | __start_cc_report 17:53:59 INFO - PID 1637 | _x_x_mozilla_cycle_collect,418 17:53:59 INFO - PID 1637 | __end_cc_report 17:53:59 INFO - PID 1637 | __startTimestamp1493427239756__endTimestamp 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | ------- Summary: start ------- 17:53:59 INFO - PID 1637 | Number of tests: 6 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:6163.36 Median:6374.39 stddev:736.23 (11.5%) stddev-sans-first:698.89 17:53:59 INFO - PID 1637 | Values: 3126.8 3609.9 3621.0 3659.1 3683.3 6108.0 6192.3 6205.5 6242.3 6276.7 6107.1 6151.8 6164.2 6226.3 6261.4 5425.5 5448.9 5463.3 5464.5 5486.3 4993.6 5576.4 5588.2 5593.9 5615.1 5354.1 5413.5 5478.7 5493.5 5572.3 5474.6 5506.7 5510.9 5513.6 5543.7 5387.6 5425.7 5440.0 5483.3 5486.6 5096.7 6041.5 6119.4 6242.9 6259.7 6513.0 6572.6 6633.5 6646.1 6669.6 6732.2 6782.5 6784.0 6787.0 6793.7 6263.1 6292.8 6305.7 6322.2 6341.5 6585.3 6681.6 6882.8 6889.4 6968.6 6294.5 6331.3 6494.1 6540.2 6622.4 6669.7 6804.9 6808.9 6811.7 6813.0 6501.3 6684.5 6711.8 6711.8 6716.9 6514.6 6533.8 6623.0 6665.1 6683.8 5332.3 5336.5 5343.1 5356.7 5361.5 4741.4 4748.8 4758.5 4780.5 4801.7 6136.4 6244.3 6340.9 6357.7 6362.1 5657.4 6763.1 6796.6 6802.9 6813.8 6336.2 6366.6 6373.3 6385.1 6405.3 5725.2 5795.7 5802.2 5816.8 5923.1 6800.9 6840.5 6955.8 6984.5 7006.2 6781.4 6821.8 6824.0 6831.9 6862.5 6984.2 7013.6 7016.8 7041.4 7044.2 6423.8 6468.5 6589.5 6663.0 6683.3 6150.8 6736.4 6805.9 6807.6 6815.7 5607.7 6370.8 6374.4 6537.4 6549.3 6589.1 6603.0 6608.4 6610.7 6621.2 5306.3 6231.2 6283.1 6452.1 6456.7 6526.9 6534.3 6555.7 6596.6 6614.3 6392.8 6396.6 6410.9 6426.7 6457.5 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:45475.66 Median:175318.34 stddev:79622.80 (45.4%) stddev-sans-first:79775.56 17:53:59 INFO - PID 1637 | Values: 816.1 837.8 1162.5 1237.0 1246.5 37788.4 38227.6 38291.9 38346.2 38413.0 37710.1 38024.2 38079.0 38082.2 38110.0 6842.9 7875.1 8029.0 8195.2 8366.4 8493.8 8516.4 8613.6 8622.0 8626.9 8527.5 8556.5 8598.0 8635.7 8647.8 7299.5 7630.7 8156.1 8452.0 8577.7 8357.0 8358.5 8417.0 8430.5 8431.5 29317.6 36736.6 36794.8 36830.3 36895.4 3568.8 3606.7 3611.3 3613.8 3619.3 29283.7 29716.3 29738.6 29764.1 29784.4 3064.8 3114.8 3130.8 3139.5 3156.4 293909.0 295064.0 296740.0 296787.0 297164.0 45030.5 47425.0 47520.8 48124.0 48329.8 41185.8 49770.8 49786.8 49851.3 49945.3 14102.1 14219.4 14220.0 14225.0 14247.3 11338.8 11395.3 11436.9 11462.7 11479.2 13008.3 13038.7 13094.8 13148.9 13232.1 5767.8 5841.0 5865.9 5870.6 5878.4 1023.8 1026.3 1027.4 1055.9 1062.9 21013.5 29921.9 29966.9 30066.7 30495.2 1100.6 1103.7 1140.0 1143.5 1151.4 11951.6 12131.0 12179.8 12198.3 12225.7 315116.0 317338.0 317741.0 318723.0 319353.0 50620.0 50684.2 50820.7 50830.7 50920.2 1454.2 1488.7 1530.1 1530.3 1548.9 18606.8 21163.0 23163.0 23556.0 23908.4 37056.0 49267.0 50144.2 50282.7 50350.0 295823.0 296666.0 296679.0 297437.0 297984.0 34500.1 34809.5 34881.8 34907.0 35125.6 43047.6 43185.1 44297.0 45250.8 45265.8 26228.3 30672.5 30762.0 31222.5 31350.0 30532.5 31062.4 31082.5 31140.8 31277.7 37138.0 37482.8 37501.0 37503.8 37629.0 29507.7 30902.0 30946.1 31913.7 32179.7 21109.8 22365.9 23593.9 24234.4 24613.9 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:33744.33 Median:12232.72 stddev:86350.88 (705.9%) stddev-sans-first:86556.76 17:53:59 INFO - PID 1637 | Values: 369.4 432.6 432.7 448.8 460.1 17913.7 18357.5 20762.7 21546.7 21617.1 21718.8 22031.3 22149.3 22244.1 22265.7 5221.8 5597.2 5742.5 6006.3 6022.2 5867.9 5899.8 6016.9 6135.9 6180.0 6119.3 6122.2 6127.1 6140.1 6158.5 5937.8 6071.5 6078.8 6086.8 6094.0 5002.5 5061.5 5318.8 5367.1 5390.0 25269.5 25367.0 25862.5 26025.0 26101.5 2158.8 2221.3 2243.6 2257.0 2262.9 16973.3 17217.4 17379.1 17554.9 17586.5 1874.6 2067.6 2129.1 2150.2 2165.2 146594.3 151851.0 152903.0 153645.2 157606.0 11752.9 12177.6 12216.2 12231.4 12276.1 15747.9 15788.3 15801.3 15807.7 15821.4 8582.1 8698.3 8753.6 8828.3 8891.2 8151.3 8296.8 8358.7 8437.8 8451.3 6411.0 7540.6 7588.4 7689.7 7753.5 1874.7 1900.8 2180.9 2194.6 2337.8 954.5 969.9 976.4 1007.9 1009.4 18950.4 19944.4 20127.7 20152.0 20457.9 961.5 1009.4 1027.3 1035.2 1041.6 8498.7 8756.5 9897.9 10026.6 10397.8 499535.0 500207.5 506957.5 510191.0 517150.0 101477.5 119531.0 122787.0 123813.1 125219.4 1164.9 1175.5 1206.2 1210.2 1212.8 16800.6 17045.7 17274.0 20903.7 22498.6 41516.6 58519.0 59046.0 60409.0 60599.7 76880.3 77255.6 77631.9 78055.6 79236.0 8581.7 8635.9 8752.8 8954.9 8982.4 13795.5 13819.4 13893.4 14169.6 14180.8 11168.7 11833.3 11904.0 11910.9 12009.7 10807.2 10864.2 10875.6 11208.0 11210.0 11836.9 11847.8 12079.8 12110.5 12160.0 8459.5 8611.4 8721.3 8737.3 8779.7 11552.2 11689.3 11795.8 11884.4 11915.2 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:7097.07 Median:4152.50 stddev:4511.66 (108.6%) stddev-sans-first:4503.89 17:53:59 INFO - PID 1637 | Values: 1382.9 1425.5 1444.9 1446.2 1456.2 9555.6 9945.0 12071.8 12097.3 12097.4 11581.5 11717.1 11836.2 11841.1 11842.9 2527.3 2557.8 2571.7 2574.7 2576.2 2481.1 2523.8 2534.4 2537.0 2537.6 2497.5 2517.1 2547.6 2547.7 2559.1 2468.9 2469.5 2509.1 2509.2 2517.6 2398.9 2485.0 2493.5 2496.0 2501.1 11631.7 11708.7 11731.4 11772.5 11792.2 5514.3 5647.8 6551.8 6821.7 6827.7 3816.4 3966.2 4097.9 4270.8 4351.5 1125.9 1231.7 1243.3 1291.7 1295.3 16056.5 16415.8 16567.2 16594.1 16654.4 5407.4 5552.7 5567.2 5696.0 5702.8 11551.3 11644.7 11738.3 11742.9 11743.9 5468.3 6392.5 6456.8 6481.8 6491.3 5969.6 6086.1 6141.9 6204.3 6257.3 3991.3 4035.3 4207.1 4321.9 4340.3 1109.9 1244.2 1274.5 1285.7 1290.7 752.3 807.1 819.0 827.6 856.5 5129.7 6009.8 6104.3 6430.0 7315.0 806.7 904.3 956.7 961.4 970.4 4373.6 4393.6 4422.6 4444.0 4540.8 14942.5 15276.5 15285.1 15401.3 15419.5 14951.0 15035.5 15227.7 15423.4 15444.8 8363.6 8565.8 8636.9 8755.8 8845.4 6980.2 7049.8 7090.5 7219.9 7234.3 11282.8 13034.3 13147.5 13671.3 13804.4 13825.7 13990.5 14013.2 14041.4 14421.5 9301.0 9576.0 9578.3 9595.2 9622.3 8191.9 9033.7 10495.0 10512.7 10856.1 9139.9 9234.0 9235.8 9259.6 9328.8 8837.2 8942.5 9064.1 9085.4 9127.2 7023.6 8237.1 8270.8 8368.7 8391.1 6028.9 6105.1 6163.6 6186.5 6216.3 6117.3 6172.3 6281.6 6304.5 6324.3 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5321.24 Median:6033.43 stddev:1725.24 (28.6%) stddev-sans-first:1690.33 17:53:59 INFO - PID 1637 | Values: 415.5 415.9 422.5 424.1 429.1 6106.7 6161.9 6349.2 6371.4 6376.8 5586.6 5901.5 6171.0 6199.4 6234.0 3799.8 4097.7 4372.3 4428.8 4482.6 4459.5 4474.5 4483.9 4505.9 4512.1 4230.8 4452.6 4458.3 4458.7 4465.4 4262.1 4382.6 4417.5 4433.6 4451.2 3225.0 3341.3 3735.3 3785.7 3794.2 4987.7 6010.0 6030.8 6032.1 6034.7 4675.0 5211.3 5305.9 5317.1 5327.4 6206.2 6250.4 6582.4 6609.0 6709.8 3934.4 4012.3 4320.9 4329.5 4332.6 5659.2 6427.4 6992.4 7014.3 7178.5 4235.5 4349.4 4352.2 4355.8 4396.8 3746.8 4417.0 4465.1 4472.4 4474.8 5172.4 5182.9 5261.1 5281.7 5325.3 5668.3 5705.7 5957.5 6478.3 6565.0 1401.5 1499.8 1528.3 1532.7 1537.3 960.0 980.7 987.8 996.2 997.6 5895.6 6343.9 6376.8 6385.2 6404.6 6026.8 6285.0 6542.3 6903.4 6933.8 5379.8 6436.5 6475.3 6480.6 6490.4 3199.2 3482.7 3564.8 3593.2 3642.2 7097.4 7133.9 7168.1 7186.5 7207.8 6210.9 6809.2 7107.5 7119.3 7132.9 5955.8 6269.9 7169.7 7176.1 7187.9 6659.6 6722.9 6897.8 7002.5 7005.9 5476.8 6692.8 6738.6 6861.6 6869.7 7248.4 7279.4 7299.2 7336.5 7438.4 4053.3 4398.5 4403.6 4420.2 4434.3 5795.8 6331.3 6576.5 6946.1 7061.1 5569.0 6738.5 6753.0 6764.2 6766.9 6492.9 6685.1 6701.8 6749.8 6761.6 5483.3 6577.6 6595.6 6596.8 6609.3 6186.2 6235.7 6475.9 6525.9 6728.2 5479.8 5732.7 5808.1 6595.5 6628.9 17:53:59 INFO - PID 1637 | 17:53:59 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:22375.37 Median:18082.59 stddev:31620.66 (174.9%) stddev-sans-first:31667.85 17:53:59 INFO - PID 1637 | Values: 796.4 833.9 841.4 868.9 873.2 16393.0 16908.0 17104.2 18137.5 19296.4 17668.1 18097.0 18169.6 18346.3 18437.4 1005.9 1017.6 1031.1 1043.3 1045.6 998.1 1026.8 1041.6 1046.3 1047.5 1069.1 1108.4 1120.8 1122.8 1123.2 1096.4 1113.9 1114.3 1116.7 1120.8 811.9 823.0 830.9 832.8 834.9 16947.7 16950.6 17008.6 17453.4 17622.4 16962.4 17087.1 17315.2 17399.0 17484.2 12223.9 13550.1 13583.7 13862.0 14100.3 3462.7 3486.5 3489.9 3492.0 3497.0 76566.3 112259.0 118078.2 125837.0 128231.7 12143.0 12225.8 12349.3 12400.9 12452.8 23291.0 23954.4 24292.8 24305.0 24316.3 7844.4 8080.3 8081.9 8089.8 8131.0 3826.4 3939.4 3958.6 4034.9 4051.9 4262.4 4343.5 4350.4 4354.2 4360.2 936.8 937.8 941.7 950.3 958.5 646.1 660.3 666.6 668.0 689.6 10680.4 11551.1 11782.5 12157.1 12204.3 609.6 615.3 620.0 624.2 626.4 5511.5 5681.1 5692.3 5735.8 5766.3 114908.0 117119.0 117244.0 117398.0 120791.0 99701.5 100720.5 101939.0 103572.4 105181.0 76026.0 83995.0 86149.6 89674.6 89765.0 9237.5 10245.7 10602.2 11393.8 11706.3 38609.6 43880.6 43993.3 44203.8 44453.1 47314.8 53663.7 57099.4 57830.7 58472.0 15792.5 17887.3 17961.2 17964.9 18080.2 17773.5 18085.0 18815.5 19104.1 19202.5 17554.8 17718.8 17889.1 18346.5 18387.4 17589.8 17665.6 18306.7 18308.1 18674.4 16659.5 16925.7 17070.4 17173.2 17258.5 11883.5 11973.6 12204.6 12210.2 12573.2 11559.3 12199.1 13850.5 14191.0 14215.7 17:53:59 INFO - PID 1637 | -------- Summary: end -------- 17:53:59 INFO - PID 1637 | 17:54:00 INFO - TEST-INFO | 1637: exit 0 17:54:00 INFO - TEST-OK | dromaeo_css | took 1115133ms 17:54:00 INFO - TEST-START | kraken 17:54:00 INFO - operating with platform_type : mac_ 17:54:00 INFO - Initialising browser for kraken test... 17:54:00 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmppeVfZa/profile http://localhost:49228/getInfo.html) 17:54:02 INFO - PID 1650 | 2017-04-28 17:54:02.736 plugin-container[1651:10238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:54:02 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:02 INFO - PID 1650 | 2017-04-28 17:54:02.739 plugin-container[1651:10238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 17:54:02 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:02 INFO - PID 1650 | 2017-04-28 17:54:02.739 plugin-container[1651:10238] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:54:02 INFO - PID 1650 | __metrics Screen width/height:1600/1200 17:54:02 INFO - PID 1650 | colorDepth:24 17:54:02 INFO - PID 1650 | Browser inner width/height: 1024/689 17:54:02 INFO - PID 1650 | __metrics 17:54:03 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:54:03 INFO - TEST-INFO | 1650: exit 0 17:54:03 INFO - Browser initialized. 17:54:03 INFO - Running cycle 1/1 for kraken test... 17:54:03 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmppeVfZa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:05 INFO - PID 1652 | 2017-04-28 17:54:05.925 plugin-container[1653:10359] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933b, name = 'com.apple.tsm.portname' 17:54:05 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:05 INFO - PID 1652 | 2017-04-28 17:54:05.925 plugin-container[1653:10359] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9527, name = 'com.apple.CFPasteboardClient' 17:54:05 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:54:05 INFO - PID 1652 | 2017-04-28 17:54:05.925 plugin-container[1653:10359] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:54:16 INFO - PID 1652 | RSS: Main: 251523072 17:54:16 INFO - PID 1652 | 17:54:19 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:20 INFO - PID 1652 | RSS: Main: 259178496 17:54:20 INFO - PID 1652 | 17:54:22 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-dft) 17:54:23 INFO - PID 1652 | RSS: Main: 266174464 17:54:23 INFO - PID 1652 | 17:54:26 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-fft) 17:54:27 INFO - PID 1652 | RSS: Main: 262508544 17:54:27 INFO - PID 1652 | 17:54:29 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator) 17:54:30 INFO - PID 1652 | RSS: Main: 264364032 17:54:30 INFO - PID 1652 | 17:54:32 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:32 INFO - PID 1652 | RSS: Main: 264855552 17:54:32 INFO - PID 1652 | 17:54:35 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:36 INFO - PID 1652 | RSS: Main: 269864960 17:54:36 INFO - PID 1652 | 17:54:39 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:39 INFO - PID 1652 | RSS: Main: 270999552 17:54:39 INFO - PID 1652 | 17:54:42 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial) 17:54:43 INFO - PID 1652 | RSS: Main: 270884864 17:54:43 INFO - PID 1652 | 17:54:44 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:45 INFO - PID 1652 | RSS: Main: 270663680 17:54:45 INFO - PID 1652 | 17:54:47 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:48 INFO - PID 1652 | RSS: Main: 270716928 17:54:48 INFO - PID 1652 | 17:54:50 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:50 INFO - PID 1652 | RSS: Main: 270356480 17:54:50 INFO - PID 1652 | 17:54:53 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:54 INFO - PID 1652 | RSS: Main: 270860288 17:54:54 INFO - PID 1652 | 17:54:57 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:58 INFO - PID 1652 | RSS: Main: 270737408 17:54:58 INFO - PID 1652 | 17:54:59 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49228/tests/kraken/driver.html?testName=ai-astar) 17:55:00 INFO - PID 1652 | RSS: Main: 272424960 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | __start_tp_report 17:55:00 INFO - PID 1652 | _x_x_mozilla_page_load 17:55:00 INFO - PID 1652 | _x_x_mozilla_page_load_details 17:55:00 INFO - PID 1652 | |i|pagename|runs| 17:55:00 INFO - PID 1652 | |0;ai-astar;103;119;162;169;145;116;115;170;168;127 17:55:00 INFO - PID 1652 | |1;audio-beat-detection;150;112;113;158;108;114;111;110;143;108 17:55:00 INFO - PID 1652 | |2;audio-dft;198;197;206;243;273;278;190;246;283;213 17:55:00 INFO - PID 1652 | |3;audio-fft;81;55;79;109;52;64;87;88;89;86 17:55:00 INFO - PID 1652 | |4;audio-oscillator;86;70;82;71;70;72;81;71;69;89 17:55:00 INFO - PID 1652 | |5;imaging-gaussian-blur;95;89;87;87;89;101;88;89;88;88 17:55:00 INFO - PID 1652 | |6;imaging-darkroom;96;96;127;152;95;119;151;136;96;96 17:55:00 INFO - PID 1652 | |7;imaging-desaturate;89;94;92;91;100;94;92;95;93;90 17:55:00 INFO - PID 1652 | |8;json-parse-financial;51;50;48;49;52;51;52;53;62;57 17:55:00 INFO - PID 1652 | |9;json-stringify-tinderbox;69;67;58;69;63;58;60;58;61;56 17:55:00 INFO - PID 1652 | |10;stanford-crypto-aes;82;84;84;83;84;82;83;83;84;84 17:55:00 INFO - PID 1652 | |11;stanford-crypto-ccm;153;162;135;153;159;141;136;142;186;137 17:55:00 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;190;197;186;184;186;189;187;188;186;199 17:55:00 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;69;70;64;70;69;69;70;70;69;67 17:55:00 INFO - PID 1652 | __end_tp_report 17:55:00 INFO - PID 1652 | __start_cc_report 17:55:00 INFO - PID 1652 | _x_x_mozilla_cycle_collect,1000 17:55:00 INFO - PID 1652 | __end_cc_report 17:55:00 INFO - PID 1652 | __startTimestamp1493427300058__endTimestamp 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | ------- Summary: start ------- 17:55:00 INFO - PID 1652 | Number of tests: 14 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:139.40 Median:153.50 stddev:26.27 (17.1%) stddev-sans-first:24.34 17:55:00 INFO - PID 1652 | Values: 103.0 119.0 162.0 169.0 145.0 116.0 115.0 170.0 168.0 127.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:113.50 stddev:19.49 (17.2%) stddev-sans-first:17.99 17:55:00 INFO - PID 1652 | Values: 150.0 112.0 113.0 158.0 108.0 114.0 111.0 110.0 143.0 108.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:232.70 Median:244.50 stddev:36.35 (14.9%) stddev-sans-first:36.32 17:55:00 INFO - PID 1652 | Values: 198.0 197.0 206.0 243.0 273.0 278.0 190.0 246.0 283.0 213.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:79.00 Median:83.50 stddev:17.41 (20.9%) stddev-sans-first:18.45 17:55:00 INFO - PID 1652 | Values: 81.0 55.0 79.0 109.0 52.0 64.0 87.0 88.0 89.0 86.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:76.50 stddev:7.58 (9.9%) stddev-sans-first:7.14 17:55:00 INFO - PID 1652 | Values: 86.0 70.0 82.0 71.0 70.0 72.0 81.0 71.0 69.0 89.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:88.50 stddev:4.46 (5.0%) stddev-sans-first:4.36 17:55:00 INFO - PID 1652 | Values: 95.0 89.0 87.0 87.0 89.0 101.0 88.0 89.0 88.0 88.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:116.40 Median:95.50 stddev:23.78 (24.9%) stddev-sans-first:24.05 17:55:00 INFO - PID 1652 | Values: 96.0 96.0 127.0 152.0 95.0 119.0 151.0 136.0 96.0 96.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:93.00 Median:92.50 stddev:3.09 (3.3%) stddev-sans-first:2.92 17:55:00 INFO - PID 1652 | Values: 89.0 94.0 92.0 91.0 100.0 94.0 92.0 95.0 93.0 90.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:4.14 (8.0%) stddev-sans-first:4.36 17:55:00 INFO - PID 1652 | Values: 51.0 50.0 48.0 49.0 52.0 51.0 52.0 53.0 62.0 57.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:4.86 (7.8%) stddev-sans-first:4.43 17:55:00 INFO - PID 1652 | Values: 69.0 67.0 58.0 69.0 63.0 58.0 60.0 58.0 61.0 56.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 17:55:00 INFO - PID 1652 | Values: 82.0 84.0 84.0 83.0 84.0 82.0 83.0 83.0 84.0 84.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:153.00 stddev:15.89 (10.4%) stddev-sans-first:16.83 17:55:00 INFO - PID 1652 | Values: 153.0 162.0 135.0 153.0 159.0 141.0 136.0 142.0 186.0 137.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:188.50 stddev:4.96 (2.6%) stddev-sans-first:5.25 17:55:00 INFO - PID 1652 | Values: 190.0 197.0 186.0 184.0 186.0 189.0 187.0 188.0 186.0 199.0 17:55:00 INFO - PID 1652 | 17:55:00 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.89 (2.7%) stddev-sans-first:2.00 17:55:00 INFO - PID 1652 | Values: 69.0 70.0 64.0 70.0 69.0 69.0 70.0 70.0 69.0 67.0 17:55:00 INFO - PID 1652 | -------- Summary: end -------- 17:55:00 INFO - PID 1652 | 17:55:01 INFO - TEST-INFO | 1652: exit 0 17:55:01 INFO - TEST-OK | kraken | took 60691ms 17:55:01 INFO - SUITE-END | took 1175s 17:55:01 INFO - Completed test suite (00:19:35) 17:55:01 INFO - javascript benchmark 17:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7889.248327158727, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.8123912565247, 3609.8917032489035, 3620.981895090524, 3659.1218107654154, 3683.300172967136, 6107.969460152704, 6192.287886893008, 6205.503559715224, 6242.250929888414, 6276.654783986879, 6107.097787096192, 6151.753929842801, 6164.198654174962, 6226.283977342607, 6261.373862613747, 5425.511703946644, 5448.891022179554, 5463.344398672165, 5464.453554644533, 5486.286782718261, 4993.567260044134, 5576.358718747356, 5588.245586845765, 5593.944060559404, 5615.101583746601, 5354.116570765819, 5413.53984911283, 5478.698671573062, 5493.450654934514, 5572.331320241577, 5474.644148130359, 5506.669599823983, 5510.9448905510835, 5513.558915286768, 5543.722813859291, 5387.622866399353, 5425.7287135643455, 5440.0, 5483.314585676791, 5486.61593688442, 5096.694198348111, 6041.456268935817, 6119.441623354618, 6242.906356404657, 6259.655718935457, 6512.967435162841, 6572.572782769104, 6633.4693224541925, 6646.069550262967, 6669.599824010526, 6732.158480189976, 6782.491313151533, 6784.0, 6786.966065169642, 6793.728250869959, 6263.091851681481, 6292.842678933018, 6305.68471576424, 6322.178116844781, 6341.4609758170145, 6585.308542603054, 6681.599104053772, 6882.793516194522, 6889.379955804002, 6968.581885086911, 6294.496440284766, 6331.271903731038, 6494.123293355431, 6540.247871494839, 6622.437092847162, 6669.699863506154, 6804.931950680529, 6808.8978665320055, 6811.659417029129, 6813.0, 6501.31736167705, 6684.498662600325, 6711.798646040626, 6711.832204194934, 6716.932830671729, 6514.6416947068365, 6533.803985880336, 6623.0, 6665.066890635315, 6683.7660681875905, 5332.253484512172, 5336.519713225751, 5343.118385466432, 5356.705381203993, 5361.490658387447, 4741.431028276629, 4748.762561871893, 4758.500357462486, 4780.450248221429, 4801.68789028712, 6136.427173609184, 6244.344343843922, 6340.9365906340345, 6357.713902874381, 6362.141110950055, 5657.434256574392, 6763.086983257197, 6796.592204467748, 6802.897956530656, 6813.761518346834, 6336.239651241881, 6366.649834259068, 6373.298937117006, 6385.074164246158, 6405.327440618761, 5725.198472213893, 5795.710214489259, 5802.187693722883, 5816.767329306865, 5923.141144534018, 6800.93199068003, 6840.452763778786, 6955.791326260221, 6984.546004509691, 7006.159260888726, 6781.42357899584, 6821.795346139624, 6824.0, 6831.863362732817, 6862.519623626498, 6984.2317345093015, 7013.579185248901, 7016.824579385556, 7041.43668506508, 7044.15470143586, 6423.775167869102, 6468.482521398371, 6589.47284217271, 6662.966685166737, 6683.331666833278, 6150.7847225346895, 6736.360045795642, 6805.89791153143, 6807.625580593115, 6815.693293801692, 5607.719614019201, 6370.77702280418, 6374.394432528902, 6537.444317233088, 6549.279579246374, 6589.110470086669, 6602.966985165043, 6608.43828274602, 6610.6694665267505, 6621.172353455818, 5306.25712400272, 6231.22109736283, 6283.088952102011, 6452.128962590178, 6456.741730330734, 6526.934730652632, 6534.346565343428, 6555.737770489318, 6596.637184954873, 6614.305497922649, 6392.776252831129, 6396.6481843497195, 6410.935890641033, 6426.742930282923, 6457.483401327976], "value": 6114.265176247077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.1471262530656, 837.8324335132972, 1162.5233654201775, 1236.9876301236995, 1246.4515613130227, 37788.43317350242, 38227.61772382279, 38291.85124446264, 38346.23307533851, 38413.03967400816, 37710.0572485688, 38024.23951520968, 38079.0, 38082.238355232876, 38110.0, 6842.863142737142, 7875.133735289128, 8029.0, 8195.221453961864, 8366.37252206087, 8493.787655308604, 8516.361272904525, 8613.612387442548, 8621.95689021554, 8626.870596941051, 8527.530985795778, 8556.48661080334, 8598.011228708716, 8635.69775057873, 8647.783805404852, 7299.452541059389, 7630.694772209105, 8156.124091458968, 8451.957740211259, 8577.699780507652, 8356.997160340798, 8358.498490090553, 8417.0, 8430.53632050237, 8431.494110353337, 29317.56023659647, 36736.63263367359, 36794.816025919965, 36830.263394732225, 36895.4465683015, 3568.7858728476376, 3606.7114630829733, 3611.3138503684218, 3613.837377318027, 3619.348517266891, 29283.707162928313, 29716.257093572618, 29738.553921691193, 29764.10707678773, 29784.40431191386, 3064.7548196144253, 3114.7508199343997, 3130.780845340827, 3139.5133754268127, 3156.3687262547583, 293909.0, 295064.0, 296740.0, 296787.0, 297164.0, 45030.549694503294, 47425.0, 47520.7623961878, 48124.0, 48329.75835120802, 41185.79407102945, 49770.75573110701, 49786.75106624516, 49851.25223121656, 49945.25082123771, 14102.083364581269, 14219.36012879423, 14220.0, 14225.0, 14247.287635618384, 11338.829917551244, 11395.316281023164, 11436.885631143748, 11462.713432164262, 11479.19645624815, 13008.349582521025, 13038.674033149247, 13094.803577946339, 13148.934255328662, 13232.073754837069, 5767.798127065533, 5840.970795145997, 5865.882682346414, 5870.647761134345, 5878.382769809108, 1023.7696518283476, 1026.2559644257854, 1027.3733022856052, 1055.9208059395576, 1062.8724553053682, 21013.474663133544, 29921.850390747906, 29966.85016574903, 30066.69933300683, 30495.237619059702, 1100.5652767156928, 1103.7130346110068, 1140.0, 1143.4568579924469, 1151.401271338899, 11951.641450756491, 12130.968867646348, 12179.817302740466, 12198.268103913793, 12225.694357640952, 315116.0, 317338.0, 317741.0, 318723.0, 319353.0, 50620.0, 50684.239736403986, 50820.74589627102, 50830.74584627053, 50920.23619645708, 1454.2292584930003, 1488.709701608176, 1530.1431198528637, 1530.2731202678638, 1548.914809685478, 18606.81393186105, 21163.0, 23163.0, 23556.0, 23908.40228994289, 37056.0, 49267.0, 50144.24783628321, 50282.748586256836, 50350.0, 295823.0, 296666.0, 296679.0, 297437.0, 297984.0, 34500.137496562784, 34809.47785783266, 34881.825590871886, 34906.9527914163, 35125.64874351326, 43047.56952430436, 43185.136297274505, 44297.0, 45250.77374613106, 45265.773671131436, 26228.344291392867, 30672.539911900894, 30762.0, 31222.494374415146, 31350.0, 30532.542011869395, 31062.378752425277, 31082.53376199404, 31140.844295778377, 31277.68722312748, 37138.0, 37482.812585936896, 37501.0, 37503.81248093742, 37629.0, 29507.704922950496, 30902.0, 30946.0716178515, 31913.68086319107, 32179.678203217667, 21109.788902110784, 22365.888170559043, 23593.88203058974, 24234.394140146636, 24613.87693061523], "value": 17608.939746974564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.42001058338406, 432.61713383655456, 432.71873282366437, 448.76365612736913, 460.084431980359, 17913.7312940306, 18357.541061473436, 20762.6885596716, 21546.676799848014, 21617.135314587416, 21718.782812171874, 22031.33905982819, 22149.335519934386, 22244.110235590597, 22265.66601500975, 5221.765020574065, 5597.216389705444, 5742.454466825655, 6006.309274433453, 6022.187004754368, 5867.941320586782, 5899.823005309848, 6016.879662406749, 6135.8772824543485, 6180.0, 6119.326874043852, 6122.204113465244, 6127.142200091991, 6140.140380346755, 6158.507319414436, 5937.7624895004365, 6071.544634152434, 6078.787242446538, 6086.847828804271, 6094.0, 5002.549770520634, 5061.468545802674, 5318.760655770499, 5367.087595108841, 5389.973050134763, 25269.494610107697, 25367.0, 25862.482750344887, 26025.0, 26101.477970440486, 2158.7733288004847, 2221.3224966385246, 2243.618584840565, 2256.954860902773, 2262.9434264143365, 16973.3210671573, 17217.397391091377, 17379.13104344778, 17554.85893416924, 17586.472405827844, 1874.6157037807218, 2067.648499755045, 2129.1376992318137, 2150.182930486421, 2165.1664109317867, 146594.26702866418, 151851.0, 152903.0, 153645.23177384154, 157606.0, 11752.94123529394, 12177.573784917486, 12216.205946613441, 12231.449584768707, 12276.079294052981, 15747.921260393625, 15788.289526971084, 15801.288941997638, 15807.683846323009, 15821.446249381217, 8582.055973842873, 8698.304135669132, 8753.606087726068, 8828.293736501064, 8891.155340242667, 8151.307138893142, 8296.83406331882, 8358.749237522885, 8437.789055273544, 8451.323894088458, 6410.967945160244, 7540.622968851536, 7588.436002857488, 7689.730859419893, 7753.496022758615, 1874.7375367448567, 1900.7814101378242, 2180.945476363104, 2194.6049711052165, 2337.812974961999, 954.4845783277092, 969.8739163908647, 976.4239098931664, 1007.8538611901233, 1009.4094954451581, 18950.43148705541, 19944.401667949984, 20127.69170003945, 20152.0, 20457.874816884916, 961.5240455974198, 1009.3641006166068, 1027.2536687631057, 1035.1822060572215, 1041.6458404142627, 8498.74503764888, 8756.518391488402, 9897.901020989842, 10026.598936042623, 10397.792044159074, 499535.0, 500207.49896250287, 506957.46521267155, 510191.0, 517150.0, 101477.49261253646, 119531.0, 122787.0, 123813.14280285803, 125219.37390313172, 1164.9068074554016, 1175.5474142455216, 1206.1797977375293, 1210.1831263896834, 1212.7877621416394, 16800.57998550046, 17045.744313835054, 17274.0, 20903.686444703646, 22498.550028999656, 41516.58483415248, 58519.0, 59046.0, 60409.0, 60599.69700151471, 76880.30918917811, 77255.61372193103, 77631.8947242104, 78055.60972195103, 79236.0, 8581.742547723577, 8635.87046194295, 8752.781180470285, 8954.865677014981, 8982.416142950688, 13795.517156899461, 13819.378127984064, 13893.374798133906, 14169.574912752634, 14180.787288190479, 11168.72078198019, 11833.349165795964, 11904.0, 11910.940445297718, 12009.699757506132, 10807.189460790314, 10864.185186111232, 10875.564977400816, 11208.0, 11209.991100800968, 11836.940815295868, 11847.76304473923, 12079.818802717791, 12110.45502952387, 12159.966402855502, 8459.492430454193, 8611.354148438766, 8721.345899057469, 8737.326637376, 8779.736607901774, 11552.249103808226, 11689.298642081503, 11795.823062653895, 11884.405779711153, 11915.2255103418], "value": 10178.889471354027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.854800245974, 1425.4939496478755, 1444.884409247259, 1446.2118145610648, 1456.1699831096275, 9555.56999935003, 9945.0, 12071.75856482871, 12097.274163550193, 12097.395130243485, 11581.536738530449, 11717.121215908799, 11836.171467997243, 11841.052715782738, 11842.881571184285, 2527.254459934319, 2557.7825884799813, 2571.742825717432, 2574.6524219230446, 2576.240009197282, 2481.057198264657, 2523.823332366735, 2534.3664083979006, 2537.0486067724605, 2537.581299085658, 2497.4880149569294, 2517.0686845866962, 2547.5796493578537, 2547.6688030556, 2559.1298958354155, 2468.888899999495, 2469.469064151207, 2509.0841842727455, 2509.1970569417795, 2517.559427100259, 2398.940026499334, 2484.962725559118, 2493.5386953413677, 2495.962560561593, 2501.1496091328854, 11631.6510504685, 11708.707282317924, 11731.413429328499, 11772.529098836036, 11792.174547781658, 5514.283143191399, 5647.774089036434, 6551.80344589663, 6821.658917054127, 6827.658617069176, 3816.3512202925567, 3966.186931678999, 4097.8770636880945, 4270.829166833354, 4351.521332653406, 1125.881782412843, 1231.6797632615494, 1243.2913239453515, 1291.7416516696699, 1295.2681734819796, 16056.518304450885, 16415.83584164155, 16567.17164141788, 16594.08732519711, 16654.417095401604, 5407.432219616962, 5552.7223638817895, 5567.220589117527, 5695.971520142372, 5702.771889124471, 11551.306921584732, 11644.6506604802, 11738.295702257721, 11742.941285293518, 11743.941280293715, 5468.28912241406, 6392.520560957947, 6456.806295811133, 6481.837954051187, 6491.253505846888, 5969.641821490638, 6086.117512960596, 6141.92516309644, 6204.317525072239, 6257.311695713468, 3991.261616600938, 4035.2736507428945, 4207.116505533811, 4321.870343889688, 4340.327249276367, 1109.89565382445, 1244.2099266965542, 1274.5029438518984, 1285.6785803549112, 1290.6966862787237, 752.2928447259559, 807.1113594189625, 818.9631466584018, 827.5986146718836, 856.5160684213399, 5129.717865517432, 6009.828083523671, 6104.328523862371, 6430.035494675836, 7315.049043624401, 806.6531391501593, 904.2675432899373, 956.6941125363828, 961.3654987708079, 970.3886551472668, 4373.6282415994365, 4393.626541743987, 4422.624076953431, 4444.0, 4540.79566419512, 14942.477013304482, 15276.465323713617, 15285.082895026111, 15401.306941187673, 15419.460318888785, 14951.0, 15035.473758418622, 15227.695446091016, 15423.383064677288, 15444.845551544566, 8363.58182090893, 8565.78585535354, 8636.913630863737, 8755.781105472286, 8845.380823342433, 6980.197277313174, 7049.7885063448175, 7090.4682148840075, 7219.855602887807, 7234.312740289664, 11282.830757538808, 13034.348282585643, 13147.474101035852, 13671.31643417845, 13804.447822087004, 13825.723485530434, 13990.510332138327, 14013.229272390117, 14041.36813843359, 14421.495247666282, 9301.046780176239, 9576.042395760369, 9578.281628878001, 9595.23238140933, 9622.278329125484, 8191.877121843297, 9033.728988130366, 10495.0, 10512.684619461428, 10856.077233435246, 9139.862902056342, 9234.0, 9235.753173321784, 9259.583318750538, 9328.766780830534, 8837.248833849195, 8942.46345219289, 9064.093590640883, 9085.409448385833, 9127.22418594427, 7023.648817559204, 8237.135100814328, 8270.751877443687, 8368.707095251637, 8391.118932511998, 6028.8794224116145, 6105.114758360101, 6163.630182189083, 6186.505079593531, 6216.285127210248, 6117.265928088658, 6172.259328880563, 6281.623102613858, 6304.464120549805, 6324.272708638566], "value": 5374.319682995194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.54705371145457, 415.8771317442904, 422.46769070970566, 424.10302210824096, 429.1288683971539, 6106.664133472657, 6161.907571386427, 6349.174607301056, 6371.426571608555, 6376.80869573913, 5586.55307575394, 5901.527877769779, 6171.0, 6199.380061993798, 6234.0, 3799.7530160539613, 4097.651699605537, 4372.256716358211, 4428.759947214785, 4482.551744825508, 4459.531749166324, 4474.530174331697, 4483.887902802439, 4505.8648240552675, 4512.1426928883575, 4230.809613567381, 4452.621527170194, 4458.2866741321395, 4458.687891847572, 4465.397171381855, 4262.126264115849, 4382.6055654991205, 4417.514073451917, 4433.623142032899, 4451.1542806866755, 3225.032730034677, 3341.3484370547753, 3735.34631439497, 3785.6592906638534, 3794.165283637623, 4987.700737955698, 6010.025037606413, 6030.758769649209, 6032.125341825411, 6034.728437220292, 4674.953250467486, 5211.348581427322, 5305.938812237568, 5317.096093664048, 5327.413984461706, 6206.162168107293, 6250.4374606285655, 6582.44049255809, 6609.041688955074, 6709.798706038827, 3934.380370059552, 4012.29784787661, 4320.861173718998, 4329.5237523872665, 4332.610065094125, 5659.236003139565, 6427.389398007182, 6992.370686638176, 7014.333638304353, 7178.451649664398, 4235.4917409911, 4349.434573505424, 4352.1513304905875, 4355.823927539546, 4396.780160991938, 3746.83139258734, 4416.977915110404, 4465.106978604292, 4472.351509031172, 4474.821007159742, 5172.431032586413, 5182.896342073137, 5261.131913234273, 5281.656692315064, 5325.334333208349, 5668.343918172755, 5705.686187259657, 5957.493613042853, 6478.2873883872735, 6565.0, 1401.5444980381417, 1499.7525408307724, 1528.2740698168504, 1532.716447457224, 1537.3389442539815, 959.9808003839884, 980.7401038724744, 987.7728122531857, 996.2378780233128, 997.6109317366233, 5895.587308888336, 6343.921533339343, 6376.808695739135, 6385.201849768779, 6404.615723056631, 6026.819195424145, 6285.0, 6542.34576542342, 6903.378695917391, 6933.757318493828, 5379.838604841861, 6436.517261205428, 6475.3200913903365, 6480.57876238043, 6490.383413575702, 3199.2481766784786, 3482.7387945904156, 3564.803935783557, 3593.161402492054, 3642.1805093853673, 7097.432205423554, 7133.928660713326, 7168.139823221142, 7186.461015423864, 7207.783766487014, 6210.9068363974575, 6809.182898052265, 7107.466939979522, 7119.291370071249, 7132.857342853217, 5955.79154729591, 6269.896401281304, 7169.694426124526, 7176.102987126609, 7187.856242875113, 6659.567128136656, 6722.899156512754, 6897.827554311182, 7002.474814389043, 7005.949107633692, 5476.849861529124, 6692.832679182865, 6738.629375384205, 6861.622610756456, 6869.656517174021, 7248.383887369632, 7279.381252593377, 7299.197088320387, 7336.523125996793, 7438.437928034957, 4053.331200352027, 4398.450193725785, 4403.647708183402, 4420.182266280748, 4434.312681534368, 5795.7971471, 6331.335209803088, 6576.506761992774, 6946.131733533309, 7061.1173603299585, 5568.972155139199, 6738.494612903954, 6752.966235168793, 6764.222114456704, 6766.86466270662, 6492.935070649233, 6685.130932978682, 6701.832454188684, 6749.763758268437, 6761.594304341756, 5483.341998960151, 6577.6053436792035, 6595.637239951849, 6596.8350791230605, 6609.3060228675295, 6186.19579454668, 6235.719392627252, 6475.935240647534, 6525.902111468236, 6728.180124192636, 5479.808206712746, 5732.742026608729, 5808.1123634818005, 6595.472362210916, 6628.933710663025], "value": 4785.662659400887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.4305521552089, 833.8874251975982, 841.381584535366, 868.9087645797191, 873.2053831013777, 16393.0, 16907.985520868755, 17104.23030963608, 18137.546561335974, 19296.4211073668, 17668.11659417027, 18097.0, 18169.636607267847, 18346.266149354044, 18437.446876593724, 1005.8943810899841, 1017.6031347774374, 1031.1029404418166, 1043.3270540501371, 1045.6131231444376, 998.0568362897066, 1026.7535791410046, 1041.5677493840046, 1046.2676126711294, 1047.455323231919, 1069.1393428290223, 1108.4346983038668, 1120.7590368070862, 1122.831575263713, 1123.1576317761678, 1096.3915027159924, 1113.9053180479668, 1114.2701530497536, 1116.743149075713, 1120.7590368070823, 811.8822770698275, 823.016495288131, 830.8546004449197, 832.7793134819278, 834.9165083491603, 16947.745783813254, 16950.57623559421, 17008.57478563046, 17453.389131380467, 17622.383216587485, 16962.406315778888, 17087.060211688353, 17315.220815063225, 17399.0, 17484.213210405564, 12223.899849013631, 13550.051496395256, 13583.660408489768, 13862.0, 14100.294985250799, 3462.671046250602, 3486.5467489226494, 3489.8604055837736, 3492.0, 3496.9825150874085, 76566.32017879348, 112259.0, 118078.22882656768, 125837.0, 128231.71768282291, 12143.02855771536, 12225.755484890253, 12349.259044457362, 12400.937995310147, 12452.81320780189, 23291.0, 23954.40113997129, 24292.785360731894, 24305.0, 24316.27051188467, 7844.37245020397, 8080.313173380328, 8081.919180808234, 8089.757307280791, 8131.024277086787, 3826.368649172911, 3939.4484772131923, 3958.5843486434087, 4034.9394759078637, 4051.9392209116886, 4262.403263543107, 4343.500497442835, 4350.412694286231, 4354.194474022316, 4360.193364227628, 936.7751739582587, 937.8077494113691, 941.651588912107, 950.2635457520339, 958.4872093429982, 646.0696596900449, 660.313274194832, 666.5534092158266, 667.9732810687615, 689.5793565924782, 10680.412577308167, 11551.133664975161, 11782.469788859522, 12157.148999570121, 12204.267743935392, 609.6464050850585, 615.3047056825758, 619.9876002479925, 624.2321944008804, 626.3579830673596, 5511.5039646432015, 5681.091025435993, 5692.316921969307, 5735.799247026417, 5766.336871259775, 114908.0, 117119.0, 117244.0, 117398.0, 120791.0, 99701.5044774329, 100720.49639751755, 101939.0, 103572.44641330386, 105181.0, 76026.0, 83995.0, 86149.56925215459, 89674.55162724275, 89764.99999999869, 9237.538123093953, 10245.692629221136, 10602.20483463728, 11393.829092563452, 11706.297622142698, 38609.613903861726, 43880.56119438892, 43993.340099899164, 44203.778981104886, 44453.11093778042, 47314.763426182646, 53663.6584085401, 57099.42900570941, 57830.7108464455, 58472.0, 15792.526224213292, 17887.28450861951, 17961.191746371183, 17964.91017544956, 18080.18639161267, 17773.46679599614, 18085.0, 18815.529611759815, 19104.140313686195, 19202.519937001685, 17554.824451755318, 17718.82281177172, 17889.10554472245, 18346.51416230912, 18387.356442524448, 17589.824101759332, 17665.646687065928, 18306.725399118757, 18308.084595770426, 18674.439766806474, 16659.500214993568, 16925.74611380855, 17070.402535911184, 17173.227204775565, 17258.482245532654, 11883.465244064211, 11973.580924667594, 12204.633860984184, 12210.206336588093, 12573.182743121668, 11559.30644161353, 12199.085068620067, 13850.515231966832, 14191.0, 14215.715685686435], "value": 8553.422276018258, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 119.0, 162.0, 169.0, 145.0, 116.0, 115.0, 170.0, 168.0, 127.0], "value": 139.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 112.0, 113.0, 158.0, 108.0, 114.0, 111.0, 110.0, 143.0, 108.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 206.0, 243.0, 273.0, 278.0, 190.0, 246.0, 283.0, 213.0], "value": 232.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 55.0, 79.0, 109.0, 52.0, 64.0, 87.0, 88.0, 89.0, 86.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 82.0, 71.0, 70.0, 72.0, 81.0, 71.0, 69.0, 89.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 89.0, 87.0, 87.0, 89.0, 101.0, 88.0, 89.0, 88.0, 88.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 127.0, 152.0, 95.0, 119.0, 151.0, 136.0, 96.0, 96.0], "value": 116.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 92.0, 91.0, 100.0, 94.0, 92.0, 95.0, 93.0, 90.0], "value": 93.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 48.0, 49.0, 52.0, 51.0, 52.0, 53.0, 62.0, 57.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 58.0, 69.0, 63.0, 58.0, 60.0, 58.0, 61.0, 56.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 83.0, 84.0, 82.0, 83.0, 83.0, 84.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 162.0, 135.0, 153.0, 159.0, 141.0, 136.0, 142.0, 186.0, 137.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 197.0, 186.0, 184.0, 186.0, 189.0, 187.0, 188.0, 186.0, 199.0], "value": 189.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 64.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 67.0], "value": 68.7, "unit": "score"}]}]} 17:55:01 INFO - Return code: 0 17:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:01 ERROR - # TBPL SUCCESS # 17:55:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:55:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:55:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:55:01 INFO - 2017-04-28 17:55:01.409 screenresolution[1657:10753] starting screenresolution argv=screenresolution get 17:55:01 INFO - 2017-04-28 17:55:01.412 screenresolution[1657:10753] Display 0: 1600x1200x32@60 17:55:01 INFO - 2017-04-28 17:55:01.419 screenresolution[1658:10756] starting screenresolution argv=screenresolution list 17:55:01 INFO - Available Modes on Display 0 17:55:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:55:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:55:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:55:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:55:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:55:01 INFO - Intel Iris: 17:55:01 INFO - Chipset Model: Intel Iris 17:55:01 INFO - Type: GPU 17:55:01 INFO - Bus: Built-In 17:55:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:55:01 INFO - Vendor: Intel (0x8086) 17:55:01 INFO - Device ID: 0x0a2e 17:55:01 INFO - Revision ID: 0x0009 17:55:01 INFO - Displays: 17:55:01 INFO - Display: 17:55:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:55:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:55:01 INFO - Display Serial Number: 1600x1200 60 17:55:01 INFO - Main Display: Yes 17:55:01 INFO - Mirror: Off 17:55:01 INFO - Online: Yes 17:55:01 INFO - Rotation: Supported 17:55:01 INFO - Return code: 0 17:55:01 INFO - Running post-action listener: _resource_record_post_action 17:55:01 INFO - [mozharness: 2017-04-29 00:55:01.657890Z] Finished run-tests step (success) 17:55:01 INFO - Running post-run listener: _resource_record_post_run 17:55:01 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40876544; Write bytes: 513939456; Read time: 441; Write time: 1785 17:55:01 INFO - TinderboxPrint: CPU usage
54.3% 17:55:01 INFO - TinderboxPrint: I/O read bytes / time
40,876,544 / 441 17:55:01 INFO - TinderboxPrint: I/O write bytes / time
513,939,456 / 1,785 17:55:01 INFO - TinderboxPrint: CPU idle
2,189.2 (45.7%) 17:55:01 INFO - TinderboxPrint: CPU system
962.0 (20.1%) 17:55:01 INFO - TinderboxPrint: CPU user
1,634.4 (34.2%) 17:55:01 INFO - TinderboxPrint: Swap in / out
246,296,576 / 0 17:55:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 197562880; Write bytes: 195647488; Read time: 15004; Write time: 424 17:55:01 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 39840256; Write bytes: 301449216; Read time: 423; Write time: 1312 17:55:02 INFO - Running post-run listener: _upload_blobber_files 17:55:02 INFO - Blob upload gear active. 17:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:03 INFO - (blobuploader) - INFO - Done attempting. 17:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:05 INFO - (blobuploader) - INFO - Done attempting. 17:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:06 INFO - (blobuploader) - INFO - Done attempting. 17:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:07 INFO - (blobuploader) - INFO - Done attempting. 17:55:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:07 INFO - Return code: 0 17:55:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6493118c823c8473d19a3d87be0367c74782f82189eb74a52105e095217f9407916a9f95790151f854eec0aae3f111e0f88966204dd1386b8fecdc81da8012b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47e034a67e990cece8a669bd312280f68cda65320b9b8ede71dd2b3b5f129a654e8e06464050e1abd3490b597333f5d37314e8e69f648cf8b74dc8bc271e5a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ec4dd747a6abc744f92d180bb97cab6370664f8bd8e9dc8de493f8c730a487c512d89ea8f45332f77e2c5701685b17928b3f39ca99b1aa3583ac959c7e9d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9fed4a38ff19a14ab97f9910138d80018a93f1c53ac8390fecb9b9404bda34742eca3b308e3425c521fc260197ef7744dcfe6e6b939e25274e5fa6c016b840"} 17:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:08 INFO - Contents: 17:55:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6493118c823c8473d19a3d87be0367c74782f82189eb74a52105e095217f9407916a9f95790151f854eec0aae3f111e0f88966204dd1386b8fecdc81da8012b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47e034a67e990cece8a669bd312280f68cda65320b9b8ede71dd2b3b5f129a654e8e06464050e1abd3490b597333f5d37314e8e69f648cf8b74dc8bc271e5a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ec4dd747a6abc744f92d180bb97cab6370664f8bd8e9dc8de493f8c730a487c512d89ea8f45332f77e2c5701685b17928b3f39ca99b1aa3583ac959c7e9d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9fed4a38ff19a14ab97f9910138d80018a93f1c53ac8390fecb9b9404bda34742eca3b308e3425c521fc260197ef7744dcfe6e6b939e25274e5fa6c016b840"} 17:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:08 INFO - Copying logs to upload dir... 17:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.400213 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-28 17:55:08.059095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:08.062430) ========= 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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/6493118c823c8473d19a3d87be0367c74782f82189eb74a52105e095217f9407916a9f95790151f854eec0aae3f111e0f88966204dd1386b8fecdc81da8012b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47e034a67e990cece8a669bd312280f68cda65320b9b8ede71dd2b3b5f129a654e8e06464050e1abd3490b597333f5d37314e8e69f648cf8b74dc8bc271e5a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ec4dd747a6abc744f92d180bb97cab6370664f8bd8e9dc8de493f8c730a487c512d89ea8f45332f77e2c5701685b17928b3f39ca99b1aa3583ac959c7e9d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9fed4a38ff19a14ab97f9910138d80018a93f1c53ac8390fecb9b9404bda34742eca3b308e3425c521fc260197ef7744dcfe6e6b939e25274e5fa6c016b840"} 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.011032 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/6493118c823c8473d19a3d87be0367c74782f82189eb74a52105e095217f9407916a9f95790151f854eec0aae3f111e0f88966204dd1386b8fecdc81da8012b2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47e034a67e990cece8a669bd312280f68cda65320b9b8ede71dd2b3b5f129a654e8e06464050e1abd3490b597333f5d37314e8e69f648cf8b74dc8bc271e5a2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92ec4dd747a6abc744f92d180bb97cab6370664f8bd8e9dc8de493f8c730a487c512d89ea8f45332f77e2c5701685b17928b3f39ca99b1aa3583ac959c7e9d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9fed4a38ff19a14ab97f9910138d80018a93f1c53ac8390fecb9b9404bda34742eca3b308e3425c521fc260197ef7744dcfe6e6b939e25274e5fa6c016b840"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:08.097994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:08.098351) ========= 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.VmhJw3lXq8/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.J6CYoAbzv9/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.004969 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:55:08.147060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:55:08.147414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:55:08.147762) ========= ========= Total master_lag: 0.19 =========