builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0235 starttime: 1490307062.53 results: success (0) buildid: 20170323111525 builduid: 2dbf2738ee2041269ad90b35d4aa6174 revision: fde19b9411ee0735e5e66dc02e68c815bdbe66bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:02.526779) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:02.527202) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-03-23 15:11:02.527504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-03-23 15:11:05.865101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 15:11:05.865456) ========= 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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-03-23 15:11:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2017-03-23 15:11:06 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164715 ========= master_lag: 0.85 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 15:11:06.882407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:06.882795) ========= 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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.026420 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:06.933588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 15:11:06.933952) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev fde19b9411ee0735e5e66dc02e68c815bdbe66bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev fde19b9411ee0735e5e66dc02e68c815bdbe66bd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gKFN4bWXW3/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.8ydcfSzNVY/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-03-23 15:11:07,002 truncating revision to first 12 chars 2017-03-23 15:11:07,002 Setting DEBUG logging. 2017-03-23 15:11:07,003 attempt 1/10 2017-03-23 15:11:07,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/fde19b9411ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 15:11:08,434 unpacking tar archive at: pine-fde19b9411ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.697739 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 15:11:08.658352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:08.658721) ========= script_repo_revision: fde19b9411ee0735e5e66dc02e68c815bdbe66bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:08.659113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:08.659418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 15:11:08.679132) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-23 15:11:08.679584) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gKFN4bWXW3/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.8ydcfSzNVY/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:11:08 INFO - MultiFileLogger online at 20170323 15:11:08 in /builds/slave/test 15:11:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 15:11:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:11:08 INFO - {'append_to_log': False, 15:11:08 INFO - 'base_work_dir': '/builds/slave/test', 15:11:08 INFO - 'blob_upload_branch': 'Pine', 15:11:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:11:08 INFO - 'branch': 'Pine', 15:11:08 INFO - 'buildbot_json_path': 'buildprops.json', 15:11:08 INFO - 'config_files': ('talos/mac_config.py',), 15:11:08 INFO - 'default_actions': ('clobber', 15:11:08 INFO - 'read-buildbot-config', 15:11:08 INFO - 'download-and-extract', 15:11:08 INFO - 'populate-webroot', 15:11:08 INFO - 'create-virtualenv', 15:11:08 INFO - 'install', 15:11:08 INFO - 'run-tests'), 15:11:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:11:08 INFO - 'download_minidump_stackwalk': True, 15:11:08 INFO - 'download_symbols': 'ondemand', 15:11:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:11:08 INFO - 'tooltool.py': '/tools/tooltool.py', 15:11:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:11:08 INFO - '/tools/misc-python/virtualenv.py')}, 15:11:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:11:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:11:08 INFO - 'gecko_profile': False, 15:11:08 INFO - 'gecko_profile_interval': 0, 15:11:08 INFO - 'installer_path': 'installer.exe', 15:11:08 INFO - 'log_level': 'info', 15:11:08 INFO - 'log_name': 'talos', 15:11:08 INFO - 'log_to_console': True, 15:11:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:11:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:11:08 INFO - 'opt_config_files': (), 15:11:08 INFO - 'pip_index': False, 15:11:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:11:08 INFO - 'cmd': ('bash', 15:11:08 INFO - '-c', 15:11:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:11:08 INFO - 'enabled': True, 15:11:08 INFO - 'halt_on_failure': False, 15:11:08 INFO - 'name': 'check_screen_resolution'},), 15:11:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:11:08 INFO - 'cmd': ('bash', 15:11:08 INFO - '-c', 15:11:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:11:08 INFO - 'enabled': True, 15:11:08 INFO - 'halt_on_failure': False, 15:11:08 INFO - 'name': 'check_screen_resolution'},), 15:11:08 INFO - 'run_cmd_checks_enabled': True, 15:11:08 INFO - 'suite': 'dromaeojs-e10s', 15:11:08 INFO - 'system_bits': '32', 15:11:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:11:08 INFO - 'title': 't-yosemite-r7-0235', 15:11:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:11:08 INFO - 'use_talos_json': True, 15:11:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:11:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:11:08 INFO - 'work_dir': 'build'} 15:11:08 INFO - [mozharness: 2017-03-23 22:11:08.854494Z] Running clobber step. 15:11:08 INFO - Running pre-action listener: _resource_record_pre_action 15:11:08 INFO - Running main action method: clobber 15:11:08 INFO - rmtree: /builds/slave/test/build 15:11:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:11:11 INFO - Running post-action listener: _resource_record_post_action 15:11:11 INFO - [mozharness: 2017-03-23 22:11:11.147858Z] Finished clobber step (success) 15:11:11 INFO - [mozharness: 2017-03-23 22:11:11.147983Z] Running read-buildbot-config step. 15:11:11 INFO - Running pre-action listener: _resource_record_pre_action 15:11:11 INFO - Running main action method: read_buildbot_config 15:11:11 INFO - Using buildbot properties: 15:11:11 INFO - { 15:11:11 INFO - "project": "", 15:11:11 INFO - "product": "firefox", 15:11:11 INFO - "script_repo_revision": "default", 15:11:11 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 15:11:11 INFO - "repository": "", 15:11:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 15:11:11 INFO - "buildid": "20170323111525", 15:11:11 INFO - "pgo_build": "False", 15:11:11 INFO - "basedir": "/builds/slave/test", 15:11:11 INFO - "buildnumber": 5, 15:11:11 INFO - "slavename": "t-yosemite-r7-0235", 15:11:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:11:11 INFO - "platform": "yosemite_r7", 15:11:11 INFO - "scheduler": "tests-pine-macosx64-talos", 15:11:11 INFO - "branch": "pine", 15:11:11 INFO - "repo_path": "projects/pine", 15:11:11 INFO - "revision": "fde19b9411ee0735e5e66dc02e68c815bdbe66bd", 15:11:11 INFO - "stage_platform": "macosx64", 15:11:11 INFO - "builduid": "2dbf2738ee2041269ad90b35d4aa6174", 15:11:11 INFO - "slavebuilddir": "test" 15:11:11 INFO - } 15:11:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:11:11 INFO - Running post-action listener: _resource_record_post_action 15:11:11 INFO - [mozharness: 2017-03-23 22:11:11.151345Z] Finished read-buildbot-config step (success) 15:11:11 INFO - [mozharness: 2017-03-23 22:11:11.151478Z] Running download-and-extract step. 15:11:11 INFO - Running pre-action listener: _resource_record_pre_action 15:11:11 INFO - Running main action method: download_and_extract 15:11:11 INFO - mkdir: /builds/slave/test/build/tests 15:11:11 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')]} 15:11:11 INFO - trying https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:11:11 INFO - Downloading https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:11:12 INFO - Downloaded 1325 bytes. 15:11:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:11:12 INFO - Using the following test package requirements: 15:11:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:11:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:11:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:11:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:11:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'jsshell-mac.zip'], 15:11:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:11:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:11:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:11:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:11:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:11:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:11:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:11:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:11:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:11:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:11:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:11:13 INFO - Expected file size: 52406549 15:11:13 INFO - Obtained file size: 52406549 15:11:29 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 15:11:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:11:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:11:29 INFO - Fetch https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:11:31 INFO - Expected file size: 52406549 15:11:31 INFO - Obtained file size: 52406549 15:11:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:11:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:11:46 INFO - Fetch https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:11:47 INFO - Expected file size: 14404171 15:11:47 INFO - Obtained file size: 14404171 15:11: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')]} 15:11:47 INFO - trying https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:11:47 INFO - Downloading https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:11:49 INFO - Downloaded 75533384 bytes. 15:11:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:11:49 INFO - mkdir: /builds/slave/test/properties 15:11:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:11:49 INFO - Writing to file /builds/slave/test/properties/build_url 15:11:49 INFO - Contents: 15:11:49 INFO - build_url:https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:11:50 INFO - Running post-action listener: _resource_record_post_action 15:11:50 INFO - Running post-action listener: set_extra_try_arguments 15:11:50 INFO - [mozharness: 2017-03-23 22:11:50.690003Z] Finished download-and-extract step (success) 15:11:50 INFO - [mozharness: 2017-03-23 22:11:50.690155Z] Running populate-webroot step. 15:11:50 INFO - Running pre-action listener: _resource_record_pre_action 15:11:50 INFO - Running main action method: populate_webroot 15:11:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:11:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:11:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:11:50 INFO - '--tppagecycles', 15:11:50 INFO - '7'], 15:11:50 INFO - 'tests': ['tsvgm']}}, 15:11:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:11:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:11:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:11:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:11:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:11:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:11:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['damp', 'tps']}, 15:11:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'tests': ['damp', 'tps']}, 15:11:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['dromaeo_dom']}, 15:11:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:11:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['basic_compositor_video']}, 15:11:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:11:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['a11yr', 15:11:50 INFO - 'ts_paint', 15:11:50 INFO - 'tpaint', 15:11:50 INFO - 'sessionrestore', 15:11:50 INFO - 'sessionrestore_no_auto_restore', 15:11:50 INFO - 'tabpaint']}, 15:11:50 INFO - 'other-e10s': {'tests': ['a11yr', 15:11:50 INFO - 'ts_paint', 15:11:50 INFO - 'tpaint', 15:11:50 INFO - 'sessionrestore', 15:11:50 INFO - 'sessionrestore_no_auto_restore', 15:11:50 INFO - 'tabpaint']}, 15:11:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:11:50 INFO - 'ts_paint', 15:11:50 INFO - 'tpaint', 15:11:50 INFO - 'sessionrestore', 15:11:50 INFO - 'sessionrestore_no_auto_restore', 15:11:50 INFO - 'tabpaint']}, 15:11:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:11:50 INFO - 'ts_paint', 15:11:50 INFO - 'tpaint', 15:11:50 INFO - 'sessionrestore', 15:11:50 INFO - 'sessionrestore_no_auto_restore', 15:11:50 INFO - 'tabpaint']}, 15:11:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['a11yr', 15:11:50 INFO - 'ts_paint', 15:11:50 INFO - 'tpaint', 15:11:50 INFO - 'sessionrestore', 15:11:50 INFO - 'sessionrestore_no_auto_restore', 15:11:50 INFO - 'tabpaint']}, 15:11:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['a11yr', 15:11:50 INFO - 'ts_paint', 15:11:50 INFO - 'tpaint', 15:11:50 INFO - 'sessionrestore', 15:11:50 INFO - 'sessionrestore_no_auto_restore', 15:11:50 INFO - 'tabpaint']}, 15:11:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['tsvgx', 15:11:50 INFO - 'tsvgr_opacity', 15:11:50 INFO - 'tart', 15:11:50 INFO - 'tscrollx', 15:11:50 INFO - 'cart', 15:11:50 INFO - 'tsvg_static']}, 15:11:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:11:50 INFO - 'tsvgr_opacity', 15:11:50 INFO - 'tart', 15:11:50 INFO - 'tscrollx', 15:11:50 INFO - 'cart', 15:11:50 INFO - 'tsvg_static']}, 15:11:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'talos_options': ['--disable-e10s'], 15:11:50 INFO - 'tests': ['tp5o']}, 15:11:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:11:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'talos_options': ['--disable-e10s', 15:11:50 INFO - '--xperf_path', 15:11:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:11:50 INFO - 'tests': ['tp5n']}, 15:11:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:11:50 INFO - 'talos_options': ['--xperf_path', 15:11:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:11:50 INFO - 'tests': ['tp5n']}}, 15:11:50 INFO - 'talos.zip': {'path': '', 15:11:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:11:50 INFO - Running post-action listener: _resource_record_post_action 15:11:50 INFO - [mozharness: 2017-03-23 22:11:50.708827Z] Finished populate-webroot step (success) 15:11:50 INFO - [mozharness: 2017-03-23 22:11:50.708967Z] Running create-virtualenv step. 15:11:50 INFO - Running pre-action listener: _resource_record_pre_action 15:11:50 INFO - Running main action method: create_virtualenv 15:11:50 INFO - Creating virtualenv /builds/slave/test/build/venv 15:11:50 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 15:11:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:11:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:11:50 INFO - Using real prefix '/tools/python27' 15:11:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:11:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:11:54 INFO - Installing pip.................done. 15:11:54 INFO - Return code: 0 15:11:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:11:54 INFO - Reading from file tmpfile_stdout 15:11:54 INFO - Output received: 15:11:54 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) 15:11:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:55 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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:11:55 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 15:11:55 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 15:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:55 INFO - 'HOME': '/Users/cltbld', 15:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:55 INFO - 'LOGNAME': 'cltbld', 15:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:55 INFO - 'MOZ_NO_REMOTE': '1', 15:11:55 INFO - 'NO_EM_RESTART': '1', 15:11:55 INFO - 'PAGER': '/bin/cat', 15:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:55 INFO - 'PWD': '/builds/slave/test', 15:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:55 INFO - 'SHELL': '/bin/bash', 15:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:11:55 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:55 INFO - 'USER': 'cltbld', 15:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:55 INFO - 'XPC_FLAGS': '0x0', 15:11:55 INFO - 'XPC_SERVICE_NAME': '0', 15:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:55 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 15:11:55 INFO - Cleaning up... 15:11:55 INFO - Return code: 0 15:11:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:55 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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:11:55 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 15:11:55 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 15:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:55 INFO - 'HOME': '/Users/cltbld', 15:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:55 INFO - 'LOGNAME': 'cltbld', 15:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:55 INFO - 'MOZ_NO_REMOTE': '1', 15:11:55 INFO - 'NO_EM_RESTART': '1', 15:11:55 INFO - 'PAGER': '/bin/cat', 15:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:55 INFO - 'PWD': '/builds/slave/test', 15:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:55 INFO - 'SHELL': '/bin/bash', 15:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:11:55 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:55 INFO - 'USER': 'cltbld', 15:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:55 INFO - 'XPC_FLAGS': '0x0', 15:11:55 INFO - 'XPC_SERVICE_NAME': '0', 15:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:56 INFO - Downloading/unpacking psutil>=3.1.1 15:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:59 INFO - Installing collected packages: psutil 15:11:59 INFO - Running setup.py install for psutil 15:11:59 INFO - building 'psutil._psutil_osx' extension 15:11:59 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 15:12:00 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 15:12:00 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 15:12:00 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 15:12:00 INFO - building 'psutil._psutil_posix' extension 15:12:00 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 15:12:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:12:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:12:00 INFO - ^ 15:12:00 INFO - 1 warning generated. 15:12:00 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 15:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:00 INFO - Successfully installed psutil 15:12:00 INFO - Cleaning up... 15:12:00 INFO - Return code: 0 15:12:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:00 INFO - 'HOME': '/Users/cltbld', 15:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:00 INFO - 'LOGNAME': 'cltbld', 15:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:00 INFO - 'MOZ_NO_REMOTE': '1', 15:12:00 INFO - 'NO_EM_RESTART': '1', 15:12:00 INFO - 'PAGER': '/bin/cat', 15:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:00 INFO - 'PWD': '/builds/slave/test', 15:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:00 INFO - 'SHELL': '/bin/bash', 15:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:00 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:00 INFO - 'USER': 'cltbld', 15:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:00 INFO - 'XPC_FLAGS': '0x0', 15:12:00 INFO - 'XPC_SERVICE_NAME': '0', 15:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:12:01 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 15:12:01 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 15:12:01 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 15:12:01 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 15:12:01 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 15:12:01 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 15:12:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:12:03 INFO - Installing collected packages: mozsystemmonitor 15:12:03 INFO - Running setup.py install for mozsystemmonitor 15:12:03 INFO - Successfully installed mozsystemmonitor 15:12:03 INFO - Cleaning up... 15:12:03 INFO - Return code: 0 15:12:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:03 INFO - 'HOME': '/Users/cltbld', 15:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:03 INFO - 'LOGNAME': 'cltbld', 15:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:03 INFO - 'MOZ_NO_REMOTE': '1', 15:12:03 INFO - 'NO_EM_RESTART': '1', 15:12:03 INFO - 'PAGER': '/bin/cat', 15:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:03 INFO - 'PWD': '/builds/slave/test', 15:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:03 INFO - 'SHELL': '/bin/bash', 15:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:03 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:03 INFO - 'USER': 'cltbld', 15:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:03 INFO - 'XPC_FLAGS': '0x0', 15:12:03 INFO - 'XPC_SERVICE_NAME': '0', 15:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:04 INFO - Downloading/unpacking jsonschema==2.5.1 15:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:12:06 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 15:12:06 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 15:12:06 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 15:12:06 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 15:12:06 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 15:12:06 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 15:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:07 INFO - warning: no files found matching '*.txt' 15:12:07 INFO - no previously-included directories found matching 'build' 15:12:07 INFO - no previously-included directories found matching 'dist' 15:12:07 INFO - no previously-included directories found matching '.git*' 15:12:07 INFO - Installing collected packages: jsonschema, functools32 15:12:07 INFO - Running setup.py install for functools32 15:12:07 INFO - warning: no files found matching '*.txt' 15:12:07 INFO - no previously-included directories found matching 'build' 15:12:07 INFO - no previously-included directories found matching 'dist' 15:12:07 INFO - no previously-included directories found matching '.git*' 15:12:07 INFO - Successfully installed jsonschema functools32 15:12:07 INFO - Cleaning up... 15:12:07 INFO - Return code: 0 15:12:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:07 INFO - 'HOME': '/Users/cltbld', 15:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:07 INFO - 'LOGNAME': 'cltbld', 15:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:07 INFO - 'MOZ_NO_REMOTE': '1', 15:12:07 INFO - 'NO_EM_RESTART': '1', 15:12:07 INFO - 'PAGER': '/bin/cat', 15:12:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:07 INFO - 'PWD': '/builds/slave/test', 15:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:07 INFO - 'SHELL': '/bin/bash', 15:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:07 INFO - 'USER': 'cltbld', 15:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:07 INFO - 'XPC_FLAGS': '0x0', 15:12:07 INFO - 'XPC_SERVICE_NAME': '0', 15:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:12:07 INFO - Cleaning up... 15:12:07 INFO - Return code: 0 15:12:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:07 INFO - 'HOME': '/Users/cltbld', 15:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:07 INFO - 'LOGNAME': 'cltbld', 15:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:07 INFO - 'MOZ_NO_REMOTE': '1', 15:12:07 INFO - 'NO_EM_RESTART': '1', 15:12:07 INFO - 'PAGER': '/bin/cat', 15:12:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:07 INFO - 'PWD': '/builds/slave/test', 15:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:07 INFO - 'SHELL': '/bin/bash', 15:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:07 INFO - 'USER': 'cltbld', 15:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:07 INFO - 'XPC_FLAGS': '0x0', 15:12:07 INFO - 'XPC_SERVICE_NAME': '0', 15:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:10 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12:10 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 15:12:10 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 15:12:10 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 15:12:10 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 15:12:10 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 15:12:10 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 15:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12:11 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 15:12:11 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 15:12:11 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 15:12:11 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 15:12:11 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 15:12:11 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 15:12:11 INFO - Downloading docopt-0.6.1.tar.gz 15:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:11 INFO - Running setup.py install for blobuploader 15:12:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:12 INFO - Running setup.py install for requests 15:12:12 INFO - Running setup.py install for docopt 15:12:12 INFO - Successfully installed blobuploader requests docopt 15:12:12 INFO - Cleaning up... 15:12:12 INFO - Return code: 0 15:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:12 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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:12 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 15:12:12 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 15:12:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:12 INFO - 'HOME': '/Users/cltbld', 15:12:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:12 INFO - 'LOGNAME': 'cltbld', 15:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:12 INFO - 'MOZ_NO_REMOTE': '1', 15:12:12 INFO - 'NO_EM_RESTART': '1', 15:12:12 INFO - 'PAGER': '/bin/cat', 15:12:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:12 INFO - 'PWD': '/builds/slave/test', 15:12:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:12 INFO - 'SHELL': '/bin/bash', 15:12:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:12 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:12 INFO - 'USER': 'cltbld', 15:12:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:12 INFO - 'XPC_FLAGS': '0x0', 15:12:12 INFO - 'XPC_SERVICE_NAME': '0', 15:12:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Y2Uywv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hWLOeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KQoUBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tQLFXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-lc80h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-wtMFow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-3F_nO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-XtggB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:13 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-nUS8az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-kJ3q6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-fPG2Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-91Xec2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-d0YEiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Ci9VwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-vxekBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-8QCCZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:14 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-FI0A65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:14 INFO - Running setup.py install for manifestparser 15:12:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:15 INFO - Running setup.py install for mozcrash 15:12:15 INFO - Running setup.py install for mozdebug 15:12:15 INFO - Running setup.py install for mozdevice 15:12:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:15 INFO - Running setup.py install for mozfile 15:12:15 INFO - Running setup.py install for mozhttpd 15:12:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:15 INFO - Running setup.py install for mozinfo 15:12:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:15 INFO - Running setup.py install for mozInstall 15:12:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Running setup.py install for mozleak 15:12:16 INFO - Running setup.py install for mozlog 15:12:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Running setup.py install for moznetwork 15:12:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Running setup.py install for mozprocess 15:12:16 INFO - Running setup.py install for mozprofile 15:12:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:16 INFO - Running setup.py install for mozrunner 15:12:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:17 INFO - Running setup.py install for mozscreenshot 15:12:17 INFO - Running setup.py install for moztest 15:12:17 INFO - Running setup.py install for mozversion 15:12:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:17 INFO - Cleaning up... 15:12:17 INFO - Return code: 0 15:12:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:17 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')]} 15:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:17 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')]} 15:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:17 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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:17 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 15:12:17 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 15:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:17 INFO - 'HOME': '/Users/cltbld', 15:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:17 INFO - 'LOGNAME': 'cltbld', 15:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:17 INFO - 'MOZ_NO_REMOTE': '1', 15:12:17 INFO - 'NO_EM_RESTART': '1', 15:12:17 INFO - 'PAGER': '/bin/cat', 15:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:17 INFO - 'PWD': '/builds/slave/test', 15:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:17 INFO - 'SHELL': '/bin/bash', 15:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:17 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:17 INFO - 'USER': 'cltbld', 15:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:17 INFO - 'XPC_FLAGS': '0x0', 15:12:17 INFO - 'XPC_SERVICE_NAME': '0', 15:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tHDmHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:17 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)) 15:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-XUU_DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:17 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)) 15:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:17 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-IBlgIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-F3XGKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-deUr4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-4Dv_D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-2I09bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Wi0E9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-yVn_wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bvN5Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-q_ITh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:18 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)) 15:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:18 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-7OIfDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:19 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)) 15:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:19 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ncBFEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:19 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)) 15:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:19 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-9GaVJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:19 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)) 15:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:19 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-S8Cu43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:19 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)) 15:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:19 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YFx47u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:19 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)) 15:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:19 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-b3RcCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:19 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)) 15:12:19 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)) 15:12:19 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)) 15:12:19 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)) 15:12:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:22 INFO - Downloading blessings-1.6.tar.gz 15:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:22 INFO - Installing collected packages: blessings 15:12:22 INFO - Running setup.py install for blessings 15:12:22 INFO - Successfully installed blessings 15:12:22 INFO - Cleaning up... 15:12:22 INFO - Return code: 0 15:12:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:22 INFO - Reading from file tmpfile_stdout 15:12:22 INFO - Current package versions: 15:12:22 INFO - blessings == 1.6 15:12:22 INFO - blobuploader == 1.2.4 15:12:22 INFO - docopt == 0.6.1 15:12:22 INFO - functools32 == 3.2.3-2 15:12:22 INFO - jsonschema == 2.5.1 15:12:22 INFO - manifestparser == 1.1 15:12:22 INFO - mozInstall == 1.12 15:12:22 INFO - mozcrash == 1.0 15:12:22 INFO - mozdebug == 0.1 15:12:22 INFO - mozdevice == 0.49 15:12:22 INFO - mozfile == 1.2 15:12:22 INFO - mozhttpd == 0.7 15:12:22 INFO - mozinfo == 0.9 15:12:22 INFO - mozleak == 0.1 15:12:22 INFO - mozlog == 3.4 15:12:22 INFO - moznetwork == 0.27 15:12:22 INFO - mozprocess == 0.25 15:12:22 INFO - mozprofile == 0.28 15:12:22 INFO - mozrunner == 6.13 15:12:22 INFO - mozscreenshot == 0.1 15:12:22 INFO - mozsystemmonitor == 0.3 15:12:22 INFO - moztest == 0.8 15:12:22 INFO - mozversion == 1.4 15:12:22 INFO - psutil == 3.1.1 15:12:22 INFO - requests == 1.2.3 15:12:22 INFO - wsgiref == 0.1.2 15:12:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:22 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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:22 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 15:12:22 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 15:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:22 INFO - 'HOME': '/Users/cltbld', 15:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:22 INFO - 'LOGNAME': 'cltbld', 15:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:22 INFO - 'MOZ_NO_REMOTE': '1', 15:12:22 INFO - 'NO_EM_RESTART': '1', 15:12:22 INFO - 'PAGER': '/bin/cat', 15:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:22 INFO - 'PWD': '/builds/slave/test', 15:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:22 INFO - 'SHELL': '/bin/bash', 15:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:22 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:22 INFO - 'USER': 'cltbld', 15:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:22 INFO - 'XPC_FLAGS': '0x0', 15:12:22 INFO - 'XPC_SERVICE_NAME': '0', 15:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 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)) 15:12:23 INFO - Cleaning up... 15:12:23 INFO - Return code: 0 15:12:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:12:23 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')]} 15:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:23 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')]} 15:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:23 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 0x1041e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb62c67050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, '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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 15:12:23 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 15:12:23 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 15:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:23 INFO - 'HOME': '/Users/cltbld', 15:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:23 INFO - 'LOGNAME': 'cltbld', 15:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:23 INFO - 'MOZ_NO_REMOTE': '1', 15:12:23 INFO - 'NO_EM_RESTART': '1', 15:12:23 INFO - 'PAGER': '/bin/cat', 15:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:23 INFO - 'PWD': '/builds/slave/test', 15:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:23 INFO - 'SHELL': '/bin/bash', 15:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:23 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:23 INFO - 'USER': 'cltbld', 15:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:23 INFO - 'XPC_FLAGS': '0x0', 15:12:23 INFO - 'XPC_SERVICE_NAME': '0', 15:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:12:23 INFO - Cleaning up... 15:12:23 INFO - Return code: 0 15:12:23 INFO - Running post-action listener: _resource_record_post_action 15:12:23 INFO - Running post-action listener: _start_resource_monitoring 15:12:23 INFO - Starting resource monitoring. 15:12:23 INFO - [mozharness: 2017-03-23 22:12:23.461307Z] Finished create-virtualenv step (success) 15:12:23 INFO - [mozharness: 2017-03-23 22:12:23.462280Z] Running install step. 15:12:23 INFO - Running pre-action listener: _resource_record_pre_action 15:12:23 INFO - Running main action method: install 15:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:23 INFO - Reading from file tmpfile_stdout 15:12:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:12:23 INFO - Reading from file tmpfile_stdout 15:12:23 INFO - Output received: 15:12:23 INFO - Usage: mozinstall [options] installer 15:12:23 INFO - Options: 15:12:23 INFO - -h, --help show this help message and exit 15:12:23 INFO - -d DEST, --destination=DEST 15:12:23 INFO - Directory to install application into. [default: 15:12:23 INFO - "/builds/slave/test"] 15:12:23 INFO - --app=APP Application being installed. [default: firefox] 15:12:23 INFO - mkdir: /builds/slave/test/build/application 15:12:23 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'] 15:12:23 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 15:12:44 INFO - Reading from file tmpfile_stdout 15:12:44 INFO - Output received: 15:12:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:12:44 INFO - Running post-action listener: _resource_record_post_action 15:12:44 INFO - [mozharness: 2017-03-23 22:12:44.322810Z] Finished install step (success) 15:12:44 INFO - [mozharness: 2017-03-23 22:12:44.322964Z] Running run-tests step. 15:12:44 INFO - Running pre-action listener: _resource_record_pre_action 15:12:44 INFO - Running main action method: run_tests 15:12:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:12:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:12:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:12:44 INFO - 2017-03-23 15:12:44.337 screenresolution[1643:7497] starting screenresolution argv=screenresolution get 15:12:44 INFO - 2017-03-23 15:12:44.339 screenresolution[1643:7497] Display 0: 1600x1200x32@60 15:12:44 INFO - 2017-03-23 15:12:44.345 screenresolution[1644:7499] starting screenresolution argv=screenresolution list 15:12:44 INFO - Available Modes on Display 0 15:12:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:12:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:12:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:12:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:12:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:12:44 INFO - Intel Iris: 15:12:44 INFO - Chipset Model: Intel Iris 15:12:44 INFO - Type: GPU 15:12:44 INFO - Bus: Built-In 15:12:44 INFO - VRAM (Dynamic, Max): 1536 MB 15:12:44 INFO - Vendor: Intel (0x8086) 15:12:44 INFO - Device ID: 0x0a2e 15:12:44 INFO - Revision ID: 0x0009 15:12:44 INFO - Displays: 15:12:44 INFO - Display: 15:12:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:12:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:12:44 INFO - Display Serial Number: 1600x1200 60 15:12:44 INFO - Main Display: Yes 15:12:44 INFO - Mirror: Off 15:12:44 INFO - Online: Yes 15:12:44 INFO - Rotation: Supported 15:12:44 INFO - Return code: 0 15:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:12:44 INFO - Python 2.7.3 15:12:44 INFO - Return code: 0 15:12:44 INFO - grabbing minidump binary from tooltool 15:12:44 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')]} 15:12:44 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 0x103fbed30>, '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 0x103ee5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fb3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:12:44 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 15:12:44 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 15:12:44 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 15:12:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:12:44 INFO - Return code: 0 15:12:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:12:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:12:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:12:44 INFO - ENV: RUST_BACKTRACE is now 1 15:12:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:12:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 15:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 15:12:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gKFN4bWXW3/Render', 15:12:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:12:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:12:44 INFO - 'HOME': '/Users/cltbld', 15:12:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:12:44 INFO - 'LOGNAME': 'cltbld', 15:12:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:44 INFO - 'MOZ_NO_REMOTE': '1', 15:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:12:44 INFO - 'NO_EM_RESTART': '1', 15:12:44 INFO - 'PAGER': '/bin/cat', 15:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:44 INFO - 'PWD': '/builds/slave/test', 15:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:12:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:12:44 INFO - 'RUST_BACKTRACE': '1', 15:12:44 INFO - 'SHELL': '/bin/bash', 15:12:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ydcfSzNVY/Listeners', 15:12:44 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 15:12:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:12:44 INFO - 'USER': 'cltbld', 15:12:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:12:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:44 INFO - 'XPC_FLAGS': '0x0', 15:12:44 INFO - 'XPC_SERVICE_NAME': '0', 15:12:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:12:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 15:12:44 INFO - mozversion application_buildid: 20170323111525 15:12:44 INFO - mozversion application_changeset: fde19b9411ee0735e5e66dc02e68c815bdbe66bd 15:12:44 INFO - mozversion application_display_name: Nightly 15:12:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:12:44 INFO - mozversion application_name: Firefox 15:12:44 INFO - mozversion application_remotingname: firefox 15:12:44 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 15:12:44 INFO - mozversion application_vendor: Mozilla 15:12:44 INFO - mozversion application_version: 55.0a1 15:12:44 INFO - mozversion platform_buildid: 20170323111525 15:12:44 INFO - mozversion platform_changeset: fde19b9411ee0735e5e66dc02e68c815bdbe66bd 15:12:44 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 15:12:44 INFO - mozversion platform_version: 55.0a1 15:12:44 INFO - using testdate: 1490307164 15:12:44 INFO - actual date: 1490307164 15:12:44 INFO - starting webserver on 'localhost:49244' 15:12:44 INFO - SUITE-START | Running 2 tests 15:12:44 INFO - TEST-START | dromaeo_css 15:12:44 INFO - operating with platform_type : mac_ 15:12:44 INFO - Initialising browser for dromaeo_css test... 15:12:44 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpFZbpYa/profile http://localhost:49244/getInfo.html) 15:12:47 INFO - PID 1654 | 2017-03-23 15:12:47.874 plugin-container[1657:7681] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 15:12:47 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:12:47 INFO - PID 1654 | 2017-03-23 15:12:47.877 plugin-container[1657:7681] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 15:12:47 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:12:47 INFO - PID 1654 | 2017-03-23 15:12:47.877 plugin-container[1657:7681] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:12:47 INFO - PID 1654 | __metrics Screen width/height:1600/1200 15:12:47 INFO - PID 1654 | colorDepth:24 15:12:47 INFO - PID 1654 | Browser inner width/height: 1024/689 15:12:47 INFO - PID 1654 | __metrics 15:12:48 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 15:12:48 INFO - TEST-INFO | 1654: exit 0 15:12:48 INFO - Browser initialized. 15:12:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:12:48 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpFZbpYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:51 INFO - PID 1658 | 2017-03-23 15:12:51.439 plugin-container[1659:7808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 15:12:51 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:12:51 INFO - PID 1658 | 2017-03-23 15:12:51.440 plugin-container[1659:7808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 15:12:51 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:12:51 INFO - PID 1658 | 2017-03-23 15:12:51.440 plugin-container[1659:7808] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:13:01 INFO - PID 1658 | RSS: Main: 228814848 15:13:01 INFO - PID 1658 | 15:16:05 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 15:16:07 INFO - PID 1658 | RSS: Main: 252358656 15:16:07 INFO - PID 1658 | 15:17:49 INFO - PID 1658 | ************************* 15:17:49 INFO - PID 1658 | A coding exception was thrown and uncaught in a Task. 15:17:49 INFO - PID 1658 | 15:17:49 ERROR - PID 1658 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:17:49 INFO - PID 1658 | Full stack: 15:17:49 INFO - PID 1658 | ************************* 15:19:09 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 15:19:10 INFO - PID 1658 | RSS: Main: 260087808 15:19:10 INFO - PID 1658 | 15:22:12 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 15:22:12 INFO - PID 1658 | RSS: Main: 272195584 15:22:12 INFO - PID 1658 | 15:25:14 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 15:25:15 INFO - PID 1658 | RSS: Main: 264593408 15:25:15 INFO - PID 1658 | 15:28:17 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 15:28:18 INFO - PID 1658 | RSS: Main: 274849792 15:28:18 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 15:31:21 INFO - PID 1658 | RSS: Main: 268623872 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | __start_tp_report 15:31:21 INFO - PID 1658 | _x_x_mozilla_page_load 15:31:21 INFO - PID 1658 | _x_x_mozilla_page_load_details 15:31:21 INFO - PID 1658 | |i|pagename|runs| 15:31:21 INFO - PID 1658 | |0;dojo.html;3494.6505349465046;3562.821858907054;3627.183883626186;3630.600633930267;3637.5998640149587;5663.377028526864;6107.158472117341;6110.847228819276;6226.3462336454695;6271.498280137589;6107.279845777768;6162.630242185472;6205.534584906128;6229.937700623003;6253.71858266378;5589.854079913608;5627.634203776762;5745.626534275259;5775.740091695863;5816.738246778884;5530.861728456781;5612.85967850805;5758;5813.128030795372;5838.503727183194;5476.26070480484;5538.169274608841;5562.749676264578;5702;5726.940516004553;5541.778328866841;5543.501084902337;5584.994700953867;5672.035753921802;5710.343310519302;5542.695151766651;5611.719414029323;5619.269494965669;5646.322441307028;5668.858278543028;5969.850753731148;6170.7223174957235;6184.31972483031;6196.721147548326;6202.503799696014;6438.806835794933;6565.507586930951;6645.368689974444;6702.396784289389;6707.429868461187;6725.125733654642;6737.258901520829;6752.953292239662;6799.966000170017;6830.897536536956;6247.125402443661;6280.371962803683;6288.496920246369;6295.055741638745;6295.181626388632;6589.670516474157;6620.337966203341;6772.2211945625895;6925.445964322842;6926.896096558556;6293.181886354744;6353.174087368612;6503.837404064841;6504.38208370204;6574.178227721535;6583.407493325623;6736.989451582302;6749.392554670005;6757.662116894136;6761.797146085625;6586.440152586988;6653.367930046637;6673.432758215606;6677.29888361715;6686.364795344434;6307.621542707452;6398.008308712064;6675.198976122896;6683.2314283857;6709.563878347892;5253.763580638881;5264.289320941624;5265.341832270966;5316.813911513079;5323.494268044529;4715.434147902273;4759.666823322404;4760.166970780169;4760.33355330254;4804.597701149425;6245.906311405332;6257.78097766576;6293.118963345135;6305.117283580303;6311.084892690534;6447;6524.706388212542;6722.159730033746;6738;6742.595444273359;6259.937400626027;6294.496440284766;6302.306746257908;6304.653244071528;6307.558470906993;4945.629077819106;5878.059510478389;5914.260717410324;5920.970395148083;5921.082232254007;5516.310461192351;6509.251436084911;6578.76974305897;6783.932160678528;6850.520463567503;6598.27418983921;6613.570117942319;6707.966460167668;6708.899366509604;6722.630255335808;6835.965820170867;6838.863222735617;6848.486363522656;6867.3476019778045;6882.7591034315565;6345.90481142774;6503.154589903472;6628.436582890508;6652.168478940132;6653.268140504638;5407.540359069523;6635.933640663531;6687.933120668731;6692.83267918306;6725.8991115134295;6484.773032943825;6503.284638689645;6503.967480162758;6519.022146678036;6519.4132528072705;6120.755169793337;6238.064290356483;6317.873642527032;6354.650494222862;6464.967675161594;5087.491250874883;6279.748810047729;6337.968310158604;6338.492920566436;6350.714217860115;6499.2200935887995;6517.185351831021;6517.217933847968;6528.053432252202;6536.607803531613;6173;6210.782622608187;6257.812265632038;6373.490120790233;6374.936250637435 15:31:21 INFO - PID 1658 | |1;ext.html;727.3344889426176;741.5550669598242;830.6801881275709;1259.4647274908161;1272.5609664665687;31290.843545782267;36664.083397915034;38812.83561493153;38842.417363739565;38869.61130388695;38827;39001.804990975004;39228.21543569127;39269.803650981776;39300.60699393005;8148.755537333875;8301.211384918422;8605.440646357998;8818.735437936872;8824.117588241188;8720;8789.736307910742;8836.955815220947;8852.070532594082;8855.24730397917;8799.34004949628;8850.867236991451;8853.203211710945;8860.556972151398;8863.601137948775;8784.165504277084;8811.95594022029;8836.33727470439;8837.646494140226;8845.911540884637;8617.956910215471;8656.956715216447;8719.171678690514;8727.738167854974;8742.737717868475;31700.365992680247;39507.20985580301;39598.20803583941;39743.40384894229;39767.40348894769;2742.794290428206;3014.2464383904025;3029.59100521429;3038.7417069549115;3070.140360699008;28543.714562854315;28824.135275941757;28953.855230723922;29112.563311550133;29357.559636605467;2685.0333879803256;2687.1401151631485;2711.3221694576355;2727.1409506005543;2730.945381092367;300068;334931;341591.2920435407;342472;346807;49119;49845.25232121521;49867.50132498701;49885;50057;53499;53598;53625.731871340395;53681.463185368426;53765;12992.350382480838;13224.677532246698;14243.78634320486;14358.641033974234;14578.562643120724;11642.825357619642;11673.124515661359;11684.824727629093;11700.180987330805;11708.824367634492;12451.066170037102;13982.930085349508;14174.85825141756;14214.360353784105;14234.786478202835;6030.18592490017;6055.788047418319;6090.208272924491;6108.17539632144;6120.326764055951;813.6094674556127;906.4425378392241;956.7179978828403;959.6785076999143;976.951152442375;19977.900110499355;22525.953621574336;22954.54090918206;25564.744352556238;25602.359941001625;1042.2339580408393;1070.8340207267886;1072.1851392941421;1106.8395082712962;1114.570890207276;12352.320622365856;13020.869791302155;13024;13059.869401306056;13086.280254586089;469383;469409;473194;474091;474615;57320.71339643275;57366.71316643473;57594.7120264396;57631.71184144053;57748.13377799336;1450.3690894460942;1463.1733070814955;1477.135875512837;1484.1540322016563;1488.3153749275455;22985.540289194458;26618.86690566535;28093.57859632148;28531.42937141204;30530.694693052785;40583.39124913188;40990.180196396504;41006.949652517855;41114.58885411227;41203.58796412117;419849;423349;425245;427293;427523;28712.569311460764;33917.8128765492;35072.824635876656;35883.64116358803;36378;43267.35098973581;43899.56100438955;45000.77499612481;45077;45770;23438.29685109381;29966.70033299639;30446;30539.389212216076;30775.2306192347;30377.088687339416;30425.847870760503;31046.689533105284;31114.844425777726;31249.68750312468;36339.091522712144;37347.439788402655;37355.252894942496;37433.43849842309;37502.43746343753;23718;26042.479150416508;30859.537106942964;31342;31404.528932066496;23682;24759;24791.62812557777;25240.495190096462;25265.989360425378 15:31:21 INFO - PID 1658 | |2;jquery.html;426.0839195729184;427.7680280791321;436.4108453587657;443.52985835014886;453.4490593928376;19858.801411985856;21596.460088497777;22128.22551210708;22315.55368892621;22445.3266402008;19428.805711942878;21461.785382146172;22110.557788844253;22512;22893.19873804417;6189.597676151047;6376.776812811552;6395.488360931115;6401.647909364983;6422.325655806143;5967.582269241155;6277.780277690282;6295.842603934892;6342.112104305401;6345.999999999977;4903.2645103234445;5314.521693047625;5404.891902161954;6246.562740608159;6279.497640188797;4777.784999675006;6281.246250449953;6298.937010629881;6310.747570097191;6333.968330158343;4791.425028996543;5402.864928376783;5493.176023596453;5582.609217354787;5588.804391846266;18100.366487172887;26299;26543.601845972134;26830.731692683017;27286.181414557595;1889.3387314439835;1910.4077735901776;1928.4503916383903;1949.87325823821;1956.2859556261863;14889.776653350209;15366.028994768198;15781;15807.367705291774;16067.517974460668;1609.3079975610483;1692.9153542322958;1715.3609983163242;1719.6474722681821;1727.9308827646878;150124.2493787524;159699;160376;162769.18615406967;163863;12347.938260308641;12404.19372740787;12424.503019879103;12427.005839532816;12642.367881606067;16198.919005404898;16345.754813677804;16367.91816040912;16384.344626215057;16442.177891105395;7000.50996430245;8858.335624828034;8858.335624828163;9008;9031.232345250595;8245.299149572353;8264.8347033059;8297.25324720766;8422.28410585095;8443.95778021106;7704.072452468138;7765.572893490799;7836.921630783733;7883.448158628956;7893.447458677838;2139.261954625683;2144.4960434297927;2150.193677370986;2155.5365596396537;2350.74141844397;855.4054931822449;917.9495127767904;923.6813299411692;960.9231261499064;966.8839739231197;19483;19970.406806434312;20036.599268014557;20067.498312542302;20442.795572044088;949.4635530925005;950.8098380323963;989.366805244644;990.7622170678985;991.8958509356557;8350.62422191003;9643.855342169873;10342.172626189888;10357;10397.428141452141;696097;713712;729660;731692.3415382996;733297;95622;115596;137582;155274.447255526;163401;1088.1294964028746;1184.1059999700171;1230.6369620961839;1246.1028059796931;1246.1962034487706;21236.25673101434;21396.893015535446;21579.352619421443;21660.241891533722;21673.241436549644;51713.741431292605;59290;60086.69956650189;61246.38753612407;64821.67589162024;67834.98247526192;77978.22021779709;81986.59006704928;83552;85540;8009.879851802344;8383.58082095905;8480.279176270085;8495.532745699045;8692.739217823475;11804.881951180721;12008.85915837994;13162.47350105985;13343.399547020601;13685.384157712728;10528.473576321307;11440.771184576095;11560.768784624428;11691.590794322497;12052.638420847388;9559.474228917476;9748.415095094317;10560.84158737635;10651.094656954245;11000.449977501254;11637.301761894314;11807.940960295144;12096.879031209575;12115.394230288626;12295.508179672714;8396.370272229486;8434.493930364199;8591;8850.291976641724;8854.911450885666;11350.489227984926;11712.648620541397;11768.646940591796;11812.936835684486;12050.276983380674 15:31:21 INFO - PID 1658 | |3;mootools.html;1374.9243791591464;1388.8402833674124;1396.2669598460814;1405.8102156208909;1426.9001169918104;10463.895361046387;10788.460576971149;10803.189760767935;10935.507902144403;10977.945110274457;10768.569257229701;10874.45627718613;10987.61543345983;10995.395253261067;11020.173486988488;2432.282476669378;2463.1009681466317;2478.50429914017;2480.1071614218868;2482.429041320497;2138.721966144399;2357.210334537932;2443.1571107967725;2454.7177074636465;2456.5701002324613;2357.1043003658588;2442.206282958037;2455.72986971433;2457.4716435966266;2462.175171317602;2309.9653505197434;2427.720812106613;2437.5612389769835;2440.316711320842;2472.814538909589;2050.7744148143693;2126.808587227157;2364.1961733010685;2433.4646377797035;2448.094205144108;10739.731506712316;10997.670069897917;11008.669739907815;11051.392173430459;11085.168612354106;6263.279722831887;6460.773872914472;6468.773592924272;6481.902771458432;6483.902741458882;4039.8990025249605;4075.286824805647;4090.795460226977;4111.376006477425;4148.668106551469;1172.226330621794;1180.1797750563362;1223.5105957616936;1224.3205021213223;1235.925844449336;15062.849371506363;15200.315985780666;15211.695766084616;15330.386784528606;15365.308561114889;5201.505856943584;5366.6243362964215;5406.324209473816;5457.672539647634;5509.228707980886;8653.740387788377;9176.220021298264;11073.335599864035;11566;11569.88430115705;5147.485251474897;6247.625142491465;6248.343923888017;6268.341824108494;6298.338674439209;5479;5835.387284335168;5864.8533786654825;5906.8818623627285;5935.169076329317;4141;4316.611504964505;4348.826046958086;4391.890202744957;4405.647548196137;1037.3568387599585;1273.1660762200772;1282.205032879602;1290.5805613175755;1291.180100636103;605.6729366142234;633.7306644675995;765.6745882999703;778.1829079466537;796.5857753967904;5884.176215329857;5908.675022873783;6093.69531523422;6125.754969801158;6195.132681424604;573.1860757724041;580.8547863034241;583.2417856786161;585.7656937225144;591.045461579546;3800.600936901641;3975.4036894465485;4089.427480152781;4278.657707383401;4355.281378572563;13615.25116118623;13973.510927117502;14143;14180.290985450893;14192.077514961495;13762.65593360154;13945.721085578232;13984.51054213118;14030.368633411521;14086.78869816933;9857.605695772232;10095.444750538643;10157.644482443227;10269.99999999985;10343;6365.554411191172;6490.578112422866;6534.346565343428;6547.574407663486;6550.7707230246715;9272.6290948364;11614;12045;12162.452689629165;12822.935885320514;12720.491180352683;12734.299613521345;12759;12927.353632318534;12956.935215323863;8266.214709602578;8282.047564530156;8329.83340333202;8346.998360196816;8411.495310281403;10133.240006999356;10218.897811021794;10259.717535308086;10296.897031029594;10298.948505257726;7580.772576822704;8240.670373185005;8579.575815384338;8671.21959023691;8700.695475658322;7256.9274307256255;8369.0375606806;8418.957905210435;8459.492430454193;8504.659813607386;7795.610219489116;7854.764357069297;7913.525188488709;7933.444658873824;7944.682212711658;4793.808247670054;5838.649681019152;5846.94153058481;5896.469317761251;6052.334243233329;5735.655860648374;6057.818265452043;6061.817346031225;6091.329953705001;6113.908291375722 15:31:21 INFO - PID 1658 | |4;prototype.html;398.50187265917606;400.7535365750065;400.77356293694044;401.4560270833021;401.68848708965214;4928.901421971558;5267.499587539182;5529.944700552994;6428.839279018027;6461.22465304163;5714.200011998323;6033.6379817211;6196.225471816012;6228.377162283769;6291.937080629193;4359.904467827831;4827.131116399047;4897.600175913813;4905.23968784839;4918.557329840313;3811.1805961718223;4972.925406118911;4973.552380285773;4984.551390374865;4989.176785830334;4046.817893194813;4697.647676424264;4818.831340903069;4882.145624515713;4912.606991440676;3534.7759427484166;4219.7551722242015;4220.767857767822;4893.608511319086;4953.380827396575;3584.874529391485;3881.359575670011;4056.675465962716;4330.350447432878;4338.522762496123;4806.975965120187;5636.2954630671165;6030.577859549833;6168.9691551541955;6176.197094377702;5699.572532060112;5700.828975130753;5720.685362305072;5722.570807189478;5723.227364305849;6552.7378904843745;6789.321067893221;6802.537454447268;6842.247352791189;6847.383735463783;3585.7848529088337;4791.856244312677;4802.879928001793;4813.253945638432;4830.830920917751;6223.533235007392;6823.55646882951;7019.92980070203;7048.5241871411;7157.928420715778;4035.535913369941;4102.569230230843;4535.138323718483;4894.412670479494;4906.116898958222;5002.724850133205;5015.3229314042865;5022.824201153016;5025.874353141127;5033.647644664911;5178.6597644519825;5392.838214853561;5453.15476101205;5647.661140331593;5712.600117991784;5256.816011439581;6218.756248750177;6728.158980127484;6747.561408508432;6823.69293381799;1449.8187726534184;1567.0519335801903;1570.9842901571067;1580.9170718058167;1580.936762529486;764.0220517737305;878.725847521097;899.0694631056825;920.3695468604028;1042.5725452564411;5678.744456499468;6301.487642965747;6311.526635502356;6326.2092238470195;6329.525285603599;6012.6392416455155;6683.36257616887;6916.23921368649;6944.618046007417;6951.339622735832;4930.556249937523;5364.103384172581;5755.841249862607;6211.565190436626;6307.846076961519;3199.9520007199912;3617.656322649344;3634.491171236029;3656.213914008501;3670.284294562535;6942.236354001056;7012.228654847962;7092.787216383414;7155.606441645656;7169.4981351304905;6074.967255566565;6738.966305168443;7180.31786980236;7233.276672332725;7235.963820180866;5989.041753319448;6159.96920015406;6707.6981535831;6802.387785099365;7157.4274058075225;5854.750613409428;6952.165740111219;6994.160700715946;7013.614251216232;7025.156981162293;6024.307204671519;6543.149390579194;6776.864462710817;6889.658515620021;6897.448204143556;6494.91491541514;7007.649617519001;7101.325374089453;7135.357817796424;7162.534435261691;3928.09653779638;4517.277235642281;4524.751138687404;4532.546745325441;4555.749433781174;5336.706481143419;6267.96866015667;6865.5537390069485;6955.965220173866;7004.264552221944;5645;6595.94464885616;6663.167104111986;6666.733330666913;6724.428423583854;6360.4275615193;6690.966545167243;6697.2633010367845;6737.292584278776;6775.762848300483;6069.666168360783;6320.4311611955145;6623.072769812326;6635.568688035262;6639.004149377439;5779.566532510163;6625.933740662532;6695.363940425652;6784.59292442455;6806.944923536859;5741.339745929272;6250.531210159165;6515.446187074152;6552.180977377828;6572.934270657232 15:31:21 INFO - PID 1658 | |5;yui.html;596.8806238752248;616.5067945643485;697.3410127429581;733.9302766237209;747.947643664943;12904.870951290484;14431.773299269562;15641.296141673623;15784.44754433595;15870.841291587096;14580.562583122497;14622.341994610242;15458.84541154588;16199.514014579552;16364;929.60027188309;946.2950102173891;947.9146876781089;951.8572214167896;952.2191802721771;736.2343163110359;946.6497395963503;952.0574631115215;955.0211033690488;960.3805545423198;854.3805740837873;998.7802683409639;999.7650552120245;1002.5338217728755;1009.0363702663975;1006.4816619440994;1008.2841182760249;1009.3792317724583;1010.151472762879;1010.8332125199333;737.200137850433;744.6686224630042;747.8392145688649;748.580794754939;749.0412272291476;15436.691266174726;15983.360665573364;16205.675886482322;16409.91795041029;16651.000939943642;11810.350430726307;13699.260147970446;13835.930820345833;13906.58280251594;13964.092333998258;9633.886421130233;11227.831582526269;11674.591389301419;11809.527618895234;12362.938185309016;2982.4631566318053;2989.5964044853886;3043.117495926179;3074.0777766669908;3097.798643088192;84718;88587.55706221492;102273.4658980116;104734;105682.47158764234;11172.273802202832;11184.161187910939;11220.438978051065;11454.885451145381;11803.704907377385;23078.769212307998;23149.884250578976;23168.53662926732;23384.883075584512;23385.181518646765;7856.528608283521;7896.526208427513;7963;8007.319377852948;8079.272865442138;4128.896777580524;4192.151948032539;4207.200631879933;4233;4234.3860140279485;4086.4891888513935;4151.418801367811;4160.00159961607;4164.312888373384;4171.687123465752;847.2967437027253;848.2058709734944;861.6553378648465;864.9264812491009;879.1164879296266;528.6009063157292;539.3366159623685;545.3401384325011;547.460751160107;570.4552152694167;8668.140466792154;9437.868199073162;9940.658011168543;10113.747156321151;10241.48792560369;488.93888263967006;518.8780636550408;523.2047288122034;566.7251383079204;585.5257241634205;4589.380433641482;4627.8843028923875;4634.513376095461;4637;4725.432948046187;90481.6427753571;93583.59624605636;95039;95294.52352738331;95716;53952.730236348565;59422.40577594255;67186.32034199087;72024.2797572028;74329.62835185898;63793.68103159455;64461.03308450377;65743;67780;68594;9610.807783844424;10574.524146413583;10760.623378181726;10816.56733730642;10983.725406864893;36288.27423451569;36622.71820486377;36638.63361366352;36947.44578831374;38459.61540384672;48979.75510122427;49234.769130772016;49364.50635493599;49541.25688114609;50097.74951125221;10463.633772817915;12153.84538468844;13180.472781088649;13330.266835323762;13632.97752668534;14143.787843182155;14257.122088681479;14414.279286035446;14518.346674399467;14614.853851461774;10868.456577171268;11402.94298528502;13479.663008424868;13481.97230181477;14072.155670659384;10989.835152472879;13443.193408395528;13464.730705386033;13559.254241016839;13636.795448068486;13080.672983175116;13185.40665670028;13344.332783360987;13563.623827771566;13790.65523361924;9496.843806869818;9601;9627.229821614394;9707.563159657691;9800.166985806287;9519.857617085994;9904.724292836987;10849.294795838245;11313.886861131612;11351.829722554003 15:31:21 INFO - PID 1658 | __end_tp_report 15:31:21 INFO - PID 1658 | __start_cc_report 15:31:21 INFO - PID 1658 | _x_x_mozilla_cycle_collect,429 15:31:21 INFO - PID 1658 | __end_cc_report 15:31:21 INFO - PID 1658 | __startTimestamp1490308281799__endTimestamp 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | ------- Summary: start ------- 15:31:21 INFO - PID 1658 | Number of tests: 6 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | [#0] dojo.html Cycles:165 Average:6141.54 Median:6305.12 stddev:683.23 (10.8%) stddev-sans-first:653.01 15:31:21 INFO - PID 1658 | Values: 3494.7 3562.8 3627.2 3630.6 3637.6 5663.4 6107.2 6110.8 6226.3 6271.5 6107.3 6162.6 6205.5 6229.9 6253.7 5589.9 5627.6 5745.6 5775.7 5816.7 5530.9 5612.9 5758.0 5813.1 5838.5 5476.3 5538.2 5562.7 5702.0 5726.9 5541.8 5543.5 5585.0 5672.0 5710.3 5542.7 5611.7 5619.3 5646.3 5668.9 5969.9 6170.7 6184.3 6196.7 6202.5 6438.8 6565.5 6645.4 6702.4 6707.4 6725.1 6737.3 6753.0 6800.0 6830.9 6247.1 6280.4 6288.5 6295.1 6295.2 6589.7 6620.3 6772.2 6925.4 6926.9 6293.2 6353.2 6503.8 6504.4 6574.2 6583.4 6737.0 6749.4 6757.7 6761.8 6586.4 6653.4 6673.4 6677.3 6686.4 6307.6 6398.0 6675.2 6683.2 6709.6 5253.8 5264.3 5265.3 5316.8 5323.5 4715.4 4759.7 4760.2 4760.3 4804.6 6245.9 6257.8 6293.1 6305.1 6311.1 6447.0 6524.7 6722.2 6738.0 6742.6 6259.9 6294.5 6302.3 6304.7 6307.6 4945.6 5878.1 5914.3 5921.0 5921.1 5516.3 6509.3 6578.8 6783.9 6850.5 6598.3 6613.6 6708.0 6708.9 6722.6 6836.0 6838.9 6848.5 6867.3 6882.8 6345.9 6503.2 6628.4 6652.2 6653.3 5407.5 6635.9 6687.9 6692.8 6725.9 6484.8 6503.3 6504.0 6519.0 6519.4 6120.8 6238.1 6317.9 6354.7 6465.0 5087.5 6279.7 6338.0 6338.5 6350.7 6499.2 6517.2 6517.2 6528.1 6536.6 6173.0 6210.8 6257.8 6373.5 6374.9 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | [#1] ext.html Cycles:180 Average:54635.52 Median:37005.76 stddev:109957.39 (297.1%) stddev-sans-first:110191.35 15:31:21 INFO - PID 1658 | Values: 727.3 741.6 830.7 1259.5 1272.6 31290.8 36664.1 38812.8 38842.4 38869.6 38827.0 39001.8 39228.2 39269.8 39300.6 8148.8 8301.2 8605.4 8818.7 8824.1 8720.0 8789.7 8837.0 8852.1 8855.2 8799.3 8850.9 8853.2 8860.6 8863.6 8784.2 8812.0 8836.3 8837.6 8845.9 8618.0 8657.0 8719.2 8727.7 8742.7 31700.4 39507.2 39598.2 39743.4 39767.4 2742.8 3014.2 3029.6 3038.7 3070.1 28543.7 28824.1 28953.9 29112.6 29357.6 2685.0 2687.1 2711.3 2727.1 2730.9 300068.0 334931.0 341591.3 342472.0 346807.0 49119.0 49845.3 49867.5 49885.0 50057.0 53499.0 53598.0 53625.7 53681.5 53765.0 12992.4 13224.7 14243.8 14358.6 14578.6 11642.8 11673.1 11684.8 11700.2 11708.8 12451.1 13982.9 14174.9 14214.4 14234.8 6030.2 6055.8 6090.2 6108.2 6120.3 813.6 906.4 956.7 959.7 977.0 19977.9 22526.0 22954.5 25564.7 25602.4 1042.2 1070.8 1072.2 1106.8 1114.6 12352.3 13020.9 13024.0 13059.9 13086.3 469383.0 469409.0 473194.0 474091.0 474615.0 57320.7 57366.7 57594.7 57631.7 57748.1 1450.4 1463.2 1477.1 1484.2 1488.3 22985.5 26618.9 28093.6 28531.4 30530.7 40583.4 40990.2 41006.9 41114.6 41203.6 419849.0 423349.0 425245.0 427293.0 427523.0 28712.6 33917.8 35072.8 35883.6 36378.0 43267.4 43899.6 45000.8 45077.0 45770.0 23438.3 29966.7 30446.0 30539.4 30775.2 30377.1 30425.8 31046.7 31114.8 31249.7 36339.1 37347.4 37355.3 37433.4 37502.4 23718.0 26042.5 30859.5 31342.0 31404.5 23682.0 24759.0 24791.6 25240.5 25266.0 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | [#2] jquery.html Cycles:180 Average:40433.64 Median:14324.87 stddev:120430.22 (840.7%) stddev-sans-first:120730.59 15:31:21 INFO - PID 1658 | Values: 426.1 427.8 436.4 443.5 453.4 19858.8 21596.5 22128.2 22315.6 22445.3 19428.8 21461.8 22110.6 22512.0 22893.2 6189.6 6376.8 6395.5 6401.6 6422.3 5967.6 6277.8 6295.8 6342.1 6346.0 4903.3 5314.5 5404.9 6246.6 6279.5 4777.8 6281.2 6298.9 6310.7 6334.0 4791.4 5402.9 5493.2 5582.6 5588.8 18100.4 26299.0 26543.6 26830.7 27286.2 1889.3 1910.4 1928.5 1949.9 1956.3 14889.8 15366.0 15781.0 15807.4 16067.5 1609.3 1692.9 1715.4 1719.6 1727.9 150124.2 159699.0 160376.0 162769.2 163863.0 12347.9 12404.2 12424.5 12427.0 12642.4 16198.9 16345.8 16367.9 16384.3 16442.2 7000.5 8858.3 8858.3 9008.0 9031.2 8245.3 8264.8 8297.3 8422.3 8444.0 7704.1 7765.6 7836.9 7883.4 7893.4 2139.3 2144.5 2150.2 2155.5 2350.7 855.4 917.9 923.7 960.9 966.9 19483.0 19970.4 20036.6 20067.5 20442.8 949.5 950.8 989.4 990.8 991.9 8350.6 9643.9 10342.2 10357.0 10397.4 696097.0 713712.0 729660.0 731692.3 733297.0 95622.0 115596.0 137582.0 155274.4 163401.0 1088.1 1184.1 1230.6 1246.1 1246.2 21236.3 21396.9 21579.4 21660.2 21673.2 51713.7 59290.0 60086.7 61246.4 64821.7 67835.0 77978.2 81986.6 83552.0 85540.0 8009.9 8383.6 8480.3 8495.5 8692.7 11804.9 12008.9 13162.5 13343.4 13685.4 10528.5 11440.8 11560.8 11691.6 12052.6 9559.5 9748.4 10560.8 10651.1 11000.4 11637.3 11807.9 12096.9 12115.4 12295.5 8396.4 8434.5 8591.0 8850.3 8854.9 11350.5 11712.6 11768.6 11812.9 12050.3 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | [#3] mootools.html Cycles:180 Average:6706.03 Median:3141.51 stddev:4171.92 (132.8%) stddev-sans-first:4164.39 15:31:21 INFO - PID 1658 | Values: 1374.9 1388.8 1396.3 1405.8 1426.9 10463.9 10788.5 10803.2 10935.5 10977.9 10768.6 10874.5 10987.6 10995.4 11020.2 2432.3 2463.1 2478.5 2480.1 2482.4 2138.7 2357.2 2443.2 2454.7 2456.6 2357.1 2442.2 2455.7 2457.5 2462.2 2310.0 2427.7 2437.6 2440.3 2472.8 2050.8 2126.8 2364.2 2433.5 2448.1 10739.7 10997.7 11008.7 11051.4 11085.2 6263.3 6460.8 6468.8 6481.9 6483.9 4039.9 4075.3 4090.8 4111.4 4148.7 1172.2 1180.2 1223.5 1224.3 1235.9 15062.8 15200.3 15211.7 15330.4 15365.3 5201.5 5366.6 5406.3 5457.7 5509.2 8653.7 9176.2 11073.3 11566.0 11569.9 5147.5 6247.6 6248.3 6268.3 6298.3 5479.0 5835.4 5864.9 5906.9 5935.2 4141.0 4316.6 4348.8 4391.9 4405.6 1037.4 1273.2 1282.2 1290.6 1291.2 605.7 633.7 765.7 778.2 796.6 5884.2 5908.7 6093.7 6125.8 6195.1 573.2 580.9 583.2 585.8 591.0 3800.6 3975.4 4089.4 4278.7 4355.3 13615.3 13973.5 14143.0 14180.3 14192.1 13762.7 13945.7 13984.5 14030.4 14086.8 9857.6 10095.4 10157.6 10270.0 10343.0 6365.6 6490.6 6534.3 6547.6 6550.8 9272.6 11614.0 12045.0 12162.5 12822.9 12720.5 12734.3 12759.0 12927.4 12956.9 8266.2 8282.0 8329.8 8347.0 8411.5 10133.2 10218.9 10259.7 10296.9 10298.9 7580.8 8240.7 8579.6 8671.2 8700.7 7256.9 8369.0 8419.0 8459.5 8504.7 7795.6 7854.8 7913.5 7933.4 7944.7 4793.8 5838.6 5846.9 5896.5 6052.3 5735.7 6057.8 6061.8 6091.3 6113.9 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | [#4] prototype.html Cycles:180 Average:5407.73 Median:6032.11 stddev:1691.41 (28.0%) stddev-sans-first:1653.84 15:31:21 INFO - PID 1658 | Values: 398.5 400.8 400.8 401.5 401.7 4928.9 5267.5 5529.9 6428.8 6461.2 5714.2 6033.6 6196.2 6228.4 6291.9 4359.9 4827.1 4897.6 4905.2 4918.6 3811.2 4972.9 4973.6 4984.6 4989.2 4046.8 4697.6 4818.8 4882.1 4912.6 3534.8 4219.8 4220.8 4893.6 4953.4 3584.9 3881.4 4056.7 4330.4 4338.5 4807.0 5636.3 6030.6 6169.0 6176.2 5699.6 5700.8 5720.7 5722.6 5723.2 6552.7 6789.3 6802.5 6842.2 6847.4 3585.8 4791.9 4802.9 4813.3 4830.8 6223.5 6823.6 7019.9 7048.5 7157.9 4035.5 4102.6 4535.1 4894.4 4906.1 5002.7 5015.3 5022.8 5025.9 5033.6 5178.7 5392.8 5453.2 5647.7 5712.6 5256.8 6218.8 6728.2 6747.6 6823.7 1449.8 1567.1 1571.0 1580.9 1580.9 764.0 878.7 899.1 920.4 1042.6 5678.7 6301.5 6311.5 6326.2 6329.5 6012.6 6683.4 6916.2 6944.6 6951.3 4930.6 5364.1 5755.8 6211.6 6307.8 3200.0 3617.7 3634.5 3656.2 3670.3 6942.2 7012.2 7092.8 7155.6 7169.5 6075.0 6739.0 7180.3 7233.3 7236.0 5989.0 6160.0 6707.7 6802.4 7157.4 5854.8 6952.2 6994.2 7013.6 7025.2 6024.3 6543.1 6776.9 6889.7 6897.4 6494.9 7007.6 7101.3 7135.4 7162.5 3928.1 4517.3 4524.8 4532.5 4555.7 5336.7 6268.0 6865.6 6956.0 7004.3 5645.0 6595.9 6663.2 6666.7 6724.4 6360.4 6691.0 6697.3 6737.3 6775.8 6069.7 6320.4 6623.1 6635.6 6639.0 5779.6 6625.9 6695.4 6784.6 6806.9 5741.3 6250.5 6515.4 6552.2 6572.9 15:31:21 INFO - PID 1658 | 15:31:21 INFO - PID 1658 | [#5] yui.html Cycles:180 Average:18129.98 Median:4155.71 stddev:24890.88 (599.0%) stddev-sans-first:24925.89 15:31:21 INFO - PID 1658 | Values: 596.9 616.5 697.3 733.9 747.9 12904.9 14431.8 15641.3 15784.4 15870.8 14580.6 14622.3 15458.8 16199.5 16364.0 929.6 946.3 947.9 951.9 952.2 736.2 946.6 952.1 955.0 960.4 854.4 998.8 999.8 1002.5 1009.0 1006.5 1008.3 1009.4 1010.2 1010.8 737.2 744.7 747.8 748.6 749.0 15436.7 15983.4 16205.7 16409.9 16651.0 11810.4 13699.3 13835.9 13906.6 13964.1 9633.9 11227.8 11674.6 11809.5 12362.9 2982.5 2989.6 3043.1 3074.1 3097.8 84718.0 88587.6 102273.5 104734.0 105682.5 11172.3 11184.2 11220.4 11454.9 11803.7 23078.8 23149.9 23168.5 23384.9 23385.2 7856.5 7896.5 7963.0 8007.3 8079.3 4128.9 4192.2 4207.2 4233.0 4234.4 4086.5 4151.4 4160.0 4164.3 4171.7 847.3 848.2 861.7 864.9 879.1 528.6 539.3 545.3 547.5 570.5 8668.1 9437.9 9940.7 10113.7 10241.5 488.9 518.9 523.2 566.7 585.5 4589.4 4627.9 4634.5 4637.0 4725.4 90481.6 93583.6 95039.0 95294.5 95716.0 53952.7 59422.4 67186.3 72024.3 74329.6 63793.7 64461.0 65743.0 67780.0 68594.0 9610.8 10574.5 10760.6 10816.6 10983.7 36288.3 36622.7 36638.6 36947.4 38459.6 48979.8 49234.8 49364.5 49541.3 50097.7 10463.6 12153.8 13180.5 13330.3 13633.0 14143.8 14257.1 14414.3 14518.3 14614.9 10868.5 11402.9 13479.7 13482.0 14072.2 10989.8 13443.2 13464.7 13559.3 13636.8 13080.7 13185.4 13344.3 13563.6 13790.7 9496.8 9601.0 9627.2 9707.6 9800.2 9519.9 9904.7 10849.3 11313.9 11351.8 15:31:21 INFO - PID 1658 | -------- Summary: end -------- 15:31:21 INFO - PID 1658 | 15:31:22 INFO - TEST-INFO | 1658: exit 0 15:31:22 INFO - TEST-OK | dromaeo_css | took 1117592ms 15:31:22 INFO - TEST-START | kraken 15:31:22 INFO - operating with platform_type : mac_ 15:31:22 INFO - Initialising browser for kraken test... 15:31:22 INFO - TEST-INFO | started process 1782 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpQk5Ry1/profile http://localhost:49244/getInfo.html) 15:31:25 INFO - PID 1782 | 2017-03-23 15:31:25.375 plugin-container[1783:10444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 15:31:25 INFO - PID 1782 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:31:25 INFO - PID 1782 | 2017-03-23 15:31:25.378 plugin-container[1783:10444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1b, name = 'com.apple.CFPasteboardClient' 15:31:25 INFO - PID 1782 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:31:25 INFO - PID 1782 | 2017-03-23 15:31:25.378 plugin-container[1783:10444] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:31:25 INFO - PID 1782 | __metrics Screen width/height:1600/1200 15:31:25 INFO - PID 1782 | colorDepth:24 15:31:25 INFO - PID 1782 | Browser inner width/height: 1024/689 15:31:25 INFO - PID 1782 | __metrics 15:31:25 ERROR - PID 1782 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 15:31:26 INFO - TEST-INFO | 1782: exit 0 15:31:26 INFO - Browser initialized. 15:31:26 INFO - Running cycle 1/1 for kraken test... 15:31:26 INFO - TEST-INFO | started process 1784 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpQk5Ry1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:28 INFO - PID 1784 | 2017-03-23 15:31:28.762 plugin-container[1786:10572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 15:31:28 INFO - PID 1784 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:31:28 INFO - PID 1784 | 2017-03-23 15:31:28.764 plugin-container[1786:10572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 15:31:28 INFO - PID 1784 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:31:28 INFO - PID 1784 | 2017-03-23 15:31:28.764 plugin-container[1786:10572] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:31:38 INFO - PID 1784 | RSS: Main: 229302272 15:31:38 INFO - PID 1784 | 15:31:41 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 15:31:42 INFO - PID 1784 | RSS: Main: 243200000 15:31:42 INFO - PID 1784 | 15:31:44 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 15:31:45 INFO - PID 1784 | RSS: Main: 251740160 15:31:45 INFO - PID 1784 | 15:31:48 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 15:31:49 INFO - PID 1784 | RSS: Main: 254332928 15:31:49 INFO - PID 1784 | 15:31:51 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 15:31:51 INFO - PID 1784 | RSS: Main: 256577536 15:31:51 INFO - PID 1784 | 15:31:53 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:31:54 INFO - PID 1784 | RSS: Main: 257241088 15:31:54 INFO - PID 1784 | 15:31:57 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 15:31:58 INFO - PID 1784 | RSS: Main: 262778880 15:31:58 INFO - PID 1784 | 15:32:01 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:01 INFO - PID 1784 | RSS: Main: 264282112 15:32:01 INFO - PID 1784 | 15:32:04 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 15:32:05 INFO - PID 1784 | RSS: Main: 263802880 15:32:05 INFO - PID 1784 | 15:32:07 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:07 INFO - PID 1784 | RSS: Main: 262971392 15:32:07 INFO - PID 1784 | 15:32:09 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:10 INFO - PID 1784 | RSS: Main: 263102464 15:32:10 INFO - PID 1784 | 15:32:12 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:12 INFO - PID 1784 | RSS: Main: 263057408 15:32:12 INFO - PID 1784 | 15:32:15 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:16 INFO - PID 1784 | RSS: Main: 263008256 15:32:16 INFO - PID 1784 | 15:32:20 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:20 INFO - PID 1784 | RSS: Main: 260603904 15:32:20 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 15:32:22 INFO - PID 1784 | RSS: Main: 262303744 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | __start_tp_report 15:32:22 INFO - PID 1784 | _x_x_mozilla_page_load 15:32:22 INFO - PID 1784 | _x_x_mozilla_page_load_details 15:32:22 INFO - PID 1784 | |i|pagename|runs| 15:32:22 INFO - PID 1784 | |0;ai-astar;104;117;115;114;114;114;116;114;122;159 15:32:22 INFO - PID 1784 | |1;audio-beat-detection;147;115;113;155;127;149;148;117;132;114 15:32:22 INFO - PID 1784 | |2;audio-dft;196;204;206;198;209;225;199;201;197;195 15:32:22 INFO - PID 1784 | |3;audio-fft;85;60;60;88;61;58;60;65;75;60 15:32:22 INFO - PID 1784 | |4;audio-oscillator;82;72;85;71;72;71;86;56;95;117 15:32:22 INFO - PID 1784 | |5;imaging-gaussian-blur;89;89;90;89;91;89;95;110;89;90 15:32:22 INFO - PID 1784 | |6;imaging-darkroom;129;98;98;99;98;98;96;97;100;98 15:32:22 INFO - PID 1784 | |7;imaging-desaturate;91;106;113;91;91;97;118;89;92;91 15:32:22 INFO - PID 1784 | |8;json-parse-financial;68;67;67;68;68;68;68;68;69;68 15:32:22 INFO - PID 1784 | |9;json-stringify-tinderbox;73;92;92;63;64;58;60;58;59;60 15:32:22 INFO - PID 1784 | |10;stanford-crypto-aes;82;85;87;85;83;84;84;87;84;74 15:32:22 INFO - PID 1784 | |11;stanford-crypto-ccm;140;142;138;153;132;139;152;151;212;159 15:32:22 INFO - PID 1784 | |12;stanford-crypto-pbkdf2;179;194;193;235;251;199;247;247;193;193 15:32:22 INFO - PID 1784 | |13;stanford-crypto-sha256-iterative;70;70;67;71;75;61;60;74;68;93 15:32:22 INFO - PID 1784 | __end_tp_report 15:32:22 INFO - PID 1784 | __start_cc_report 15:32:22 INFO - PID 1784 | _x_x_mozilla_cycle_collect,1015 15:32:22 INFO - PID 1784 | __end_cc_report 15:32:22 INFO - PID 1784 | __startTimestamp1490308342680__endTimestamp 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | ------- Summary: start ------- 15:32:22 INFO - PID 1784 | Number of tests: 14 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#0] ai-astar Cycles:10 Average:118.90 Median:115.50 stddev:14.77 (12.8%) stddev-sans-first:14.65 15:32:22 INFO - PID 1784 | Values: 104.0 117.0 115.0 114.0 114.0 114.0 116.0 114.0 122.0 159.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:139.50 stddev:16.74 (12.0%) stddev-sans-first:16.82 15:32:22 INFO - PID 1784 | Values: 147.0 115.0 113.0 155.0 127.0 149.0 148.0 117.0 132.0 114.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#2] audio-dft Cycles:10 Average:203.00 Median:202.50 stddev:8.97 (4.4%) stddev-sans-first:9.15 15:32:22 INFO - PID 1784 | Values: 196.0 204.0 206.0 198.0 209.0 225.0 199.0 201.0 197.0 195.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#3] audio-fft Cycles:10 Average:67.20 Median:63.00 stddev:11.28 (17.9%) stddev-sans-first:9.96 15:32:22 INFO - PID 1784 | Values: 85.0 60.0 60.0 88.0 61.0 58.0 60.0 65.0 75.0 60.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#4] audio-oscillator Cycles:10 Average:80.70 Median:77.00 stddev:16.73 (21.7%) stddev-sans-first:17.74 15:32:22 INFO - PID 1784 | Values: 82.0 72.0 85.0 71.0 72.0 71.0 86.0 56.0 95.0 117.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:89.50 stddev:6.56 (7.3%) stddev-sans-first:6.86 15:32:22 INFO - PID 1784 | Values: 89.0 89.0 90.0 89.0 91.0 89.0 95.0 110.0 89.0 90.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:98.00 stddev:9.86 (10.1%) stddev-sans-first:1.12 15:32:22 INFO - PID 1784 | Values: 129.0 98.0 98.0 99.0 98.0 98.0 96.0 97.0 100.0 98.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:91.00 stddev:10.56 (11.6%) stddev-sans-first:10.90 15:32:22 INFO - PID 1784 | Values: 91.0 106.0 113.0 91.0 91.0 97.0 118.0 89.0 92.0 91.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 15:32:22 INFO - PID 1784 | Values: 68.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:63.50 stddev:13.44 (21.2%) stddev-sans-first:14.13 15:32:22 INFO - PID 1784 | Values: 73.0 92.0 92.0 63.0 64.0 58.0 60.0 58.0 59.0 60.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.50 stddev:3.69 (4.4%) stddev-sans-first:3.87 15:32:22 INFO - PID 1784 | Values: 82.0 85.0 87.0 85.0 83.0 84.0 84.0 87.0 84.0 74.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:151.50 stddev:22.75 (15.0%) stddev-sans-first:23.73 15:32:22 INFO - PID 1784 | Values: 140.0 142.0 138.0 153.0 132.0 139.0 152.0 151.0 212.0 159.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:213.10 Median:217.00 stddev:28.19 (13.0%) stddev-sans-first:27.07 15:32:22 INFO - PID 1784 | Values: 179.0 194.0 193.0 235.0 251.0 199.0 247.0 247.0 193.0 193.0 15:32:22 INFO - PID 1784 | 15:32:22 INFO - PID 1784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:9.17 (13.0%) stddev-sans-first:9.72 15:32:22 INFO - PID 1784 | Values: 70.0 70.0 67.0 71.0 75.0 61.0 60.0 74.0 68.0 93.0 15:32:22 INFO - PID 1784 | -------- Summary: end -------- 15:32:22 INFO - PID 1784 | 15:32:23 INFO - TEST-INFO | 1784: exit 0 15:32:23 INFO - TEST-OK | kraken | took 61325ms 15:32:23 INFO - SUITE-END | took 1178s 15:32:24 INFO - Completed test suite (00:19:39) 15:32:24 INFO - javascript benchmark 15:32:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7654.7672436575185, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3494.6505349465046, 3562.821858907054, 3627.183883626186, 3630.600633930267, 3637.5998640149587, 5663.377028526864, 6107.158472117341, 6110.847228819276, 6226.3462336454695, 6271.498280137589, 6107.279845777768, 6162.630242185472, 6205.534584906128, 6229.937700623003, 6253.71858266378, 5589.854079913608, 5627.634203776762, 5745.626534275259, 5775.740091695863, 5816.738246778884, 5530.861728456781, 5612.85967850805, 5758.0, 5813.128030795372, 5838.503727183194, 5476.26070480484, 5538.169274608841, 5562.749676264578, 5702.0, 5726.940516004553, 5541.778328866841, 5543.501084902337, 5584.994700953867, 5672.035753921802, 5710.343310519302, 5542.695151766651, 5611.719414029323, 5619.269494965669, 5646.322441307028, 5668.858278543028, 5969.850753731148, 6170.7223174957235, 6184.31972483031, 6196.721147548326, 6202.503799696014, 6438.806835794933, 6565.507586930951, 6645.368689974444, 6702.396784289389, 6707.429868461187, 6725.125733654642, 6737.258901520829, 6752.953292239662, 6799.966000170017, 6830.897536536956, 6247.125402443661, 6280.371962803683, 6288.496920246369, 6295.055741638745, 6295.181626388632, 6589.670516474157, 6620.337966203341, 6772.2211945625895, 6925.445964322842, 6926.896096558556, 6293.181886354744, 6353.174087368612, 6503.837404064841, 6504.38208370204, 6574.178227721535, 6583.407493325623, 6736.989451582302, 6749.392554670005, 6757.662116894136, 6761.797146085625, 6586.440152586988, 6653.367930046637, 6673.432758215606, 6677.29888361715, 6686.364795344434, 6307.621542707452, 6398.008308712064, 6675.198976122896, 6683.2314283857, 6709.563878347892, 5253.763580638881, 5264.289320941624, 5265.341832270966, 5316.813911513079, 5323.494268044529, 4715.434147902273, 4759.666823322404, 4760.166970780169, 4760.33355330254, 4804.597701149425, 6245.906311405332, 6257.78097766576, 6293.118963345135, 6305.117283580303, 6311.084892690534, 6447.0, 6524.706388212542, 6722.159730033746, 6738.0, 6742.595444273359, 6259.937400626027, 6294.496440284766, 6302.306746257908, 6304.653244071528, 6307.558470906993, 4945.629077819106, 5878.059510478389, 5914.260717410324, 5920.970395148083, 5921.082232254007, 5516.310461192351, 6509.251436084911, 6578.76974305897, 6783.932160678528, 6850.520463567503, 6598.27418983921, 6613.570117942319, 6707.966460167668, 6708.899366509604, 6722.630255335808, 6835.965820170867, 6838.863222735617, 6848.486363522656, 6867.3476019778045, 6882.7591034315565, 6345.90481142774, 6503.154589903472, 6628.436582890508, 6652.168478940132, 6653.268140504638, 5407.540359069523, 6635.933640663531, 6687.933120668731, 6692.83267918306, 6725.8991115134295, 6484.773032943825, 6503.284638689645, 6503.967480162758, 6519.022146678036, 6519.4132528072705, 6120.755169793337, 6238.064290356483, 6317.873642527032, 6354.650494222862, 6464.967675161594, 5087.491250874883, 6279.748810047729, 6337.968310158604, 6338.492920566436, 6350.714217860115, 6499.2200935887995, 6517.185351831021, 6517.217933847968, 6528.053432252202, 6536.607803531613, 6173.0, 6210.782622608187, 6257.812265632038, 6373.490120790233, 6374.936250637435], "value": 6099.382541047803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.3344889426176, 741.5550669598242, 830.6801881275709, 1259.4647274908161, 1272.5609664665687, 31290.843545782267, 36664.083397915034, 38812.83561493153, 38842.417363739565, 38869.61130388695, 38827.0, 39001.804990975004, 39228.21543569127, 39269.803650981776, 39300.60699393005, 8148.755537333875, 8301.211384918422, 8605.440646357998, 8818.735437936872, 8824.117588241188, 8720.0, 8789.736307910742, 8836.955815220947, 8852.070532594082, 8855.24730397917, 8799.34004949628, 8850.867236991451, 8853.203211710945, 8860.556972151398, 8863.601137948775, 8784.165504277084, 8811.95594022029, 8836.33727470439, 8837.646494140226, 8845.911540884637, 8617.956910215471, 8656.956715216447, 8719.171678690514, 8727.738167854974, 8742.737717868475, 31700.365992680247, 39507.20985580301, 39598.20803583941, 39743.40384894229, 39767.40348894769, 2742.794290428206, 3014.2464383904025, 3029.59100521429, 3038.7417069549115, 3070.140360699008, 28543.714562854315, 28824.135275941757, 28953.855230723922, 29112.563311550133, 29357.559636605467, 2685.0333879803256, 2687.1401151631485, 2711.3221694576355, 2727.1409506005543, 2730.945381092367, 300068.0, 334931.0, 341591.2920435407, 342472.0, 346807.0, 49119.0, 49845.25232121521, 49867.50132498701, 49885.0, 50057.0, 53499.0, 53598.0, 53625.731871340395, 53681.463185368426, 53765.0, 12992.350382480838, 13224.677532246698, 14243.78634320486, 14358.641033974234, 14578.562643120724, 11642.825357619642, 11673.124515661359, 11684.824727629093, 11700.180987330805, 11708.824367634492, 12451.066170037102, 13982.930085349508, 14174.85825141756, 14214.360353784105, 14234.786478202835, 6030.18592490017, 6055.788047418319, 6090.208272924491, 6108.17539632144, 6120.326764055951, 813.6094674556127, 906.4425378392241, 956.7179978828403, 959.6785076999143, 976.951152442375, 19977.900110499355, 22525.953621574336, 22954.54090918206, 25564.744352556238, 25602.359941001625, 1042.2339580408393, 1070.8340207267886, 1072.1851392941421, 1106.8395082712962, 1114.570890207276, 12352.320622365856, 13020.869791302155, 13024.0, 13059.869401306056, 13086.280254586089, 469383.0, 469409.0, 473194.0, 474091.0, 474615.0, 57320.71339643275, 57366.71316643473, 57594.7120264396, 57631.71184144053, 57748.13377799336, 1450.3690894460942, 1463.1733070814955, 1477.135875512837, 1484.1540322016563, 1488.3153749275455, 22985.540289194458, 26618.86690566535, 28093.57859632148, 28531.42937141204, 30530.694693052785, 40583.39124913188, 40990.180196396504, 41006.949652517855, 41114.58885411227, 41203.58796412117, 419849.0, 423349.0, 425245.0, 427293.0, 427523.0, 28712.569311460764, 33917.8128765492, 35072.824635876656, 35883.64116358803, 36378.0, 43267.35098973581, 43899.56100438955, 45000.77499612481, 45077.0, 45770.0, 23438.29685109381, 29966.70033299639, 30446.0, 30539.389212216076, 30775.2306192347, 30377.088687339416, 30425.847870760503, 31046.689533105284, 31114.844425777726, 31249.68750312468, 36339.091522712144, 37347.439788402655, 37355.252894942496, 37433.43849842309, 37502.43746343753, 23718.0, 26042.479150416508, 30859.537106942964, 31342.0, 31404.528932066496, 23682.0, 24759.0, 24791.62812557777, 25240.495190096462, 25265.989360425378], "value": 18009.50043521346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.0839195729184, 427.7680280791321, 436.4108453587657, 443.52985835014886, 453.4490593928376, 19858.801411985856, 21596.460088497777, 22128.22551210708, 22315.55368892621, 22445.3266402008, 19428.805711942878, 21461.785382146172, 22110.557788844253, 22512.0, 22893.19873804417, 6189.597676151047, 6376.776812811552, 6395.488360931115, 6401.647909364983, 6422.325655806143, 5967.582269241155, 6277.780277690282, 6295.842603934892, 6342.112104305401, 6345.999999999977, 4903.2645103234445, 5314.521693047625, 5404.891902161954, 6246.562740608159, 6279.497640188797, 4777.784999675006, 6281.246250449953, 6298.937010629881, 6310.747570097191, 6333.968330158343, 4791.425028996543, 5402.864928376783, 5493.176023596453, 5582.609217354787, 5588.804391846266, 18100.366487172887, 26299.0, 26543.601845972134, 26830.731692683017, 27286.181414557595, 1889.3387314439835, 1910.4077735901776, 1928.4503916383903, 1949.87325823821, 1956.2859556261863, 14889.776653350209, 15366.028994768198, 15781.0, 15807.367705291774, 16067.517974460668, 1609.3079975610483, 1692.9153542322958, 1715.3609983163242, 1719.6474722681821, 1727.9308827646878, 150124.2493787524, 159699.0, 160376.0, 162769.18615406967, 163863.0, 12347.938260308641, 12404.19372740787, 12424.503019879103, 12427.005839532816, 12642.367881606067, 16198.919005404898, 16345.754813677804, 16367.91816040912, 16384.344626215057, 16442.177891105395, 7000.50996430245, 8858.335624828034, 8858.335624828163, 9008.0, 9031.232345250595, 8245.299149572353, 8264.8347033059, 8297.25324720766, 8422.28410585095, 8443.95778021106, 7704.072452468138, 7765.572893490799, 7836.921630783733, 7883.448158628956, 7893.447458677838, 2139.261954625683, 2144.4960434297927, 2150.193677370986, 2155.5365596396537, 2350.74141844397, 855.4054931822449, 917.9495127767904, 923.6813299411692, 960.9231261499064, 966.8839739231197, 19483.0, 19970.406806434312, 20036.599268014557, 20067.498312542302, 20442.795572044088, 949.4635530925005, 950.8098380323963, 989.366805244644, 990.7622170678985, 991.8958509356557, 8350.62422191003, 9643.855342169873, 10342.172626189888, 10357.0, 10397.428141452141, 696097.0, 713712.0, 729660.0, 731692.3415382996, 733297.0, 95622.0, 115596.0, 137582.0, 155274.447255526, 163401.0, 1088.1294964028746, 1184.1059999700171, 1230.6369620961839, 1246.1028059796931, 1246.1962034487706, 21236.25673101434, 21396.893015535446, 21579.352619421443, 21660.241891533722, 21673.241436549644, 51713.741431292605, 59290.0, 60086.69956650189, 61246.38753612407, 64821.67589162024, 67834.98247526192, 77978.22021779709, 81986.59006704928, 83552.0, 85540.0, 8009.879851802344, 8383.58082095905, 8480.279176270085, 8495.532745699045, 8692.739217823475, 11804.881951180721, 12008.85915837994, 13162.47350105985, 13343.399547020601, 13685.384157712728, 10528.473576321307, 11440.771184576095, 11560.768784624428, 11691.590794322497, 12052.638420847388, 9559.474228917476, 9748.415095094317, 10560.84158737635, 10651.094656954245, 11000.449977501254, 11637.301761894314, 11807.940960295144, 12096.879031209575, 12115.394230288626, 12295.508179672714, 8396.370272229486, 8434.493930364199, 8591.0, 8850.291976641724, 8854.911450885666, 11350.489227984926, 11712.648620541397, 11768.646940591796, 11812.936835684486, 12050.276983380674], "value": 10245.484415979166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.9243791591464, 1388.8402833674124, 1396.2669598460814, 1405.8102156208909, 1426.9001169918104, 10463.895361046387, 10788.460576971149, 10803.189760767935, 10935.507902144403, 10977.945110274457, 10768.569257229701, 10874.45627718613, 10987.61543345983, 10995.395253261067, 11020.173486988488, 2432.282476669378, 2463.1009681466317, 2478.50429914017, 2480.1071614218868, 2482.429041320497, 2138.721966144399, 2357.210334537932, 2443.1571107967725, 2454.7177074636465, 2456.5701002324613, 2357.1043003658588, 2442.206282958037, 2455.72986971433, 2457.4716435966266, 2462.175171317602, 2309.9653505197434, 2427.720812106613, 2437.5612389769835, 2440.316711320842, 2472.814538909589, 2050.7744148143693, 2126.808587227157, 2364.1961733010685, 2433.4646377797035, 2448.094205144108, 10739.731506712316, 10997.670069897917, 11008.669739907815, 11051.392173430459, 11085.168612354106, 6263.279722831887, 6460.773872914472, 6468.773592924272, 6481.902771458432, 6483.902741458882, 4039.8990025249605, 4075.286824805647, 4090.795460226977, 4111.376006477425, 4148.668106551469, 1172.226330621794, 1180.1797750563362, 1223.5105957616936, 1224.3205021213223, 1235.925844449336, 15062.849371506363, 15200.315985780666, 15211.695766084616, 15330.386784528606, 15365.308561114889, 5201.505856943584, 5366.6243362964215, 5406.324209473816, 5457.672539647634, 5509.228707980886, 8653.740387788377, 9176.220021298264, 11073.335599864035, 11566.0, 11569.88430115705, 5147.485251474897, 6247.625142491465, 6248.343923888017, 6268.341824108494, 6298.338674439209, 5479.0, 5835.387284335168, 5864.8533786654825, 5906.8818623627285, 5935.169076329317, 4141.0, 4316.611504964505, 4348.826046958086, 4391.890202744957, 4405.647548196137, 1037.3568387599585, 1273.1660762200772, 1282.205032879602, 1290.5805613175755, 1291.180100636103, 605.6729366142234, 633.7306644675995, 765.6745882999703, 778.1829079466537, 796.5857753967904, 5884.176215329857, 5908.675022873783, 6093.69531523422, 6125.754969801158, 6195.132681424604, 573.1860757724041, 580.8547863034241, 583.2417856786161, 585.7656937225144, 591.045461579546, 3800.600936901641, 3975.4036894465485, 4089.427480152781, 4278.657707383401, 4355.281378572563, 13615.25116118623, 13973.510927117502, 14143.0, 14180.290985450893, 14192.077514961495, 13762.65593360154, 13945.721085578232, 13984.51054213118, 14030.368633411521, 14086.78869816933, 9857.605695772232, 10095.444750538643, 10157.644482443227, 10269.99999999985, 10343.0, 6365.554411191172, 6490.578112422866, 6534.346565343428, 6547.574407663486, 6550.7707230246715, 9272.6290948364, 11614.0, 12045.0, 12162.452689629165, 12822.935885320514, 12720.491180352683, 12734.299613521345, 12759.0, 12927.353632318534, 12956.935215323863, 8266.214709602578, 8282.047564530156, 8329.83340333202, 8346.998360196816, 8411.495310281403, 10133.240006999356, 10218.897811021794, 10259.717535308086, 10296.897031029594, 10298.948505257726, 7580.772576822704, 8240.670373185005, 8579.575815384338, 8671.21959023691, 8700.695475658322, 7256.9274307256255, 8369.0375606806, 8418.957905210435, 8459.492430454193, 8504.659813607386, 7795.610219489116, 7854.764357069297, 7913.525188488709, 7933.444658873824, 7944.682212711658, 4793.808247670054, 5838.649681019152, 5846.94153058481, 5896.469317761251, 6052.334243233329, 5735.655860648374, 6057.818265452043, 6061.817346031225, 6091.329953705001, 6113.908291375722], "value": 5061.974082034333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.50187265917606, 400.7535365750065, 400.77356293694044, 401.4560270833021, 401.68848708965214, 4928.901421971558, 5267.499587539182, 5529.944700552994, 6428.839279018027, 6461.22465304163, 5714.200011998323, 6033.6379817211, 6196.225471816012, 6228.377162283769, 6291.937080629193, 4359.904467827831, 4827.131116399047, 4897.600175913813, 4905.23968784839, 4918.557329840313, 3811.1805961718223, 4972.925406118911, 4973.552380285773, 4984.551390374865, 4989.176785830334, 4046.817893194813, 4697.647676424264, 4818.831340903069, 4882.145624515713, 4912.606991440676, 3534.7759427484166, 4219.7551722242015, 4220.767857767822, 4893.608511319086, 4953.380827396575, 3584.874529391485, 3881.359575670011, 4056.675465962716, 4330.350447432878, 4338.522762496123, 4806.975965120187, 5636.2954630671165, 6030.577859549833, 6168.9691551541955, 6176.197094377702, 5699.572532060112, 5700.828975130753, 5720.685362305072, 5722.570807189478, 5723.227364305849, 6552.7378904843745, 6789.321067893221, 6802.537454447268, 6842.247352791189, 6847.383735463783, 3585.7848529088337, 4791.856244312677, 4802.879928001793, 4813.253945638432, 4830.830920917751, 6223.533235007392, 6823.55646882951, 7019.92980070203, 7048.5241871411, 7157.928420715778, 4035.535913369941, 4102.569230230843, 4535.138323718483, 4894.412670479494, 4906.116898958222, 5002.724850133205, 5015.3229314042865, 5022.824201153016, 5025.874353141127, 5033.647644664911, 5178.6597644519825, 5392.838214853561, 5453.15476101205, 5647.661140331593, 5712.600117991784, 5256.816011439581, 6218.756248750177, 6728.158980127484, 6747.561408508432, 6823.69293381799, 1449.8187726534184, 1567.0519335801903, 1570.9842901571067, 1580.9170718058167, 1580.936762529486, 764.0220517737305, 878.725847521097, 899.0694631056825, 920.3695468604028, 1042.5725452564411, 5678.744456499468, 6301.487642965747, 6311.526635502356, 6326.2092238470195, 6329.525285603599, 6012.6392416455155, 6683.36257616887, 6916.23921368649, 6944.618046007417, 6951.339622735832, 4930.556249937523, 5364.103384172581, 5755.841249862607, 6211.565190436626, 6307.846076961519, 3199.9520007199912, 3617.656322649344, 3634.491171236029, 3656.213914008501, 3670.284294562535, 6942.236354001056, 7012.228654847962, 7092.787216383414, 7155.606441645656, 7169.4981351304905, 6074.967255566565, 6738.966305168443, 7180.31786980236, 7233.276672332725, 7235.963820180866, 5989.041753319448, 6159.96920015406, 6707.6981535831, 6802.387785099365, 7157.4274058075225, 5854.750613409428, 6952.165740111219, 6994.160700715946, 7013.614251216232, 7025.156981162293, 6024.307204671519, 6543.149390579194, 6776.864462710817, 6889.658515620021, 6897.448204143556, 6494.91491541514, 7007.649617519001, 7101.325374089453, 7135.357817796424, 7162.534435261691, 3928.09653779638, 4517.277235642281, 4524.751138687404, 4532.546745325441, 4555.749433781174, 5336.706481143419, 6267.96866015667, 6865.5537390069485, 6955.965220173866, 7004.264552221944, 5645.0, 6595.94464885616, 6663.167104111986, 6666.733330666913, 6724.428423583854, 6360.4275615193, 6690.966545167243, 6697.2633010367845, 6737.292584278776, 6775.762848300483, 6069.666168360783, 6320.4311611955145, 6623.072769812326, 6635.568688035262, 6639.004149377439, 5779.566532510163, 6625.933740662532, 6695.363940425652, 6784.59292442455, 6806.944923536859, 5741.339745929272, 6250.531210159165, 6515.446187074152, 6552.180977377828, 6572.934270657232], "value": 4867.927543057708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.8806238752248, 616.5067945643485, 697.3410127429581, 733.9302766237209, 747.947643664943, 12904.870951290484, 14431.773299269562, 15641.296141673623, 15784.44754433595, 15870.841291587096, 14580.562583122497, 14622.341994610242, 15458.84541154588, 16199.514014579552, 16364.0, 929.60027188309, 946.2950102173891, 947.9146876781089, 951.8572214167896, 952.2191802721771, 736.2343163110359, 946.6497395963503, 952.0574631115215, 955.0211033690488, 960.3805545423198, 854.3805740837873, 998.7802683409639, 999.7650552120245, 1002.5338217728755, 1009.0363702663975, 1006.4816619440994, 1008.2841182760249, 1009.3792317724583, 1010.151472762879, 1010.8332125199333, 737.200137850433, 744.6686224630042, 747.8392145688649, 748.580794754939, 749.0412272291476, 15436.691266174726, 15983.360665573364, 16205.675886482322, 16409.91795041029, 16651.000939943642, 11810.350430726307, 13699.260147970446, 13835.930820345833, 13906.58280251594, 13964.092333998258, 9633.886421130233, 11227.831582526269, 11674.591389301419, 11809.527618895234, 12362.938185309016, 2982.4631566318053, 2989.5964044853886, 3043.117495926179, 3074.0777766669908, 3097.798643088192, 84718.0, 88587.55706221492, 102273.4658980116, 104734.0, 105682.47158764234, 11172.273802202832, 11184.161187910939, 11220.438978051065, 11454.885451145381, 11803.704907377385, 23078.769212307998, 23149.884250578976, 23168.53662926732, 23384.883075584512, 23385.181518646765, 7856.528608283521, 7896.526208427513, 7963.0, 8007.319377852948, 8079.272865442138, 4128.896777580524, 4192.151948032539, 4207.200631879933, 4233.0, 4234.3860140279485, 4086.4891888513935, 4151.418801367811, 4160.00159961607, 4164.312888373384, 4171.687123465752, 847.2967437027253, 848.2058709734944, 861.6553378648465, 864.9264812491009, 879.1164879296266, 528.6009063157292, 539.3366159623685, 545.3401384325011, 547.460751160107, 570.4552152694167, 8668.140466792154, 9437.868199073162, 9940.658011168543, 10113.747156321151, 10241.48792560369, 488.93888263967006, 518.8780636550408, 523.2047288122034, 566.7251383079204, 585.5257241634205, 4589.380433641482, 4627.8843028923875, 4634.513376095461, 4637.0, 4725.432948046187, 90481.6427753571, 93583.59624605636, 95039.0, 95294.52352738331, 95716.0, 53952.730236348565, 59422.40577594255, 67186.32034199087, 72024.2797572028, 74329.62835185898, 63793.68103159455, 64461.03308450377, 65743.0, 67780.0, 68594.0, 9610.807783844424, 10574.524146413583, 10760.623378181726, 10816.56733730642, 10983.725406864893, 36288.27423451569, 36622.71820486377, 36638.63361366352, 36947.44578831374, 38459.61540384672, 48979.75510122427, 49234.769130772016, 49364.50635493599, 49541.25688114609, 50097.74951125221, 10463.633772817915, 12153.84538468844, 13180.472781088649, 13330.266835323762, 13632.97752668534, 14143.787843182155, 14257.122088681479, 14414.279286035446, 14518.346674399467, 14614.853851461774, 10868.456577171268, 11402.94298528502, 13479.663008424868, 13481.97230181477, 14072.155670659384, 10989.835152472879, 13443.193408395528, 13464.730705386033, 13559.254241016839, 13636.795448068486, 13080.672983175116, 13185.40665670028, 13344.332783360987, 13563.623827771566, 13790.65523361924, 9496.843806869818, 9601.0, 9627.229821614394, 9707.563159657691, 9800.166985806287, 9519.857617085994, 9904.724292836987, 10849.294795838245, 11313.886861131612, 11351.829722554003], "value": 7253.96928274148, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 115.0, 114.0, 114.0, 114.0, 116.0, 114.0, 122.0, 159.0], "value": 118.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 113.0, 155.0, 127.0, 149.0, 148.0, 117.0, 132.0, 114.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 204.0, 206.0, 198.0, 209.0, 225.0, 199.0, 201.0, 197.0, 195.0], "value": 203.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 60.0, 88.0, 61.0, 58.0, 60.0, 65.0, 75.0, 60.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 85.0, 71.0, 72.0, 71.0, 86.0, 56.0, 95.0, 117.0], "value": 80.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 89.0, 91.0, 89.0, 95.0, 110.0, 89.0, 90.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 98.0, 98.0, 99.0, 98.0, 98.0, 96.0, 97.0, 100.0, 98.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 106.0, 113.0, 91.0, 91.0, 97.0, 118.0, 89.0, 92.0, 91.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 92.0, 92.0, 63.0, 64.0, 58.0, 60.0, 58.0, 59.0, 60.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 87.0, 85.0, 83.0, 84.0, 84.0, 87.0, 84.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 138.0, 153.0, 132.0, 139.0, 152.0, 151.0, 212.0, 159.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 194.0, 193.0, 235.0, 251.0, 199.0, 247.0, 247.0, 193.0, 193.0], "value": 213.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 67.0, 71.0, 75.0, 61.0, 60.0, 74.0, 68.0, 93.0], "value": 70.9, "unit": "score"}]}]} 15:32:24 INFO - Return code: 0 15:32:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:32:24 ERROR - # TBPL SUCCESS # 15:32:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:32:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:32:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:32:24 INFO - 2017-03-23 15:32:24.467 screenresolution[1795:10960] starting screenresolution argv=screenresolution get 15:32:24 INFO - 2017-03-23 15:32:24.470 screenresolution[1795:10960] Display 0: 1600x1200x32@60 15:32:24 INFO - 2017-03-23 15:32:24.476 screenresolution[1796:10963] starting screenresolution argv=screenresolution list 15:32:24 INFO - Available Modes on Display 0 15:32:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:32:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:32:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:32:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:32:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:32:24 INFO - Intel Iris: 15:32:24 INFO - Chipset Model: Intel Iris 15:32:24 INFO - Type: GPU 15:32:24 INFO - Bus: Built-In 15:32:24 INFO - VRAM (Dynamic, Max): 1536 MB 15:32:24 INFO - Vendor: Intel (0x8086) 15:32:24 INFO - Device ID: 0x0a2e 15:32:24 INFO - Revision ID: 0x0009 15:32:24 INFO - Displays: 15:32:24 INFO - Display: 15:32:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:32:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:32:24 INFO - Display Serial Number: 1600x1200 60 15:32:24 INFO - Main Display: Yes 15:32:24 INFO - Mirror: Off 15:32:24 INFO - Online: Yes 15:32:24 INFO - Rotation: Supported 15:32:24 INFO - Return code: 0 15:32:24 INFO - Running post-action listener: _resource_record_post_action 15:32:24 INFO - [mozharness: 2017-03-23 22:32:24.712773Z] Finished run-tests step (success) 15:32:24 INFO - Running post-run listener: _resource_record_post_run 15:32:24 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39295488; Write bytes: 521527296; Read time: 257; Write time: 1703 15:32:24 INFO - TinderboxPrint: CPU usage
54.1% 15:32:24 INFO - TinderboxPrint: I/O read bytes / time
39,295,488 / 257 15:32:24 INFO - TinderboxPrint: I/O write bytes / time
521,527,296 / 1,703 15:32:24 INFO - TinderboxPrint: CPU idle
2,205.8 (45.9%) 15:32:24 INFO - TinderboxPrint: CPU system
966.0 (20.1%) 15:32:24 INFO - TinderboxPrint: CPU user
1,629.7 (33.9%) 15:32:24 INFO - TinderboxPrint: Swap in / out
250,355,712 / 0 15:32:24 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202713600; Write bytes: 202031104; Read time: 15948; Write time: 445 15:32:24 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 38316544; Write bytes: 307410944; Read time: 239; Write time: 1218 15:32:25 INFO - Running post-run listener: _upload_blobber_files 15:32:25 INFO - Blob upload gear active. 15:32:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:25 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 15:32:25 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:32:25 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:32:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:26 INFO - (blobuploader) - INFO - Done attempting. 15:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:32:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:27 INFO - (blobuploader) - INFO - Done attempting. 15:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:28 INFO - (blobuploader) - INFO - Done attempting. 15:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:31 INFO - (blobuploader) - INFO - Done attempting. 15:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 15:32:31 INFO - Return code: 0 15:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca8c4b724ad6ac18de4fbcb2ba32dd30322676df8c70c3d9c65e2d60443b5b1c1596d3d77e00c24f7dd73b3b20766779a55433b5835baa489a208b373e2fab7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4f75060699b02406dc77645b458b9be2cfd52c0d442c66f26b36cdff64e8f53ce0379c73fe799daa5dd73d2fa3df703efe9fb4317dc047e53fbea75fab21c6e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7f2e845cf064cf3de390e70d6515c0ddfda3b35c53c56d4b34802240af9c3085ccce9f4333b4178b6a85ae93937474d262772536515f1d37a0b58d465695809c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/06dea847656addfe8b1a92eec08db43913af14d174bc6c3fd55b8c12f6a3516102af7e43a3210f03ab23d28342e12a2e039415a638ca737d428ea7d89acf8dd5"} 15:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:32:31 INFO - Contents: 15:32:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca8c4b724ad6ac18de4fbcb2ba32dd30322676df8c70c3d9c65e2d60443b5b1c1596d3d77e00c24f7dd73b3b20766779a55433b5835baa489a208b373e2fab7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4f75060699b02406dc77645b458b9be2cfd52c0d442c66f26b36cdff64e8f53ce0379c73fe799daa5dd73d2fa3df703efe9fb4317dc047e53fbea75fab21c6e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7f2e845cf064cf3de390e70d6515c0ddfda3b35c53c56d4b34802240af9c3085ccce9f4333b4178b6a85ae93937474d262772536515f1d37a0b58d465695809c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/06dea847656addfe8b1a92eec08db43913af14d174bc6c3fd55b8c12f6a3516102af7e43a3210f03ab23d28342e12a2e039415a638ca737d428ea7d89acf8dd5"} 15:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 15:32:31 INFO - Copying logs to upload dir... 15:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 15:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.565620 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-23 15:32:31.293501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 15:32:31.297801) ========= 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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/Pine/sha512/ca8c4b724ad6ac18de4fbcb2ba32dd30322676df8c70c3d9c65e2d60443b5b1c1596d3d77e00c24f7dd73b3b20766779a55433b5835baa489a208b373e2fab7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4f75060699b02406dc77645b458b9be2cfd52c0d442c66f26b36cdff64e8f53ce0379c73fe799daa5dd73d2fa3df703efe9fb4317dc047e53fbea75fab21c6e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7f2e845cf064cf3de390e70d6515c0ddfda3b35c53c56d4b34802240af9c3085ccce9f4333b4178b6a85ae93937474d262772536515f1d37a0b58d465695809c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/06dea847656addfe8b1a92eec08db43913af14d174bc6c3fd55b8c12f6a3516102af7e43a3210f03ab23d28342e12a2e039415a638ca737d428ea7d89acf8dd5"} build_url:https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/AKr-5rxGQLeLP6MA_7FoZA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca8c4b724ad6ac18de4fbcb2ba32dd30322676df8c70c3d9c65e2d60443b5b1c1596d3d77e00c24f7dd73b3b20766779a55433b5835baa489a208b373e2fab7e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4f75060699b02406dc77645b458b9be2cfd52c0d442c66f26b36cdff64e8f53ce0379c73fe799daa5dd73d2fa3df703efe9fb4317dc047e53fbea75fab21c6e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/7f2e845cf064cf3de390e70d6515c0ddfda3b35c53c56d4b34802240af9c3085ccce9f4333b4178b6a85ae93937474d262772536515f1d37a0b58d465695809c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/06dea847656addfe8b1a92eec08db43913af14d174bc6c3fd55b8c12f6a3516102af7e43a3210f03ab23d28342e12a2e039415a638ca737d428ea7d89acf8dd5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 15:32:31.339600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 15:32:31.340185) ========= 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.gKFN4bWXW3/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.8ydcfSzNVY/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005226 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 15:32:31.390610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 15:32:31.390950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 15:32:31.391310) ========= ========= Total master_lag: 1.03 =========